builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0079 starttime: 1461580145.87 results: success (0) buildid: 20160424125552 builduid: 29fa51451e6247e79de74546a4441689 revision: 98da47b4d83c576ce17d189942d2655df5a36dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:05.867701) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:05.868103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:05.868433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:05.908717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:05.909003) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHTqkzbwqy/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 03:29:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 8.14M=0.001s 2016-04-25 03:29:06 (8.14 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.521722 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:06.806880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:06.810676) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHTqkzbwqy/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020143 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:06.879762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 03:29:06.880122) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98da47b4d83c576ce17d189942d2655df5a36dc1 --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-aurora --rev 98da47b4d83c576ce17d189942d2655df5a36dc1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHTqkzbwqy/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 03:29:06,963 truncating revision to first 12 chars 2016-04-25 03:29:06,963 Setting DEBUG logging. 2016-04-25 03:29:06,963 attempt 1/10 2016-04-25 03:29:06,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/98da47b4d83c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 03:29:07,744 unpacking tar archive at: mozilla-aurora-98da47b4d83c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.024245 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 03:29:07.935717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:07.936480) ========= script_repo_revision: 98da47b4d83c576ce17d189942d2655df5a36dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:07.937596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:07.938332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 03:29:07.953290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-25 03:29:07.953600) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHTqkzbwqy/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:29:08 INFO - MultiFileLogger online at 20160425 03:29:08 in /builds/slave/test 03:29:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:29:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:08 INFO - {'append_to_log': False, 03:29:08 INFO - 'base_work_dir': '/builds/slave/test', 03:29:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:29:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:08 INFO - 'branch': 'Mozilla-Aurora', 03:29:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:08 INFO - 'config_files': ('talos/mac_config.py',), 03:29:08 INFO - 'default_actions': ('clobber', 03:29:08 INFO - 'read-buildbot-config', 03:29:08 INFO - 'download-and-extract', 03:29:08 INFO - 'populate-webroot', 03:29:08 INFO - 'create-virtualenv', 03:29:08 INFO - 'install', 03:29:08 INFO - 'run-tests'), 03:29:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:08 INFO - 'download_minidump_stackwalk': True, 03:29:08 INFO - 'download_symbols': 'ondemand', 03:29:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:29:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:29:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:29:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:29:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:08 INFO - 'installer_path': 'installer.exe', 03:29:08 INFO - 'log_level': 'info', 03:29:08 INFO - 'log_name': 'talos', 03:29:08 INFO - 'log_to_console': True, 03:29:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:29:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:29:08 INFO - 'opt_config_files': (), 03:29:08 INFO - 'pip_index': False, 03:29:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:29:08 INFO - 'cmd': ('bash', 03:29:08 INFO - '-c', 03:29:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:29:08 INFO - 'enabled': True, 03:29:08 INFO - 'halt_on_failure': False, 03:29:08 INFO - 'name': 'check_screen_resolution'},), 03:29:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:29:08 INFO - 'cmd': ('bash', 03:29:08 INFO - '-c', 03:29:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:29:08 INFO - 'enabled': True, 03:29:08 INFO - 'halt_on_failure': False, 03:29:08 INFO - 'name': 'check_screen_resolution'},), 03:29:08 INFO - 'run_cmd_checks_enabled': True, 03:29:08 INFO - 'sps_profile': False, 03:29:08 INFO - 'sps_profile_interval': 0, 03:29:08 INFO - 'suite': 'dromaeojs-e10s', 03:29:08 INFO - 'system_bits': '32', 03:29:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:08 INFO - 'title': 't-yosemite-r7-0079', 03:29:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:08 INFO - 'use_talos_json': True, 03:29:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:08 INFO - 'work_dir': 'build'} 03:29:08 INFO - ##### 03:29:08 INFO - ##### Running clobber step. 03:29:08 INFO - ##### 03:29:08 INFO - Running pre-action listener: _resource_record_pre_action 03:29:08 INFO - Running main action method: clobber 03:29:08 INFO - rmtree: /builds/slave/test/build 03:29:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:09 INFO - Running post-action listener: _resource_record_post_action 03:29:09 INFO - ##### 03:29:09 INFO - ##### Running read-buildbot-config step. 03:29:09 INFO - ##### 03:29:09 INFO - Running pre-action listener: _resource_record_pre_action 03:29:09 INFO - Running main action method: read_buildbot_config 03:29:09 INFO - Using buildbot properties: 03:29:09 INFO - { 03:29:09 INFO - "project": "", 03:29:09 INFO - "product": "firefox", 03:29:09 INFO - "script_repo_revision": "production", 03:29:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:29:09 INFO - "repository": "", 03:29:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:29:09 INFO - "buildid": "20160424125552", 03:29:09 INFO - "pgo_build": "False", 03:29:09 INFO - "basedir": "/builds/slave/test", 03:29:09 INFO - "buildnumber": 294, 03:29:09 INFO - "slavename": "t-yosemite-r7-0079", 03:29:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:29:09 INFO - "platform": "yosemite_r7", 03:29:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:29:09 INFO - "branch": "mozilla-aurora", 03:29:09 INFO - "repo_path": "releases/mozilla-aurora", 03:29:09 INFO - "revision": "98da47b4d83c576ce17d189942d2655df5a36dc1", 03:29:09 INFO - "stage_platform": "macosx64", 03:29:09 INFO - "builduid": "29fa51451e6247e79de74546a4441689", 03:29:09 INFO - "slavebuilddir": "test" 03:29:09 INFO - } 03:29:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 03:29:09 INFO - Running post-action listener: _resource_record_post_action 03:29:09 INFO - ##### 03:29:09 INFO - ##### Running download-and-extract step. 03:29:09 INFO - ##### 03:29:09 INFO - Running pre-action listener: _resource_record_pre_action 03:29:09 INFO - Running main action method: download_and_extract 03:29:09 INFO - mkdir: /builds/slave/test/build/tests 03:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:09 INFO - https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:29:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:29:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:29:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 03:29:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 03:29:24 INFO - Downloaded 1277 bytes. 03:29:24 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 03:29:24 INFO - Using the following test package requirements: 03:29:24 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:29:24 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 03:29:24 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 03:29:24 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'jsshell-mac.zip'], 03:29:24 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 03:29:24 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:29:24 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 03:29:24 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 03:29:24 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 03:29:24 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:29:24 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:29:24 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 03:29:24 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:24 INFO - https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:29:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:29:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:29:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:29:35 INFO - Downloaded 17919003 bytes. 03:29:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:29:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:29:38 INFO - Return code: 0 03:29:38 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:38 INFO - https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:29:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:29:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:29:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:29:40 INFO - Downloaded 17919003 bytes. 03:29:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:29:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:29:43 INFO - Return code: 0 03:29: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')]} 03:29:43 INFO - https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:29:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:29:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:29:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:29:44 INFO - Downloaded 10845194 bytes. 03:29:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:29:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:29:44 INFO - Return code: 0 03:29:44 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')]} 03:29:44 INFO - https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:29:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:29:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:29:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 03:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 03:29:51 INFO - Downloaded 115764096 bytes. 03:29:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:29:51 INFO - mkdir: /builds/slave/test/properties 03:29:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:51 INFO - Contents: 03:29:51 INFO - build_url:https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:29:52 INFO - Running post-action listener: _resource_record_post_action 03:29:52 INFO - Running post-action listener: set_extra_try_arguments 03:29:52 INFO - ##### 03:29:52 INFO - ##### Running populate-webroot step. 03:29:52 INFO - ##### 03:29:52 INFO - Running pre-action listener: _resource_record_pre_action 03:29:52 INFO - Running main action method: populate_webroot 03:29:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:52 INFO - '--tppagecycles', 03:29:52 INFO - '7'], 03:29:52 INFO - 'tests': ['tsvgm']}}, 03:29:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:29:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:29:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'tests': ['damp', 'tps']}, 03:29:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['damp', 'tps']}, 03:29:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:29:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:52 INFO - 'other': {'tests': ['a11yr', 03:29:52 INFO - 'ts_paint', 03:29:52 INFO - 'tpaint', 03:29:52 INFO - 'sessionrestore', 03:29:52 INFO - 'sessionrestore_no_auto_restore', 03:29:52 INFO - 'tabpaint']}, 03:29:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['a11yr', 03:29:52 INFO - 'ts_paint', 03:29:52 INFO - 'tpaint', 03:29:52 INFO - 'sessionrestore', 03:29:52 INFO - 'sessionrestore_no_auto_restore', 03:29:52 INFO - 'tabpaint']}, 03:29:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['a11yr', 03:29:52 INFO - 'ts_paint', 03:29:52 INFO - 'tpaint', 03:29:52 INFO - 'sessionrestore', 03:29:52 INFO - 'sessionrestore_no_auto_restore', 03:29:52 INFO - 'tabpaint']}, 03:29:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['a11yr', 03:29:52 INFO - 'ts_paint', 03:29:52 INFO - 'tpaint', 03:29:52 INFO - 'sessionrestore', 03:29:52 INFO - 'sessionrestore_no_auto_restore', 03:29:52 INFO - 'tabpaint']}, 03:29:52 INFO - 'other_l64': {'tests': ['a11yr', 03:29:52 INFO - 'ts_paint', 03:29:52 INFO - 'tpaint', 03:29:52 INFO - 'sessionrestore', 03:29:52 INFO - 'sessionrestore_no_auto_restore', 03:29:52 INFO - 'tabpaint']}, 03:29:52 INFO - 'other_nol64': {'tests': ['a11yr', 03:29:52 INFO - 'ts_paint', 03:29:52 INFO - 'tpaint', 03:29:52 INFO - 'sessionrestore', 03:29:52 INFO - 'sessionrestore_no_auto_restore', 03:29:52 INFO - 'tabpaint']}, 03:29:52 INFO - 'svgr': {'tests': ['tsvgx', 03:29:52 INFO - 'tsvgr_opacity', 03:29:52 INFO - 'tart', 03:29:52 INFO - 'tscrollx', 03:29:52 INFO - 'cart']}, 03:29:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['tsvgx', 03:29:52 INFO - 'tsvgr_opacity', 03:29:52 INFO - 'tart', 03:29:52 INFO - 'tscrollx', 03:29:52 INFO - 'cart']}, 03:29:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'tests': ['tp5o']}, 03:29:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'talos_options': ['--e10s'], 03:29:52 INFO - 'tests': ['tp5o']}, 03:29:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'talos_options': ['--xperf_path', 03:29:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:52 INFO - 'tests': ['tp5n']}, 03:29:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:52 INFO - 'talos_options': ['--e10s', 03:29:52 INFO - '--xperf_path', 03:29:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:52 INFO - 'tests': ['tp5n']}}, 03:29:52 INFO - 'talos.zip': {'path': '', 03:29:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:52 INFO - Running post-action listener: _resource_record_post_action 03:29:52 INFO - ##### 03:29:52 INFO - ##### Running create-virtualenv step. 03:29:52 INFO - ##### 03:29:52 INFO - Running pre-action listener: _resource_record_pre_action 03:29:52 INFO - Running main action method: create_virtualenv 03:29:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:52 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 03:29:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:52 INFO - Using real prefix '/tools/python27' 03:29:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:56 INFO - Installing pip.................done. 03:29:56 INFO - Return code: 0 03:29:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:29:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:29:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:56 INFO - 'HOME': '/Users/cltbld', 03:29:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:56 INFO - 'LOGNAME': 'cltbld', 03:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:56 INFO - 'MOZ_NO_REMOTE': '1', 03:29:56 INFO - 'NO_EM_RESTART': '1', 03:29:56 INFO - 'PAGER': '/bin/cat', 03:29:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:56 INFO - 'PWD': '/builds/slave/test', 03:29:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:56 INFO - 'SHELL': '/bin/bash', 03:29:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:29:56 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:29:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:56 INFO - 'USER': 'cltbld', 03:29:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:56 INFO - 'XPC_FLAGS': '0x0', 03:29:56 INFO - 'XPC_SERVICE_NAME': '0', 03:29:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:56 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 03:29:56 INFO - Cleaning up... 03:29:56 INFO - Return code: 0 03:29:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:29:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:29:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:56 INFO - 'HOME': '/Users/cltbld', 03:29:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:56 INFO - 'LOGNAME': 'cltbld', 03:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:56 INFO - 'MOZ_NO_REMOTE': '1', 03:29:56 INFO - 'NO_EM_RESTART': '1', 03:29:56 INFO - 'PAGER': '/bin/cat', 03:29:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:56 INFO - 'PWD': '/builds/slave/test', 03:29:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:56 INFO - 'SHELL': '/bin/bash', 03:29:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:29:56 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:29:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:56 INFO - 'USER': 'cltbld', 03:29:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:56 INFO - 'XPC_FLAGS': '0x0', 03:29:56 INFO - 'XPC_SERVICE_NAME': '0', 03:29:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:56 INFO - Downloading/unpacking psutil>=0.7.1 03:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:59 INFO - Installing collected packages: psutil 03:29:59 INFO - Running setup.py install for psutil 03:29:59 INFO - building 'psutil._psutil_osx' extension 03:29:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:30:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:30:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:30:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:30:00 INFO - building 'psutil._psutil_posix' extension 03:30:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:30:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:30:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:30:00 INFO - ^ 03:30:00 INFO - 1 warning generated. 03:30:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:30:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:00 INFO - Successfully installed psutil 03:30:00 INFO - Cleaning up... 03:30:00 INFO - Return code: 0 03:30:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:30:00 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')]} 03:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:00 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')]} 03:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:00 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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:30:00 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 03:30:00 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 03:30:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:30:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:00 INFO - 'HOME': '/Users/cltbld', 03:30:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:00 INFO - 'LOGNAME': 'cltbld', 03:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:00 INFO - 'MOZ_NO_REMOTE': '1', 03:30:00 INFO - 'NO_EM_RESTART': '1', 03:30:00 INFO - 'PAGER': '/bin/cat', 03:30:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:00 INFO - 'PWD': '/builds/slave/test', 03:30:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:00 INFO - 'SHELL': '/bin/bash', 03:30:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:30:00 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:30:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:00 INFO - 'USER': 'cltbld', 03:30:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:00 INFO - 'XPC_FLAGS': '0x0', 03:30:00 INFO - 'XPC_SERVICE_NAME': '0', 03:30:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:30:00 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 03:30:00 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 03:30:00 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 03:30:00 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 03:30:00 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 03:30:00 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 03:30:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:30:03 INFO - Installing collected packages: mozsystemmonitor 03:30:03 INFO - Running setup.py install for mozsystemmonitor 03:30:03 INFO - Successfully installed mozsystemmonitor 03:30:03 INFO - Cleaning up... 03:30:03 INFO - Return code: 0 03:30:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:03 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')]} 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:03 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')]} 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:03 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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:30:03 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 03:30:03 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 03:30:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:30:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:03 INFO - 'HOME': '/Users/cltbld', 03:30:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:03 INFO - 'LOGNAME': 'cltbld', 03:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:03 INFO - 'MOZ_NO_REMOTE': '1', 03:30:03 INFO - 'NO_EM_RESTART': '1', 03:30:03 INFO - 'PAGER': '/bin/cat', 03:30:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:03 INFO - 'PWD': '/builds/slave/test', 03:30:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:03 INFO - 'SHELL': '/bin/bash', 03:30:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:30:03 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:30:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:03 INFO - 'USER': 'cltbld', 03:30:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:03 INFO - 'XPC_FLAGS': '0x0', 03:30:03 INFO - 'XPC_SERVICE_NAME': '0', 03:30:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:03 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 03:30:03 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 03:30:03 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 03:30:03 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 03:30:03 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 03:30:03 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 03:30:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:07 INFO - Downloading docopt-0.6.1.tar.gz 03:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:07 INFO - Running setup.py install for blobuploader 03:30:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:07 INFO - Running setup.py install for requests 03:30:08 INFO - Running setup.py install for docopt 03:30:08 INFO - Successfully installed blobuploader requests docopt 03:30:08 INFO - Cleaning up... 03:30:08 INFO - Return code: 0 03:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:08 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')]} 03:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:08 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')]} 03:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:08 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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:30:08 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 03:30:08 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 03:30:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:30:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:08 INFO - 'HOME': '/Users/cltbld', 03:30:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:08 INFO - 'LOGNAME': 'cltbld', 03:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:08 INFO - 'MOZ_NO_REMOTE': '1', 03:30:08 INFO - 'NO_EM_RESTART': '1', 03:30:08 INFO - 'PAGER': '/bin/cat', 03:30:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:08 INFO - 'PWD': '/builds/slave/test', 03:30:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:08 INFO - 'SHELL': '/bin/bash', 03:30:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:30:08 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:30:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:08 INFO - 'USER': 'cltbld', 03:30:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:08 INFO - 'XPC_FLAGS': '0x0', 03:30:08 INFO - 'XPC_SERVICE_NAME': '0', 03:30:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-B6fRrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-5vFUl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-WVCoek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-S0Oh0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-wzodQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Y3bSlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-YA650G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-u_T6O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Ifhy4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-GZkWmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-jHpXZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-EPKMyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:10 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BiLSi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:10 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-TcWO1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:10 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-dTPRe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:10 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-pQzWWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:10 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-NPcyDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:10 INFO - Running setup.py install for manifestparser 03:30:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:10 INFO - Running setup.py install for mozcrash 03:30:10 INFO - Running setup.py install for mozdebug 03:30:10 INFO - Running setup.py install for mozdevice 03:30:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Running setup.py install for mozfile 03:30:11 INFO - Running setup.py install for mozhttpd 03:30:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Running setup.py install for mozinfo 03:30:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Running setup.py install for mozInstall 03:30:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:11 INFO - Running setup.py install for mozleak 03:30:11 INFO - Running setup.py install for mozlog 03:30:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:12 INFO - Running setup.py install for moznetwork 03:30:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:12 INFO - Running setup.py install for mozprocess 03:30:12 INFO - Running setup.py install for mozprofile 03:30:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:12 INFO - Running setup.py install for mozrunner 03:30:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:12 INFO - Running setup.py install for mozscreenshot 03:30:12 INFO - Running setup.py install for moztest 03:30:12 INFO - Running setup.py install for mozversion 03:30:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:13 INFO - Cleaning up... 03:30:13 INFO - Return code: 0 03:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:13 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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:30:13 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 03:30:13 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 03:30:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:30:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:13 INFO - 'HOME': '/Users/cltbld', 03:30:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:13 INFO - 'LOGNAME': 'cltbld', 03:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:13 INFO - 'MOZ_NO_REMOTE': '1', 03:30:13 INFO - 'NO_EM_RESTART': '1', 03:30:13 INFO - 'PAGER': '/bin/cat', 03:30:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:13 INFO - 'PWD': '/builds/slave/test', 03:30:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:13 INFO - 'SHELL': '/bin/bash', 03:30:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:30:13 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:30:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:13 INFO - 'USER': 'cltbld', 03:30:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:13 INFO - 'XPC_FLAGS': '0x0', 03:30:13 INFO - 'XPC_SERVICE_NAME': '0', 03:30:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-nzJftl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:13 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)) 03:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9Ii3nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-X41LGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bo1QfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-PeInoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-zboK_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-B4Et8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-YVHAiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_JEn68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-TnE2it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:14 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)) 03:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-wNORDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:15 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)) 03:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-kHKUPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:15 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)) 03:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-c60Mwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:15 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)) 03:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-vHt3D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:15 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)) 03:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-jvohKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:15 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)) 03:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-tfKGR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:15 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)) 03:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-mswkXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:15 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)) 03:30:15 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)) 03:30:15 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)) 03:30:15 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)) 03:30:15 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)) 03:30:15 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)) 03:30:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:18 INFO - Downloading blessings-1.6.tar.gz 03:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:18 INFO - Installing collected packages: blessings 03:30:18 INFO - Running setup.py install for blessings 03:30:18 INFO - Successfully installed blessings 03:30:18 INFO - Cleaning up... 03:30:19 INFO - Return code: 0 03:30:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:19 INFO - Reading from file tmpfile_stdout 03:30:19 INFO - Current package versions: 03:30:19 INFO - blessings == 1.6 03:30:19 INFO - blobuploader == 1.2.4 03:30:19 INFO - docopt == 0.6.1 03:30:19 INFO - manifestparser == 1.1 03:30:19 INFO - mozInstall == 1.12 03:30:19 INFO - mozcrash == 0.17 03:30:19 INFO - mozdebug == 0.1 03:30:19 INFO - mozdevice == 0.48 03:30:19 INFO - mozfile == 1.2 03:30:19 INFO - mozhttpd == 0.7 03:30:19 INFO - mozinfo == 0.9 03:30:19 INFO - mozleak == 0.1 03:30:19 INFO - mozlog == 3.1 03:30:19 INFO - moznetwork == 0.27 03:30:19 INFO - mozprocess == 0.22 03:30:19 INFO - mozprofile == 0.28 03:30:19 INFO - mozrunner == 6.11 03:30:19 INFO - mozscreenshot == 0.1 03:30:19 INFO - mozsystemmonitor == 0.0 03:30:19 INFO - moztest == 0.7 03:30:19 INFO - mozversion == 1.4 03:30:19 INFO - psutil == 3.1.1 03:30:19 INFO - requests == 1.2.3 03:30:19 INFO - wsgiref == 0.1.2 03:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:19 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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:30:19 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 03:30:19 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 03:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:19 INFO - 'HOME': '/Users/cltbld', 03:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:19 INFO - 'LOGNAME': 'cltbld', 03:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:19 INFO - 'MOZ_NO_REMOTE': '1', 03:30:19 INFO - 'NO_EM_RESTART': '1', 03:30:19 INFO - 'PAGER': '/bin/cat', 03:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:19 INFO - 'PWD': '/builds/slave/test', 03:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:19 INFO - 'SHELL': '/bin/bash', 03:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:30:19 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:19 INFO - 'USER': 'cltbld', 03:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:19 INFO - 'XPC_FLAGS': '0x0', 03:30:19 INFO - 'XPC_SERVICE_NAME': '0', 03:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 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)) 03:30:19 INFO - Cleaning up... 03:30:19 INFO - Return code: 0 03:30:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:19 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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:30:19 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 03:30:19 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 03:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:19 INFO - 'HOME': '/Users/cltbld', 03:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:19 INFO - 'LOGNAME': 'cltbld', 03:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:19 INFO - 'MOZ_NO_REMOTE': '1', 03:30:19 INFO - 'NO_EM_RESTART': '1', 03:30:19 INFO - 'PAGER': '/bin/cat', 03:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:19 INFO - 'PWD': '/builds/slave/test', 03:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:19 INFO - 'SHELL': '/bin/bash', 03:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:30:19 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:19 INFO - 'USER': 'cltbld', 03:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:19 INFO - 'XPC_FLAGS': '0x0', 03:30:19 INFO - 'XPC_SERVICE_NAME': '0', 03:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:19 INFO - Downloading/unpacking jsonschema 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:22 INFO - Downloading/unpacking functools32 (from jsonschema) 03:30:22 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 03:30:22 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 03:30:22 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 03:30:22 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 03:30:22 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 03:30:22 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 03:30:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:22 INFO - warning: no files found matching '*.txt' 03:30:22 INFO - no previously-included directories found matching 'build' 03:30:22 INFO - no previously-included directories found matching 'dist' 03:30:22 INFO - no previously-included directories found matching '.git*' 03:30:22 INFO - Installing collected packages: jsonschema, functools32 03:30:22 INFO - Running setup.py install for functools32 03:30:22 INFO - warning: no files found matching '*.txt' 03:30:22 INFO - no previously-included directories found matching 'build' 03:30:22 INFO - no previously-included directories found matching 'dist' 03:30:22 INFO - no previously-included directories found matching '.git*' 03:30:22 INFO - Successfully installed jsonschema functools32 03:30:22 INFO - Cleaning up... 03:30:22 INFO - Return code: 0 03:30:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:22 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 0x10c146a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb511471b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:30:22 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 03:30:22 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 03:30:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:30:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:30:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:30:22 INFO - 'HOME': '/Users/cltbld', 03:30:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:30:22 INFO - 'LOGNAME': 'cltbld', 03:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:22 INFO - 'MOZ_NO_REMOTE': '1', 03:30:22 INFO - 'NO_EM_RESTART': '1', 03:30:22 INFO - 'PAGER': '/bin/cat', 03:30:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:22 INFO - 'PWD': '/builds/slave/test', 03:30:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:30:22 INFO - 'SHELL': '/bin/bash', 03:30:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:30:22 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:30:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:30:22 INFO - 'USER': 'cltbld', 03:30:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:30:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:22 INFO - 'XPC_FLAGS': '0x0', 03:30:22 INFO - 'XPC_SERVICE_NAME': '0', 03:30:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:23 INFO - Downloading/unpacking flake8 03:30:23 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 03:30:23 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 03:30:23 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 03:30:23 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 03:30:23 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 03:30:23 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 03:30:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:30:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:30:25 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 03:30:25 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 03:30:25 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 03:30:25 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 03:30:25 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 03:30:25 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 03:30:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:30:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:27 INFO - no previously-included directories found matching 'docs/_build' 03:30:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:30:27 INFO - Running setup.py install for pep8 03:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:27 INFO - no previously-included directories found matching 'docs/_build' 03:30:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:30:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:30:27 INFO - Cleaning up... 03:30:27 INFO - Return code: 0 03:30:27 INFO - Running post-action listener: _resource_record_post_action 03:30:27 INFO - Running post-action listener: _start_resource_monitoring 03:30:27 INFO - Starting resource monitoring. 03:30:27 INFO - ##### 03:30:27 INFO - ##### Running install step. 03:30:27 INFO - ##### 03:30:27 INFO - Running pre-action listener: _resource_record_pre_action 03:30:27 INFO - Running main action method: install 03:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:27 INFO - Reading from file tmpfile_stdout 03:30:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:27 INFO - Reading from file tmpfile_stdout 03:30:27 INFO - Output received: 03:30:27 INFO - Usage: mozinstall [options] installer 03:30:27 INFO - Options: 03:30:27 INFO - -h, --help show this help message and exit 03:30:27 INFO - -d DEST, --destination=DEST 03:30:27 INFO - Directory to install application into. [default: 03:30:27 INFO - "/builds/slave/test"] 03:30:27 INFO - --app=APP Application being installed. [default: firefox] 03:30:27 INFO - mkdir: /builds/slave/test/build/application 03:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:30:59 INFO - Reading from file tmpfile_stdout 03:30:59 INFO - Output received: 03:30:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:30:59 INFO - Running post-action listener: _resource_record_post_action 03:30:59 INFO - ##### 03:30:59 INFO - ##### Running run-tests step. 03:30:59 INFO - ##### 03:30:59 INFO - Running pre-action listener: _resource_record_pre_action 03:30:59 INFO - Running main action method: run_tests 03:30:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:30:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:30:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:30:59 INFO - 2016-04-25 03:30:59.490 screenresolution[2197:17689] starting screenresolution argv=screenresolution get 03:30:59 INFO - 2016-04-25 03:30:59.493 screenresolution[2197:17689] Display 0: 1600x1200x32@60 03:30:59 INFO - 2016-04-25 03:30:59.499 screenresolution[2198:17691] starting screenresolution argv=screenresolution list 03:30:59 INFO - Available Modes on Display 0 03:30:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:30:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:30:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:30:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:30:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:30:59 INFO - Intel Iris: 03:30:59 INFO - Chipset Model: Intel Iris 03:30:59 INFO - Type: GPU 03:30:59 INFO - Bus: Built-In 03:30:59 INFO - VRAM (Dynamic, Max): 1536 MB 03:30:59 INFO - Vendor: Intel (0x8086) 03:30:59 INFO - Device ID: 0x0a2e 03:30:59 INFO - Revision ID: 0x0009 03:30:59 INFO - Displays: 03:30:59 INFO - Display: 03:30:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:30:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:30:59 INFO - Display Serial Number: 1600x1200 60 03:30:59 INFO - Main Display: Yes 03:30:59 INFO - Mirror: Off 03:30:59 INFO - Online: Yes 03:30:59 INFO - Rotation: Supported 03:30:59 INFO - Return code: 0 03:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:59 INFO - Python 2.7.3 03:30:59 INFO - Return code: 0 03:30:59 INFO - grabbing minidump binary from tooltool 03:30: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')]} 03:30:59 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfead30>, '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 0x10be4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:59 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:30:59 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:30:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:59 INFO - Return code: 0 03:30:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:30:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:30:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:31:00 INFO - Return code: 0 03:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:31:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tHTqkzbwqy/Render', 03:31:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:31:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:31:01 INFO - 'HOME': '/Users/cltbld', 03:31:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:31:01 INFO - 'LOGNAME': 'cltbld', 03:31:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:01 INFO - 'MOZ_NO_REMOTE': '1', 03:31:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:01 INFO - 'NO_EM_RESTART': '1', 03:31:01 INFO - 'PAGER': '/bin/cat', 03:31:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:01 INFO - 'PWD': '/builds/slave/test', 03:31:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:31:01 INFO - 'SHELL': '/bin/bash', 03:31:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners', 03:31:01 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:31:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:31:01 INFO - 'USER': 'cltbld', 03:31:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:31:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:01 INFO - 'XPC_FLAGS': '0x0', 03:31:01 INFO - 'XPC_SERVICE_NAME': '0', 03:31:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:31:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:31:01 INFO - mozversion application_buildid: 20160424125552 03:31:01 INFO - mozversion application_changeset: 98da47b4d83c576ce17d189942d2655df5a36dc1 03:31:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:01 INFO - mozversion application_name: Firefox 03:31:01 INFO - mozversion application_remotingname: firefox-dev 03:31:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:01 INFO - mozversion application_vendor: Mozilla 03:31:01 INFO - mozversion application_version: 47.0a2 03:31:01 INFO - mozversion platform_buildid: 20160424125552 03:31:01 INFO - mozversion platform_changeset: 98da47b4d83c576ce17d189942d2655df5a36dc1 03:31:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:01 INFO - mozversion platform_version: 47.0a2 03:31:01 INFO - using testdate: 1461580261 03:31:01 INFO - actual date: 1461580261 03:31:01 INFO - starting webserver on 'localhost:52583' 03:31:01 INFO - SUITE-START | Running 2 tests 03:31:01 INFO - TEST-START | dromaeo_css 03:31:01 INFO - operating with platform_type : mac_ 03:31:01 INFO - Initialising browser for dromaeo_css test... 03:31:01 INFO - TEST-INFO | started process 2216 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpGvTt9m/profile http://localhost:52583/getInfo.html) 03:31:03 INFO - PROCESS | 2216 | __metrics Screen width/height:1600/1200 03:31:03 INFO - PROCESS | 2216 | colorDepth:24 03:31:03 INFO - PROCESS | 2216 | Browser inner width/height: 1024/689 03:31:03 INFO - PROCESS | 2216 | __metrics 03:31:03 ERROR - PROCESS | 2216 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:31:04 INFO - TEST-INFO | 2216: exit 0 03:31:04 INFO - Browser initialized. 03:31:04 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:04 INFO - TEST-INFO | started process 2219 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpGvTt9m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:16 INFO - PROCESS | 2219 | RSS: Main: 217776128 03:31:16 INFO - PROCESS | 2219 | 03:32:06 INFO - PROCESS | 2219 | 1461580326138 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] 03:34:16 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:52583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52583/tests/dromaeo/cssquery-ext.html) 03:34:17 INFO - PROCESS | 2219 | RSS: Main: 228515840 03:34:17 INFO - PROCESS | 2219 | 03:37:19 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:52583/tests/dromaeo/cssquery-ext.html (next: http://localhost:52583/tests/dromaeo/cssquery-jquery.html) 03:37:20 INFO - PROCESS | 2219 | RSS: Main: 240336896 03:37:20 INFO - PROCESS | 2219 | 03:40:21 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:52583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52583/tests/dromaeo/cssquery-mootools.html) 03:40:22 INFO - PROCESS | 2219 | RSS: Main: 242208768 03:40:22 INFO - PROCESS | 2219 | 03:43:24 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:52583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52583/tests/dromaeo/cssquery-prototype.html) 03:43:24 INFO - PROCESS | 2219 | RSS: Main: 243802112 03:43:24 INFO - PROCESS | 2219 | 03:46:27 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:52583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52583/tests/dromaeo/cssquery-yui.html) 03:46:28 INFO - PROCESS | 2219 | RSS: Main: 246837248 03:46:28 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:52583/tests/dromaeo/cssquery-yui.html (next: http://localhost:52583/tests/dromaeo/cssquery-dojo.html) 03:49:30 INFO - PROCESS | 2219 | RSS: Main: 248221696 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | __start_tp_report 03:49:30 INFO - PROCESS | 2219 | _x_x_mozilla_page_load 03:49:30 INFO - PROCESS | 2219 | _x_x_mozilla_page_load_details 03:49:30 INFO - PROCESS | 2219 | |i|pagename|runs| 03:49:30 INFO - PROCESS | 2219 | |0;dojo.html;3495.2659941412307;3520.5423294971642;3527.3121741260434;3561.180928386471;3582.086567925177;5829;5844.357120716718;5856.238688970433;5856.531477481802;5859.414058594144;4655.30170474429;4710.97644511777;5829.329627092886;5842.766289348431;5856;5218.32161818964;5231.398389185235;5265.236540701596;5267.446918073604;5368.91946620801;5212.400573933989;5309.681419114846;5336.4129945705945;5355.08963476208;5421.539169170625;5384.865378365533;5416.268803711488;5419.105847535172;5432.592555558329;5450.182472629098;4468.754218517964;5142.434332223453;5342.545883599899;5351.17056856186;5367.43641917597;4088.8364465421346;5148.330717006803;5252.921206181911;5282.603804714662;5316.362036555638;5601.383847776782;5662.235598194232;5679.716014199274;5710;5735.684537350444;5912.4974377178;6215.316315205324;6246.469050130744;6251.999680051215;6333.714982825784;6209.627422354628;6279.403456671609;6284.87430251397;6286.9056964145575;6335.524835637346;6018.097285407181;6025.517958563304;6028.09578563219;6033.668148251844;6039.667818270037;6239.656818875005;6365.3316401778075;6391.552591318563;6413.134226879405;6449.484041276686;6227.034809604518;6265.4361107500545;6324.936750632435;6325.810225693236;6338.7464501420345;6316.494680425555;6324.968375158187;6348.555601107878;6377.617342959437;6387.520935929824;5557.527610153183;6166.753329866755;6225.408586184396;6286.402791734778;6302.65335406557;6209.565330426917;6261.123442718023;6296.5277604178955;6301.338359472281;6310.652914089769;4999.450060493343;5029.2958985742025;5033;5042.924356134661;5058.721770302669;4425.137098265807;4452.732836029849;4501.099780044005;4510.774461276923;4541.2733962565835;4676.532346765296;5793.565482588822;5909.8227053188475;5936.7328470218945;5939.881202375928;6253.280872699698;6283.968580157161;6289.993601023905;6303.149074874833;6338.714757835908;5822.883542329129;5915.1718759373725;5940.435658612425;5959.374265702038;6001.399860013964;5481.725913704378;5485.506304432541;5504.422035686275;5508.91736623951;5540;6417.871642567123;6425.228972523327;6451;6462.063000864849;6469;6242.344553821783;6302.621842689453;6317.147185129948;6326.557141000086;6335.493160547053;5185.196294574347;6464.482841372773;6482.935170648233;6508.934910651023;6533.607983521004;6144.047672610753;6276.089966954857;6300.117983482408;6304.810855674337;6312.747490100528;5331.973340133274;6259.812205633838;6264.123022776906;6315.368463153832;6319.304876463677;6185.134081228542;6237.220347456568;6256;6261.3112557617715;6305.747770089145;6234.563580549318;6247.281562620356;6247.875042499034;6248.843778905563;6257.1240026395435;5827.3007239131575;6106.45041946227;6106.521339539896;6114.877702446015;6131.315499378873;5335.09303418412;5999.970000149971;6236.158118653923;6240.906386404116;6254.781082662085;4753.287006948985;6093.48205402528;6123.9693801532485;6133.049377346519;6133.233345831771 03:49:30 INFO - PROCESS | 2219 | |1;ext.html;496.8683298925783;528.0257924129984;594.2571785268415;683.5659356308744;689.8275431142215;27876;39363;39504.40743388851;39537;39735.20529589406;41285.174296514124;41829.37255941163;42082.579174208324;42111.36832947501;42235;9651.95174024129;9754.219662426989;9805.901940980606;9827.410355378664;9869.851952220723;9608.231341492663;9816.558254878548;9820.803583928317;9857.162141218005;9924.206063514937;9778.364406313602;9818.50907454628;9842.507874606277;9858.211343092535;9858.309918305722;9774.657886973957;9842.163416109639;9851.261155413373;9873.654422095227;9894.455804930725;9695.51522423876;9752.853707194397;9770.071843174886;9785.217182625443;9800.215982721365;40083.7995810022;40154.59845401538;40437.59562404368;40484.79757601193;40555.39166912498;3359.479280711469;3360.4959256111533;3458.56767904012;3590.964090359089;3613.9096522586883;27243.727562724514;28318.858405708044;28337.858310708314;28486.145415637566;28629.57055644167;2783.9721602783916;2791.8553393108728;2805.1724741201397;2814.1557532740303;2919.664238612544;509237;510754;513000;513406.9999999963;514356;48154.51845481501;74116;74412.62793685996;74754;74815.62592187004;47636.761816190694;47804.76097619559;48073.519264807604;48321.758391208525;48506.27240591394;16489.175541222892;16499.6700065998;16708.916455417646;16809.6638067238;16872.493825185265;13337.666558335924;13465.932670336586;13483.921286297073;13486.865131348757;13537.1200871943;12346.691332716753;12785.936070319774;12948.964082873348;15408.614784630474;15871.920640396724;5643;6381.1066450696935;6772.288909664513;6779.72881084761;6807.319268073153;1009.7021378693303;1036.9948150259352;1079.8175997282963;1106.5794997900746;1137.732632831284;30693.69306306953;30965.69034309628;31073.378532429226;31233.53149702756;31305.8434707825;1114.4817659788075;1117.452448300327;1141.5319718915205;1197.8382918306093;1260.6470188347278;14588.85411145875;14653.633659158393;14758.819294456418;14953.775693364609;14956.476523321631;654496;655136;659652;666455;666643;62287.688561556904;62531;62724.372756271856;62751.37248627455;62951;1553.6659618182146;1559.6334861307585;1579.6998570271842;1593.3865461797059;1595.4734937470607;28791.568126478538;29010.41979160363;29223.853880731313;29499.115026549236;29662.406751865274;51352.94588216579;51403;51940;52015.219771704215;52050.95898082093;494428.5278573584;506956;509825;510097;511587;32454;34105.65894341025;34310.313793723486;34505.654943450245;34631.787887423816;45487.31769023401;45693;45723.54276457193;45778;46231;33286.66713332836;37554;37869.431958520094;38143.80928095342;38192;37529;37991.62008379991;38021.04947376338;38242;38411.039724007125;32222.83888580542;37017.81491092527;37241.441378378804;37609.059773505884;37823.81088094542;24043.759562404153;24786.59594507524;29574.112776616737;32258;33035.17412064718;23797.64303535483;24253.51492970166;25048.499030019662;25308;25412 03:49:30 INFO - PROCESS | 2219 | |2;jquery.html;341.2066944354376;380.5129434324064;386.21790873481206;392.23318412503556;394.05426975259354;20284.69572956405;20778;20940.16239350424;21557.353279401603;21563.568728625418;10312.917143699897;12081.697957551065;12311.322877241748;12360.814587781191;12401.255924644527;5095.490450954893;5262.394824595172;5458.6724796512135;5484.287042684446;5801.07182850744;5670.461306175906;5683.630564013347;5748.712564371785;5813.6221145625395;6055.333913269559;5876.353601103875;5990.820275391745;6004.159417681528;6030.246219222598;6047.485963693091;5891.823245302648;5898.823035308927;5990.9400905990815;6416.326285739977;6528.37980391862;5758.7696492140685;5780.1907732917425;5802.65184088956;5803.042497987827;5809.82570522885;13681.179129252178;13704;13865.792013119812;13967.580972570839;22245.22141725032;2152.849300548962;2166.516834958293;2304.446932736148;2318.93043208704;2334.2880421471446;9956.502174891226;10600.204984626107;10700.518476668569;11598.304101753922;15098.245087745569;1676.5305714399988;1807.13257636334;1852.3701941339875;1854.6754317994432;1867.5424520992308;93315.53342233246;98271.99999999929;100193;104387;110121.89878101197;11207.495662695035;11450.370229637283;11634.883651163549;11637.767244655059;11739.589114380955;14341.498047568284;14405.42378304856;14458.421663133357;14501.564953051426;14507;7479.70081196746;8733.912660873437;8760.8685869712;8855.158759917798;8864.734057978141;8964.238039766693;9040.63837446508;9074.546272686339;9147.131022552847;9166.129217724305;3874.2445223181207;4567.383403240587;4648.070385922829;4669.743164125938;4708.741019243906;1637.8607818335336;1638.6804573108368;1735.1844633022458;1749.160403006564;1968.2815772243027;898.9280857531381;905.7373361725158;915.9129882661136;969.3602222533094;1060.0883240413239;19365.32221372245;20173.092210850547;20532.897335513226;20593.897030514752;20625.865577393386;855.3798496090409;991.548845275398;1005.331454582709;1035.0787798859021;1038.657243109772;8937.838081049422;10105.9494702526;10892.891071089347;10933.343999359904;11009.174311926638;682962;687774;693601;693870;700040;124730;125301;128273.35863320624;128596;131632;1027.5992362978445;1035.6530562261576;1043.6138628707427;1044.1594516414207;1066.1311031509294;18415.53961150982;18437.354692585694;18561.793483423535;18579.5241780465;18616.81383186151;51761.48238517717;52622.47377526176;52752;53457;55052.72473637606;76999.61500192463;78163.82754258804;78168.60915695385;79962;80050.59974700089;8125.715599953974;8323.875141872755;8438.113998030118;8445.915540844513;8455.915440845758;12140.271583705005;12765.425555849823;13453.394597242952;13646.385912634154;13723.588292351245;10691.198160138176;11536.59621913229;11571.19001669875;11724.355160466257;11875.465604048011;11412.828807567726;11540.24988375753;11650.184487085822;11687.837750016275;11879.22785018971;9881.802363952824;10975.341479511255;11890.464929078385;12183.086268529718;12186.756264874475;7985.92014079875;8113.797155071171;8146.429749917449;8339.166083391612;8610.44032137909;11094;11658.70853228676;11779;11820;11848.763024739284 03:49:30 INFO - PROCESS | 2219 | |3;mootools.html;1663.9084850333231;1679.8656107511404;2028.0974966140063;2051.1180192517213;2108.20942146695;8357.540335281557;8776.42953208041;9201.493917834516;9393.906060939396;9417.905820941789;8985.146411090953;9028.90971090289;9045.502497362642;9126.406783559081;9137.725868223948;2552.2981180175416;2571.4085760275148;2581.1998280533003;2584.147231413629;2586.922392328224;2535.8732063396847;2553;2553.106412755539;2553.195743340851;2558.731333210014;2535.733747956466;2545.2364290712803;2580.870956452179;2600.8309459885045;2602.4795040991785;2241.4645967512224;2492.626106084093;2561.8462892226526;2610.7258737832635;2619.305883940738;2550.489902019585;2580.896764129451;2585.7543533364487;2588.4305452800354;2626.395928936355;9225.12361325673;9281.72154835356;9299.442033477946;9325.347225694204;9341.925678546986;4614.515475875019;4712.929306060412;5611.102223644198;5746.367899531048;5862.296524417097;3213.469777486712;3724.4971928789537;3767.830447629863;3838.1556057667267;3851.171998020411;1083.4041277297456;1089.1994384127738;1091.4215465803138;1110.5946329589722;1127.149002503113;10306.639267625596;12305.384730763515;12341.321227332493;12516.311602861839;12556.74886502274;5044.571211447068;5064.772085256172;5128.8461346159675;5144.511271429208;5193.402758682724;10466.476676166161;10720.035196832323;10721.83917241242;10731.034206921415;10738.463076846127;5580.358258800209;5650.63270887391;5719.857003574861;5732.942670573241;5736.225609542742;4665.6734028617675;4958.553730164303;5036.294918711384;5074.2895994560795;5168.224766285088;4131.421600975866;4183.184279065553;4186.518550366686;4208.116295577902;4216.451861258017;1379.4344318829233;1392.8467868534453;1400.180894176918;1401.7967394727707;1415.6319356967056;1206.2400687566776;1386.2167875150508;1388.7014291927285;1460.8831293496494;1466.5746933389198;8484;8638.481691098554;8645.913540864636;8649.091845356146;8667.479951202948;536.3644081763123;546.9288992431038;548.5901233829101;548.6735392441491;552.2241251042292;6368.363163683594;6374;6408.967955160288;6427.389398007275;6428;9122.179003889549;10935.28920620157;11171.273867198606;11242.831357529643;11329.2069555132;10795.56817727282;10957;11058.834117488244;11130.888691113147;11146.275492092987;8561.14388561139;8565;8652.740417787476;8661.307095432476;8681.045085040514;8084;8094.757157285291;8225.383096267684;8303.875441868498;8326.12575679569;9637.084476974676;9968.950155249177;10000.2999790014;10105;10161.898381016095;10172.593096276361;10332.53503592325;10405.84391234117;10467.267291289536;10580.259381843198;7595.88606170919;7811.921880781119;7822.960885195537;7898.565578892986;7921.485103468256;8653.048164702004;8661.177188167114;8714.346424018351;8749.037605863223;8749.387542871938;7523.623818809147;7650.885236721342;7684.001079859582;7705.345045671181;7769.92230077692;6287.685615719287;7427.4800763946005;7446.367058800062;7484.363829074372;7630.351420129351;8025.438219324591;8073.19268073188;8126.471779334324;8194.098649148707;8206.630701618322;6149.907751383644;7300.087489063867;7348.816279593053;7387.224341444071;7414.888776668462;5700.945325114867;7203.71185152588;7437.739679111205;7493.475456718195;7515.924840751522 03:49:30 INFO - PROCESS | 2219 | |4;prototype.html;328.17627754336615;351.38682998168184;352.86062005507824;355.52182314786603;358.77217966591206;5453.945460545398;6747.727352234175;6748.6288254146;6775.59346439214;6778.152730908637;5270.262163297132;6410.8780963331465;6788.626625535606;6827.351401616838;6863.622500762456;4250.788525270299;4456.844010459635;4907.803687852482;4934.876628084308;5031.597472202224;4917.532834380746;4955.578775804043;4956.405231372222;4957.380327459067;4987.301777751118;4898.14282500561;4904.313396124546;4922.966177102812;4932.8520144395725;4952.108620448318;4917.139500587401;4928.408590969071;4971.577415919651;4985.825496107619;4988.7505624718615;3500.299940012008;4290.570942905716;4295.892602684927;4298.20483210607;4313.547077556874;6308.400701933355;6465.903011454832;6487.7080531376205;6563.212414510242;6604.405603495708;4815.6388270879825;5941.494972927263;5973.581849270553;5987.820365389045;5998.640081595118;7244.855102897913;7252.274772522758;7254.419646428273;7275.527090739085;7311.597862117582;4223.556526564728;4584.426946631671;4857.295692124658;4880.8047678092835;4900.093482705675;6123.87752244957;7624.42816788743;7649.617519124022;7650.770476885702;7655.50239234448;4654.325122857167;4798.5441383068555;4816.20532612115;4889.755512224375;4898.387701537308;5022.221555658879;5034.395872495324;5037;5038.269450929668;5043.092243396224;5911.3201981772645;5918.822435326947;5922.111683247547;5936.465718085306;5958.2850057992455;7296.19741828409;7304.744333948286;7307.561546307238;7311.268873112646;7329.45029122818;1644.4491095483147;1692.0439951427404;1727.9827201728074;1745.5636090977255;1750.6761249168944;1116.4250411038322;1122.8827316819816;1135.3755434510986;1139.8689150747605;1145.9140564457698;6637.800865974028;6665.833354166185;6676.165479315086;6708.362705542965;6714.462842972551;7450.366718828852;7461.626918654046;7464.066991626047;7492.250774922573;7516.098068231738;5456.345238571317;6593.901091483632;6621.370969757865;6647.933520664731;6708.262091169968;3634.618365071682;3915.7078164205745;3951.9012024699614;3953.189596132786;3978.960210397917;6382.776602818879;7820.726274580363;7837.255460731221;7910.841783164305;8030.23712747288;6331.145295385156;7837.2162783722315;7910.248526389983;7921.683132674629;7938.880916786253;7977.407342613557;7991.400644951652;7991.72028978983;8024.438289319692;8048.114707382183;7277.454190935595;7612.1246056701975;7622.31399174077;7625.466217364731;7690.307872291521;7430.3684186842565;7469.701211951461;7495.17553069151;7504.249575042452;7526.698932042657;7970.003749531309;7988.840223195387;7989.760307190561;8006.879896801669;8010.158933311918;4927.605791536596;4959.628027897994;4966.205407134841;4972.65191436596;4989.850304490726;7266.600336981305;7570.621468926422;7601.163871974189;7630.542167469969;7640.80897977555;7296.416286697157;7340.192578816433;7361.1166660001145;7364.594947277951;7369.494371913575;7287.890681639674;7304.488685791944;7323.8535229296185;7329.120505539369;7335.339819416278;6969.268226836312;7156.534825236343;7161;7164.570125792469;7204.639768011683;7211.639418028973;7292;7309.853802923805;7329.963350183215;7346.4122870169185;7071.752488662872;7118.323759242864;7123.109611298588;7164.104486939133;7210.026646402668 03:49:30 INFO - PROCESS | 2219 | |5;yui.html;722.6242353975932;769.2845653542207;790.754865991543;795.4710117771682;799.9960000200002;14992.475263365784;15150.393984240645;15301.46444874427;15356.155411452366;15377.46178883738;14201.360938757754;14211.289435528208;14232.359543820527;14238.430462781476;14272.643183920407;801.5631480842925;979.6962941488162;985.2462865907586;994.4431118573622;996.3772642098688;796.760971708488;963.7879666473365;983.8917719050935;994.5126887824949;996.1084829078007;1031.747221930628;1032.4528000159928;1039.3296323871098;1042.9791404171913;1052.0899421999952;997.6757553794973;1020.34187948773;1034.0125180452687;1036.0364860679565;1040.0795296162876;777.5529070784265;778.3656320099101;793.6825269892032;793.9761807145795;794.8847417124484;15021.849781502155;15075.773863392058;15076.09543427387;15106.018108822891;15171.468998585107;13254.602361929157;13301;13302.800457993138;13368.665783355495;13402.195868247936;10210.336328138721;10249.282550221487;10256.487175641263;10337.069663730224;10565.366078035266;3557.928841423157;3567.7324200684793;3614.9096272593397;3615.7830530168276;3835.0795809005917;72250;81869.59065204696;81872.18127818705;82064.17935820625;83281;9669;9675.612975481043;9688.854667179998;10069.093781559695;10120.696379108638;22935.655965160535;23149.76850231476;23156.3053108407;23293.41766455852;23325.53348933012;6293.82162008183;7686.846263074819;7724.613769311624;7748.186440423787;7849.175836537195;4131.731437456616;4160.854370097032;4197.97901010493;4240.809163587646;4287.549807270254;3059.189314831571;3587.6053634100226;3715.1269451678836;3727.925441491155;3742.513473248515;626.7806267806232;636.1189752193245;642.2742301199614;654.4306453385585;685.8936864785966;478.99322170047304;557.239368262319;578.6036564952936;609.5032548472981;621.3103455164763;8234.547099909443;8487.490750554987;8766.12338766131;8770.254528365032;9066.9818441858;599.9850003749941;617.6232498176109;621.254494606474;626.743035355502;631.6336524815596;3855.5373355196994;3990.2219067281603;4033.394990751352;4049.1699201663587;4173.394857745609;85878.57060714782;86072;95885;96681;97407.51296243473;68954;87367.56316218378;87450.56274718713;87669.56165219133;89311.55344223237;75002.62498687471;75401.6229918847;75750.62124689452;76115;76661;7897.289243968071;8075.959620201861;8166.510009399218;8175.509469431853;8187.345012399113;51029;51101;51550.711232219495;52269.477305226465;52803;69379;72273.55452891017;72605.6369718148;73723;74537;9921.603135874773;10162.136218421518;10206.285560010729;10410.843837342598;10699.14406847466;11064.778704426028;11165.609203677832;11171.776564468828;11455.656330310105;11594.246373985665;8583.957080214559;10770.407627580558;10906.890931090587;10907.236493445384;10999.34003959765;10570.947145264225;10693.930606939244;10764.08505277029;10904.945475272572;11078.833817492583;8496.787580310542;10403.598176976744;10441.58233670675;10584.047435730821;10828.675139745821;8938.2402495786;9122.087791220825;9166.54167291646;9240.537973101453;9396.201322887631;7997.800054998439;8021.318187953856;8068.7175948841505;8129.268365846866;8377.204165604258 03:49:30 INFO - PROCESS | 2219 | __end_tp_report 03:49:30 INFO - PROCESS | 2219 | __start_cc_report 03:49:30 INFO - PROCESS | 2219 | _x_x_mozilla_cycle_collect,362 03:49:30 INFO - PROCESS | 2219 | __end_cc_report 03:49:30 INFO - PROCESS | 2219 | __startTimestamp1461581370446__endTimestamp 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | ------- Summary: start ------- 03:49:30 INFO - PROCESS | 2219 | Number of tests: 6 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | [#0] dojo.html Cycles:165 Average:5793.25 Median:6039.67 stddev:674.29 (11.2%) stddev-sans-first:651.81 03:49:30 INFO - PROCESS | 2219 | Values: 3495.3 3520.5 3527.3 3561.2 3582.1 5829.0 5844.4 5856.2 5856.5 5859.4 4655.3 4711.0 5829.3 5842.8 5856.0 5218.3 5231.4 5265.2 5267.4 5368.9 5212.4 5309.7 5336.4 5355.1 5421.5 5384.9 5416.3 5419.1 5432.6 5450.2 4468.8 5142.4 5342.5 5351.2 5367.4 4088.8 5148.3 5252.9 5282.6 5316.4 5601.4 5662.2 5679.7 5710.0 5735.7 5912.5 6215.3 6246.5 6252.0 6333.7 6209.6 6279.4 6284.9 6286.9 6335.5 6018.1 6025.5 6028.1 6033.7 6039.7 6239.7 6365.3 6391.6 6413.1 6449.5 6227.0 6265.4 6324.9 6325.8 6338.7 6316.5 6325.0 6348.6 6377.6 6387.5 5557.5 6166.8 6225.4 6286.4 6302.7 6209.6 6261.1 6296.5 6301.3 6310.7 4999.5 5029.3 5033.0 5042.9 5058.7 4425.1 4452.7 4501.1 4510.8 4541.3 4676.5 5793.6 5909.8 5936.7 5939.9 6253.3 6284.0 6290.0 6303.1 6338.7 5822.9 5915.2 5940.4 5959.4 6001.4 5481.7 5485.5 5504.4 5508.9 5540.0 6417.9 6425.2 6451.0 6462.1 6469.0 6242.3 6302.6 6317.1 6326.6 6335.5 5185.2 6464.5 6482.9 6508.9 6533.6 6144.0 6276.1 6300.1 6304.8 6312.7 5332.0 6259.8 6264.1 6315.4 6319.3 6185.1 6237.2 6256.0 6261.3 6305.7 6234.6 6247.3 6247.9 6248.8 6257.1 5827.3 6106.5 6106.5 6114.9 6131.3 5335.1 6000.0 6236.2 6240.9 6254.8 4753.3 6093.5 6124.0 6133.0 6133.2 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | [#1] ext.html Cycles:180 Average:69127.96 Median:38887.02 stddev:150853.16 (387.9%) stddev-sans-first:151188.34 03:49:30 INFO - PROCESS | 2219 | Values: 496.9 528.0 594.3 683.6 689.8 27876.0 39363.0 39504.4 39537.0 39735.2 41285.2 41829.4 42082.6 42111.4 42235.0 9652.0 9754.2 9805.9 9827.4 9869.9 9608.2 9816.6 9820.8 9857.2 9924.2 9778.4 9818.5 9842.5 9858.2 9858.3 9774.7 9842.2 9851.3 9873.7 9894.5 9695.5 9752.9 9770.1 9785.2 9800.2 40083.8 40154.6 40437.6 40484.8 40555.4 3359.5 3360.5 3458.6 3591.0 3613.9 27243.7 28318.9 28337.9 28486.1 28629.6 2784.0 2791.9 2805.2 2814.2 2919.7 509237.0 510754.0 513000.0 513407.0 514356.0 48154.5 74116.0 74412.6 74754.0 74815.6 47636.8 47804.8 48073.5 48321.8 48506.3 16489.2 16499.7 16708.9 16809.7 16872.5 13337.7 13465.9 13483.9 13486.9 13537.1 12346.7 12785.9 12949.0 15408.6 15871.9 5643.0 6381.1 6772.3 6779.7 6807.3 1009.7 1037.0 1079.8 1106.6 1137.7 30693.7 30965.7 31073.4 31233.5 31305.8 1114.5 1117.5 1141.5 1197.8 1260.6 14588.9 14653.6 14758.8 14953.8 14956.5 654496.0 655136.0 659652.0 666455.0 666643.0 62287.7 62531.0 62724.4 62751.4 62951.0 1553.7 1559.6 1579.7 1593.4 1595.5 28791.6 29010.4 29223.9 29499.1 29662.4 51352.9 51403.0 51940.0 52015.2 52051.0 494428.5 506956.0 509825.0 510097.0 511587.0 32454.0 34105.7 34310.3 34505.7 34631.8 45487.3 45693.0 45723.5 45778.0 46231.0 33286.7 37554.0 37869.4 38143.8 38192.0 37529.0 37991.6 38021.0 38242.0 38411.0 32222.8 37017.8 37241.4 37609.1 37823.8 24043.8 24786.6 29574.1 32258.0 33035.2 23797.6 24253.5 25048.5 25308.0 25412.0 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | [#2] jquery.html Cycles:180 Average:36774.70 Median:11546.51 stddev:114424.11 (991.0%) stddev-sans-first:114712.40 03:49:30 INFO - PROCESS | 2219 | Values: 341.2 380.5 386.2 392.2 394.1 20284.7 20778.0 20940.2 21557.4 21563.6 10312.9 12081.7 12311.3 12360.8 12401.3 5095.5 5262.4 5458.7 5484.3 5801.1 5670.5 5683.6 5748.7 5813.6 6055.3 5876.4 5990.8 6004.2 6030.2 6047.5 5891.8 5898.8 5990.9 6416.3 6528.4 5758.8 5780.2 5802.7 5803.0 5809.8 13681.2 13704.0 13865.8 13967.6 22245.2 2152.8 2166.5 2304.4 2318.9 2334.3 9956.5 10600.2 10700.5 11598.3 15098.2 1676.5 1807.1 1852.4 1854.7 1867.5 93315.5 98272.0 100193.0 104387.0 110121.9 11207.5 11450.4 11634.9 11637.8 11739.6 14341.5 14405.4 14458.4 14501.6 14507.0 7479.7 8733.9 8760.9 8855.2 8864.7 8964.2 9040.6 9074.5 9147.1 9166.1 3874.2 4567.4 4648.1 4669.7 4708.7 1637.9 1638.7 1735.2 1749.2 1968.3 898.9 905.7 915.9 969.4 1060.1 19365.3 20173.1 20532.9 20593.9 20625.9 855.4 991.5 1005.3 1035.1 1038.7 8937.8 10105.9 10892.9 10933.3 11009.2 682962.0 687774.0 693601.0 693870.0 700040.0 124730.0 125301.0 128273.4 128596.0 131632.0 1027.6 1035.7 1043.6 1044.2 1066.1 18415.5 18437.4 18561.8 18579.5 18616.8 51761.5 52622.5 52752.0 53457.0 55052.7 76999.6 78163.8 78168.6 79962.0 80050.6 8125.7 8323.9 8438.1 8445.9 8455.9 12140.3 12765.4 13453.4 13646.4 13723.6 10691.2 11536.6 11571.2 11724.4 11875.5 11412.8 11540.2 11650.2 11687.8 11879.2 9881.8 10975.3 11890.5 12183.1 12186.8 7985.9 8113.8 8146.4 8339.2 8610.4 11094.0 11658.7 11779.0 11820.0 11848.8 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | [#3] mootools.html Cycles:180 Average:6274.82 Median:5136.68 stddev:3320.12 (64.6%) stddev-sans-first:3311.35 03:49:30 INFO - PROCESS | 2219 | Values: 1663.9 1679.9 2028.1 2051.1 2108.2 8357.5 8776.4 9201.5 9393.9 9417.9 8985.1 9028.9 9045.5 9126.4 9137.7 2552.3 2571.4 2581.2 2584.1 2586.9 2535.9 2553.0 2553.1 2553.2 2558.7 2535.7 2545.2 2580.9 2600.8 2602.5 2241.5 2492.6 2561.8 2610.7 2619.3 2550.5 2580.9 2585.8 2588.4 2626.4 9225.1 9281.7 9299.4 9325.3 9341.9 4614.5 4712.9 5611.1 5746.4 5862.3 3213.5 3724.5 3767.8 3838.2 3851.2 1083.4 1089.2 1091.4 1110.6 1127.1 10306.6 12305.4 12341.3 12516.3 12556.7 5044.6 5064.8 5128.8 5144.5 5193.4 10466.5 10720.0 10721.8 10731.0 10738.5 5580.4 5650.6 5719.9 5732.9 5736.2 4665.7 4958.6 5036.3 5074.3 5168.2 4131.4 4183.2 4186.5 4208.1 4216.5 1379.4 1392.8 1400.2 1401.8 1415.6 1206.2 1386.2 1388.7 1460.9 1466.6 8484.0 8638.5 8645.9 8649.1 8667.5 536.4 546.9 548.6 548.7 552.2 6368.4 6374.0 6409.0 6427.4 6428.0 9122.2 10935.3 11171.3 11242.8 11329.2 10795.6 10957.0 11058.8 11130.9 11146.3 8561.1 8565.0 8652.7 8661.3 8681.0 8084.0 8094.8 8225.4 8303.9 8326.1 9637.1 9969.0 10000.3 10105.0 10161.9 10172.6 10332.5 10405.8 10467.3 10580.3 7595.9 7811.9 7823.0 7898.6 7921.5 8653.0 8661.2 8714.3 8749.0 8749.4 7523.6 7650.9 7684.0 7705.3 7769.9 6287.7 7427.5 7446.4 7484.4 7630.4 8025.4 8073.2 8126.5 8194.1 8206.6 6149.9 7300.1 7348.8 7387.2 7414.9 5700.9 7203.7 7437.7 7493.5 7515.9 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | [#4] prototype.html Cycles:180 Average:5940.27 Median:6656.88 stddev:1913.59 (28.7%) stddev-sans-first:1872.02 03:49:30 INFO - PROCESS | 2219 | Values: 328.2 351.4 352.9 355.5 358.8 5453.9 6747.7 6748.6 6775.6 6778.2 5270.3 6410.9 6788.6 6827.4 6863.6 4250.8 4456.8 4907.8 4934.9 5031.6 4917.5 4955.6 4956.4 4957.4 4987.3 4898.1 4904.3 4923.0 4932.9 4952.1 4917.1 4928.4 4971.6 4985.8 4988.8 3500.3 4290.6 4295.9 4298.2 4313.5 6308.4 6465.9 6487.7 6563.2 6604.4 4815.6 5941.5 5973.6 5987.8 5998.6 7244.9 7252.3 7254.4 7275.5 7311.6 4223.6 4584.4 4857.3 4880.8 4900.1 6123.9 7624.4 7649.6 7650.8 7655.5 4654.3 4798.5 4816.2 4889.8 4898.4 5022.2 5034.4 5037.0 5038.3 5043.1 5911.3 5918.8 5922.1 5936.5 5958.3 7296.2 7304.7 7307.6 7311.3 7329.5 1644.4 1692.0 1728.0 1745.6 1750.7 1116.4 1122.9 1135.4 1139.9 1145.9 6637.8 6665.8 6676.2 6708.4 6714.5 7450.4 7461.6 7464.1 7492.3 7516.1 5456.3 6593.9 6621.4 6647.9 6708.3 3634.6 3915.7 3951.9 3953.2 3979.0 6382.8 7820.7 7837.3 7910.8 8030.2 6331.1 7837.2 7910.2 7921.7 7938.9 7977.4 7991.4 7991.7 8024.4 8048.1 7277.5 7612.1 7622.3 7625.5 7690.3 7430.4 7469.7 7495.2 7504.2 7526.7 7970.0 7988.8 7989.8 8006.9 8010.2 4927.6 4959.6 4966.2 4972.7 4989.9 7266.6 7570.6 7601.2 7630.5 7640.8 7296.4 7340.2 7361.1 7364.6 7369.5 7287.9 7304.5 7323.9 7329.1 7335.3 6969.3 7156.5 7161.0 7164.6 7204.6 7211.6 7292.0 7309.9 7330.0 7346.4 7071.8 7118.3 7123.1 7164.1 7210.0 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - PROCESS | 2219 | [#5] yui.html Cycles:180 Average:18759.32 Median:589.29 stddev:26809.84 (4549.5%) stddev-sans-first:26850.84 03:49:30 INFO - PROCESS | 2219 | Values: 722.6 769.3 790.8 795.5 800.0 14992.5 15150.4 15301.5 15356.2 15377.5 14201.4 14211.3 14232.4 14238.4 14272.6 801.6 979.7 985.2 994.4 996.4 796.8 963.8 983.9 994.5 996.1 1031.7 1032.5 1039.3 1043.0 1052.1 997.7 1020.3 1034.0 1036.0 1040.1 777.6 778.4 793.7 794.0 794.9 15021.8 15075.8 15076.1 15106.0 15171.5 13254.6 13301.0 13302.8 13368.7 13402.2 10210.3 10249.3 10256.5 10337.1 10565.4 3557.9 3567.7 3614.9 3615.8 3835.1 72250.0 81869.6 81872.2 82064.2 83281.0 9669.0 9675.6 9688.9 10069.1 10120.7 22935.7 23149.8 23156.3 23293.4 23325.5 6293.8 7686.8 7724.6 7748.2 7849.2 4131.7 4160.9 4198.0 4240.8 4287.5 3059.2 3587.6 3715.1 3727.9 3742.5 626.8 636.1 642.3 654.4 685.9 479.0 557.2 578.6 609.5 621.3 8234.5 8487.5 8766.1 8770.3 9067.0 600.0 617.6 621.3 626.7 631.6 3855.5 3990.2 4033.4 4049.2 4173.4 85878.6 86072.0 95885.0 96681.0 97407.5 68954.0 87367.6 87450.6 87669.6 89311.6 75002.6 75401.6 75750.6 76115.0 76661.0 7897.3 8076.0 8166.5 8175.5 8187.3 51029.0 51101.0 51550.7 52269.5 52803.0 69379.0 72273.6 72605.6 73723.0 74537.0 9921.6 10162.1 10206.3 10410.8 10699.1 11064.8 11165.6 11171.8 11455.7 11594.2 8584.0 10770.4 10906.9 10907.2 10999.3 10570.9 10693.9 10764.1 10904.9 11078.8 8496.8 10403.6 10441.6 10584.0 10828.7 8938.2 9122.1 9166.5 9240.5 9396.2 7997.8 8021.3 8068.7 8129.3 8377.2 03:49:30 INFO - PROCESS | 2219 | -------- Summary: end -------- 03:49:30 INFO - PROCESS | 2219 | 03:49:30 INFO - TEST-INFO | 2219: exit 0 03:49:30 INFO - TEST-OK | dromaeo_css | took 1109778ms 03:49:30 INFO - TEST-START | kraken 03:49:30 INFO - operating with platform_type : mac_ 03:49:30 INFO - Initialising browser for kraken test... 03:49:31 INFO - TEST-INFO | started process 2247 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpxNXBuC/profile http://localhost:52583/getInfo.html) 03:49:33 INFO - PROCESS | 2247 | __metrics Screen width/height:1600/1200 03:49:33 INFO - PROCESS | 2247 | colorDepth:24 03:49:33 INFO - PROCESS | 2247 | Browser inner width/height: 1024/689 03:49:33 INFO - PROCESS | 2247 | __metrics 03:49:33 ERROR - PROCESS | 2247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:49:34 INFO - TEST-INFO | 2247: exit 0 03:49:34 INFO - Browser initialized. 03:49:34 INFO - Running cycle 1/1 for kraken test... 03:49:34 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpxNXBuC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:46 INFO - PROCESS | 2250 | RSS: Main: 218464256 03:49:46 INFO - PROCESS | 2250 | 03:49:48 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52583/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:49 INFO - PROCESS | 2250 | RSS: Main: 230277120 03:49:49 INFO - PROCESS | 2250 | 03:49:51 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52583/tests/kraken/driver.html?testName=audio-dft) 03:49:52 INFO - PROCESS | 2250 | RSS: Main: 239124480 03:49:52 INFO - PROCESS | 2250 | 03:49:55 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52583/tests/kraken/driver.html?testName=audio-fft) 03:49:56 INFO - PROCESS | 2250 | RSS: Main: 242737152 03:49:56 INFO - PROCESS | 2250 | 03:49:58 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52583/tests/kraken/driver.html?testName=audio-oscillator) 03:49:59 INFO - PROCESS | 2250 | RSS: Main: 243548160 03:49:59 INFO - PROCESS | 2250 | 03:50:01 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:01 INFO - PROCESS | 2250 | RSS: Main: 243691520 03:50:01 INFO - PROCESS | 2250 | 03:50:04 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52583/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:05 INFO - PROCESS | 2250 | RSS: Main: 244355072 03:50:05 INFO - PROCESS | 2250 | 03:50:07 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52583/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:08 INFO - PROCESS | 2250 | RSS: Main: 243564544 03:50:08 INFO - PROCESS | 2250 | 03:50:11 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52583/tests/kraken/driver.html?testName=json-parse-financial) 03:50:12 INFO - PROCESS | 2250 | RSS: Main: 244834304 03:50:12 INFO - PROCESS | 2250 | 03:50:13 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:14 INFO - PROCESS | 2250 | RSS: Main: 244592640 03:50:14 INFO - PROCESS | 2250 | 03:50:16 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:16 INFO - PROCESS | 2250 | RSS: Main: 244826112 03:50:16 INFO - PROCESS | 2250 | 03:50:19 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:19 INFO - PROCESS | 2250 | RSS: Main: 245870592 03:50:19 INFO - PROCESS | 2250 | 03:50:22 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:22 INFO - PROCESS | 2250 | RSS: Main: 245153792 03:50:22 INFO - PROCESS | 2250 | 03:50:25 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:26 INFO - PROCESS | 2250 | RSS: Main: 245960704 03:50:26 INFO - PROCESS | 2250 | 03:50:27 INFO - PROCESS | 2250 | Cycle 1(1): loaded http://localhost:52583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52583/tests/kraken/driver.html?testName=ai-astar) 03:50:28 INFO - PROCESS | 2250 | RSS: Main: 247046144 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | __start_tp_report 03:50:28 INFO - PROCESS | 2250 | _x_x_mozilla_page_load 03:50:28 INFO - PROCESS | 2250 | _x_x_mozilla_page_load_details 03:50:28 INFO - PROCESS | 2250 | |i|pagename|runs| 03:50:28 INFO - PROCESS | 2250 | |0;ai-astar;115;112;115;113;114;129;114;114;116;114 03:50:28 INFO - PROCESS | 2250 | |1;audio-beat-detection;158;122;159;148;117;142;121;151;146;123 03:50:28 INFO - PROCESS | 2250 | |2;audio-dft;194;195;193;197;197;195;197;192;202;196 03:50:28 INFO - PROCESS | 2250 | |3;audio-fft;65;65;78;130;73;76;88;87;145;57 03:50:28 INFO - PROCESS | 2250 | |4;audio-oscillator;86;80;122;78;81;80;115;77;79;116 03:50:28 INFO - PROCESS | 2250 | |5;imaging-gaussian-blur;87;85;92;85;89;85;89;85;92;124 03:50:28 INFO - PROCESS | 2250 | |6;imaging-darkroom;94;94;94;94;121;94;95;99;93;100 03:50:28 INFO - PROCESS | 2250 | |7;imaging-desaturate;96;107;132;90;127;151;79;140;147;141 03:50:28 INFO - PROCESS | 2250 | |8;json-parse-financial;51;53;57;59;59;59;57;66;58;62 03:50:28 INFO - PROCESS | 2250 | |9;json-stringify-tinderbox;63;67;60;73;117;110;105;98;81;65 03:50:28 INFO - PROCESS | 2250 | |10;stanford-crypto-aes;80;83;83;98;108;72;70;93;98;113 03:50:28 INFO - PROCESS | 2250 | |11;stanford-crypto-ccm;117;126;122;135;135;138;115;122;139;138 03:50:28 INFO - PROCESS | 2250 | |12;stanford-crypto-pbkdf2;121;121;156;182;184;156;136;139;145;163 03:50:28 INFO - PROCESS | 2250 | |13;stanford-crypto-sha256-iterative;65;68;94;97;98;70;64;65;67;65 03:50:28 INFO - PROCESS | 2250 | __end_tp_report 03:50:28 INFO - PROCESS | 2250 | __start_cc_report 03:50:28 INFO - PROCESS | 2250 | _x_x_mozilla_cycle_collect,919 03:50:28 INFO - PROCESS | 2250 | __end_cc_report 03:50:28 INFO - PROCESS | 2250 | __startTimestamp1461581428086__endTimestamp 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | ------- Summary: start ------- 03:50:28 INFO - PROCESS | 2250 | Number of tests: 14 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#0] ai-astar Cycles:10 Average:115.60 Median:114.50 stddev:4.84 (4.2%) stddev-sans-first:5.12 03:50:28 INFO - PROCESS | 2250 | Values: 115.0 112.0 115.0 113.0 114.0 129.0 114.0 114.0 116.0 114.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:147.00 stddev:16.32 (11.1%) stddev-sans-first:15.74 03:50:28 INFO - PROCESS | 2250 | Values: 158.0 122.0 159.0 148.0 117.0 142.0 121.0 151.0 146.0 123.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#2] audio-dft Cycles:10 Average:195.80 Median:196.50 stddev:2.78 (1.4%) stddev-sans-first:2.87 03:50:28 INFO - PROCESS | 2250 | Values: 194.0 195.0 193.0 197.0 197.0 195.0 197.0 192.0 202.0 196.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#3] audio-fft Cycles:10 Average:86.40 Median:74.50 stddev:28.82 (38.7%) stddev-sans-first:29.51 03:50:28 INFO - PROCESS | 2250 | Values: 65.0 65.0 78.0 130.0 73.0 76.0 88.0 87.0 145.0 57.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:79.50 stddev:18.37 (23.1%) stddev-sans-first:19.38 03:50:28 INFO - PROCESS | 2250 | Values: 86.0 80.0 122.0 78.0 81.0 80.0 115.0 77.0 79.0 116.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:88.00 stddev:11.82 (13.4%) stddev-sans-first:12.44 03:50:28 INFO - PROCESS | 2250 | Values: 87.0 85.0 92.0 85.0 89.0 85.0 89.0 85.0 92.0 124.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:94.00 stddev:8.48 (9.0%) stddev-sans-first:8.89 03:50:28 INFO - PROCESS | 2250 | Values: 94.0 94.0 94.0 94.0 121.0 94.0 95.0 99.0 93.0 100.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#7] imaging-desaturate Cycles:10 Average:121.00 Median:149.00 stddev:25.91 (17.4%) stddev-sans-first:25.85 03:50:28 INFO - PROCESS | 2250 | Values: 96.0 107.0 132.0 90.0 127.0 151.0 79.0 140.0 147.0 141.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:59.00 stddev:4.20 (7.1%) stddev-sans-first:3.59 03:50:28 INFO - PROCESS | 2250 | Values: 51.0 53.0 57.0 59.0 59.0 59.0 57.0 66.0 58.0 62.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#9] json-stringify-tinderbox Cycles:10 Average:83.90 Median:66.00 stddev:21.60 (32.7%) stddev-sans-first:21.55 03:50:28 INFO - PROCESS | 2250 | Values: 63.0 67.0 60.0 73.0 117.0 110.0 105.0 98.0 81.0 65.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:83.00 stddev:14.57 (17.6%) stddev-sans-first:15.02 03:50:28 INFO - PROCESS | 2250 | Values: 80.0 83.0 83.0 98.0 108.0 72.0 70.0 93.0 98.0 113.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:135.00 stddev:9.31 (6.9%) stddev-sans-first:8.86 03:50:28 INFO - PROCESS | 2250 | Values: 117.0 126.0 122.0 135.0 135.0 138.0 115.0 122.0 139.0 138.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:156.00 stddev:22.22 (14.2%) stddev-sans-first:20.89 03:50:28 INFO - PROCESS | 2250 | Values: 121.0 121.0 156.0 182.0 184.0 156.0 136.0 139.0 145.0 163.0 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - PROCESS | 2250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:69.00 stddev:14.65 (21.2%) stddev-sans-first:15.06 03:50:28 INFO - PROCESS | 2250 | Values: 65.0 68.0 94.0 97.0 98.0 70.0 64.0 65.0 67.0 65.0 03:50:28 INFO - PROCESS | 2250 | -------- Summary: end -------- 03:50:28 INFO - PROCESS | 2250 | 03:50:28 INFO - TEST-INFO | 2250: exit 0 03:50:28 INFO - TEST-OK | kraken | took 57830ms 03:50:28 INFO - SUITE-END | took 1167s 03:50:29 INFO - Completed test suite (00:19:28) 03:50:29 INFO - javascript benchmark 03:50:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3495.2659941412307, 3520.5423294971642, 3527.3121741260434, 3561.180928386471, 3582.086567925177, 5829.0, 5844.357120716718, 5856.238688970433, 5856.531477481802, 5859.414058594144, 4655.30170474429, 4710.97644511777, 5829.329627092886, 5842.766289348431, 5856.0, 5218.32161818964, 5231.398389185235, 5265.236540701596, 5267.446918073604, 5368.91946620801, 5212.400573933989, 5309.681419114846, 5336.4129945705945, 5355.08963476208, 5421.539169170625, 5384.865378365533, 5416.268803711488, 5419.105847535172, 5432.592555558329, 5450.182472629098, 4468.754218517964, 5142.434332223453, 5342.545883599899, 5351.17056856186, 5367.43641917597, 4088.8364465421346, 5148.330717006803, 5252.921206181911, 5282.603804714662, 5316.362036555638, 5601.383847776782, 5662.235598194232, 5679.716014199274, 5710.0, 5735.684537350444, 5912.4974377178, 6215.316315205324, 6246.469050130744, 6251.999680051215, 6333.714982825784, 6209.627422354628, 6279.403456671609, 6284.87430251397, 6286.9056964145575, 6335.524835637346, 6018.097285407181, 6025.517958563304, 6028.09578563219, 6033.668148251844, 6039.667818270037, 6239.656818875005, 6365.3316401778075, 6391.552591318563, 6413.134226879405, 6449.484041276686, 6227.034809604518, 6265.4361107500545, 6324.936750632435, 6325.810225693236, 6338.7464501420345, 6316.494680425555, 6324.968375158187, 6348.555601107878, 6377.617342959437, 6387.520935929824, 5557.527610153183, 6166.753329866755, 6225.408586184396, 6286.402791734778, 6302.65335406557, 6209.565330426917, 6261.123442718023, 6296.5277604178955, 6301.338359472281, 6310.652914089769, 4999.450060493343, 5029.2958985742025, 5033.0, 5042.924356134661, 5058.721770302669, 4425.137098265807, 4452.732836029849, 4501.099780044005, 4510.774461276923, 4541.2733962565835, 4676.532346765296, 5793.565482588822, 5909.8227053188475, 5936.7328470218945, 5939.881202375928, 6253.280872699698, 6283.968580157161, 6289.993601023905, 6303.149074874833, 6338.714757835908, 5822.883542329129, 5915.1718759373725, 5940.435658612425, 5959.374265702038, 6001.399860013964, 5481.725913704378, 5485.506304432541, 5504.422035686275, 5508.91736623951, 5540.0, 6417.871642567123, 6425.228972523327, 6451.0, 6462.063000864849, 6469.0, 6242.344553821783, 6302.621842689453, 6317.147185129948, 6326.557141000086, 6335.493160547053, 5185.196294574347, 6464.482841372773, 6482.935170648233, 6508.934910651023, 6533.607983521004, 6144.047672610753, 6276.089966954857, 6300.117983482408, 6304.810855674337, 6312.747490100528, 5331.973340133274, 6259.812205633838, 6264.123022776906, 6315.368463153832, 6319.304876463677, 6185.134081228542, 6237.220347456568, 6256.0, 6261.3112557617715, 6305.747770089145, 6234.563580549318, 6247.281562620356, 6247.875042499034, 6248.843778905563, 6257.1240026395435, 5827.3007239131575, 6106.45041946227, 6106.521339539896, 6114.877702446015, 6131.315499378873, 5335.09303418412, 5999.970000149971, 6236.158118653923, 6240.906386404116, 6254.781082662085, 4753.287006948985, 6093.48205402528, 6123.9693801532485, 6133.049377346519, 6133.233345831771], "unit": "score", "name": "dojo.html", "value": 5753.588712932069}, {"lowerIsBetter": false, "replicates": [496.8683298925783, 528.0257924129984, 594.2571785268415, 683.5659356308744, 689.8275431142215, 27876.0, 39363.0, 39504.40743388851, 39537.0, 39735.20529589406, 41285.174296514124, 41829.37255941163, 42082.579174208324, 42111.36832947501, 42235.0, 9651.95174024129, 9754.219662426989, 9805.901940980606, 9827.410355378664, 9869.851952220723, 9608.231341492663, 9816.558254878548, 9820.803583928317, 9857.162141218005, 9924.206063514937, 9778.364406313602, 9818.50907454628, 9842.507874606277, 9858.211343092535, 9858.309918305722, 9774.657886973957, 9842.163416109639, 9851.261155413373, 9873.654422095227, 9894.455804930725, 9695.51522423876, 9752.853707194397, 9770.071843174886, 9785.217182625443, 9800.215982721365, 40083.7995810022, 40154.59845401538, 40437.59562404368, 40484.79757601193, 40555.39166912498, 3359.479280711469, 3360.4959256111533, 3458.56767904012, 3590.964090359089, 3613.9096522586883, 27243.727562724514, 28318.858405708044, 28337.858310708314, 28486.145415637566, 28629.57055644167, 2783.9721602783916, 2791.8553393108728, 2805.1724741201397, 2814.1557532740303, 2919.664238612544, 509237.0, 510754.0, 513000.0, 513406.9999999963, 514356.0, 48154.51845481501, 74116.0, 74412.62793685996, 74754.0, 74815.62592187004, 47636.761816190694, 47804.76097619559, 48073.519264807604, 48321.758391208525, 48506.27240591394, 16489.175541222892, 16499.6700065998, 16708.916455417646, 16809.6638067238, 16872.493825185265, 13337.666558335924, 13465.932670336586, 13483.921286297073, 13486.865131348757, 13537.1200871943, 12346.691332716753, 12785.936070319774, 12948.964082873348, 15408.614784630474, 15871.920640396724, 5643.0, 6381.1066450696935, 6772.288909664513, 6779.72881084761, 6807.319268073153, 1009.7021378693303, 1036.9948150259352, 1079.8175997282963, 1106.5794997900746, 1137.732632831284, 30693.69306306953, 30965.69034309628, 31073.378532429226, 31233.53149702756, 31305.8434707825, 1114.4817659788075, 1117.452448300327, 1141.5319718915205, 1197.8382918306093, 1260.6470188347278, 14588.85411145875, 14653.633659158393, 14758.819294456418, 14953.775693364609, 14956.476523321631, 654496.0, 655136.0, 659652.0, 666455.0, 666643.0, 62287.688561556904, 62531.0, 62724.372756271856, 62751.37248627455, 62951.0, 1553.6659618182146, 1559.6334861307585, 1579.6998570271842, 1593.3865461797059, 1595.4734937470607, 28791.568126478538, 29010.41979160363, 29223.853880731313, 29499.115026549236, 29662.406751865274, 51352.94588216579, 51403.0, 51940.0, 52015.219771704215, 52050.95898082093, 494428.5278573584, 506956.0, 509825.0, 510097.0, 511587.0, 32454.0, 34105.65894341025, 34310.313793723486, 34505.654943450245, 34631.787887423816, 45487.31769023401, 45693.0, 45723.54276457193, 45778.0, 46231.0, 33286.66713332836, 37554.0, 37869.431958520094, 38143.80928095342, 38192.0, 37529.0, 37991.62008379991, 38021.04947376338, 38242.0, 38411.039724007125, 32222.83888580542, 37017.81491092527, 37241.441378378804, 37609.059773505884, 37823.81088094542, 24043.759562404153, 24786.59594507524, 29574.112776616737, 32258.0, 33035.17412064718, 23797.64303535483, 24253.51492970166, 25048.499030019662, 25308.0, 25412.0], "unit": "score", "name": "ext.html", "value": 19858.564650622833}, {"lowerIsBetter": false, "replicates": [341.2066944354376, 380.5129434324064, 386.21790873481206, 392.23318412503556, 394.05426975259354, 20284.69572956405, 20778.0, 20940.16239350424, 21557.353279401603, 21563.568728625418, 10312.917143699897, 12081.697957551065, 12311.322877241748, 12360.814587781191, 12401.255924644527, 5095.490450954893, 5262.394824595172, 5458.6724796512135, 5484.287042684446, 5801.07182850744, 5670.461306175906, 5683.630564013347, 5748.712564371785, 5813.6221145625395, 6055.333913269559, 5876.353601103875, 5990.820275391745, 6004.159417681528, 6030.246219222598, 6047.485963693091, 5891.823245302648, 5898.823035308927, 5990.9400905990815, 6416.326285739977, 6528.37980391862, 5758.7696492140685, 5780.1907732917425, 5802.65184088956, 5803.042497987827, 5809.82570522885, 13681.179129252178, 13704.0, 13865.792013119812, 13967.580972570839, 22245.22141725032, 2152.849300548962, 2166.516834958293, 2304.446932736148, 2318.93043208704, 2334.2880421471446, 9956.502174891226, 10600.204984626107, 10700.518476668569, 11598.304101753922, 15098.245087745569, 1676.5305714399988, 1807.13257636334, 1852.3701941339875, 1854.6754317994432, 1867.5424520992308, 93315.53342233246, 98271.99999999929, 100193.0, 104387.0, 110121.89878101197, 11207.495662695035, 11450.370229637283, 11634.883651163549, 11637.767244655059, 11739.589114380955, 14341.498047568284, 14405.42378304856, 14458.421663133357, 14501.564953051426, 14507.0, 7479.70081196746, 8733.912660873437, 8760.8685869712, 8855.158759917798, 8864.734057978141, 8964.238039766693, 9040.63837446508, 9074.546272686339, 9147.131022552847, 9166.129217724305, 3874.2445223181207, 4567.383403240587, 4648.070385922829, 4669.743164125938, 4708.741019243906, 1637.8607818335336, 1638.6804573108368, 1735.1844633022458, 1749.160403006564, 1968.2815772243027, 898.9280857531381, 905.7373361725158, 915.9129882661136, 969.3602222533094, 1060.0883240413239, 19365.32221372245, 20173.092210850547, 20532.897335513226, 20593.897030514752, 20625.865577393386, 855.3798496090409, 991.548845275398, 1005.331454582709, 1035.0787798859021, 1038.657243109772, 8937.838081049422, 10105.9494702526, 10892.891071089347, 10933.343999359904, 11009.174311926638, 682962.0, 687774.0, 693601.0, 693870.0, 700040.0, 124730.0, 125301.0, 128273.35863320624, 128596.0, 131632.0, 1027.5992362978445, 1035.6530562261576, 1043.6138628707427, 1044.1594516414207, 1066.1311031509294, 18415.53961150982, 18437.354692585694, 18561.793483423535, 18579.5241780465, 18616.81383186151, 51761.48238517717, 52622.47377526176, 52752.0, 53457.0, 55052.72473637606, 76999.61500192463, 78163.82754258804, 78168.60915695385, 79962.0, 80050.59974700089, 8125.715599953974, 8323.875141872755, 8438.113998030118, 8445.915540844513, 8455.915440845758, 12140.271583705005, 12765.425555849823, 13453.394597242952, 13646.385912634154, 13723.588292351245, 10691.198160138176, 11536.59621913229, 11571.19001669875, 11724.355160466257, 11875.465604048011, 11412.828807567726, 11540.24988375753, 11650.184487085822, 11687.837750016275, 11879.22785018971, 9881.802363952824, 10975.341479511255, 11890.464929078385, 12183.086268529718, 12186.756264874475, 7985.92014079875, 8113.797155071171, 8146.429749917449, 8339.166083391612, 8610.44032137909, 11094.0, 11658.70853228676, 11779.0, 11820.0, 11848.763024739284], "unit": "score", "name": "jquery.html", "value": 9401.406889809212}, {"lowerIsBetter": false, "replicates": [1663.9084850333231, 1679.8656107511404, 2028.0974966140063, 2051.1180192517213, 2108.20942146695, 8357.540335281557, 8776.42953208041, 9201.493917834516, 9393.906060939396, 9417.905820941789, 8985.146411090953, 9028.90971090289, 9045.502497362642, 9126.406783559081, 9137.725868223948, 2552.2981180175416, 2571.4085760275148, 2581.1998280533003, 2584.147231413629, 2586.922392328224, 2535.8732063396847, 2553.0, 2553.106412755539, 2553.195743340851, 2558.731333210014, 2535.733747956466, 2545.2364290712803, 2580.870956452179, 2600.8309459885045, 2602.4795040991785, 2241.4645967512224, 2492.626106084093, 2561.8462892226526, 2610.7258737832635, 2619.305883940738, 2550.489902019585, 2580.896764129451, 2585.7543533364487, 2588.4305452800354, 2626.395928936355, 9225.12361325673, 9281.72154835356, 9299.442033477946, 9325.347225694204, 9341.925678546986, 4614.515475875019, 4712.929306060412, 5611.102223644198, 5746.367899531048, 5862.296524417097, 3213.469777486712, 3724.4971928789537, 3767.830447629863, 3838.1556057667267, 3851.171998020411, 1083.4041277297456, 1089.1994384127738, 1091.4215465803138, 1110.5946329589722, 1127.149002503113, 10306.639267625596, 12305.384730763515, 12341.321227332493, 12516.311602861839, 12556.74886502274, 5044.571211447068, 5064.772085256172, 5128.8461346159675, 5144.511271429208, 5193.402758682724, 10466.476676166161, 10720.035196832323, 10721.83917241242, 10731.034206921415, 10738.463076846127, 5580.358258800209, 5650.63270887391, 5719.857003574861, 5732.942670573241, 5736.225609542742, 4665.6734028617675, 4958.553730164303, 5036.294918711384, 5074.2895994560795, 5168.224766285088, 4131.421600975866, 4183.184279065553, 4186.518550366686, 4208.116295577902, 4216.451861258017, 1379.4344318829233, 1392.8467868534453, 1400.180894176918, 1401.7967394727707, 1415.6319356967056, 1206.2400687566776, 1386.2167875150508, 1388.7014291927285, 1460.8831293496494, 1466.5746933389198, 8484.0, 8638.481691098554, 8645.913540864636, 8649.091845356146, 8667.479951202948, 536.3644081763123, 546.9288992431038, 548.5901233829101, 548.6735392441491, 552.2241251042292, 6368.363163683594, 6374.0, 6408.967955160288, 6427.389398007275, 6428.0, 9122.179003889549, 10935.28920620157, 11171.273867198606, 11242.831357529643, 11329.2069555132, 10795.56817727282, 10957.0, 11058.834117488244, 11130.888691113147, 11146.275492092987, 8561.14388561139, 8565.0, 8652.740417787476, 8661.307095432476, 8681.045085040514, 8084.0, 8094.757157285291, 8225.383096267684, 8303.875441868498, 8326.12575679569, 9637.084476974676, 9968.950155249177, 10000.2999790014, 10105.0, 10161.898381016095, 10172.593096276361, 10332.53503592325, 10405.84391234117, 10467.267291289536, 10580.259381843198, 7595.88606170919, 7811.921880781119, 7822.960885195537, 7898.565578892986, 7921.485103468256, 8653.048164702004, 8661.177188167114, 8714.346424018351, 8749.037605863223, 8749.387542871938, 7523.623818809147, 7650.885236721342, 7684.001079859582, 7705.345045671181, 7769.92230077692, 6287.685615719287, 7427.4800763946005, 7446.367058800062, 7484.363829074372, 7630.351420129351, 8025.438219324591, 8073.19268073188, 8126.471779334324, 8194.098649148707, 8206.630701618322, 6149.907751383644, 7300.087489063867, 7348.816279593053, 7387.224341444071, 7414.888776668462, 5700.945325114867, 7203.71185152588, 7437.739679111205, 7493.475456718195, 7515.924840751522], "unit": "score", "name": "mootools.html", "value": 5050.127604056753}, {"lowerIsBetter": false, "replicates": [328.17627754336615, 351.38682998168184, 352.86062005507824, 355.52182314786603, 358.77217966591206, 5453.945460545398, 6747.727352234175, 6748.6288254146, 6775.59346439214, 6778.152730908637, 5270.262163297132, 6410.8780963331465, 6788.626625535606, 6827.351401616838, 6863.622500762456, 4250.788525270299, 4456.844010459635, 4907.803687852482, 4934.876628084308, 5031.597472202224, 4917.532834380746, 4955.578775804043, 4956.405231372222, 4957.380327459067, 4987.301777751118, 4898.14282500561, 4904.313396124546, 4922.966177102812, 4932.8520144395725, 4952.108620448318, 4917.139500587401, 4928.408590969071, 4971.577415919651, 4985.825496107619, 4988.7505624718615, 3500.299940012008, 4290.570942905716, 4295.892602684927, 4298.20483210607, 4313.547077556874, 6308.400701933355, 6465.903011454832, 6487.7080531376205, 6563.212414510242, 6604.405603495708, 4815.6388270879825, 5941.494972927263, 5973.581849270553, 5987.820365389045, 5998.640081595118, 7244.855102897913, 7252.274772522758, 7254.419646428273, 7275.527090739085, 7311.597862117582, 4223.556526564728, 4584.426946631671, 4857.295692124658, 4880.8047678092835, 4900.093482705675, 6123.87752244957, 7624.42816788743, 7649.617519124022, 7650.770476885702, 7655.50239234448, 4654.325122857167, 4798.5441383068555, 4816.20532612115, 4889.755512224375, 4898.387701537308, 5022.221555658879, 5034.395872495324, 5037.0, 5038.269450929668, 5043.092243396224, 5911.3201981772645, 5918.822435326947, 5922.111683247547, 5936.465718085306, 5958.2850057992455, 7296.19741828409, 7304.744333948286, 7307.561546307238, 7311.268873112646, 7329.45029122818, 1644.4491095483147, 1692.0439951427404, 1727.9827201728074, 1745.5636090977255, 1750.6761249168944, 1116.4250411038322, 1122.8827316819816, 1135.3755434510986, 1139.8689150747605, 1145.9140564457698, 6637.800865974028, 6665.833354166185, 6676.165479315086, 6708.362705542965, 6714.462842972551, 7450.366718828852, 7461.626918654046, 7464.066991626047, 7492.250774922573, 7516.098068231738, 5456.345238571317, 6593.901091483632, 6621.370969757865, 6647.933520664731, 6708.262091169968, 3634.618365071682, 3915.7078164205745, 3951.9012024699614, 3953.189596132786, 3978.960210397917, 6382.776602818879, 7820.726274580363, 7837.255460731221, 7910.841783164305, 8030.23712747288, 6331.145295385156, 7837.2162783722315, 7910.248526389983, 7921.683132674629, 7938.880916786253, 7977.407342613557, 7991.400644951652, 7991.72028978983, 8024.438289319692, 8048.114707382183, 7277.454190935595, 7612.1246056701975, 7622.31399174077, 7625.466217364731, 7690.307872291521, 7430.3684186842565, 7469.701211951461, 7495.17553069151, 7504.249575042452, 7526.698932042657, 7970.003749531309, 7988.840223195387, 7989.760307190561, 8006.879896801669, 8010.158933311918, 4927.605791536596, 4959.628027897994, 4966.205407134841, 4972.65191436596, 4989.850304490726, 7266.600336981305, 7570.621468926422, 7601.163871974189, 7630.542167469969, 7640.80897977555, 7296.416286697157, 7340.192578816433, 7361.1166660001145, 7364.594947277951, 7369.494371913575, 7287.890681639674, 7304.488685791944, 7323.8535229296185, 7329.120505539369, 7335.339819416278, 6969.268226836312, 7156.534825236343, 7161.0, 7164.570125792469, 7204.639768011683, 7211.639418028973, 7292.0, 7309.853802923805, 7329.963350183215, 7346.4122870169185, 7071.752488662872, 7118.323759242864, 7123.109611298588, 7164.104486939133, 7210.026646402668], "unit": "score", "name": "prototype.html", "value": 5310.571291359878}, {"lowerIsBetter": false, "replicates": [722.6242353975932, 769.2845653542207, 790.754865991543, 795.4710117771682, 799.9960000200002, 14992.475263365784, 15150.393984240645, 15301.46444874427, 15356.155411452366, 15377.46178883738, 14201.360938757754, 14211.289435528208, 14232.359543820527, 14238.430462781476, 14272.643183920407, 801.5631480842925, 979.6962941488162, 985.2462865907586, 994.4431118573622, 996.3772642098688, 796.760971708488, 963.7879666473365, 983.8917719050935, 994.5126887824949, 996.1084829078007, 1031.747221930628, 1032.4528000159928, 1039.3296323871098, 1042.9791404171913, 1052.0899421999952, 997.6757553794973, 1020.34187948773, 1034.0125180452687, 1036.0364860679565, 1040.0795296162876, 777.5529070784265, 778.3656320099101, 793.6825269892032, 793.9761807145795, 794.8847417124484, 15021.849781502155, 15075.773863392058, 15076.09543427387, 15106.018108822891, 15171.468998585107, 13254.602361929157, 13301.0, 13302.800457993138, 13368.665783355495, 13402.195868247936, 10210.336328138721, 10249.282550221487, 10256.487175641263, 10337.069663730224, 10565.366078035266, 3557.928841423157, 3567.7324200684793, 3614.9096272593397, 3615.7830530168276, 3835.0795809005917, 72250.0, 81869.59065204696, 81872.18127818705, 82064.17935820625, 83281.0, 9669.0, 9675.612975481043, 9688.854667179998, 10069.093781559695, 10120.696379108638, 22935.655965160535, 23149.76850231476, 23156.3053108407, 23293.41766455852, 23325.53348933012, 6293.82162008183, 7686.846263074819, 7724.613769311624, 7748.186440423787, 7849.175836537195, 4131.731437456616, 4160.854370097032, 4197.97901010493, 4240.809163587646, 4287.549807270254, 3059.189314831571, 3587.6053634100226, 3715.1269451678836, 3727.925441491155, 3742.513473248515, 626.7806267806232, 636.1189752193245, 642.2742301199614, 654.4306453385585, 685.8936864785966, 478.99322170047304, 557.239368262319, 578.6036564952936, 609.5032548472981, 621.3103455164763, 8234.547099909443, 8487.490750554987, 8766.12338766131, 8770.254528365032, 9066.9818441858, 599.9850003749941, 617.6232498176109, 621.254494606474, 626.743035355502, 631.6336524815596, 3855.5373355196994, 3990.2219067281603, 4033.394990751352, 4049.1699201663587, 4173.394857745609, 85878.57060714782, 86072.0, 95885.0, 96681.0, 97407.51296243473, 68954.0, 87367.56316218378, 87450.56274718713, 87669.56165219133, 89311.55344223237, 75002.62498687471, 75401.6229918847, 75750.62124689452, 76115.0, 76661.0, 7897.289243968071, 8075.959620201861, 8166.510009399218, 8175.509469431853, 8187.345012399113, 51029.0, 51101.0, 51550.711232219495, 52269.477305226465, 52803.0, 69379.0, 72273.55452891017, 72605.6369718148, 73723.0, 74537.0, 9921.603135874773, 10162.136218421518, 10206.285560010729, 10410.843837342598, 10699.14406847466, 11064.778704426028, 11165.609203677832, 11171.776564468828, 11455.656330310105, 11594.246373985665, 8583.957080214559, 10770.407627580558, 10906.890931090587, 10907.236493445384, 10999.34003959765, 10570.947145264225, 10693.930606939244, 10764.08505277029, 10904.945475272572, 11078.833817492583, 8496.787580310542, 10403.598176976744, 10441.58233670675, 10584.047435730821, 10828.675139745821, 8938.2402495786, 9122.087791220825, 9166.54167291646, 9240.537973101453, 9396.201322887631, 7997.800054998439, 8021.318187953856, 8068.7175948841505, 8129.268365846866, 8377.204165604258], "unit": "score", "name": "yui.html", "value": 7010.944134090992}], "name": "dromaeo_css", "value": 7659.882644337536}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 112.0, 115.0, 113.0, 114.0, 129.0, 114.0, 114.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [158.0, 122.0, 159.0, 148.0, 117.0, 142.0, 121.0, 151.0, 146.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [194.0, 195.0, 193.0, 197.0, 197.0, 195.0, 197.0, 192.0, 202.0, 196.0], "unit": "score", "name": "audio-dft", "value": 195.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 78.0, 130.0, 73.0, 76.0, 88.0, 87.0, 145.0, 57.0], "unit": "score", "name": "audio-fft", "value": 86.4}, {"lowerIsBetter": true, "replicates": [86.0, 80.0, 122.0, 78.0, 81.0, 80.0, 115.0, 77.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 91.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 92.0, 85.0, 89.0, 85.0, 89.0, 85.0, 92.0, 124.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 121.0, 94.0, 95.0, 99.0, 93.0, 100.0], "unit": "score", "name": "imaging-darkroom", "value": 97.8}, {"lowerIsBetter": true, "replicates": [96.0, 107.0, 132.0, 90.0, 127.0, 151.0, 79.0, 140.0, 147.0, 141.0], "unit": "score", "name": "imaging-desaturate", "value": 121.0}, {"lowerIsBetter": true, "replicates": [51.0, 53.0, 57.0, 59.0, 59.0, 59.0, 57.0, 66.0, 58.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 60.0, 73.0, 117.0, 110.0, 105.0, 98.0, 81.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 83.9}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 83.0, 98.0, 108.0, 72.0, 70.0, 93.0, 98.0, 113.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.8}, {"lowerIsBetter": true, "replicates": [117.0, 126.0, 122.0, 135.0, 135.0, 138.0, 115.0, 122.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 156.0, 182.0, 184.0, 156.0, 136.0, 139.0, 145.0, 163.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 94.0, 97.0, 98.0, 70.0, 64.0, 65.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.3}], "name": "kraken", "value": 1524.1}]} 03:50:29 INFO - Return code: 0 03:50:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:50:29 ERROR - # TBPL SUCCESS # 03:50:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:50:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:50:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:50:29 INFO - 2016-04-25 03:50:29.414 screenresolution[2255:20529] starting screenresolution argv=screenresolution get 03:50:29 INFO - 2016-04-25 03:50:29.417 screenresolution[2255:20529] Display 0: 1600x1200x32@60 03:50:29 INFO - 2016-04-25 03:50:29.423 screenresolution[2256:20532] starting screenresolution argv=screenresolution list 03:50:29 INFO - Available Modes on Display 0 03:50:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:50:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:50:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:50:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:50:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:50:29 INFO - Intel Iris: 03:50:29 INFO - Chipset Model: Intel Iris 03:50:29 INFO - Type: GPU 03:50:29 INFO - Bus: Built-In 03:50:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:50:29 INFO - Vendor: Intel (0x8086) 03:50:29 INFO - Device ID: 0x0a2e 03:50:29 INFO - Revision ID: 0x0009 03:50:29 INFO - Displays: 03:50:29 INFO - Display: 03:50:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:50:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:50:29 INFO - Display Serial Number: 1600x1200 60 03:50:29 INFO - Main Display: Yes 03:50:29 INFO - Mirror: Off 03:50:29 INFO - Online: Yes 03:50:29 INFO - Rotation: Supported 03:50:29 INFO - Return code: 0 03:50:29 INFO - Running post-action listener: _resource_record_post_action 03:50:29 INFO - Running post-run listener: _resource_record_post_run 03:50:30 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 909312; Write bytes: 667854336; Read time: 12; Write time: 2265 03:50:30 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 0; Write bytes: 364472320; Read time: 0; Write time: 751 03:50:30 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 909312; Write bytes: 302534144; Read time: 12; Write time: 1511 03:50:30 INFO - Running post-run listener: _upload_blobber_files 03:50:30 INFO - Blob upload gear active. 03:50:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:30 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 03:50:30 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:50:30 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:50:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:50:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:32 INFO - (blobuploader) - INFO - Done attempting. 03:50:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:50:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:50:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:33 INFO - (blobuploader) - INFO - Done attempting. 03:50:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:33 INFO - Return code: 0 03:50:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2475ab4761559b9b3387520df90b08a95812e98de233bdff56828b5135a3040077e2f005d9bcbe854e619860cd728bc8a2b6c07c8e253fc283ee38ef840c06e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb5f07c423f5aef7191bb94ffa64d50eb5c9e26e25de94dbd7f4683395c2ae3a4c6c5e600ffd9a953a419cfccb69ddeb57973520bc41ba2434c563a4f7f7574b"} 03:50:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:33 INFO - Contents: 03:50:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2475ab4761559b9b3387520df90b08a95812e98de233bdff56828b5135a3040077e2f005d9bcbe854e619860cd728bc8a2b6c07c8e253fc283ee38ef840c06e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb5f07c423f5aef7191bb94ffa64d50eb5c9e26e25de94dbd7f4683395c2ae3a4c6c5e600ffd9a953a419cfccb69ddeb57973520bc41ba2434c563a4f7f7574b"} 03:50:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:33 INFO - Copying logs to upload dir... 03:50:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.155607 ========= master_lag: 1.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-25 03:50:34.699013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-25 03:50:34.700264) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHTqkzbwqy/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2475ab4761559b9b3387520df90b08a95812e98de233bdff56828b5135a3040077e2f005d9bcbe854e619860cd728bc8a2b6c07c8e253fc283ee38ef840c06e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb5f07c423f5aef7191bb94ffa64d50eb5c9e26e25de94dbd7f4683395c2ae3a4c6c5e600ffd9a953a419cfccb69ddeb57973520bc41ba2434c563a4f7f7574b"} build_url:https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/OhmjSpHVQVGyMjeHEqCLDg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2475ab4761559b9b3387520df90b08a95812e98de233bdff56828b5135a3040077e2f005d9bcbe854e619860cd728bc8a2b6c07c8e253fc283ee38ef840c06e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb5f07c423f5aef7191bb94ffa64d50eb5c9e26e25de94dbd7f4683395c2ae3a4c6c5e600ffd9a953a419cfccb69ddeb57973520bc41ba2434c563a4f7f7574b"}' ========= master_lag: 1.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-25 03:50:36.025205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 03:50:36.025596) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tHTqkzbwqy/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hgY1zMWb6N/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005146 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 03:50:36.055156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 03:50:36.055496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 03:50:36.059610) ========= ========= Total master_lag: 3.38 =========