builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1468847810.73 results: success (0) buildid: 20160718030454 builduid: bd53cdf8946447a581b1df14c09f0c13 revision: 0fbdcd21fad76a00328e67875c6f40dc219235f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:50.726176) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:50.726604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:50.726893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:50.752221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:50.752600) ========= 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.fV89OlLeCW/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.hclT16k6Jc/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-07-18 06:16:50-- 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% 12.0M=0.001s 2016-07-18 06:16:50 (12.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156763 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:50.967669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:50.968029) ========= 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.fV89OlLeCW/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.hclT16k6Jc/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.028017 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:51.015439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 06:16:51.015786) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0fbdcd21fad76a00328e67875c6f40dc219235f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0fbdcd21fad76a00328e67875c6f40dc219235f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fV89OlLeCW/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.hclT16k6Jc/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-07-18 06:16:51,093 truncating revision to first 12 chars 2016-07-18 06:16:51,093 Setting DEBUG logging. 2016-07-18 06:16:51,093 attempt 1/10 2016-07-18 06:16:51,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0fbdcd21fad7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 06:16:51,845 unpacking tar archive at: mozilla-central-0fbdcd21fad7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.021250 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 06:16:52.099697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:52.100170) ========= script_repo_revision: 0fbdcd21fad76a00328e67875c6f40dc219235f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:52.100558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:52.100843) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 06:16:52.124174) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-07-18 06:16:52.124624) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fV89OlLeCW/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.hclT16k6Jc/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:16:52 INFO - MultiFileLogger online at 20160718 06:16:52 in /builds/slave/test 06:16:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:16:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:16:52 INFO - {'append_to_log': False, 06:16:52 INFO - 'base_work_dir': '/builds/slave/test', 06:16:52 INFO - 'blob_upload_branch': 'Firefox', 06:16:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:16:52 INFO - 'branch': 'Firefox', 06:16:52 INFO - 'buildbot_json_path': 'buildprops.json', 06:16:52 INFO - 'config_files': ('talos/mac_config.py',), 06:16:52 INFO - 'default_actions': ('clobber', 06:16:52 INFO - 'read-buildbot-config', 06:16:52 INFO - 'download-and-extract', 06:16:52 INFO - 'populate-webroot', 06:16:52 INFO - 'create-virtualenv', 06:16:52 INFO - 'install', 06:16:52 INFO - 'run-tests'), 06:16:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:16:52 INFO - 'download_minidump_stackwalk': True, 06:16:52 INFO - 'download_symbols': 'ondemand', 06:16:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:16:52 INFO - 'tooltool.py': '/tools/tooltool.py', 06:16:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:16:52 INFO - '/tools/misc-python/virtualenv.py')}, 06:16:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:16:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:16:52 INFO - 'installer_path': 'installer.exe', 06:16:52 INFO - 'log_level': 'info', 06:16:52 INFO - 'log_name': 'talos', 06:16:52 INFO - 'log_to_console': True, 06:16:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:16:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:16:52 INFO - 'opt_config_files': (), 06:16:52 INFO - 'pip_index': False, 06:16:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:16:52 INFO - 'cmd': ('bash', 06:16:52 INFO - '-c', 06:16:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:16:52 INFO - 'enabled': True, 06:16:52 INFO - 'halt_on_failure': False, 06:16:52 INFO - 'name': 'check_screen_resolution'},), 06:16:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:16:52 INFO - 'cmd': ('bash', 06:16:52 INFO - '-c', 06:16:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:16:52 INFO - 'enabled': True, 06:16:52 INFO - 'halt_on_failure': False, 06:16:52 INFO - 'name': 'check_screen_resolution'},), 06:16:52 INFO - 'run_cmd_checks_enabled': True, 06:16:52 INFO - 'sps_profile': False, 06:16:52 INFO - 'sps_profile_interval': 0, 06:16:52 INFO - 'suite': 'dromaeojs', 06:16:52 INFO - 'system_bits': '32', 06:16:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:16:52 INFO - 'title': 't-yosemite-r7-0191', 06:16:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:16:52 INFO - 'use_talos_json': True, 06:16:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:16:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:16:52 INFO - 'work_dir': 'build'} 06:16:52 INFO - ##### 06:16:52 INFO - ##### Running clobber step. 06:16:52 INFO - ##### 06:16:52 INFO - Running pre-action listener: _resource_record_pre_action 06:16:52 INFO - Running main action method: clobber 06:16:52 INFO - rmtree: /builds/slave/test/build 06:16:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:16:54 INFO - Running post-action listener: _resource_record_post_action 06:16:54 INFO - ##### 06:16:54 INFO - ##### Finished clobber step (success) 06:16:54 INFO - ##### 06:16:54 INFO - ##### 06:16:54 INFO - ##### Running read-buildbot-config step. 06:16:54 INFO - ##### 06:16:54 INFO - Running pre-action listener: _resource_record_pre_action 06:16:54 INFO - Running main action method: read_buildbot_config 06:16:54 INFO - Using buildbot properties: 06:16:54 INFO - { 06:16:54 INFO - "project": "", 06:16:54 INFO - "product": "firefox", 06:16:54 INFO - "script_repo_revision": "production", 06:16:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:16:54 INFO - "repository": "", 06:16:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:16:54 INFO - "buildid": "20160718030454", 06:16:54 INFO - "stage_platform": "macosx64", 06:16:54 INFO - "basedir": "/builds/slave/test", 06:16:54 INFO - "nightly_build": "True", 06:16:54 INFO - "buildnumber": 49, 06:16:54 INFO - "slavename": "t-yosemite-r7-0191", 06:16:54 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:16:54 INFO - "platform": "yosemite_r7", 06:16:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:16:54 INFO - "branch": "mozilla-central", 06:16:54 INFO - "repo_path": "mozilla-central", 06:16:54 INFO - "revision": "0fbdcd21fad76a00328e67875c6f40dc219235f4", 06:16:54 INFO - "pgo_build": "False", 06:16:54 INFO - "builduid": "bd53cdf8946447a581b1df14c09f0c13", 06:16:54 INFO - "slavebuilddir": "test" 06:16:54 INFO - } 06:16:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 06:16:54 INFO - Running post-action listener: _resource_record_post_action 06:16:54 INFO - ##### 06:16:54 INFO - ##### Finished read-buildbot-config step (success) 06:16:54 INFO - ##### 06:16:54 INFO - ##### 06:16:54 INFO - ##### Running download-and-extract step. 06:16:54 INFO - ##### 06:16:54 INFO - Running pre-action listener: _resource_record_pre_action 06:16:54 INFO - Running main action method: download_and_extract 06:16:54 INFO - mkdir: /builds/slave/test/build/tests 06:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:54 INFO - https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:16:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:16:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:16:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 06:17:24 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 06:17:24 INFO - retry: attempt #1 caught exception: timed out 06:17:24 INFO - retry: Failed, sleeping 30 seconds before retrying 06:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 06:17:55 INFO - Downloaded 1199 bytes. 06:17:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:17:55 INFO - Using the following test package requirements: 06:17:55 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:17:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 06:17:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 06:17:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'jsshell-mac.zip'], 06:17:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 06:17:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:17:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 06:17:55 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 06:17:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 06:17:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:17:55 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 06:17:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:55 INFO - https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:17:56 INFO - Downloaded 18835998 bytes. 06:17:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:17:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:17:59 INFO - Return code: 0 06:17:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:17: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')]} 06:17:59 INFO - https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:18:00 INFO - Downloaded 18835998 bytes. 06:18:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:18:04 INFO - Return code: 0 06:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:04 INFO - https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:18:05 INFO - Downloaded 14403317 bytes. 06:18:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:18:05 INFO - Return code: 0 06:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:05 INFO - https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 06:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 06:18:08 INFO - Downloaded 112896560 bytes. 06:18:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:18:08 INFO - mkdir: /builds/slave/test/properties 06:18:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:08 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:08 INFO - Contents: 06:18:08 INFO - build_url:https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:18:09 INFO - Running post-action listener: _resource_record_post_action 06:18:09 INFO - Running post-action listener: set_extra_try_arguments 06:18:09 INFO - ##### 06:18:09 INFO - ##### Finished download-and-extract step (success) 06:18:09 INFO - ##### 06:18:09 INFO - ##### 06:18:09 INFO - ##### Running populate-webroot step. 06:18:09 INFO - ##### 06:18:09 INFO - Running pre-action listener: _resource_record_pre_action 06:18:09 INFO - Running main action method: populate_webroot 06:18:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:09 INFO - '--tppagecycles', 06:18:09 INFO - '7'], 06:18:09 INFO - 'tests': ['tsvgm']}}, 06:18:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:18:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:18:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['damp', 'tps']}, 06:18:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'tests': ['damp', 'tps']}, 06:18:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['dromaeo_dom']}, 06:18:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['basic_compositor_video']}, 06:18:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:18:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['a11yr', 06:18:09 INFO - 'ts_paint', 06:18:09 INFO - 'tpaint', 06:18:09 INFO - 'sessionrestore', 06:18:09 INFO - 'sessionrestore_no_auto_restore', 06:18:09 INFO - 'tabpaint']}, 06:18:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:18:09 INFO - 'ts_paint', 06:18:09 INFO - 'tpaint', 06:18:09 INFO - 'sessionrestore', 06:18:09 INFO - 'sessionrestore_no_auto_restore', 06:18:09 INFO - 'tabpaint']}, 06:18:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:18:09 INFO - 'ts_paint', 06:18:09 INFO - 'tpaint', 06:18:09 INFO - 'sessionrestore', 06:18:09 INFO - 'sessionrestore_no_auto_restore', 06:18:09 INFO - 'tabpaint']}, 06:18:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:18:09 INFO - 'ts_paint', 06:18:09 INFO - 'tpaint', 06:18:09 INFO - 'sessionrestore', 06:18:09 INFO - 'sessionrestore_no_auto_restore', 06:18:09 INFO - 'tabpaint']}, 06:18:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['a11yr', 06:18:09 INFO - 'ts_paint', 06:18:09 INFO - 'tpaint', 06:18:09 INFO - 'sessionrestore', 06:18:09 INFO - 'sessionrestore_no_auto_restore', 06:18:09 INFO - 'tabpaint']}, 06:18:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['a11yr', 06:18:09 INFO - 'ts_paint', 06:18:09 INFO - 'tpaint', 06:18:09 INFO - 'sessionrestore', 06:18:09 INFO - 'sessionrestore_no_auto_restore', 06:18:09 INFO - 'tabpaint']}, 06:18:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['tsvgx', 06:18:09 INFO - 'tsvgr_opacity', 06:18:09 INFO - 'tart', 06:18:09 INFO - 'tscrollx', 06:18:09 INFO - 'cart']}, 06:18:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:18:09 INFO - 'tsvgr_opacity', 06:18:09 INFO - 'tart', 06:18:09 INFO - 'tscrollx', 06:18:09 INFO - 'cart']}, 06:18:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'talos_options': ['--disable-e10s'], 06:18:09 INFO - 'tests': ['tp5o']}, 06:18:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'tests': ['tp5o']}, 06:18:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'talos_options': ['--disable-e10s', 06:18:09 INFO - '--xperf_path', 06:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:09 INFO - 'tests': ['tp5n']}, 06:18:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:09 INFO - 'talos_options': ['--xperf_path', 06:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:09 INFO - 'tests': ['tp5n']}}, 06:18:09 INFO - 'talos.zip': {'path': '', 06:18:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:09 INFO - Running post-action listener: _resource_record_post_action 06:18:09 INFO - ##### 06:18:09 INFO - ##### Finished populate-webroot step (success) 06:18:09 INFO - ##### 06:18:09 INFO - ##### 06:18:09 INFO - ##### Running create-virtualenv step. 06:18:09 INFO - ##### 06:18:09 INFO - Running pre-action listener: _resource_record_pre_action 06:18:09 INFO - Running main action method: create_virtualenv 06:18:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:09 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 06:18:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:09 INFO - Using real prefix '/tools/python27' 06:18:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:13 INFO - Installing pip.................done. 06:18:13 INFO - Return code: 0 06:18:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 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 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:13 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 06:18:13 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 06:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:13 INFO - 'HOME': '/Users/cltbld', 06:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:13 INFO - 'LOGNAME': 'cltbld', 06:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:13 INFO - 'MOZ_NO_REMOTE': '1', 06:18:13 INFO - 'NO_EM_RESTART': '1', 06:18:13 INFO - 'PAGER': '/bin/cat', 06:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:13 INFO - 'PWD': '/builds/slave/test', 06:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:13 INFO - 'SHELL': '/bin/bash', 06:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:13 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:13 INFO - 'USER': 'cltbld', 06:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:13 INFO - 'XPC_FLAGS': '0x0', 06:18:13 INFO - 'XPC_SERVICE_NAME': '0', 06:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:13 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 06:18:13 INFO - Cleaning up... 06:18:13 INFO - Return code: 0 06:18:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:13 INFO - 'HOME': '/Users/cltbld', 06:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:13 INFO - 'LOGNAME': 'cltbld', 06:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:13 INFO - 'MOZ_NO_REMOTE': '1', 06:18:13 INFO - 'NO_EM_RESTART': '1', 06:18:13 INFO - 'PAGER': '/bin/cat', 06:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:13 INFO - 'PWD': '/builds/slave/test', 06:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:13 INFO - 'SHELL': '/bin/bash', 06:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:13 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:13 INFO - 'USER': 'cltbld', 06:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:13 INFO - 'XPC_FLAGS': '0x0', 06:18:13 INFO - 'XPC_SERVICE_NAME': '0', 06:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:13 INFO - Downloading/unpacking psutil>=3.1.1 06:18:13 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 06:18:13 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 06:18:13 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 06:18:13 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 06:18:13 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 06:18:13 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 06:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:17 INFO - Installing collected packages: psutil 06:18:17 INFO - Running setup.py install for psutil 06:18:17 INFO - building 'psutil._psutil_osx' extension 06:18:17 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 06:18:17 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 06:18:17 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 06:18:18 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 06:18:18 INFO - building 'psutil._psutil_posix' extension 06:18:18 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 06:18:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:18:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:18:18 INFO - ^ 06:18:18 INFO - 1 warning generated. 06:18:18 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 06:18:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:18 INFO - Successfully installed psutil 06:18:18 INFO - Cleaning up... 06:18:18 INFO - Return code: 0 06:18:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:18 INFO - 'HOME': '/Users/cltbld', 06:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:18 INFO - 'LOGNAME': 'cltbld', 06:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:18 INFO - 'MOZ_NO_REMOTE': '1', 06:18:18 INFO - 'NO_EM_RESTART': '1', 06:18:18 INFO - 'PAGER': '/bin/cat', 06:18:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:18 INFO - 'PWD': '/builds/slave/test', 06:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:18 INFO - 'SHELL': '/bin/bash', 06:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:18 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:18 INFO - 'USER': 'cltbld', 06:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:18 INFO - 'XPC_FLAGS': '0x0', 06:18:18 INFO - 'XPC_SERVICE_NAME': '0', 06:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:18:21 INFO - Installing collected packages: mozsystemmonitor 06:18:21 INFO - Running setup.py install for mozsystemmonitor 06:18:21 INFO - Successfully installed mozsystemmonitor 06:18:21 INFO - Cleaning up... 06:18:21 INFO - Return code: 0 06:18:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:21 INFO - 'HOME': '/Users/cltbld', 06:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:21 INFO - 'LOGNAME': 'cltbld', 06:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:21 INFO - 'MOZ_NO_REMOTE': '1', 06:18:21 INFO - 'NO_EM_RESTART': '1', 06:18:21 INFO - 'PAGER': '/bin/cat', 06:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:21 INFO - 'PWD': '/builds/slave/test', 06:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:21 INFO - 'SHELL': '/bin/bash', 06:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:21 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:21 INFO - 'USER': 'cltbld', 06:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:21 INFO - 'XPC_FLAGS': '0x0', 06:18:21 INFO - 'XPC_SERVICE_NAME': '0', 06:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:21 INFO - Downloading/unpacking jsonschema==2.5.1 06:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:24 INFO - warning: no files found matching '*.txt' 06:18:24 INFO - no previously-included directories found matching 'build' 06:18:24 INFO - no previously-included directories found matching 'dist' 06:18:24 INFO - no previously-included directories found matching '.git*' 06:18:24 INFO - Installing collected packages: jsonschema, functools32 06:18:24 INFO - Running setup.py install for functools32 06:18:24 INFO - warning: no files found matching '*.txt' 06:18:24 INFO - no previously-included directories found matching 'build' 06:18:24 INFO - no previously-included directories found matching 'dist' 06:18:24 INFO - no previously-included directories found matching '.git*' 06:18:24 INFO - Successfully installed jsonschema functools32 06:18:24 INFO - Cleaning up... 06:18:24 INFO - Return code: 0 06:18:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:24 INFO - 'HOME': '/Users/cltbld', 06:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:24 INFO - 'LOGNAME': 'cltbld', 06:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:24 INFO - 'MOZ_NO_REMOTE': '1', 06:18:24 INFO - 'NO_EM_RESTART': '1', 06:18:24 INFO - 'PAGER': '/bin/cat', 06:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:24 INFO - 'PWD': '/builds/slave/test', 06:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:24 INFO - 'SHELL': '/bin/bash', 06:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:24 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:24 INFO - 'USER': 'cltbld', 06:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:24 INFO - 'XPC_FLAGS': '0x0', 06:18:24 INFO - 'XPC_SERVICE_NAME': '0', 06:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18:28 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 06:18:28 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 06:18:28 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 06:18:28 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 06:18:28 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 06:18:28 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 06:18:28 INFO - Downloading docopt-0.6.1.tar.gz 06:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:29 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:29 INFO - Running setup.py install for blobuploader 06:18:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:29 INFO - Running setup.py install for requests 06:18:29 INFO - Running setup.py install for docopt 06:18:29 INFO - Successfully installed blobuploader requests docopt 06:18:29 INFO - Cleaning up... 06:18:29 INFO - Return code: 0 06:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:29 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')]} 06:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:29 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')]} 06:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:29 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 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:29 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 06:18:29 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 06:18:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:29 INFO - 'HOME': '/Users/cltbld', 06:18:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:29 INFO - 'LOGNAME': 'cltbld', 06:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:29 INFO - 'MOZ_NO_REMOTE': '1', 06:18:29 INFO - 'NO_EM_RESTART': '1', 06:18:29 INFO - 'PAGER': '/bin/cat', 06:18:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:29 INFO - 'PWD': '/builds/slave/test', 06:18:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:29 INFO - 'SHELL': '/bin/bash', 06:18:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:29 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:29 INFO - 'USER': 'cltbld', 06:18:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:29 INFO - 'XPC_FLAGS': '0x0', 06:18:29 INFO - 'XPC_SERVICE_NAME': '0', 06:18:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ZZdj6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UqeisD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-TK_v5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1yRcVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-7IvUnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-SZJLql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-pLc8hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-epuGOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8FTfLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-p1ZLJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-tVY67h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ntiYd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-uOR8UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-X2shK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ugC7yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_pPgeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-pRMZ77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:32 INFO - Running setup.py install for manifestparser 06:18:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozcrash 06:18:32 INFO - Running setup.py install for mozdebug 06:18:32 INFO - Running setup.py install for mozdevice 06:18:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozfile 06:18:32 INFO - Running setup.py install for mozhttpd 06:18:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozinfo 06:18:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozInstall 06:18:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozleak 06:18:33 INFO - Running setup.py install for mozlog 06:18:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for moznetwork 06:18:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozprocess 06:18:33 INFO - Running setup.py install for mozprofile 06:18:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozrunner 06:18:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:34 INFO - Running setup.py install for mozscreenshot 06:18:34 INFO - Running setup.py install for moztest 06:18:34 INFO - Running setup.py install for mozversion 06:18:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:34 INFO - Cleaning up... 06:18:34 INFO - Return code: 0 06:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 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 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:34 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 06:18:34 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 06:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:34 INFO - 'HOME': '/Users/cltbld', 06:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:34 INFO - 'LOGNAME': 'cltbld', 06:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:34 INFO - 'MOZ_NO_REMOTE': '1', 06:18:34 INFO - 'NO_EM_RESTART': '1', 06:18:34 INFO - 'PAGER': '/bin/cat', 06:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:34 INFO - 'PWD': '/builds/slave/test', 06:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:34 INFO - 'SHELL': '/bin/bash', 06:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:34 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:34 INFO - 'USER': 'cltbld', 06:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:34 INFO - 'XPC_FLAGS': '0x0', 06:18:34 INFO - 'XPC_SERVICE_NAME': '0', 06:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:34 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-L4nKyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:34 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)) 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:34 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-s1nFSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-kEm3K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-LmWiYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_a4Hyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-whqRNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-kuVCS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Fc9dfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-xht32i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:35 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)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-mmjH5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:35 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-AeDXPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:36 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)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:36 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-jYfx6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:36 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-AikPZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:36 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)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:36 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-rnFw2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:36 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yrcE8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:36 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)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:36 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-awUN4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:36 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)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:36 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yNRgQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:39 INFO - Downloading blessings-1.6.tar.gz 06:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:39 INFO - Installing collected packages: blessings 06:18:39 INFO - Running setup.py install for blessings 06:18:39 INFO - Successfully installed blessings 06:18:39 INFO - Cleaning up... 06:18:39 INFO - Return code: 0 06:18:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:39 INFO - Reading from file tmpfile_stdout 06:18:39 INFO - Current package versions: 06:18:39 INFO - blessings == 1.6 06:18:39 INFO - blobuploader == 1.2.4 06:18:39 INFO - docopt == 0.6.1 06:18:39 INFO - functools32 == 3.2.3-2 06:18:39 INFO - jsonschema == 2.5.1 06:18:39 INFO - manifestparser == 1.1 06:18:39 INFO - mozInstall == 1.12 06:18:39 INFO - mozcrash == 0.17 06:18:39 INFO - mozdebug == 0.1 06:18:39 INFO - mozdevice == 0.48 06:18:39 INFO - mozfile == 1.2 06:18:39 INFO - mozhttpd == 0.7 06:18:39 INFO - mozinfo == 0.9 06:18:39 INFO - mozleak == 0.1 06:18:39 INFO - mozlog == 3.2 06:18:39 INFO - moznetwork == 0.27 06:18:39 INFO - mozprocess == 0.23 06:18:39 INFO - mozprofile == 0.28 06:18:39 INFO - mozrunner == 6.12 06:18:39 INFO - mozscreenshot == 0.1 06:18:39 INFO - mozsystemmonitor == 0.3 06:18:39 INFO - moztest == 0.7 06:18:39 INFO - mozversion == 1.4 06:18:39 INFO - psutil == 3.1.1 06:18:39 INFO - requests == 1.2.3 06:18:39 INFO - wsgiref == 0.1.2 06:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:39 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')]} 06:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:39 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')]} 06:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:39 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 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:39 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 06:18:39 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 06:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:39 INFO - 'HOME': '/Users/cltbld', 06:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:39 INFO - 'LOGNAME': 'cltbld', 06:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:39 INFO - 'MOZ_NO_REMOTE': '1', 06:18:39 INFO - 'NO_EM_RESTART': '1', 06:18:39 INFO - 'PAGER': '/bin/cat', 06:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:39 INFO - 'PWD': '/builds/slave/test', 06:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:39 INFO - 'SHELL': '/bin/bash', 06:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:39 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:39 INFO - 'USER': 'cltbld', 06:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:39 INFO - 'XPC_FLAGS': '0x0', 06:18:39 INFO - 'XPC_SERVICE_NAME': '0', 06:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 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)) 06:18:40 INFO - Cleaning up... 06:18:40 INFO - Return code: 0 06:18:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:40 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 0x10df6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e001618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02359b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, '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.fV89OlLeCW/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.hclT16k6Jc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 06:18:40 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 06:18:40 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 06:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:40 INFO - 'HOME': '/Users/cltbld', 06:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:40 INFO - 'LOGNAME': 'cltbld', 06:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:40 INFO - 'MOZ_NO_REMOTE': '1', 06:18:40 INFO - 'NO_EM_RESTART': '1', 06:18:40 INFO - 'PAGER': '/bin/cat', 06:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:40 INFO - 'PWD': '/builds/slave/test', 06:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:40 INFO - 'SHELL': '/bin/bash', 06:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:18:40 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:40 INFO - 'USER': 'cltbld', 06:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:40 INFO - 'XPC_FLAGS': '0x0', 06:18:40 INFO - 'XPC_SERVICE_NAME': '0', 06:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:18:40 INFO - Cleaning up... 06:18:40 INFO - Return code: 0 06:18:40 INFO - Running post-action listener: _resource_record_post_action 06:18:40 INFO - Running post-action listener: _start_resource_monitoring 06:18:40 INFO - Starting resource monitoring. 06:18:40 INFO - ##### 06:18:40 INFO - ##### Finished create-virtualenv step (success) 06:18:40 INFO - ##### 06:18:40 INFO - ##### 06:18:40 INFO - ##### Running install step. 06:18:40 INFO - ##### 06:18:40 INFO - Running pre-action listener: _resource_record_pre_action 06:18:40 INFO - Running main action method: install 06:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:40 INFO - Reading from file tmpfile_stdout 06:18:40 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:40 INFO - Reading from file tmpfile_stdout 06:18:40 INFO - Output received: 06:18:40 INFO - Usage: mozinstall [options] installer 06:18:40 INFO - Options: 06:18:40 INFO - -h, --help show this help message and exit 06:18:40 INFO - -d DEST, --destination=DEST 06:18:40 INFO - Directory to install application into. [default: 06:18:40 INFO - "/builds/slave/test"] 06:18:40 INFO - --app=APP Application being installed. [default: firefox] 06:18:40 INFO - mkdir: /builds/slave/test/build/application 06:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:19:15 INFO - Reading from file tmpfile_stdout 06:19:15 INFO - Output received: 06:19:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:19:15 INFO - Running post-action listener: _resource_record_post_action 06:19:15 INFO - ##### 06:19:15 INFO - ##### Finished install step (success) 06:19:15 INFO - ##### 06:19:15 INFO - ##### 06:19:15 INFO - ##### Running run-tests step. 06:19:15 INFO - ##### 06:19:15 INFO - Running pre-action listener: _resource_record_pre_action 06:19:15 INFO - Running main action method: run_tests 06:19:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:19:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:19:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:19:15 INFO - 2016-07-18 06:19:15.589 screenresolution[1644:8805] starting screenresolution argv=screenresolution get 06:19:15 INFO - 2016-07-18 06:19:15.592 screenresolution[1644:8805] Display 0: 1600x1200x32@60 06:19:15 INFO - 2016-07-18 06:19:15.597 screenresolution[1645:8807] starting screenresolution argv=screenresolution list 06:19:15 INFO - Available Modes on Display 0 06:19:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:19:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:19:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:19:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:19:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:19:15 INFO - Intel Iris: 06:19:15 INFO - Chipset Model: Intel Iris 06:19:15 INFO - Type: GPU 06:19:15 INFO - Bus: Built-In 06:19:15 INFO - VRAM (Dynamic, Max): 1536 MB 06:19:15 INFO - Vendor: Intel (0x8086) 06:19:15 INFO - Device ID: 0x0a2e 06:19:15 INFO - Revision ID: 0x0009 06:19:15 INFO - Displays: 06:19:15 INFO - Display: 06:19:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:19:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:19:15 INFO - Display Serial Number: 1600x1200 60 06:19:15 INFO - Main Display: Yes 06:19:15 INFO - Mirror: Off 06:19:15 INFO - Online: Yes 06:19:15 INFO - Rotation: Supported 06:19:15 INFO - Return code: 0 06:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:15 INFO - Python 2.7.3 06:19:15 INFO - Return code: 0 06:19:15 INFO - grabbing minidump binary from tooltool 06:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:15 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded0d30>, '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 0x10dc35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dec8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:15 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 06:19:15 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 06:19:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:19:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:15 INFO - Return code: 0 06:19:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:19:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:19:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:19:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fV89OlLeCW/Render', 06:19:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:15 INFO - 'HOME': '/Users/cltbld', 06:19:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:15 INFO - 'LOGNAME': 'cltbld', 06:19:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:15 INFO - 'MOZ_NO_REMOTE': '1', 06:19:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:15 INFO - 'NO_EM_RESTART': '1', 06:19:15 INFO - 'PAGER': '/bin/cat', 06:19:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:15 INFO - 'PWD': '/builds/slave/test', 06:19:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:15 INFO - 'SHELL': '/bin/bash', 06:19:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hclT16k6Jc/Listeners', 06:19:15 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 06:19:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:15 INFO - 'USER': 'cltbld', 06:19:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:15 INFO - 'XPC_FLAGS': '0x0', 06:19:15 INFO - 'XPC_SERVICE_NAME': '0', 06:19:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:19:16 INFO - mozversion application_buildid: 20160718030454 06:19:16 INFO - mozversion application_changeset: 0fbdcd21fad76a00328e67875c6f40dc219235f4 06:19:16 INFO - mozversion application_display_name: Nightly 06:19:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:16 INFO - mozversion application_name: Firefox 06:19:16 INFO - mozversion application_remotingname: firefox 06:19:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:19:16 INFO - mozversion application_vendor: Mozilla 06:19:16 INFO - mozversion application_version: 50.0a1 06:19:16 INFO - mozversion platform_buildid: 20160718030454 06:19:16 INFO - mozversion platform_changeset: 0fbdcd21fad76a00328e67875c6f40dc219235f4 06:19:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:19:16 INFO - mozversion platform_version: 50.0a1 06:19:16 INFO - using testdate: 1468847956 06:19:16 INFO - actual date: 1468847956 06:19:16 INFO - starting webserver on 'localhost:49272' 06:19:16 INFO - SUITE-START | Running 2 tests 06:19:16 INFO - TEST-START | dromaeo_css 06:19:16 INFO - operating with platform_type : mac_ 06:19:16 INFO - Initialising browser for dromaeo_css test... 06:19:16 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpA9qTkc/profile http://localhost:49272/getInfo.html) 06:19:18 INFO - PROCESS | 1655 | JavaScript error: , line 0: uncaught exception: undefined 06:19:18 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 06:19:18 INFO - PROCESS | 1655 | colorDepth:24 06:19:18 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 06:19:18 INFO - PROCESS | 1655 | __metrics 06:19:18 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:19:18 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:19 INFO - TEST-INFO | 1655: exit 0 06:19:19 INFO - Browser initialized. 06:19:19 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:19 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpA9qTkc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:31 INFO - PROCESS | 1659 | RSS: Main: 244994048 06:19:31 INFO - PROCESS | 1659 | 06:20:22 INFO - PROCESS | 1659 | 1468848022417 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] 06:22:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 06:22:35 INFO - PROCESS | 1659 | RSS: Main: 375791616 06:22:35 INFO - PROCESS | 1659 | 06:25:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 06:25:39 INFO - PROCESS | 1659 | RSS: Main: 377507840 06:25:39 INFO - PROCESS | 1659 | 06:28:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 06:28:42 INFO - PROCESS | 1659 | RSS: Main: 372137984 06:28:42 INFO - PROCESS | 1659 | 06:31:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 06:31:44 INFO - PROCESS | 1659 | RSS: Main: 374513664 06:31:44 INFO - PROCESS | 1659 | 06:34:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 06:34:49 INFO - PROCESS | 1659 | RSS: Main: 337596416 06:34:49 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 06:37:52 INFO - PROCESS | 1659 | RSS: Main: 384176128 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | __start_tp_report 06:37:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 06:37:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 06:37:52 INFO - PROCESS | 1659 | |i|pagename|runs| 06:37:52 INFO - PROCESS | 1659 | |0;dojo.html;3326.085326535201;3346.765726399153;3375.206826395798;3376.645452227516;3377.138829598452;5539.473749993749;5598.9921814073505;5603.467670571299;5668.206451096849;5687.061634830248;5623.887522249563;5700.629459085157;5714.799982000621;5720.7711691532395;5728.198052272674;5193.169092945139;5212.50481204285;5214.634975551713;5240.554552863011;5299.655522391032;5288.99509093273;5296.205569164617;5298.523132918037;5299.046171689094;5307.230451584537;5199.6360254782185;5206.088934436478;5206.167013277876;5225.2162175673575;5283.656562323436;5301.151815709506;5309.814156504503;5330.733463326818;5352.5182733553775;5378.193271009341;5078.365204349457;5103.183490641517;5141.922871156936;5159.716215608178;5175.508326708957;5575.303087114111;5647.689377084259;5682.545396368322;5708.686022268815;5748;6245.125682404467;6270;6288.968555157241;6301.96849015752;6304.684765761694;6156.907646385308;6201.193844800147;6231.40801623845;6280.811575652738;6309.242890853081;5748.5688573357165;5796.8840623187725;5822.9417705822825;5910.320313163955;5914.172015917775;6256.593321434092;6256.6871656417;6264.373562643699;6268.874622507525;6270.3416141305415;5963.7912673056235;6018.307894592178;6064.46605033481;6068.180795592627;6125.142480052797;6152.753889844445;6236.937630623726;6303.117563541108;6322.114903913456;6338.651374174372;6200.968995154995;6272.278687950944;6272.529560282997;6276.968615156987;6299.748010079546;6078.726457309432;6101.786437474667;6145.877082458326;6175.938240617626;6217.844553886099;4944.085344211332;4951.084049450863;4992.5756310714;5002.874928126826;5012.122878496249;4363.716358436692;4364.454443194601;4369.08249267651;4401.625861801783;4479.888002799956;5642.520385767256;5683.5737319700365;5790.855228619318;5808.767649294065;5843.415658434207;6101.145839582462;6119.816405507842;6184.938150618526;6209.627422354673;6251.937480625226;5658.943410565842;5712.143178523254;5771.8557036074435;5793.681347525927;5794.159846822187;5407.080796264644;5485.177223416519;5492.69790161537;5494.340679118532;5496.6701997880255;6130.856783744145;6170.290416602058;6204.472619827185;6214.533909956862;6281.748730050838;6284.905726414199;6284.968575157095;6291.245050593775;6299.622022678654;6300.621962682254;6178.605143676274;6233.719482623203;6258.43674069336;6273.1844860167885;6324.841878952879;5965.463108320272;6008.669523176267;6115.635867915819;6155.0151975683675;6159.014557670751;6210.782622608187;6228.314885362697;6256.562040657111;6273.780417685359;6317.557770956173;5944.8811023780145;5968.791092311748;6112.969435152796;6140.57016008893;6180.443760061616;5851.61964472325;5862.12068189775;5920.437558431942;6075.058365953284;6123.203983482297;4676.392069031004;5920.851978700567;6055.303640081447;6059.6364218147055;6086.056661217518;6013.428724271187;6125.421496837498;6134.914129196095;6139.7022084541895;6155.84610384744;5793.768249269982;5829.183914252093;5889.793857214977;5911.940880591139;5961.225040744675 06:37:52 INFO - PROCESS | 1659 | |1;ext.html;485.76683192067804;516.617702899854;531.1793279383353;543.0334005470262;561.7556362982101;27424.451510969793;32562.67437325626;40862;41035.38446923299;41957.160856782844;43564.564354356444;43894;43922.68231953047;43966.340504892454;44051.77974110125;9725.0761177688;9918.05778451046;9925.75185620358;9926.553305101288;9930.65242716505;8839;9042.909570904272;11868.525258989674;12135;12170.81743773844;12136.878631213664;12171.269723816555;12227.205231659958;12240;12272.693182670415;8751.518666473341;8955.641774329019;12042.69893252667;12127.454264558117;12143.757124857497;8880.467171969702;8957.37298389113;11615;11947.880521194764;11949.64151075469;40756.79621601903;41031.179376412605;41049.38425923613;41109.588904110875;41195.7940210297;3482.495038219444;3662.688671462929;3669.6697297243377;3704.9073773155887;4268.253055715238;27744.445111097866;32428.675713242803;32528.512072318936;32750.672493275;33150.33699326024;3254.479283314682;3261.24991252011;3268.9836550817095;3276;3377.7297816174646;485499;487050.56474717753;487718.99999999645;487769;488403;61545;61930;61940.69029654823;62125;62135.689321554004;64401.677991609744;64401.677991609744;64501;64611.67694161593;64652.35347646557;16380.0171989681;16926.492205233862;16939.322427103023;16968.89702169355;16970.745438818427;11742.765144697229;12899.097063205485;13045.086843920835;13116.213027218397;13215.876650484817;15842.52472425829;16599.170041497877;16691.582710432336;16698;16718.99686018843;6588.439982601532;6645.607581270739;6657.167854018247;6663.167104111986;6737.562058466184;904;926.2173463423396;947.4457442396275;1085.5223701571283;1088.7876864011441;30363.544546831814;30391.69608303933;30635.540466893013;31124.844375777975;31228.843855780575;1107.1585594947899;1109.545086514525;1116.6203490813;1126.4649291586431;1158.0793269350886;15791.842081579267;15892.364305427885;15971.600709982344;16357.34570617162;16358.918205408896;679202;682432;683421;684116;685540;60111.69944150251;60359;60442.697786510784;60487.69756151191;60506.697466512385;1267.7401132767761;1387.5837248825515;1390.3743315508061;1398.923059231752;1424.423108641002;32011.35977280488;32228.35543289168;32447;32471;33194;50428;51225.23162152645;51258.23112653388;51301.48698512967;51429.742851285504;474004;490793;490858.0028098346;491465;492628;26753.732462675125;27474.725252747216;27586.586201206595;27836.30409239785;40785.79607101945;49355.50644493509;49959.750201250215;50432.74783626058;50687.746561266955;51167;40822;41218.58781412148;41447.792761037206;41939.7903010483;42189.57810421856;40444.595554044085;40545.797271013456;40945.385819213334;41899.58100418957;41943.580564193966;38837;39423.605763941996;39764.2047159061;39872.00319992023;40106.598934011454;31452.05643830689;35241.82379088191;35713;35991.82004089963;36003;25411.491770164863;25655;25796.09713660013;25934.74065259323;26172.60741088923 06:37:52 INFO - PROCESS | 1659 | |2;jquery.html;353.24229527663147;376.3395241351428;378.60246740922025;382.3385543010593;403.4210907347956;15062.92468537657;15169.544913652595;20635.2777652782;21719.67420488694;21787.891060544716;21367.786322136773;21645.891770541126;22152.446188845286;22339.553208935853;22428.102875884986;5401.918971215435;5891.675957822329;6015.548833837458;6045.879082418371;6079.513638908877;5960.344362120163;5963;6015.819525414245;6018.127371531125;6021.187139736124;5771.192033115367;5870.559708021894;5880.55895807814;5884.6174998625165;5917.585768996172;5218.191180367068;5736.225609542721;5770.221020162308;5792.362840087587;5892.528597712194;4749.833755818564;4936.136176169192;5139.768710408003;5184.144616138333;5188.688678679291;26680.59979100315;26682.5997610036;26835.46329073427;26969.865150674123;27027.86486067557;2066.73132492775;2309.2379514760255;2551.9106831260815;2559.4753075619456;3018.335966087457;15355.769663455058;15447.53657390269;15656.530304090895;15859;15897.28462219203;1839.760831091963;1864.4686264414577;1876.6622008038548;1888.7733471983313;1939.185542072333;103609.48195258975;111401;112331.43834280859;122327.38836305762;122648.77351226463;11277.605283815026;11725.941370293265;11793.054146065802;11937.820932686016;11957.940210298893;14816.96281260323;14852.2573871306;14865.628359291104;14874.107553546823;14880.553583392515;8551.315894728406;8692.565371731389;8716.346274029473;8781.560921953876;8797.868031979526;7725.845483090419;8246.05170405399;8713;8837.337199710048;8858.29133669305;4584.564466375689;4600.5169457207185;4600.930986035212;4601.401817763669;4656.092062047868;1887.37716553537;1919.9136038878285;1921.8558608104447;1923.5479662279354;1925.913333899978;848.5375470368664;861.9353548483889;900.2482926756232;1020.7805321855836;1044.4203467075845;21890.781092189194;22440.77559224387;22587.774122258896;22607.208747693752;22630.207942721925;935.9391639543408;956.9425834449955;1005.7385079879284;1038.5897570459626;1063.8191507443598;11289.774204515863;11662.358570278546;11787.528498860122;11822.172447928562;11894.048476121889;264224;353704;593872;618652;620453;81260;105734.48389644969;109590.45204773925;136115;137777.00226836462;980.6959842448864;994.6767300627181;1020.2501161646333;1029.9794004119876;1030.4744580263969;17939.910300448413;19876;19901.900490497454;20141.79858201399;20146.697799532725;47354.52645473639;50507;51029.74485127551;56175;56258.43741562532;78274.6086269565;84337;87229;88463;92115;8020.518768873886;8024.157463466252;8053.959730201312;8201.30288925448;8278.296344810758;11955.820662690241;12465.065120116209;12569;12801.551945681857;12884;10837.945810271214;11006.284591501526;11131.053860421955;11168.776624467628;11178;10989.395583242998;10992.505337259683;11082.859706850199;11167.441627918734;11229;9515.286353523652;11224.158188136085;11239.381833999209;11468.885311146782;11512.445819814553;8010.599470026592;8140.145284745016;8184.181581841768;8280.71017514384;8317.584120794058;6382.87234255303;10879.691973147299;11422.657320280405;11460;11641.359725215194 06:37:52 INFO - PROCESS | 1659 | |3;mootools.html;1533.7622668486385;1582.0112429731416;1706.4454052432961;1759.1556053094514;1899.6010837724068;8401.201885820845;8651.956740216307;8817.823643527126;8827.426217295879;8837.91162088379;6638.60168389897;8026.919730802705;8355.248027677522;8607.569621518931;8618.353623478248;2369.7156341239074;2398.0767404549288;2398.628212627037;2402.5555272274687;2407.9759202408013;2325.7557956414585;2346.671465994762;2399.5440866235444;2400.7719266669724;2401.087586717054;2085.4160834966233;2172.0985790896757;2173.978260217393;2179.095675294751;2180.2805074325433;2151.268568686646;2294.472271377576;2382.321038504018;2382.4758553118286;2389.104085967762;2331.5336932613545;2356.22244659262;2359.068168073601;2359.8112151027876;2368.029108065702;8638.265747411477;8716.041235464094;8717.389782715212;8718.215360617574;8719.346049046284;5153.484651534854;5238.109521381374;5275.630705850592;5293.9735301323635;5306.151015837486;3513.7013353864954;3636.709063274932;3637.254362855608;3651.4887915691825;3704.129529560551;1047.9738006549821;1077.7844431113808;1101.2566517600667;1106.2311693373108;1107.1087774341652;11426.542938282459;11430.971212590823;11442.885571144348;11444.828327575093;11449;4089.4683691119963;4467.553244675506;4595.195840727859;4733.455652599995;4743.739094349775;9682.854757178648;9718.979507151647;9719.708408747749;9727.319087663936;9730.464824434583;5286.101362768339;5288.206768984606;5290.206469029677;5294.179402192666;5298.231756395301;4511.255642818964;4819.445763737215;4832.734199618984;4847.80608775652;4861.708297502161;3892.6691231245095;3906.7069969752383;3926.764394136361;3985.103351745892;4006.579309172553;1256.8994480441543;1264.1151194163938;1274.4137696659454;1277.0932637827061;1278.2586100061942;837.3803385494812;877.9473231606124;882.4131952251809;926.578406824893;961.5384615384654;5969.432903874125;6003.819885403357;6015.909761353583;6058.969705151446;6089.665068421279;917.3165991336364;930.5905401623264;941.0072373645869;964.9083337082966;966.3332300712486;3664.76179048361;4054;4101.077257617072;4117.238310912491;4122.3404255319;10314.638987635397;10440.477976101165;10750.78498430027;10789.62236321725;10793.83809242862;10142;10806.78386432267;10808.405537695502;10817.945910270399;10854.945725271482;8068.1528439513;8139.941807565097;8278.586070696441;8300.667973281123;8339.457935234312;5862.208601838697;5912.70436478183;5973.880522389615;5988.251468566429;6035.5473339500595;9582;9914.652987145704;9918.801623967625;10047.849282260626;10054.447005414773;9665.90334096678;10158.39049657023;10295.742606434898;10320.845187322346;10322.2258330624;5869.53043756507;7560.432967527568;7575.621218939141;7592.392608591189;7616.124145723091;8138.755837324889;8273.793155171168;8277.461964972257;8280.751577452686;8289.295409890226;7204.963975180301;7465.06686664167;7536.0956685198125;7603.467757256939;7673.61631918413;6338.049292605961;6693.828579998578;7269.818254543678;7482.887756683545;7493.213212612815;6713.12729345182;7039.366457018893;7047.224805271314;7048.823779405556;7061.082059332254;4882.7314497701545;5050.065737838511;5051.701316666844;5096.464871188472;5118.027574760784;5023.2214006829;5039.118154323052;5044.873878152929;5091.312672789274;5237.057329680694 06:37:52 INFO - PROCESS | 1659 | |4;prototype.html;285.16873314288824;297.8808476609356;303.2933265491405;314.30068098480876;317.4428877320303;4786.353842231298;5077.238414237866;5133.409657889344;5259.447757985409;5296.496832800887;4614.492405835355;4799.640026997971;5285.8942821143555;5299.60252981026;5308.177232528955;3323.667633236681;4049.230646177224;4049.858254961077;4060.9187816243657;4119.526254480743;3641.726870484711;3796;3915.668672651298;3919.568847426781;3945.684345252387;3507.45634426663;3841.5774264830848;3989.7831161495733;4008.779517126557;4032.9798351008203;3338.6327503974667;3889.4165875118674;4040.878773636796;4040.919181616351;4070.310821009278;3265.762952377629;3488.790672559629;3494.5322964354777;3499.7375196860085;3510.8946731598094;5157.30376399185;5165.225216217597;5168.793248270064;5213.2701421800975;5262.500062494057;3762.6801721853676;3876.5541962674088;4559.99680070384;4595.517470665565;4596.54034596541;5299.986005317993;5601.915971260434;5624.634398764068;5665.773369065232;5687.317521897357;3137.7646676499353;3156.352947645727;3362.411577973845;3825.6556909878245;3842.2507611015862;5065.544101030925;5845.473907348317;5847.8245652630485;5889.7644094236175;5905.43898329658;3270.672932706758;3614.674679278825;3640.0535860676414;3884.4950156479476;3886.8639597613947;3725.2549490102087;3730.2539492101687;3744.700423966076;3947.210557888434;3960.881173564798;3942.4874766280773;4459.264221403497;4612.362611273017;4652.95347046532;4660.6970546914345;5595.804146854841;5598.544378461548;5603.159526071122;5633.774649014075;5694.914576281359;1154.2093665838927;1343.40890008396;1393.038803225771;1393.2406838273166;1394.198335956829;858.8110615664543;870.8737233101292;872.5724395046509;874.0691163910415;879.3361012435698;3815.828287727059;3907.1013666856784;4348.782560871944;4395.7142785718825;4415.470143582791;4812.0165497391845;4824.975875120672;4871.95128048715;4926;4943.505649435099;4180.47744031996;4272.957270427256;4374.628156606724;4422.955770442254;5341.412444631087;2898.7246211609863;2941.6175897133235;3045.25391279138;3085.2749603843527;3104.9068527944196;5013.448520662724;5019.623528235324;5965.850853728604;5984.640921544721;6039.188243526924;5718.828435146952;5858.238429004202;5923.703814809242;5927.377625349276;5931.466168044896;5046.66263440196;5175.844724658191;5875.236219291465;5896.260603122089;5914.792982245601;4554.8861278466975;4797.784099715591;5527.50252477279;5741.540676745767;5798.5651076168615;4698.718076915396;5532.186997312203;5560.555155587463;5697;5705.885882282248;5172.327597412313;5876.911846322394;5883.558733094949;5900.793472228452;5900.881982360414;3227.8224697641854;3609.801460919675;3837.366834472281;3840.30874442603;3936.685065194835;5325.786968521215;5416.593755468277;5572.219889215432;5620.522255608319;5703.8859222816145;5350.678959262456;5468.4531546845;5479.3424789023975;5495.203195536545;5613.410591887793;5191.454897235736;5495.120780675233;5586.050371436947;5603.271574695264;5618.831435056954;4267.76527291002;4576.679632425831;5537.529310008695;5608.411116832837;5662;5146.459621739813;5246.790128394821;5566.944330556643;5624.521915637217;5630.549556035426;5355.30381050461;5517.668939863621;5533.363663178786;5544.251526044094;5546 06:37:52 INFO - PROCESS | 1659 | |5;yui.html;726.7601691441824;777.6772639354665;810.9229623185795;834.5910503853106;853.9146085391461;14907.925460372697;16261.593460163502;16314.918425407872;16316;16350.83649163508;14736.6315842104;14897.702045959102;14944.925275373607;14955.252237388115;14966.32651530681;707.794739525537;734.7869117955786;875.8905136857893;907.4782000349792;910.3809409601469;703.451307979774;704.2007321689894;706.5866468116159;707.0348973650955;883.1389395339556;955.1117460761488;959.5058544849409;961.1013702188441;961.7739831139677;964.8504481805331;935.1957316707626;952.4618590496348;954.9045095490465;955.7132860141999;956.7321150077989;554.3126523111354;691.405391363427;711.8967749676268;713.8251128473557;715.3204455767042;15070.321835517429;15293.694126117527;15296.847031529653;15311.693766124727;15320.616984575363;14148.504802331972;14534.854651453456;14617;14647.194404307758;14666.340014699364;11414.88585114155;11429.42852857362;11487.597934072352;11619.302841829433;11793.705157371049;4578.45058592971;4621.075784843011;4753.096911586822;4766.618670506351;4767.356406885096;117605;118751.4062429691;118758;121108;125180.4963900726;11523.098688716436;11534.423278836024;11604.593839215588;11752.412379381169;11952.983996360406;22671.319860404215;22823.31530054101;22918.19786307471;22968.4257893554;23160.073597056267;7623.199564045806;7813;8117.514484876976;8138.064122625974;8156.306713929383;4172.874813755592;4246.766427846436;4319.546447623017;4462.576055274743;4469.754163521037;3490.336836001152;3598.298331825269;3599.352116618981;3604.459331100356;3606.6573675500786;632.5603705424778;646.4957333279955;650.2911826109469;655.354475841296;668.4284936379423;518.2226660009985;555.2892297858747;581.7695573861253;626.2391194698372;632.1466020871786;7697.191794861571;7914.762557123296;8188.181181881764;8998.190162885372;9096.772580685403;597.1908064572528;622.6170904893548;622.7135517661835;627.3068259573106;639.5043841023152;4023.8591649292134;4124.029771927882;4176.4570605821045;4349.195398851222;4462.821487140543;127708;129613.35193323973;133440.99838502432;164283;167827.16086419733;118519;119638;120285.39857300658;122746;124878;80275.57106503734;95869.5619565707;105167.94832051735;110815.44592276987;118744;8463.873041904253;9931.801363972825;9998.300118991601;10115.89884101179;10185.949070254897;61158.38841611705;61972.69013654903;63705;63925.72148557096;64040.67979660072;98366.01633983568;100270.99729002909;100465.49301760334;101019;104188.47905760423;13140;13345.733085338044;13357.933210333886;13639;13897.722045559234;15114.773278401053;15171.24143792828;15242.466513671969;15380.769288460458;15607;14061.789073163705;14161.787573186617;14271.215083170526;14320.928395357956;14546.418143274574;12115.515379384726;14086.577402677936;14259.42962281497;14349.067310624776;14977.625559361104;11839.489483519446;11975.401229938294;12077.456514457046;12083.818742718691;12121.333326666765;9433.540927474545;11298.322100673986;11535.307881527135;11669.183157179255;11776.88223117792;11200;11259.297510402392;11342.262752921033;11502.88497115018;11643.825342620037 06:37:52 INFO - PROCESS | 1659 | __end_tp_report 06:37:52 INFO - PROCESS | 1659 | __start_cc_report 06:37:52 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1248 06:37:52 INFO - PROCESS | 1659 | __end_cc_report 06:37:52 INFO - PROCESS | 1659 | __startTimestamp1468849072720__endTimestamp 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | ------- Summary: start ------- 06:37:52 INFO - PROCESS | 1659 | Number of tests: 6 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5736.78 Median:5920.44 stddev:631.61 (10.7%) stddev-sans-first:604.58 06:37:52 INFO - PROCESS | 1659 | Values: 3326.1 3346.8 3375.2 3376.6 3377.1 5539.5 5599.0 5603.5 5668.2 5687.1 5623.9 5700.6 5714.8 5720.8 5728.2 5193.2 5212.5 5214.6 5240.6 5299.7 5289.0 5296.2 5298.5 5299.0 5307.2 5199.6 5206.1 5206.2 5225.2 5283.7 5301.2 5309.8 5330.7 5352.5 5378.2 5078.4 5103.2 5141.9 5159.7 5175.5 5575.3 5647.7 5682.5 5708.7 5748.0 6245.1 6270.0 6289.0 6302.0 6304.7 6156.9 6201.2 6231.4 6280.8 6309.2 5748.6 5796.9 5822.9 5910.3 5914.2 6256.6 6256.7 6264.4 6268.9 6270.3 5963.8 6018.3 6064.5 6068.2 6125.1 6152.8 6236.9 6303.1 6322.1 6338.7 6201.0 6272.3 6272.5 6277.0 6299.7 6078.7 6101.8 6145.9 6175.9 6217.8 4944.1 4951.1 4992.6 5002.9 5012.1 4363.7 4364.5 4369.1 4401.6 4479.9 5642.5 5683.6 5790.9 5808.8 5843.4 6101.1 6119.8 6184.9 6209.6 6251.9 5658.9 5712.1 5771.9 5793.7 5794.2 5407.1 5485.2 5492.7 5494.3 5496.7 6130.9 6170.3 6204.5 6214.5 6281.7 6284.9 6285.0 6291.2 6299.6 6300.6 6178.6 6233.7 6258.4 6273.2 6324.8 5965.5 6008.7 6115.6 6155.0 6159.0 6210.8 6228.3 6256.6 6273.8 6317.6 5944.9 5968.8 6113.0 6140.6 6180.4 5851.6 5862.1 5920.4 6075.1 6123.2 4676.4 5920.9 6055.3 6059.6 6086.1 6013.4 6125.4 6134.9 6139.7 6155.8 5793.8 5829.2 5889.8 5911.9 5961.2 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:69734.52 Median:40275.60 stddev:149599.08 (371.4%) stddev-sans-first:149928.39 06:37:52 INFO - PROCESS | 1659 | Values: 485.8 516.6 531.2 543.0 561.8 27424.5 32562.7 40862.0 41035.4 41957.2 43564.6 43894.0 43922.7 43966.3 44051.8 9725.1 9918.1 9925.8 9926.6 9930.7 8839.0 9042.9 11868.5 12135.0 12170.8 12136.9 12171.3 12227.2 12240.0 12272.7 8751.5 8955.6 12042.7 12127.5 12143.8 8880.5 8957.4 11615.0 11947.9 11949.6 40756.8 41031.2 41049.4 41109.6 41195.8 3482.5 3662.7 3669.7 3704.9 4268.3 27744.4 32428.7 32528.5 32750.7 33150.3 3254.5 3261.2 3269.0 3276.0 3377.7 485499.0 487050.6 487719.0 487769.0 488403.0 61545.0 61930.0 61940.7 62125.0 62135.7 64401.7 64401.7 64501.0 64611.7 64652.4 16380.0 16926.5 16939.3 16968.9 16970.7 11742.8 12899.1 13045.1 13116.2 13215.9 15842.5 16599.2 16691.6 16698.0 16719.0 6588.4 6645.6 6657.2 6663.2 6737.6 904.0 926.2 947.4 1085.5 1088.8 30363.5 30391.7 30635.5 31124.8 31228.8 1107.2 1109.5 1116.6 1126.5 1158.1 15791.8 15892.4 15971.6 16357.3 16358.9 679202.0 682432.0 683421.0 684116.0 685540.0 60111.7 60359.0 60442.7 60487.7 60506.7 1267.7 1387.6 1390.4 1398.9 1424.4 32011.4 32228.4 32447.0 32471.0 33194.0 50428.0 51225.2 51258.2 51301.5 51429.7 474004.0 490793.0 490858.0 491465.0 492628.0 26753.7 27474.7 27586.6 27836.3 40785.8 49355.5 49959.8 50432.7 50687.7 51167.0 40822.0 41218.6 41447.8 41939.8 42189.6 40444.6 40545.8 40945.4 41899.6 41943.6 38837.0 39423.6 39764.2 39872.0 40106.6 31452.1 35241.8 35713.0 35991.8 36003.0 25411.5 25655.0 25796.1 25934.7 26172.6 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:32027.29 Median:12469.72 stddev:86398.70 (692.9%) stddev-sans-first:86608.34 06:37:52 INFO - PROCESS | 1659 | Values: 353.2 376.3 378.6 382.3 403.4 15062.9 15169.5 20635.3 21719.7 21787.9 21367.8 21645.9 22152.4 22339.6 22428.1 5401.9 5891.7 6015.5 6045.9 6079.5 5960.3 5963.0 6015.8 6018.1 6021.2 5771.2 5870.6 5880.6 5884.6 5917.6 5218.2 5736.2 5770.2 5792.4 5892.5 4749.8 4936.1 5139.8 5184.1 5188.7 26680.6 26682.6 26835.5 26969.9 27027.9 2066.7 2309.2 2551.9 2559.5 3018.3 15355.8 15447.5 15656.5 15859.0 15897.3 1839.8 1864.5 1876.7 1888.8 1939.2 103609.5 111401.0 112331.4 122327.4 122648.8 11277.6 11725.9 11793.1 11937.8 11957.9 14817.0 14852.3 14865.6 14874.1 14880.6 8551.3 8692.6 8716.3 8781.6 8797.9 7725.8 8246.1 8713.0 8837.3 8858.3 4584.6 4600.5 4600.9 4601.4 4656.1 1887.4 1919.9 1921.9 1923.5 1925.9 848.5 861.9 900.2 1020.8 1044.4 21890.8 22440.8 22587.8 22607.2 22630.2 935.9 956.9 1005.7 1038.6 1063.8 11289.8 11662.4 11787.5 11822.2 11894.0 264224.0 353704.0 593872.0 618652.0 620453.0 81260.0 105734.5 109590.5 136115.0 137777.0 980.7 994.7 1020.3 1030.0 1030.5 17939.9 19876.0 19901.9 20141.8 20146.7 47354.5 50507.0 51029.7 56175.0 56258.4 78274.6 84337.0 87229.0 88463.0 92115.0 8020.5 8024.2 8054.0 8201.3 8278.3 11955.8 12465.1 12569.0 12801.6 12884.0 10837.9 11006.3 11131.1 11168.8 11178.0 10989.4 10992.5 11082.9 11167.4 11229.0 9515.3 11224.2 11239.4 11468.9 11512.4 8010.6 8140.1 8184.2 8280.7 8317.6 6382.9 10879.7 11422.7 11460.0 11641.4 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5674.02 Median:5050.88 stddev:3155.10 (62.5%) stddev-sans-first:3148.61 06:37:52 INFO - PROCESS | 1659 | Values: 1533.8 1582.0 1706.4 1759.2 1899.6 8401.2 8652.0 8817.8 8827.4 8837.9 6638.6 8026.9 8355.2 8607.6 8618.4 2369.7 2398.1 2398.6 2402.6 2408.0 2325.8 2346.7 2399.5 2400.8 2401.1 2085.4 2172.1 2174.0 2179.1 2180.3 2151.3 2294.5 2382.3 2382.5 2389.1 2331.5 2356.2 2359.1 2359.8 2368.0 8638.3 8716.0 8717.4 8718.2 8719.3 5153.5 5238.1 5275.6 5294.0 5306.2 3513.7 3636.7 3637.3 3651.5 3704.1 1048.0 1077.8 1101.3 1106.2 1107.1 11426.5 11431.0 11442.9 11444.8 11449.0 4089.5 4467.6 4595.2 4733.5 4743.7 9682.9 9719.0 9719.7 9727.3 9730.5 5286.1 5288.2 5290.2 5294.2 5298.2 4511.3 4819.4 4832.7 4847.8 4861.7 3892.7 3906.7 3926.8 3985.1 4006.6 1256.9 1264.1 1274.4 1277.1 1278.3 837.4 877.9 882.4 926.6 961.5 5969.4 6003.8 6015.9 6059.0 6089.7 917.3 930.6 941.0 964.9 966.3 3664.8 4054.0 4101.1 4117.2 4122.3 10314.6 10440.5 10750.8 10789.6 10793.8 10142.0 10806.8 10808.4 10817.9 10854.9 8068.2 8139.9 8278.6 8300.7 8339.5 5862.2 5912.7 5973.9 5988.3 6035.5 9582.0 9914.7 9918.8 10047.8 10054.4 9665.9 10158.4 10295.7 10320.8 10322.2 5869.5 7560.4 7575.6 7592.4 7616.1 8138.8 8273.8 8277.5 8280.8 8289.3 7205.0 7465.1 7536.1 7603.5 7673.6 6338.0 6693.8 7269.8 7482.9 7493.2 6713.1 7039.4 7047.2 7048.8 7061.1 4882.7 5050.1 5051.7 5096.5 5118.0 5023.2 5039.1 5044.9 5091.3 5237.1 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4439.76 Median:4934.75 stddev:1387.05 (28.1%) stddev-sans-first:1355.44 06:37:52 INFO - PROCESS | 1659 | Values: 285.2 297.9 303.3 314.3 317.4 4786.4 5077.2 5133.4 5259.4 5296.5 4614.5 4799.6 5285.9 5299.6 5308.2 3323.7 4049.2 4049.9 4060.9 4119.5 3641.7 3796.0 3915.7 3919.6 3945.7 3507.5 3841.6 3989.8 4008.8 4033.0 3338.6 3889.4 4040.9 4040.9 4070.3 3265.8 3488.8 3494.5 3499.7 3510.9 5157.3 5165.2 5168.8 5213.3 5262.5 3762.7 3876.6 4560.0 4595.5 4596.5 5300.0 5601.9 5624.6 5665.8 5687.3 3137.8 3156.4 3362.4 3825.7 3842.3 5065.5 5845.5 5847.8 5889.8 5905.4 3270.7 3614.7 3640.1 3884.5 3886.9 3725.3 3730.3 3744.7 3947.2 3960.9 3942.5 4459.3 4612.4 4653.0 4660.7 5595.8 5598.5 5603.2 5633.8 5694.9 1154.2 1343.4 1393.0 1393.2 1394.2 858.8 870.9 872.6 874.1 879.3 3815.8 3907.1 4348.8 4395.7 4415.5 4812.0 4825.0 4872.0 4926.0 4943.5 4180.5 4273.0 4374.6 4423.0 5341.4 2898.7 2941.6 3045.3 3085.3 3104.9 5013.4 5019.6 5965.9 5984.6 6039.2 5718.8 5858.2 5923.7 5927.4 5931.5 5046.7 5175.8 5875.2 5896.3 5914.8 4554.9 4797.8 5527.5 5741.5 5798.6 4698.7 5532.2 5560.6 5697.0 5705.9 5172.3 5876.9 5883.6 5900.8 5900.9 3227.8 3609.8 3837.4 3840.3 3936.7 5325.8 5416.6 5572.2 5620.5 5703.9 5350.7 5468.5 5479.3 5495.2 5613.4 5191.5 5495.1 5586.1 5603.3 5618.8 4267.8 4576.7 5537.5 5608.4 5662.0 5146.5 5246.8 5566.9 5624.5 5630.5 5355.3 5517.7 5533.4 5544.3 5546.0 06:37:52 INFO - PROCESS | 1659 | 06:37:52 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:25005.80 Median:22943.31 stddev:39505.29 (172.2%) stddev-sans-first:39574.05 06:37:52 INFO - PROCESS | 1659 | Values: 726.8 777.7 810.9 834.6 853.9 14907.9 16261.6 16314.9 16316.0 16350.8 14736.6 14897.7 14944.9 14955.3 14966.3 707.8 734.8 875.9 907.5 910.4 703.5 704.2 706.6 707.0 883.1 955.1 959.5 961.1 961.8 964.9 935.2 952.5 954.9 955.7 956.7 554.3 691.4 711.9 713.8 715.3 15070.3 15293.7 15296.8 15311.7 15320.6 14148.5 14534.9 14617.0 14647.2 14666.3 11414.9 11429.4 11487.6 11619.3 11793.7 4578.5 4621.1 4753.1 4766.6 4767.4 117605.0 118751.4 118758.0 121108.0 125180.5 11523.1 11534.4 11604.6 11752.4 11953.0 22671.3 22823.3 22918.2 22968.4 23160.1 7623.2 7813.0 8117.5 8138.1 8156.3 4172.9 4246.8 4319.5 4462.6 4469.8 3490.3 3598.3 3599.4 3604.5 3606.7 632.6 646.5 650.3 655.4 668.4 518.2 555.3 581.8 626.2 632.1 7697.2 7914.8 8188.2 8998.2 9096.8 597.2 622.6 622.7 627.3 639.5 4023.9 4124.0 4176.5 4349.2 4462.8 127708.0 129613.4 133441.0 164283.0 167827.2 118519.0 119638.0 120285.4 122746.0 124878.0 80275.6 95869.6 105167.9 110815.4 118744.0 8463.9 9931.8 9998.3 10115.9 10185.9 61158.4 61972.7 63705.0 63925.7 64040.7 98366.0 100271.0 100465.5 101019.0 104188.5 13140.0 13345.7 13357.9 13639.0 13897.7 15114.8 15171.2 15242.5 15380.8 15607.0 14061.8 14161.8 14271.2 14320.9 14546.4 12115.5 14086.6 14259.4 14349.1 14977.6 11839.5 11975.4 12077.5 12083.8 12121.3 9433.5 11298.3 11535.3 11669.2 11776.9 11200.0 11259.3 11342.3 11502.9 11643.8 06:37:52 INFO - PROCESS | 1659 | -------- Summary: end -------- 06:37:52 INFO - PROCESS | 1659 | 06:37:53 INFO - TEST-INFO | 1659: exit 0 06:37:53 INFO - TEST-OK | dromaeo_css | took 1117151ms 06:37:53 INFO - TEST-START | kraken 06:37:53 INFO - operating with platform_type : mac_ 06:37:53 INFO - Initialising browser for kraken test... 06:37:53 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpi196fd/profile http://localhost:49272/getInfo.html) 06:37:55 INFO - PROCESS | 1666 | JavaScript error: , line 0: uncaught exception: undefined 06:37:55 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 06:37:55 INFO - PROCESS | 1666 | colorDepth:24 06:37:55 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 06:37:55 INFO - PROCESS | 1666 | __metrics 06:37:56 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:37:56 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:37:56 INFO - TEST-INFO | 1666: exit 0 06:37:56 INFO - Browser initialized. 06:37:56 INFO - Running cycle 1/1 for kraken test... 06:37:56 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpi196fd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:08 INFO - PROCESS | 1668 | RSS: Main: 245293056 06:38:08 INFO - PROCESS | 1668 | 06:38:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:12 INFO - PROCESS | 1668 | RSS: Main: 294371328 06:38:12 INFO - PROCESS | 1668 | 06:38:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 06:38:15 INFO - PROCESS | 1668 | RSS: Main: 305782784 06:38:15 INFO - PROCESS | 1668 | 06:38:19 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 06:38:19 INFO - PROCESS | 1668 | RSS: Main: 389812224 06:38:19 INFO - PROCESS | 1668 | 06:38:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 06:38:22 INFO - PROCESS | 1668 | RSS: Main: 291471360 06:38:22 INFO - PROCESS | 1668 | 06:38:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:25 INFO - PROCESS | 1668 | RSS: Main: 295636992 06:38:25 INFO - PROCESS | 1668 | 06:38:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:28 INFO - PROCESS | 1668 | RSS: Main: 333160448 06:38:28 INFO - PROCESS | 1668 | 06:38:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:31 INFO - PROCESS | 1668 | RSS: Main: 334897152 06:38:31 INFO - PROCESS | 1668 | 06:38:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 06:38:35 INFO - PROCESS | 1668 | RSS: Main: 333590528 06:38:35 INFO - PROCESS | 1668 | 06:38:36 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:37 INFO - PROCESS | 1668 | RSS: Main: 311894016 06:38:37 INFO - PROCESS | 1668 | 06:38:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:39 INFO - PROCESS | 1668 | RSS: Main: 319029248 06:38:39 INFO - PROCESS | 1668 | 06:38:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:42 INFO - PROCESS | 1668 | RSS: Main: 316379136 06:38:42 INFO - PROCESS | 1668 | 06:38:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:46 INFO - PROCESS | 1668 | RSS: Main: 325017600 06:38:46 INFO - PROCESS | 1668 | 06:38:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:49 INFO - PROCESS | 1668 | RSS: Main: 327602176 06:38:49 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 06:38:51 INFO - PROCESS | 1668 | RSS: Main: 371597312 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | __start_tp_report 06:38:51 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 06:38:51 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 06:38:51 INFO - PROCESS | 1668 | |i|pagename|runs| 06:38:51 INFO - PROCESS | 1668 | |0;ai-astar;101;112;112;111;113;112;112;116;147;112 06:38:51 INFO - PROCESS | 1668 | |1;audio-beat-detection;141;109;107;157;108;107;134;104;142;107 06:38:51 INFO - PROCESS | 1668 | |2;audio-dft;185;184;184;183;184;180;175;184;183;183 06:38:51 INFO - PROCESS | 1668 | |3;audio-fft;79;57;57;106;56;57;61;64;86;74 06:38:51 INFO - PROCESS | 1668 | |4;audio-oscillator;81;69;92;69;77;68;97;70;68;102 06:38:51 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;89;85;89;85;90;88;89;86;89;85 06:38:51 INFO - PROCESS | 1668 | |6;imaging-darkroom;94;94;95;94;94;94;95;95;94;95 06:38:51 INFO - PROCESS | 1668 | |7;imaging-desaturate;84;85;84;86;84;81;84;86;86;94 06:38:51 INFO - PROCESS | 1668 | |8;json-parse-financial;55;55;53;53;53;52;53;53;52;53 06:38:51 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;67;69;78;77;73;72;71;72;72;72 06:38:51 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;83;82;102;82;82;82;80;81;83;83 06:38:51 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;136;134;134;135;132;133;132;137;229;141 06:38:51 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;160;164;162;164;161;161;161;161;162;160 06:38:51 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;66;67;67;65;63;65;66;62;66;66 06:38:51 INFO - PROCESS | 1668 | __end_tp_report 06:38:51 INFO - PROCESS | 1668 | __start_cc_report 06:38:51 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2072 06:38:51 INFO - PROCESS | 1668 | __end_cc_report 06:38:51 INFO - PROCESS | 1668 | __startTimestamp1468849131711__endTimestamp 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | ------- Summary: start ------- 06:38:51 INFO - PROCESS | 1668 | Number of tests: 14 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:114.80 Median:112.00 stddev:11.95 (10.7%) stddev-sans-first:11.59 06:38:51 INFO - PROCESS | 1668 | Values: 101.0 112.0 112.0 111.0 113.0 112.0 112.0 116.0 147.0 112.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:121.50 stddev:19.70 (16.2%) stddev-sans-first:19.60 06:38:51 INFO - PROCESS | 1668 | Values: 141.0 109.0 107.0 157.0 108.0 107.0 134.0 104.0 142.0 107.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:182.50 Median:184.00 stddev:2.95 (1.6%) stddev-sans-first:2.99 06:38:51 INFO - PROCESS | 1668 | Values: 185.0 184.0 184.0 183.0 184.0 180.0 175.0 184.0 183.0 183.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:69.70 Median:62.50 stddev:16.56 (26.5%) stddev-sans-first:17.22 06:38:51 INFO - PROCESS | 1668 | Values: 79.0 57.0 57.0 106.0 56.0 57.0 61.0 64.0 86.0 74.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:73.50 stddev:13.13 (17.9%) stddev-sans-first:13.91 06:38:51 INFO - PROCESS | 1668 | Values: 81.0 69.0 92.0 69.0 77.0 68.0 97.0 70.0 68.0 102.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:89.00 stddev:2.01 (2.3%) stddev-sans-first:2.06 06:38:51 INFO - PROCESS | 1668 | Values: 89.0 85.0 89.0 85.0 90.0 88.0 89.0 86.0 89.0 85.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:38:51 INFO - PROCESS | 1668 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:3.37 (3.9%) stddev-sans-first:3.54 06:38:51 INFO - PROCESS | 1668 | Values: 84.0 85.0 84.0 86.0 84.0 81.0 84.0 86.0 86.0 94.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.03 (1.9%) stddev-sans-first:0.87 06:38:51 INFO - PROCESS | 1668 | Values: 55.0 55.0 53.0 53.0 53.0 52.0 53.0 53.0 52.0 53.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.00 stddev:3.27 (4.5%) stddev-sans-first:2.85 06:38:51 INFO - PROCESS | 1668 | Values: 67.0 69.0 78.0 77.0 73.0 72.0 71.0 72.0 72.0 72.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.00 stddev:6.39 (7.8%) stddev-sans-first:6.77 06:38:51 INFO - PROCESS | 1668 | Values: 83.0 82.0 102.0 82.0 82.0 82.0 80.0 81.0 83.0 83.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:135.50 stddev:29.88 (22.1%) stddev-sans-first:31.54 06:38:51 INFO - PROCESS | 1668 | Values: 136.0 134.0 134.0 135.0 132.0 133.0 132.0 137.0 229.0 141.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.39 06:38:51 INFO - PROCESS | 1668 | Values: 160.0 164.0 162.0 164.0 161.0 161.0 161.0 161.0 162.0 160.0 06:38:51 INFO - PROCESS | 1668 | 06:38:51 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:1.64 (2.5%) stddev-sans-first:1.72 06:38:51 INFO - PROCESS | 1668 | Values: 66.0 67.0 67.0 65.0 63.0 65.0 66.0 62.0 66.0 66.0 06:38:51 INFO - PROCESS | 1668 | -------- Summary: end -------- 06:38:51 INFO - PROCESS | 1668 | 06:38:52 INFO - TEST-INFO | 1668: exit 0 06:38:52 INFO - TEST-OK | kraken | took 59225ms 06:38:52 INFO - SUITE-END | took 1176s 06:38:52 INFO - Completed test suite (00:19:36) 06:38:52 INFO - javascript benchmark 06:38:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.085326535201, 3346.765726399153, 3375.206826395798, 3376.645452227516, 3377.138829598452, 5539.473749993749, 5598.9921814073505, 5603.467670571299, 5668.206451096849, 5687.061634830248, 5623.887522249563, 5700.629459085157, 5714.799982000621, 5720.7711691532395, 5728.198052272674, 5193.169092945139, 5212.50481204285, 5214.634975551713, 5240.554552863011, 5299.655522391032, 5288.99509093273, 5296.205569164617, 5298.523132918037, 5299.046171689094, 5307.230451584537, 5199.6360254782185, 5206.088934436478, 5206.167013277876, 5225.2162175673575, 5283.656562323436, 5301.151815709506, 5309.814156504503, 5330.733463326818, 5352.5182733553775, 5378.193271009341, 5078.365204349457, 5103.183490641517, 5141.922871156936, 5159.716215608178, 5175.508326708957, 5575.303087114111, 5647.689377084259, 5682.545396368322, 5708.686022268815, 5748.0, 6245.125682404467, 6270.0, 6288.968555157241, 6301.96849015752, 6304.684765761694, 6156.907646385308, 6201.193844800147, 6231.40801623845, 6280.811575652738, 6309.242890853081, 5748.5688573357165, 5796.8840623187725, 5822.9417705822825, 5910.320313163955, 5914.172015917775, 6256.593321434092, 6256.6871656417, 6264.373562643699, 6268.874622507525, 6270.3416141305415, 5963.7912673056235, 6018.307894592178, 6064.46605033481, 6068.180795592627, 6125.142480052797, 6152.753889844445, 6236.937630623726, 6303.117563541108, 6322.114903913456, 6338.651374174372, 6200.968995154995, 6272.278687950944, 6272.529560282997, 6276.968615156987, 6299.748010079546, 6078.726457309432, 6101.786437474667, 6145.877082458326, 6175.938240617626, 6217.844553886099, 4944.085344211332, 4951.084049450863, 4992.5756310714, 5002.874928126826, 5012.122878496249, 4363.716358436692, 4364.454443194601, 4369.08249267651, 4401.625861801783, 4479.888002799956, 5642.520385767256, 5683.5737319700365, 5790.855228619318, 5808.767649294065, 5843.415658434207, 6101.145839582462, 6119.816405507842, 6184.938150618526, 6209.627422354673, 6251.937480625226, 5658.943410565842, 5712.143178523254, 5771.8557036074435, 5793.681347525927, 5794.159846822187, 5407.080796264644, 5485.177223416519, 5492.69790161537, 5494.340679118532, 5496.6701997880255, 6130.856783744145, 6170.290416602058, 6204.472619827185, 6214.533909956862, 6281.748730050838, 6284.905726414199, 6284.968575157095, 6291.245050593775, 6299.622022678654, 6300.621962682254, 6178.605143676274, 6233.719482623203, 6258.43674069336, 6273.1844860167885, 6324.841878952879, 5965.463108320272, 6008.669523176267, 6115.635867915819, 6155.0151975683675, 6159.014557670751, 6210.782622608187, 6228.314885362697, 6256.562040657111, 6273.780417685359, 6317.557770956173, 5944.8811023780145, 5968.791092311748, 6112.969435152796, 6140.57016008893, 6180.443760061616, 5851.61964472325, 5862.12068189775, 5920.437558431942, 6075.058365953284, 6123.203983482297, 4676.392069031004, 5920.851978700567, 6055.303640081447, 6059.6364218147055, 6086.056661217518, 6013.428724271187, 6125.421496837498, 6134.914129196095, 6139.7022084541895, 6155.84610384744, 5793.768249269982, 5829.183914252093, 5889.793857214977, 5911.940880591139, 5961.225040744675], "value": 5696.540371172474, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.76683192067804, 516.617702899854, 531.1793279383353, 543.0334005470262, 561.7556362982101, 27424.451510969793, 32562.67437325626, 40862.0, 41035.38446923299, 41957.160856782844, 43564.564354356444, 43894.0, 43922.68231953047, 43966.340504892454, 44051.77974110125, 9725.0761177688, 9918.05778451046, 9925.75185620358, 9926.553305101288, 9930.65242716505, 8839.0, 9042.909570904272, 11868.525258989674, 12135.0, 12170.81743773844, 12136.878631213664, 12171.269723816555, 12227.205231659958, 12240.0, 12272.693182670415, 8751.518666473341, 8955.641774329019, 12042.69893252667, 12127.454264558117, 12143.757124857497, 8880.467171969702, 8957.37298389113, 11615.0, 11947.880521194764, 11949.64151075469, 40756.79621601903, 41031.179376412605, 41049.38425923613, 41109.588904110875, 41195.7940210297, 3482.495038219444, 3662.688671462929, 3669.6697297243377, 3704.9073773155887, 4268.253055715238, 27744.445111097866, 32428.675713242803, 32528.512072318936, 32750.672493275, 33150.33699326024, 3254.479283314682, 3261.24991252011, 3268.9836550817095, 3276.0, 3377.7297816174646, 485499.0, 487050.56474717753, 487718.99999999645, 487769.0, 488403.0, 61545.0, 61930.0, 61940.69029654823, 62125.0, 62135.689321554004, 64401.677991609744, 64401.677991609744, 64501.0, 64611.67694161593, 64652.35347646557, 16380.0171989681, 16926.492205233862, 16939.322427103023, 16968.89702169355, 16970.745438818427, 11742.765144697229, 12899.097063205485, 13045.086843920835, 13116.213027218397, 13215.876650484817, 15842.52472425829, 16599.170041497877, 16691.582710432336, 16698.0, 16718.99686018843, 6588.439982601532, 6645.607581270739, 6657.167854018247, 6663.167104111986, 6737.562058466184, 904.0, 926.2173463423396, 947.4457442396275, 1085.5223701571283, 1088.7876864011441, 30363.544546831814, 30391.69608303933, 30635.540466893013, 31124.844375777975, 31228.843855780575, 1107.1585594947899, 1109.545086514525, 1116.6203490813, 1126.4649291586431, 1158.0793269350886, 15791.842081579267, 15892.364305427885, 15971.600709982344, 16357.34570617162, 16358.918205408896, 679202.0, 682432.0, 683421.0, 684116.0, 685540.0, 60111.69944150251, 60359.0, 60442.697786510784, 60487.69756151191, 60506.697466512385, 1267.7401132767761, 1387.5837248825515, 1390.3743315508061, 1398.923059231752, 1424.423108641002, 32011.35977280488, 32228.35543289168, 32447.0, 32471.0, 33194.0, 50428.0, 51225.23162152645, 51258.23112653388, 51301.48698512967, 51429.742851285504, 474004.0, 490793.0, 490858.0028098346, 491465.0, 492628.0, 26753.732462675125, 27474.725252747216, 27586.586201206595, 27836.30409239785, 40785.79607101945, 49355.50644493509, 49959.750201250215, 50432.74783626058, 50687.746561266955, 51167.0, 40822.0, 41218.58781412148, 41447.792761037206, 41939.7903010483, 42189.57810421856, 40444.595554044085, 40545.797271013456, 40945.385819213334, 41899.58100418957, 41943.580564193966, 38837.0, 39423.605763941996, 39764.2047159061, 39872.00319992023, 40106.598934011454, 31452.05643830689, 35241.82379088191, 35713.0, 35991.82004089963, 36003.0, 25411.491770164863, 25655.0, 25796.09713660013, 25934.74065259323, 26172.60741088923], "value": 20662.454627179886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.24229527663147, 376.3395241351428, 378.60246740922025, 382.3385543010593, 403.4210907347956, 15062.92468537657, 15169.544913652595, 20635.2777652782, 21719.67420488694, 21787.891060544716, 21367.786322136773, 21645.891770541126, 22152.446188845286, 22339.553208935853, 22428.102875884986, 5401.918971215435, 5891.675957822329, 6015.548833837458, 6045.879082418371, 6079.513638908877, 5960.344362120163, 5963.0, 6015.819525414245, 6018.127371531125, 6021.187139736124, 5771.192033115367, 5870.559708021894, 5880.55895807814, 5884.6174998625165, 5917.585768996172, 5218.191180367068, 5736.225609542721, 5770.221020162308, 5792.362840087587, 5892.528597712194, 4749.833755818564, 4936.136176169192, 5139.768710408003, 5184.144616138333, 5188.688678679291, 26680.59979100315, 26682.5997610036, 26835.46329073427, 26969.865150674123, 27027.86486067557, 2066.73132492775, 2309.2379514760255, 2551.9106831260815, 2559.4753075619456, 3018.335966087457, 15355.769663455058, 15447.53657390269, 15656.530304090895, 15859.0, 15897.28462219203, 1839.760831091963, 1864.4686264414577, 1876.6622008038548, 1888.7733471983313, 1939.185542072333, 103609.48195258975, 111401.0, 112331.43834280859, 122327.38836305762, 122648.77351226463, 11277.605283815026, 11725.941370293265, 11793.054146065802, 11937.820932686016, 11957.940210298893, 14816.96281260323, 14852.2573871306, 14865.628359291104, 14874.107553546823, 14880.553583392515, 8551.315894728406, 8692.565371731389, 8716.346274029473, 8781.560921953876, 8797.868031979526, 7725.845483090419, 8246.05170405399, 8713.0, 8837.337199710048, 8858.29133669305, 4584.564466375689, 4600.5169457207185, 4600.930986035212, 4601.401817763669, 4656.092062047868, 1887.37716553537, 1919.9136038878285, 1921.8558608104447, 1923.5479662279354, 1925.913333899978, 848.5375470368664, 861.9353548483889, 900.2482926756232, 1020.7805321855836, 1044.4203467075845, 21890.781092189194, 22440.77559224387, 22587.774122258896, 22607.208747693752, 22630.207942721925, 935.9391639543408, 956.9425834449955, 1005.7385079879284, 1038.5897570459626, 1063.8191507443598, 11289.774204515863, 11662.358570278546, 11787.528498860122, 11822.172447928562, 11894.048476121889, 264224.0, 353704.0, 593872.0, 618652.0, 620453.0, 81260.0, 105734.48389644969, 109590.45204773925, 136115.0, 137777.00226836462, 980.6959842448864, 994.6767300627181, 1020.2501161646333, 1029.9794004119876, 1030.4744580263969, 17939.910300448413, 19876.0, 19901.900490497454, 20141.79858201399, 20146.697799532725, 47354.52645473639, 50507.0, 51029.74485127551, 56175.0, 56258.43741562532, 78274.6086269565, 84337.0, 87229.0, 88463.0, 92115.0, 8020.518768873886, 8024.157463466252, 8053.959730201312, 8201.30288925448, 8278.296344810758, 11955.820662690241, 12465.065120116209, 12569.0, 12801.551945681857, 12884.0, 10837.945810271214, 11006.284591501526, 11131.053860421955, 11168.776624467628, 11178.0, 10989.395583242998, 10992.505337259683, 11082.859706850199, 11167.441627918734, 11229.0, 9515.286353523652, 11224.158188136085, 11239.381833999209, 11468.885311146782, 11512.445819814553, 8010.599470026592, 8140.145284745016, 8184.181581841768, 8280.71017514384, 8317.584120794058, 6382.87234255303, 10879.691973147299, 11422.657320280405, 11460.0, 11641.359725215194], "value": 9707.231024987012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.7622668486385, 1582.0112429731416, 1706.4454052432961, 1759.1556053094514, 1899.6010837724068, 8401.201885820845, 8651.956740216307, 8817.823643527126, 8827.426217295879, 8837.91162088379, 6638.60168389897, 8026.919730802705, 8355.248027677522, 8607.569621518931, 8618.353623478248, 2369.7156341239074, 2398.0767404549288, 2398.628212627037, 2402.5555272274687, 2407.9759202408013, 2325.7557956414585, 2346.671465994762, 2399.5440866235444, 2400.7719266669724, 2401.087586717054, 2085.4160834966233, 2172.0985790896757, 2173.978260217393, 2179.095675294751, 2180.2805074325433, 2151.268568686646, 2294.472271377576, 2382.321038504018, 2382.4758553118286, 2389.104085967762, 2331.5336932613545, 2356.22244659262, 2359.068168073601, 2359.8112151027876, 2368.029108065702, 8638.265747411477, 8716.041235464094, 8717.389782715212, 8718.215360617574, 8719.346049046284, 5153.484651534854, 5238.109521381374, 5275.630705850592, 5293.9735301323635, 5306.151015837486, 3513.7013353864954, 3636.709063274932, 3637.254362855608, 3651.4887915691825, 3704.129529560551, 1047.9738006549821, 1077.7844431113808, 1101.2566517600667, 1106.2311693373108, 1107.1087774341652, 11426.542938282459, 11430.971212590823, 11442.885571144348, 11444.828327575093, 11449.0, 4089.4683691119963, 4467.553244675506, 4595.195840727859, 4733.455652599995, 4743.739094349775, 9682.854757178648, 9718.979507151647, 9719.708408747749, 9727.319087663936, 9730.464824434583, 5286.101362768339, 5288.206768984606, 5290.206469029677, 5294.179402192666, 5298.231756395301, 4511.255642818964, 4819.445763737215, 4832.734199618984, 4847.80608775652, 4861.708297502161, 3892.6691231245095, 3906.7069969752383, 3926.764394136361, 3985.103351745892, 4006.579309172553, 1256.8994480441543, 1264.1151194163938, 1274.4137696659454, 1277.0932637827061, 1278.2586100061942, 837.3803385494812, 877.9473231606124, 882.4131952251809, 926.578406824893, 961.5384615384654, 5969.432903874125, 6003.819885403357, 6015.909761353583, 6058.969705151446, 6089.665068421279, 917.3165991336364, 930.5905401623264, 941.0072373645869, 964.9083337082966, 966.3332300712486, 3664.76179048361, 4054.0, 4101.077257617072, 4117.238310912491, 4122.3404255319, 10314.638987635397, 10440.477976101165, 10750.78498430027, 10789.62236321725, 10793.83809242862, 10142.0, 10806.78386432267, 10808.405537695502, 10817.945910270399, 10854.945725271482, 8068.1528439513, 8139.941807565097, 8278.586070696441, 8300.667973281123, 8339.457935234312, 5862.208601838697, 5912.70436478183, 5973.880522389615, 5988.251468566429, 6035.5473339500595, 9582.0, 9914.652987145704, 9918.801623967625, 10047.849282260626, 10054.447005414773, 9665.90334096678, 10158.39049657023, 10295.742606434898, 10320.845187322346, 10322.2258330624, 5869.53043756507, 7560.432967527568, 7575.621218939141, 7592.392608591189, 7616.124145723091, 8138.755837324889, 8273.793155171168, 8277.461964972257, 8280.751577452686, 8289.295409890226, 7204.963975180301, 7465.06686664167, 7536.0956685198125, 7603.467757256939, 7673.61631918413, 6338.049292605961, 6693.828579998578, 7269.818254543678, 7482.887756683545, 7493.213212612815, 6713.12729345182, 7039.366457018893, 7047.224805271314, 7048.823779405556, 7061.082059332254, 4882.7314497701545, 5050.065737838511, 5051.701316666844, 5096.464871188472, 5118.027574760784, 5023.2214006829, 5039.118154323052, 5044.873878152929, 5091.312672789274, 5237.057329680694], "value": 4575.109386121176, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.16873314288824, 297.8808476609356, 303.2933265491405, 314.30068098480876, 317.4428877320303, 4786.353842231298, 5077.238414237866, 5133.409657889344, 5259.447757985409, 5296.496832800887, 4614.492405835355, 4799.640026997971, 5285.8942821143555, 5299.60252981026, 5308.177232528955, 3323.667633236681, 4049.230646177224, 4049.858254961077, 4060.9187816243657, 4119.526254480743, 3641.726870484711, 3796.0, 3915.668672651298, 3919.568847426781, 3945.684345252387, 3507.45634426663, 3841.5774264830848, 3989.7831161495733, 4008.779517126557, 4032.9798351008203, 3338.6327503974667, 3889.4165875118674, 4040.878773636796, 4040.919181616351, 4070.310821009278, 3265.762952377629, 3488.790672559629, 3494.5322964354777, 3499.7375196860085, 3510.8946731598094, 5157.30376399185, 5165.225216217597, 5168.793248270064, 5213.2701421800975, 5262.500062494057, 3762.6801721853676, 3876.5541962674088, 4559.99680070384, 4595.517470665565, 4596.54034596541, 5299.986005317993, 5601.915971260434, 5624.634398764068, 5665.773369065232, 5687.317521897357, 3137.7646676499353, 3156.352947645727, 3362.411577973845, 3825.6556909878245, 3842.2507611015862, 5065.544101030925, 5845.473907348317, 5847.8245652630485, 5889.7644094236175, 5905.43898329658, 3270.672932706758, 3614.674679278825, 3640.0535860676414, 3884.4950156479476, 3886.8639597613947, 3725.2549490102087, 3730.2539492101687, 3744.700423966076, 3947.210557888434, 3960.881173564798, 3942.4874766280773, 4459.264221403497, 4612.362611273017, 4652.95347046532, 4660.6970546914345, 5595.804146854841, 5598.544378461548, 5603.159526071122, 5633.774649014075, 5694.914576281359, 1154.2093665838927, 1343.40890008396, 1393.038803225771, 1393.2406838273166, 1394.198335956829, 858.8110615664543, 870.8737233101292, 872.5724395046509, 874.0691163910415, 879.3361012435698, 3815.828287727059, 3907.1013666856784, 4348.782560871944, 4395.7142785718825, 4415.470143582791, 4812.0165497391845, 4824.975875120672, 4871.95128048715, 4926.0, 4943.505649435099, 4180.47744031996, 4272.957270427256, 4374.628156606724, 4422.955770442254, 5341.412444631087, 2898.7246211609863, 2941.6175897133235, 3045.25391279138, 3085.2749603843527, 3104.9068527944196, 5013.448520662724, 5019.623528235324, 5965.850853728604, 5984.640921544721, 6039.188243526924, 5718.828435146952, 5858.238429004202, 5923.703814809242, 5927.377625349276, 5931.466168044896, 5046.66263440196, 5175.844724658191, 5875.236219291465, 5896.260603122089, 5914.792982245601, 4554.8861278466975, 4797.784099715591, 5527.50252477279, 5741.540676745767, 5798.5651076168615, 4698.718076915396, 5532.186997312203, 5560.555155587463, 5697.0, 5705.885882282248, 5172.327597412313, 5876.911846322394, 5883.558733094949, 5900.793472228452, 5900.881982360414, 3227.8224697641854, 3609.801460919675, 3837.366834472281, 3840.30874442603, 3936.685065194835, 5325.786968521215, 5416.593755468277, 5572.219889215432, 5620.522255608319, 5703.8859222816145, 5350.678959262456, 5468.4531546845, 5479.3424789023975, 5495.203195536545, 5613.410591887793, 5191.454897235736, 5495.120780675233, 5586.050371436947, 5603.271574695264, 5618.831435056954, 4267.76527291002, 4576.679632425831, 5537.529310008695, 5608.411116832837, 5662.0, 5146.459621739813, 5246.790128394821, 5566.944330556643, 5624.521915637217, 5630.549556035426, 5355.30381050461, 5517.668939863621, 5533.363663178786, 5544.251526044094, 5546.0], "value": 4004.2163869297983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.7601691441824, 777.6772639354665, 810.9229623185795, 834.5910503853106, 853.9146085391461, 14907.925460372697, 16261.593460163502, 16314.918425407872, 16316.0, 16350.83649163508, 14736.6315842104, 14897.702045959102, 14944.925275373607, 14955.252237388115, 14966.32651530681, 707.794739525537, 734.7869117955786, 875.8905136857893, 907.4782000349792, 910.3809409601469, 703.451307979774, 704.2007321689894, 706.5866468116159, 707.0348973650955, 883.1389395339556, 955.1117460761488, 959.5058544849409, 961.1013702188441, 961.7739831139677, 964.8504481805331, 935.1957316707626, 952.4618590496348, 954.9045095490465, 955.7132860141999, 956.7321150077989, 554.3126523111354, 691.405391363427, 711.8967749676268, 713.8251128473557, 715.3204455767042, 15070.321835517429, 15293.694126117527, 15296.847031529653, 15311.693766124727, 15320.616984575363, 14148.504802331972, 14534.854651453456, 14617.0, 14647.194404307758, 14666.340014699364, 11414.88585114155, 11429.42852857362, 11487.597934072352, 11619.302841829433, 11793.705157371049, 4578.45058592971, 4621.075784843011, 4753.096911586822, 4766.618670506351, 4767.356406885096, 117605.0, 118751.4062429691, 118758.0, 121108.0, 125180.4963900726, 11523.098688716436, 11534.423278836024, 11604.593839215588, 11752.412379381169, 11952.983996360406, 22671.319860404215, 22823.31530054101, 22918.19786307471, 22968.4257893554, 23160.073597056267, 7623.199564045806, 7813.0, 8117.514484876976, 8138.064122625974, 8156.306713929383, 4172.874813755592, 4246.766427846436, 4319.546447623017, 4462.576055274743, 4469.754163521037, 3490.336836001152, 3598.298331825269, 3599.352116618981, 3604.459331100356, 3606.6573675500786, 632.5603705424778, 646.4957333279955, 650.2911826109469, 655.354475841296, 668.4284936379423, 518.2226660009985, 555.2892297858747, 581.7695573861253, 626.2391194698372, 632.1466020871786, 7697.191794861571, 7914.762557123296, 8188.181181881764, 8998.190162885372, 9096.772580685403, 597.1908064572528, 622.6170904893548, 622.7135517661835, 627.3068259573106, 639.5043841023152, 4023.8591649292134, 4124.029771927882, 4176.4570605821045, 4349.195398851222, 4462.821487140543, 127708.0, 129613.35193323973, 133440.99838502432, 164283.0, 167827.16086419733, 118519.0, 119638.0, 120285.39857300658, 122746.0, 124878.0, 80275.57106503734, 95869.5619565707, 105167.94832051735, 110815.44592276987, 118744.0, 8463.873041904253, 9931.801363972825, 9998.300118991601, 10115.89884101179, 10185.949070254897, 61158.38841611705, 61972.69013654903, 63705.0, 63925.72148557096, 64040.67979660072, 98366.01633983568, 100270.99729002909, 100465.49301760334, 101019.0, 104188.47905760423, 13140.0, 13345.733085338044, 13357.933210333886, 13639.0, 13897.722045559234, 15114.773278401053, 15171.24143792828, 15242.466513671969, 15380.769288460458, 15607.0, 14061.789073163705, 14161.787573186617, 14271.215083170526, 14320.928395357956, 14546.418143274574, 12115.515379384726, 14086.577402677936, 14259.42962281497, 14349.067310624776, 14977.625559361104, 11839.489483519446, 11975.401229938294, 12077.456514457046, 12083.818742718691, 12121.333326666765, 9433.540927474545, 11298.322100673986, 11535.307881527135, 11669.183157179255, 11776.88223117792, 11200.0, 11259.297510402392, 11342.262752921033, 11502.88497115018, 11643.825342620037], "value": 7896.448631575677, "unit": "score"}], "name": "dromaeo_css", "value": 7408.233346315854, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0, 116.0, 147.0, 112.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 107.0, 157.0, 108.0, 107.0, 134.0, 104.0, 142.0, 107.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 183.0, 184.0, 180.0, 175.0, 184.0, 183.0, 183.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 57.0, 106.0, 56.0, 57.0, 61.0, 64.0, 86.0, 74.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 92.0, 69.0, 77.0, 68.0, 97.0, 70.0, 68.0, 102.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 85.0, 90.0, 88.0, 89.0, 86.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 86.0, 84.0, 81.0, 84.0, 86.0, 86.0, 94.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 52.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 78.0, 77.0, 73.0, 72.0, 71.0, 72.0, 72.0, 72.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 102.0, 82.0, 82.0, 82.0, 80.0, 81.0, 83.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 134.0, 135.0, 132.0, 133.0, 132.0, 137.0, 229.0, 141.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 162.0, 164.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 63.0, 65.0, 66.0, 62.0, 66.0, 66.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1415.8999999999996, "alertThreshold": 2.0}]} 06:38:52 INFO - Return code: 0 06:38:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:38:52 INFO - # TBPL SUCCESS # 06:38:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:53 INFO - 2016-07-18 06:38:53.014 screenresolution[1672:10807] starting screenresolution argv=screenresolution get 06:38:53 INFO - 2016-07-18 06:38:53.017 screenresolution[1672:10807] Display 0: 1600x1200x32@60 06:38:53 INFO - 2016-07-18 06:38:53.023 screenresolution[1673:10810] starting screenresolution argv=screenresolution list 06:38:53 INFO - Available Modes on Display 0 06:38:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:53 INFO - Intel Iris: 06:38:53 INFO - Chipset Model: Intel Iris 06:38:53 INFO - Type: GPU 06:38:53 INFO - Bus: Built-In 06:38:53 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:53 INFO - Vendor: Intel (0x8086) 06:38:53 INFO - Device ID: 0x0a2e 06:38:53 INFO - Revision ID: 0x0009 06:38:53 INFO - Displays: 06:38:53 INFO - Display: 06:38:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:53 INFO - Display Serial Number: 1600x1200 60 06:38:53 INFO - Main Display: Yes 06:38:53 INFO - Mirror: Off 06:38:53 INFO - Online: Yes 06:38:53 INFO - Rotation: Supported 06:38:53 INFO - Return code: 0 06:38:53 INFO - Running post-action listener: _resource_record_post_action 06:38:53 INFO - ##### 06:38:53 INFO - ##### Finished run-tests step (success) 06:38:53 INFO - ##### 06:38:53 INFO - Running post-run listener: _resource_record_post_run 06:38:53 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32341504; Write bytes: 706145792; Read time: 323; Write time: 1885 06:38:53 INFO - TinderboxPrint: CPU usage
53.5% 06:38:53 INFO - TinderboxPrint: I/O read bytes / time
32,341,504 / 323 06:38:53 INFO - TinderboxPrint: I/O write bytes / time
706,145,792 / 1,885 06:38:53 INFO - TinderboxPrint: CPU idle
2,252.8 (46.5%) 06:38:53 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 06:38:53 INFO - TinderboxPrint: CPU user
1,627.9 (33.6%) 06:38:53 INFO - TinderboxPrint: Swap in / out
435,986,432 / 0 06:38:53 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407271936; Write bytes: 400758272; Read time: 30572; Write time: 729 06:38:53 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30252544; Write bytes: 295806976; Read time: 301; Write time: 1125 06:38:53 INFO - Running post-run listener: _upload_blobber_files 06:38:53 INFO - Blob upload gear active. 06:38:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:38:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:38:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:38:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:54 INFO - (blobuploader) - INFO - Done attempting. 06:38:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:38:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:38:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:55 INFO - (blobuploader) - INFO - Done attempting. 06:38:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:38:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:58 INFO - (blobuploader) - INFO - Done attempting. 06:38:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:58 INFO - Return code: 0 06:38:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/281a09da5fc41dae029d61b0ae48c46506a2588d84a53fb156587e8f4c857d5c8c1957f6ec410025dc461d741a8c90c414593936b12f89262f6b76aabe17150b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e96aa7a5810270aac69ec6aee5ac5727d8bf5c608cf90b6000d7bb7c150de215ec0778c0a81774d4358f6ca85371ea315390ac9c2ab4c3c7b72c68e727f1a436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a558b9bac4bfcb6115e41285f537af174e6b6054e4ea9f1bc99fac71367fff323f800cfcd576304c34ab48a0f793ed06a95f738abbae4d3ecc6158a5866c8af"} 06:38:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:58 INFO - Contents: 06:38:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/281a09da5fc41dae029d61b0ae48c46506a2588d84a53fb156587e8f4c857d5c8c1957f6ec410025dc461d741a8c90c414593936b12f89262f6b76aabe17150b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e96aa7a5810270aac69ec6aee5ac5727d8bf5c608cf90b6000d7bb7c150de215ec0778c0a81774d4358f6ca85371ea315390ac9c2ab4c3c7b72c68e727f1a436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a558b9bac4bfcb6115e41285f537af174e6b6054e4ea9f1bc99fac71367fff323f800cfcd576304c34ab48a0f793ed06a95f738abbae4d3ecc6158a5866c8af"} 06:38:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:58 INFO - Copying logs to upload dir... 06:38:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1326.451097 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-07-18 06:38:58.614109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 06:38:58.618049) ========= 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.fV89OlLeCW/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.hclT16k6Jc/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/281a09da5fc41dae029d61b0ae48c46506a2588d84a53fb156587e8f4c857d5c8c1957f6ec410025dc461d741a8c90c414593936b12f89262f6b76aabe17150b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e96aa7a5810270aac69ec6aee5ac5727d8bf5c608cf90b6000d7bb7c150de215ec0778c0a81774d4358f6ca85371ea315390ac9c2ab4c3c7b72c68e727f1a436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a558b9bac4bfcb6115e41285f537af174e6b6054e4ea9f1bc99fac71367fff323f800cfcd576304c34ab48a0f793ed06a95f738abbae4d3ecc6158a5866c8af"} build_url:https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/SE_We3XrSgSLRXjBv2KQ8A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/281a09da5fc41dae029d61b0ae48c46506a2588d84a53fb156587e8f4c857d5c8c1957f6ec410025dc461d741a8c90c414593936b12f89262f6b76aabe17150b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e96aa7a5810270aac69ec6aee5ac5727d8bf5c608cf90b6000d7bb7c150de215ec0778c0a81774d4358f6ca85371ea315390ac9c2ab4c3c7b72c68e727f1a436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a558b9bac4bfcb6115e41285f537af174e6b6054e4ea9f1bc99fac71367fff323f800cfcd576304c34ab48a0f793ed06a95f738abbae4d3ecc6158a5866c8af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 06:38:58.650379) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 06:38:58.650677) ========= 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.fV89OlLeCW/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.hclT16k6Jc/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 06:38:58.699346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 06:38:58.699663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 06:38:58.699973) ========= ========= Total master_lag: 0.24 =========