builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0381 starttime: 1468606581.27 results: success (0) buildid: 20160715063552 builduid: 43718ca2eb6d4c8b9dc187bb3b046f33 revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.273631) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.274014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.274300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.303973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.304325) ========= 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.z0lYIofERv/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.HaoeGujyBY/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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-15 11:16:21-- 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% 10.8M=0.001s 2016-07-15 11:16:21 (10.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189948 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.515700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.516042) ========= 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.z0lYIofERv/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.HaoeGujyBY/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.020245 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:21.564928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 11:16:21.568331) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 08f8a5aacd8308a73f6040fe522be7ba38497561 --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 08f8a5aacd8308a73f6040fe522be7ba38497561 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z0lYIofERv/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.HaoeGujyBY/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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-15 11:16:21,649 truncating revision to first 12 chars 2016-07-15 11:16:21,649 Setting DEBUG logging. 2016-07-15 11:16:21,649 attempt 1/10 2016-07-15 11:16:21,649 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/08f8a5aacd83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 11:16:22,775 unpacking tar archive at: mozilla-central-08f8a5aacd83/testing/mozharness/ program finished with exit code 0 elapsedTime=1.399529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 11:16:22.989722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:22.990058) ========= script_repo_revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:22.990450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:22.990710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 11:16:23.008707) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-15 11:16:23.009026) ========= /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.z0lYIofERv/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.HaoeGujyBY/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:16:23 INFO - MultiFileLogger online at 20160715 11:16:23 in /builds/slave/test 11:16:23 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 11:16:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:23 INFO - {'append_to_log': False, 11:16:23 INFO - 'base_work_dir': '/builds/slave/test', 11:16:23 INFO - 'blob_upload_branch': 'Firefox', 11:16:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:23 INFO - 'branch': 'Firefox', 11:16:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:23 INFO - 'config_files': ('talos/mac_config.py',), 11:16:23 INFO - 'default_actions': ('clobber', 11:16:23 INFO - 'read-buildbot-config', 11:16:23 INFO - 'download-and-extract', 11:16:23 INFO - 'populate-webroot', 11:16:23 INFO - 'create-virtualenv', 11:16:23 INFO - 'install', 11:16:23 INFO - 'run-tests'), 11:16:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:23 INFO - 'download_minidump_stackwalk': True, 11:16:23 INFO - 'download_symbols': 'ondemand', 11:16:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:23 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:23 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:23 INFO - 'installer_path': 'installer.exe', 11:16:23 INFO - 'log_level': 'info', 11:16:23 INFO - 'log_name': 'talos', 11:16:23 INFO - 'log_to_console': True, 11:16:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:16:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:16:23 INFO - 'opt_config_files': (), 11:16:23 INFO - 'pip_index': False, 11:16:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:16:23 INFO - 'cmd': ('bash', 11:16:23 INFO - '-c', 11:16:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:16:23 INFO - 'enabled': True, 11:16:23 INFO - 'halt_on_failure': False, 11:16:23 INFO - 'name': 'check_screen_resolution'},), 11:16:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:16:23 INFO - 'cmd': ('bash', 11:16:23 INFO - '-c', 11:16:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:16:23 INFO - 'enabled': True, 11:16:23 INFO - 'halt_on_failure': False, 11:16:23 INFO - 'name': 'check_screen_resolution'},), 11:16:23 INFO - 'run_cmd_checks_enabled': True, 11:16:23 INFO - 'sps_profile': False, 11:16:23 INFO - 'sps_profile_interval': 0, 11:16:23 INFO - 'suite': 'dromaeojs', 11:16:23 INFO - 'system_bits': '32', 11:16:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:23 INFO - 'title': 't-yosemite-r7-0381', 11:16:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:23 INFO - 'use_talos_json': True, 11:16:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:23 INFO - 'work_dir': 'build'} 11:16:23 INFO - ##### 11:16:23 INFO - ##### Running clobber step. 11:16:23 INFO - ##### 11:16:23 INFO - Running pre-action listener: _resource_record_pre_action 11:16:23 INFO - Running main action method: clobber 11:16:23 INFO - rmtree: /builds/slave/test/build 11:16:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:24 INFO - Running post-action listener: _resource_record_post_action 11:16:24 INFO - ##### 11:16:24 INFO - ##### Finished clobber step (success) 11:16:24 INFO - ##### 11:16:24 INFO - ##### 11:16:24 INFO - ##### Running read-buildbot-config step. 11:16:24 INFO - ##### 11:16:24 INFO - Running pre-action listener: _resource_record_pre_action 11:16:24 INFO - Running main action method: read_buildbot_config 11:16:24 INFO - Using buildbot properties: 11:16:24 INFO - { 11:16:24 INFO - "project": "", 11:16:24 INFO - "product": "firefox", 11:16:24 INFO - "script_repo_revision": "production", 11:16:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 11:16:24 INFO - "repository": "", 11:16:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 11:16:24 INFO - "buildid": "20160715063552", 11:16:24 INFO - "stage_platform": "macosx64", 11:16:24 INFO - "basedir": "/builds/slave/test", 11:16:24 INFO - "nightly_build": "True", 11:16:24 INFO - "buildnumber": 18, 11:16:24 INFO - "slavename": "t-yosemite-r7-0381", 11:16:24 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:16:24 INFO - "platform": "yosemite_r7", 11:16:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:16:24 INFO - "branch": "mozilla-central", 11:16:24 INFO - "repo_path": "mozilla-central", 11:16:24 INFO - "revision": "08f8a5aacd8308a73f6040fe522be7ba38497561", 11:16:24 INFO - "pgo_build": "False", 11:16:24 INFO - "builduid": "43718ca2eb6d4c8b9dc187bb3b046f33", 11:16:24 INFO - "slavebuilddir": "test" 11:16:24 INFO - } 11:16:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 11:16:24 INFO - Running post-action listener: _resource_record_post_action 11:16:24 INFO - ##### 11:16:24 INFO - ##### Finished read-buildbot-config step (success) 11:16:24 INFO - ##### 11:16:24 INFO - ##### 11:16:24 INFO - ##### Running download-and-extract step. 11:16:24 INFO - ##### 11:16:24 INFO - Running pre-action listener: _resource_record_pre_action 11:16:24 INFO - Running main action method: download_and_extract 11:16:24 INFO - mkdir: /builds/slave/test/build/tests 11:16: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')]} 11:16:24 INFO - https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:25 INFO - Downloaded 1199 bytes. 11:16:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:16:25 INFO - Using the following test package requirements: 11:16:25 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:16:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 11:16:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 11:16:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'jsshell-mac.zip'], 11:16:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 11:16:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:16:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 11:16:25 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 11:16:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 11:16:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:16:25 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 11:16:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:25 INFO - https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:27 INFO - Downloaded 18828104 bytes. 11:16:27 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'] 11:16:27 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 11:16:31 INFO - Return code: 0 11:16:31 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 11:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:31 INFO - https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:35 INFO - Downloaded 18828104 bytes. 11:16:35 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'] 11:16:35 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 11:16:38 INFO - Return code: 0 11:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:38 INFO - https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:40 INFO - Downloaded 14403317 bytes. 11:16:40 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'] 11:16:40 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 11:16:41 INFO - Return code: 0 11:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:41 INFO - https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 11:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FICLLhPUQQCjQujG-JnZOw/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 11:16:44 INFO - Downloaded 112895582 bytes. 11:16:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:16:44 INFO - mkdir: /builds/slave/test/properties 11:16:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:44 INFO - Contents: 11:16:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:16:45 INFO - Running post-action listener: _resource_record_post_action 11:16:45 INFO - Running post-action listener: set_extra_try_arguments 11:16:45 INFO - ##### 11:16:45 INFO - ##### Finished download-and-extract step (success) 11:16:45 INFO - ##### 11:16:45 INFO - ##### 11:16:45 INFO - ##### Running populate-webroot step. 11:16:45 INFO - ##### 11:16:45 INFO - Running pre-action listener: _resource_record_pre_action 11:16:45 INFO - Running main action method: populate_webroot 11:16:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:45 INFO - '--tppagecycles', 11:16:45 INFO - '7'], 11:16:45 INFO - 'tests': ['tsvgm']}}, 11:16:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['damp', 'tps']}, 11:16:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'tests': ['damp', 'tps']}, 11:16:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['dromaeo_dom']}, 11:16:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['basic_compositor_video']}, 11:16:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:16:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['a11yr', 11:16:45 INFO - 'ts_paint', 11:16:45 INFO - 'tpaint', 11:16:45 INFO - 'sessionrestore', 11:16:45 INFO - 'sessionrestore_no_auto_restore', 11:16:45 INFO - 'tabpaint']}, 11:16:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:45 INFO - 'ts_paint', 11:16:45 INFO - 'tpaint', 11:16:45 INFO - 'sessionrestore', 11:16:45 INFO - 'sessionrestore_no_auto_restore', 11:16:45 INFO - 'tabpaint']}, 11:16:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:45 INFO - 'ts_paint', 11:16:45 INFO - 'tpaint', 11:16:45 INFO - 'sessionrestore', 11:16:45 INFO - 'sessionrestore_no_auto_restore', 11:16:45 INFO - 'tabpaint']}, 11:16:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:45 INFO - 'ts_paint', 11:16:45 INFO - 'tpaint', 11:16:45 INFO - 'sessionrestore', 11:16:45 INFO - 'sessionrestore_no_auto_restore', 11:16:45 INFO - 'tabpaint']}, 11:16:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['a11yr', 11:16:45 INFO - 'ts_paint', 11:16:45 INFO - 'tpaint', 11:16:45 INFO - 'sessionrestore', 11:16:45 INFO - 'sessionrestore_no_auto_restore', 11:16:45 INFO - 'tabpaint']}, 11:16:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['a11yr', 11:16:45 INFO - 'ts_paint', 11:16:45 INFO - 'tpaint', 11:16:45 INFO - 'sessionrestore', 11:16:45 INFO - 'sessionrestore_no_auto_restore', 11:16:45 INFO - 'tabpaint']}, 11:16:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['tsvgx', 11:16:45 INFO - 'tsvgr_opacity', 11:16:45 INFO - 'tart', 11:16:45 INFO - 'tscrollx', 11:16:45 INFO - 'cart']}, 11:16:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:45 INFO - 'tsvgr_opacity', 11:16:45 INFO - 'tart', 11:16:45 INFO - 'tscrollx', 11:16:45 INFO - 'cart']}, 11:16:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'talos_options': ['--disable-e10s'], 11:16:45 INFO - 'tests': ['tp5o']}, 11:16:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'tests': ['tp5o']}, 11:16:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'talos_options': ['--disable-e10s', 11:16:45 INFO - '--xperf_path', 11:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:45 INFO - 'tests': ['tp5n']}, 11:16:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:45 INFO - 'talos_options': ['--xperf_path', 11:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:45 INFO - 'tests': ['tp5n']}}, 11:16:45 INFO - 'talos.zip': {'path': '', 11:16:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:45 INFO - Running post-action listener: _resource_record_post_action 11:16:45 INFO - ##### 11:16:45 INFO - ##### Finished populate-webroot step (success) 11:16:45 INFO - ##### 11:16:45 INFO - ##### 11:16:45 INFO - ##### Running create-virtualenv step. 11:16:45 INFO - ##### 11:16:45 INFO - Running pre-action listener: _resource_record_pre_action 11:16:45 INFO - Running main action method: create_virtualenv 11:16:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:45 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 11:16:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:45 INFO - Using real prefix '/tools/python27' 11:16:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:48 INFO - Installing pip.................done. 11:16:48 INFO - Return code: 0 11:16:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:48 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')]} 11:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:48 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')]} 11:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:48 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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:16:48 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 11:16:48 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 11:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:48 INFO - 'HOME': '/Users/cltbld', 11:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:48 INFO - 'LOGNAME': 'cltbld', 11:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:48 INFO - 'MOZ_NO_REMOTE': '1', 11:16:48 INFO - 'NO_EM_RESTART': '1', 11:16:48 INFO - 'PAGER': '/bin/cat', 11:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:48 INFO - 'PWD': '/builds/slave/test', 11:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:48 INFO - 'SHELL': '/bin/bash', 11:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:16:48 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:48 INFO - 'USER': 'cltbld', 11:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:48 INFO - 'XPC_FLAGS': '0x0', 11:16:48 INFO - 'XPC_SERVICE_NAME': '0', 11:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:48 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 11:16:48 INFO - Cleaning up... 11:16:48 INFO - Return code: 0 11:16:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:16:48 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')]} 11:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:48 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')]} 11:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:48 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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:16:48 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 11:16:48 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 11:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:48 INFO - 'HOME': '/Users/cltbld', 11:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:48 INFO - 'LOGNAME': 'cltbld', 11:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:48 INFO - 'MOZ_NO_REMOTE': '1', 11:16:48 INFO - 'NO_EM_RESTART': '1', 11:16:48 INFO - 'PAGER': '/bin/cat', 11:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:48 INFO - 'PWD': '/builds/slave/test', 11:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:48 INFO - 'SHELL': '/bin/bash', 11:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:16:48 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:48 INFO - 'USER': 'cltbld', 11:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:48 INFO - 'XPC_FLAGS': '0x0', 11:16:48 INFO - 'XPC_SERVICE_NAME': '0', 11:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:49 INFO - Downloading/unpacking psutil>=3.1.1 11:16:49 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 11:16:49 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 11:16:49 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 11:16:49 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 11:16:49 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 11:16:49 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 11:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:52 INFO - Installing collected packages: psutil 11:16:52 INFO - Running setup.py install for psutil 11:16:52 INFO - building 'psutil._psutil_osx' extension 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 INFO - building 'psutil._psutil_posix' extension 11:16:52 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 11:16:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:16:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:16:52 INFO - ^ 11:16:52 INFO - 1 warning generated. 11:16:52 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 11:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:52 INFO - Successfully installed psutil 11:16:52 INFO - Cleaning up... 11:16:53 INFO - Return code: 0 11:16:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16:53 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')]} 11:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:53 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')]} 11:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:53 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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:16:53 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 11:16:53 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 11:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:53 INFO - 'HOME': '/Users/cltbld', 11:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:53 INFO - 'LOGNAME': 'cltbld', 11:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:53 INFO - 'MOZ_NO_REMOTE': '1', 11:16:53 INFO - 'NO_EM_RESTART': '1', 11:16:53 INFO - 'PAGER': '/bin/cat', 11:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:53 INFO - 'PWD': '/builds/slave/test', 11:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:53 INFO - 'SHELL': '/bin/bash', 11:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:16:53 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:53 INFO - 'USER': 'cltbld', 11:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:53 INFO - 'XPC_FLAGS': '0x0', 11:16:53 INFO - 'XPC_SERVICE_NAME': '0', 11:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16:53 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 11:16:53 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 11:16:53 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 11:16:53 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 11:16:53 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 11:16:53 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 11:16:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:16:55 INFO - Installing collected packages: mozsystemmonitor 11:16:55 INFO - Running setup.py install for mozsystemmonitor 11:16:56 INFO - Successfully installed mozsystemmonitor 11:16:56 INFO - Cleaning up... 11:16:56 INFO - Return code: 0 11:16:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:16:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:16:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:56 INFO - 'HOME': '/Users/cltbld', 11:16:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:56 INFO - 'LOGNAME': 'cltbld', 11:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:56 INFO - 'MOZ_NO_REMOTE': '1', 11:16:56 INFO - 'NO_EM_RESTART': '1', 11:16:56 INFO - 'PAGER': '/bin/cat', 11:16:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:56 INFO - 'PWD': '/builds/slave/test', 11:16:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:56 INFO - 'SHELL': '/bin/bash', 11:16:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:16:56 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:16:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:56 INFO - 'USER': 'cltbld', 11:16:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:56 INFO - 'XPC_FLAGS': '0x0', 11:16:56 INFO - 'XPC_SERVICE_NAME': '0', 11:16:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:56 INFO - Downloading/unpacking jsonschema==2.5.1 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16:58 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 11:16:58 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 11:16:58 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 11:16:58 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 11:16:58 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 11:16:58 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 11:16:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:59 INFO - warning: no files found matching '*.txt' 11:16:59 INFO - no previously-included directories found matching 'build' 11:16:59 INFO - no previously-included directories found matching 'dist' 11:16:59 INFO - no previously-included directories found matching '.git*' 11:16:59 INFO - Installing collected packages: jsonschema, functools32 11:16:59 INFO - Running setup.py install for functools32 11:16:59 INFO - warning: no files found matching '*.txt' 11:16:59 INFO - no previously-included directories found matching 'build' 11:16:59 INFO - no previously-included directories found matching 'dist' 11:16:59 INFO - no previously-included directories found matching '.git*' 11:16:59 INFO - Successfully installed jsonschema functools32 11:16:59 INFO - Cleaning up... 11:16:59 INFO - Return code: 0 11:16:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:59 INFO - 'HOME': '/Users/cltbld', 11:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:59 INFO - 'LOGNAME': 'cltbld', 11:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:59 INFO - 'MOZ_NO_REMOTE': '1', 11:16:59 INFO - 'NO_EM_RESTART': '1', 11:16:59 INFO - 'PAGER': '/bin/cat', 11:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:59 INFO - 'PWD': '/builds/slave/test', 11:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:59 INFO - 'SHELL': '/bin/bash', 11:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:16:59 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:59 INFO - 'USER': 'cltbld', 11:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:59 INFO - 'XPC_FLAGS': '0x0', 11:16:59 INFO - 'XPC_SERVICE_NAME': '0', 11:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:03 INFO - Downloading docopt-0.6.1.tar.gz 11:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:03 INFO - Running setup.py install for blobuploader 11:17:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:03 INFO - Running setup.py install for requests 11:17:04 INFO - Running setup.py install for docopt 11:17:04 INFO - Successfully installed blobuploader requests docopt 11:17:04 INFO - Cleaning up... 11:17:04 INFO - Return code: 0 11:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:04 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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:17:04 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 11:17:04 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 11:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:04 INFO - 'HOME': '/Users/cltbld', 11:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:04 INFO - 'LOGNAME': 'cltbld', 11:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:04 INFO - 'MOZ_NO_REMOTE': '1', 11:17:04 INFO - 'NO_EM_RESTART': '1', 11:17:04 INFO - 'PAGER': '/bin/cat', 11:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:04 INFO - 'PWD': '/builds/slave/test', 11:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:04 INFO - 'SHELL': '/bin/bash', 11:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:17:04 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:04 INFO - 'USER': 'cltbld', 11:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:04 INFO - 'XPC_FLAGS': '0x0', 11:17:04 INFO - 'XPC_SERVICE_NAME': '0', 11:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:04 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-VJCH39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:04 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-NvTQlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:04 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-PUOGX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:04 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-VtUGVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Ik9qeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-uMIJ57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-13xZQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-5pU0Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-5z6Yo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-7A3gQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-5mcUMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Qz7cFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-i0Vlp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:05 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-hsytSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:06 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-0IbyhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:06 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-HAqXDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:06 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-hkmvMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:06 INFO - Running setup.py install for manifestparser 11:17:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:06 INFO - Running setup.py install for mozcrash 11:17:06 INFO - Running setup.py install for mozdebug 11:17:06 INFO - Running setup.py install for mozdevice 11:17:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:06 INFO - Running setup.py install for mozfile 11:17:07 INFO - Running setup.py install for mozhttpd 11:17:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Running setup.py install for mozinfo 11:17:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Running setup.py install for mozInstall 11:17:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Running setup.py install for mozleak 11:17:07 INFO - Running setup.py install for mozlog 11:17:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Running setup.py install for moznetwork 11:17:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Running setup.py install for mozprocess 11:17:08 INFO - Running setup.py install for mozprofile 11:17:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Running setup.py install for mozrunner 11:17:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Running setup.py install for mozscreenshot 11:17:08 INFO - Running setup.py install for moztest 11:17:08 INFO - Running setup.py install for mozversion 11:17:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:08 INFO - Cleaning up... 11:17:08 INFO - Return code: 0 11:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:08 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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:17:08 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 11:17:08 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 11:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:08 INFO - 'HOME': '/Users/cltbld', 11:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:08 INFO - 'LOGNAME': 'cltbld', 11:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:08 INFO - 'MOZ_NO_REMOTE': '1', 11:17:08 INFO - 'NO_EM_RESTART': '1', 11:17:08 INFO - 'PAGER': '/bin/cat', 11:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:08 INFO - 'PWD': '/builds/slave/test', 11:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:08 INFO - 'SHELL': '/bin/bash', 11:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:17:08 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:08 INFO - 'USER': 'cltbld', 11:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:08 INFO - 'XPC_FLAGS': '0x0', 11:17:08 INFO - 'XPC_SERVICE_NAME': '0', 11:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-mGjjeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:09 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)) 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-30M7Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:09 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)) 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-CVSqoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:09 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)) 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-jW6qF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:09 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)) 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-nNHvge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:09 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)) 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-h2e4CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:09 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)) 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-DMKyOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:09 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)) 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:09 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-3Owcwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-gfg9lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-flnEp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-PD6CQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-LhBcbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-zhGPLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-zHECPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-nfukL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-bhOalV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:10 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)) 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:10 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-iS8fmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:11 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)) 11:17:11 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)) 11:17:11 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)) 11:17:11 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)) 11:17:11 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)) 11:17:11 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)) 11:17:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:11 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 11:17:11 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 11:17:11 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 11:17:11 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 11:17:11 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 11:17:11 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 11:17:13 INFO - Downloading blessings-1.6.tar.gz 11:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:13 INFO - Installing collected packages: blessings 11:17:13 INFO - Running setup.py install for blessings 11:17:14 INFO - Successfully installed blessings 11:17:14 INFO - Cleaning up... 11:17:14 INFO - Return code: 0 11:17:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:14 INFO - Reading from file tmpfile_stdout 11:17:14 INFO - Current package versions: 11:17:14 INFO - blessings == 1.6 11:17:14 INFO - blobuploader == 1.2.4 11:17:14 INFO - docopt == 0.6.1 11:17:14 INFO - functools32 == 3.2.3-2 11:17:14 INFO - jsonschema == 2.5.1 11:17:14 INFO - manifestparser == 1.1 11:17:14 INFO - mozInstall == 1.12 11:17:14 INFO - mozcrash == 0.17 11:17:14 INFO - mozdebug == 0.1 11:17:14 INFO - mozdevice == 0.48 11:17:14 INFO - mozfile == 1.2 11:17:14 INFO - mozhttpd == 0.7 11:17:14 INFO - mozinfo == 0.9 11:17:14 INFO - mozleak == 0.1 11:17:14 INFO - mozlog == 3.2 11:17:14 INFO - moznetwork == 0.27 11:17:14 INFO - mozprocess == 0.23 11:17:14 INFO - mozprofile == 0.28 11:17:14 INFO - mozrunner == 6.12 11:17:14 INFO - mozscreenshot == 0.1 11:17:14 INFO - mozsystemmonitor == 0.3 11:17:14 INFO - moztest == 0.7 11:17:14 INFO - mozversion == 1.4 11:17:14 INFO - psutil == 3.1.1 11:17:14 INFO - requests == 1.2.3 11:17:14 INFO - wsgiref == 0.1.2 11:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:14 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')]} 11:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:14 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')]} 11:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:14 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 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:17:14 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 11:17:14 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 11:17:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:17:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:14 INFO - 'HOME': '/Users/cltbld', 11:17:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:14 INFO - 'LOGNAME': 'cltbld', 11:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:14 INFO - 'MOZ_NO_REMOTE': '1', 11:17:14 INFO - 'NO_EM_RESTART': '1', 11:17:14 INFO - 'PAGER': '/bin/cat', 11:17:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:14 INFO - 'PWD': '/builds/slave/test', 11:17:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:14 INFO - 'SHELL': '/bin/bash', 11:17:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:17:14 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:17:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:14 INFO - 'USER': 'cltbld', 11:17:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:14 INFO - 'XPC_FLAGS': '0x0', 11:17:14 INFO - 'XPC_SERVICE_NAME': '0', 11:17:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:17:15 INFO - Cleaning up... 11:17:15 INFO - Return code: 0 11:17:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107db1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd805537e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, '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.z0lYIofERv/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.HaoeGujyBY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 11:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:15 INFO - 'HOME': '/Users/cltbld', 11:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:15 INFO - 'LOGNAME': 'cltbld', 11:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:15 INFO - 'MOZ_NO_REMOTE': '1', 11:17:15 INFO - 'NO_EM_RESTART': '1', 11:17:15 INFO - 'PAGER': '/bin/cat', 11:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:15 INFO - 'PWD': '/builds/slave/test', 11:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:15 INFO - 'SHELL': '/bin/bash', 11:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:17:15 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:15 INFO - 'USER': 'cltbld', 11:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:15 INFO - 'XPC_FLAGS': '0x0', 11:17:15 INFO - 'XPC_SERVICE_NAME': '0', 11:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:15 INFO - Cleaning up... 11:17:15 INFO - Return code: 0 11:17:15 INFO - Running post-action listener: _resource_record_post_action 11:17:15 INFO - Running post-action listener: _start_resource_monitoring 11:17:15 INFO - Starting resource monitoring. 11:17:15 INFO - ##### 11:17:15 INFO - ##### Finished create-virtualenv step (success) 11:17:15 INFO - ##### 11:17:15 INFO - ##### 11:17:15 INFO - ##### Running install step. 11:17:15 INFO - ##### 11:17:15 INFO - Running pre-action listener: _resource_record_pre_action 11:17:15 INFO - Running main action method: install 11:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:15 INFO - Reading from file tmpfile_stdout 11:17:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:15 INFO - Reading from file tmpfile_stdout 11:17:15 INFO - Output received: 11:17:15 INFO - Usage: mozinstall [options] installer 11:17:15 INFO - Options: 11:17:15 INFO - -h, --help show this help message and exit 11:17:15 INFO - -d DEST, --destination=DEST 11:17:15 INFO - Directory to install application into. [default: 11:17:15 INFO - "/builds/slave/test"] 11:17:15 INFO - --app=APP Application being installed. [default: firefox] 11:17:15 INFO - mkdir: /builds/slave/test/build/application 11:17:15 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'] 11:17:15 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 11:17:49 INFO - Reading from file tmpfile_stdout 11:17:49 INFO - Output received: 11:17:49 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 11:17:49 INFO - Running post-action listener: _resource_record_post_action 11:17:49 INFO - ##### 11:17:49 INFO - ##### Finished install step (success) 11:17:49 INFO - ##### 11:17:49 INFO - ##### 11:17:49 INFO - ##### Running run-tests step. 11:17:49 INFO - ##### 11:17:49 INFO - Running pre-action listener: _resource_record_pre_action 11:17:49 INFO - Running main action method: run_tests 11:17:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:17:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:17:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:17:49 INFO - 2016-07-15 11:17:49.970 screenresolution[1949:17970] starting screenresolution argv=screenresolution get 11:17:49 INFO - 2016-07-15 11:17:49.973 screenresolution[1949:17970] Display 0: 1600x1200x32@60 11:17:49 INFO - 2016-07-15 11:17:49.978 screenresolution[1950:17972] starting screenresolution argv=screenresolution list 11:17:49 INFO - Available Modes on Display 0 11:17:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:17:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:17:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:17:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:17:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:17:50 INFO - Intel Iris: 11:17:50 INFO - Chipset Model: Intel Iris 11:17:50 INFO - Type: GPU 11:17:50 INFO - Bus: Built-In 11:17:50 INFO - VRAM (Dynamic, Max): 1536 MB 11:17:50 INFO - Vendor: Intel (0x8086) 11:17:50 INFO - Device ID: 0x0a2e 11:17:50 INFO - Revision ID: 0x0009 11:17:50 INFO - Displays: 11:17:50 INFO - Display: 11:17:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:17:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:17:50 INFO - Display Serial Number: 1600x1200 60 11:17:50 INFO - Main Display: Yes 11:17:50 INFO - Mirror: Off 11:17:50 INFO - Online: Yes 11:17:50 INFO - Rotation: Supported 11:17:50 INFO - Return code: 0 11:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:50 INFO - Python 2.7.3 11:17:50 INFO - Return code: 0 11:17:50 INFO - grabbing minidump binary from tooltool 11:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:50 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 0x107c80d30>, '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 0x1079e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c78b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:50 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 11:17:50 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 11:17:50 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 11:17:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:50 INFO - Return code: 0 11:17:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:17:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:17:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:50 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/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 11:17:50 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/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0381 --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 11:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0lYIofERv/Render', 11:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:17:50 INFO - 'HOME': '/Users/cltbld', 11:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:17:50 INFO - 'LOGNAME': 'cltbld', 11:17:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:50 INFO - 'MOZ_NO_REMOTE': '1', 11:17:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:50 INFO - 'NO_EM_RESTART': '1', 11:17:50 INFO - 'PAGER': '/bin/cat', 11:17:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:50 INFO - 'PWD': '/builds/slave/test', 11:17:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:17:50 INFO - 'SHELL': '/bin/bash', 11:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HaoeGujyBY/Listeners', 11:17:50 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 11:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:17:50 INFO - 'USER': 'cltbld', 11:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:50 INFO - 'XPC_FLAGS': '0x0', 11:17:50 INFO - 'XPC_SERVICE_NAME': '0', 11:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:17:50 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/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 11:17:50 INFO - mozversion application_buildid: 20160715063552 11:17:50 INFO - mozversion application_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 11:17:50 INFO - mozversion application_display_name: Nightly 11:17:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:50 INFO - mozversion application_name: Firefox 11:17:50 INFO - mozversion application_remotingname: firefox 11:17:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:17:50 INFO - mozversion application_vendor: Mozilla 11:17:50 INFO - mozversion application_version: 50.0a1 11:17:50 INFO - mozversion platform_buildid: 20160715063552 11:17:50 INFO - mozversion platform_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 11:17:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:17:50 INFO - mozversion platform_version: 50.0a1 11:17:50 INFO - using testdate: 1468606670 11:17:50 INFO - actual date: 1468606670 11:17:50 INFO - starting webserver on 'localhost:49670' 11:17:50 INFO - SUITE-START | Running 2 tests 11:17:50 INFO - TEST-START | dromaeo_css 11:17:50 INFO - operating with platform_type : mac_ 11:17:50 INFO - Initialising browser for dromaeo_css test... 11:17:50 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpqmyPod/profile http://localhost:49670/getInfo.html) 11:17:52 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 11:17:52 INFO - PROCESS | 1960 | colorDepth:24 11:17:52 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 11:17:52 INFO - PROCESS | 1960 | __metrics 11:17:53 INFO - PROCESS | 1960 | 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" 11:17:53 INFO - PROCESS | 1960 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:17:53 INFO - TEST-INFO | 1960: exit 0 11:17:53 INFO - Browser initialized. 11:17:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:53 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpqmyPod/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:05 INFO - PROCESS | 1963 | RSS: Main: 244948992 11:18:05 INFO - PROCESS | 1963 | 11:18:56 INFO - PROCESS | 1963 | 1468606736945 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] 11:21:07 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49670/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49670/tests/dromaeo/cssquery-ext.html) 11:21:09 INFO - PROCESS | 1963 | RSS: Main: 369889280 11:21:09 INFO - PROCESS | 1963 | 11:24:12 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49670/tests/dromaeo/cssquery-ext.html (next: http://localhost:49670/tests/dromaeo/cssquery-jquery.html) 11:24:13 INFO - PROCESS | 1963 | RSS: Main: 375398400 11:24:13 INFO - PROCESS | 1963 | 11:27:15 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49670/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49670/tests/dromaeo/cssquery-mootools.html) 11:27:16 INFO - PROCESS | 1963 | RSS: Main: 372404224 11:27:16 INFO - PROCESS | 1963 | 11:30:18 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49670/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49670/tests/dromaeo/cssquery-prototype.html) 11:30:19 INFO - PROCESS | 1963 | RSS: Main: 368320512 11:30:19 INFO - PROCESS | 1963 | 11:33:22 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49670/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49670/tests/dromaeo/cssquery-yui.html) 11:33:23 INFO - PROCESS | 1963 | RSS: Main: 341643264 11:33:23 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49670/tests/dromaeo/cssquery-yui.html (next: http://localhost:49670/tests/dromaeo/cssquery-dojo.html) 11:36:26 INFO - PROCESS | 1963 | RSS: Main: 427319296 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | __start_tp_report 11:36:26 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 11:36:26 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 11:36:26 INFO - PROCESS | 1963 | |i|pagename|runs| 11:36:26 INFO - PROCESS | 1963 | |0;dojo.html;2811.957820632691;3319;3322.6843449872267;3349.715274201693;3375.4430518964373;5495.670259784416;5593.412691667372;5616.045272303708;5696.401877802828;5726.455986681264;5666.914996275049;5677.943220567793;5790.797322093727;5818.389069147742;5822.883542329151;4419.845305414311;5112.156494178456;5122.564582010534;5189.7405129743365;5205.635605507616;5242.947570524303;5280.102382594949;5288.338957630296;5291.5766738661005;5292.470752924715;3922.6469617734256;4409.0520538084465;5144.382674079097;5174.689518628894;5205.947940520584;5141.048905952411;5167.121589329823;5181.404138524081;5208.635395522315;5219.71291578963;5083.466236045199;5128.282040514331;5151.716655583941;5228.424873263938;5247.895042099137;5177.896442071137;5612.719364031782;5631;5754.510866576305;5791.276090488689;6001.2498437695285;6053.273607167124;6120.051392034242;6192.752289908398;6214.751409943642;5765.942340576583;6191.597546159485;6226.128342032119;6229.813105606794;6252.249730032425;5805.216295800097;5838.7080645967535;5846.941530584682;5850.385709500526;5862.70686465675;6122.173506576644;6223.595466294676;6250.812475625738;6268.561200715906;6269.62382257066;6051.618790668127;6134.375358695336;6148.231471066117;6180.969095154495;6188.628682278988;5219.660722053054;6239.937600624026;6246.187995560639;6250.281217659936;6258.718357673915;6019.819405417845;6028.306744724325;6184.536159788034;6195.411435913581;6215.34738852423;5554.472325129106;5884.6469211847425;6120.294761999531;6223.1287619733275;6251.187345645037;4926.950730492721;4968.701877887338;4970.577500912463;4979.103761322925;5020.322256495399;4443.644508439317;4447.355133505624;4451.910961780811;4469.754163520973;4482.8206871725415;5628.437156284339;5676;5687.573431992617;5766.221560089334;5776.68228247442;6210.378962103753;6213.254409470893;6215.285242197115;6229.595076320024;6254.249490061222;5626.127950167649;5662.065759149777;5709.514691251207;5714.314282286069;5747.798827041033;5297.470252974672;5330.520253177233;5333.413324534298;5367.490088441592;5392.514673679388;6256.812295631138;6267.62394256346;6269.686515674198;6283.183186185766;6294.1188233648245;6212.534059945612;6213.285472170758;6224.097505861715;6254.687265636791;6258.43674069336;6127.769884593299;6242.968785156045;6251.99968005117;6256.874862502816;6259.3427690091885;5130.538251557377;6066.423689749467;6117.218487018478;6129.509639228761;6135.263289243823;6224.284207316216;6231.719572619152;6246.875062498633;6251.78118765841;6254.749810007549;5997.730102145501;6052.84995850787;6100.54245931548;6110.572259941761;6116.510679145568;4960.77676504551;4970.676906001098;5184.377874655065;5990.64056156632;6047.697615119138;5930.525557955267;5932.79235226765;5939.316978547349;5943.762249509971;5983.760649573968;6072.301685306246;6085.056816193497;6091.284738969781;6096.603720758137;6108.539925731173;5723.170140329712;5790.218320526675;5861.120831875252;5920.703964801829;5933.169356290036 11:36:26 INFO - PROCESS | 1963 | |1;ext.html;455.7220095741597;516.3442428116292;519.7427273499618;523.8632168195016;563.3830955104161;30584;43077.78461107694;44017.339739903924;44606;46664.300035499495;45508.772456137754;45905.62283131503;45913.7704311478;45940.540594594044;46129.53870461295;7574.886376704354;9832.065953734384;10040.146587540068;10043.598256069748;10067.5469603868;8829.558522073903;12089.939550302237;12326.5069397224;12340.13619046667;12502.12485126037;12247.326397048158;12289.201201921891;12307;12327.32199729019;12337.259764414119;7813.257740514642;8773.517456539888;8965.372423930328;12157.756844863097;12371.814422783666;8968.50673212973;11742.001929835975;12059.819102713467;12082.15424920256;12325.322107284095;43267;43690.78154609207;43739.78130109361;43760.78119609413;43762.06141447285;3535.9469607955903;3617.1680513482047;3650.3064417760806;3816.0644968647193;3868.6518213360932;29129.70870291312;33356.66643333584;33689.32621347559;33896.49155262673;34042.82978585091;2597.2987293430856;3258.8859389921477;3427.365937301582;3455.948160777565;3464.8440820163155;507535;521760;544845;550186;550221;66496;66513.66972660519;67202;67209.95110440084;67267.66366168138;35635.82182089125;36299.4555081674;36302;37683.62316376856;37729;17196.656066878844;17224;17379.826201737822;17383.217755201047;17398.0431076292;12036.45835937385;12176;12197;12379.257244565355;12940.805887911689;17878.195481203376;18860.329169756267;21022.054007569695;21052.263170789254;21078.367648970554;8076.27313541784;8196.221358970888;8197.385196110316;8213.712520061768;8250.62716760118;889.58634235081;928.7538802217283;1070.9946450267698;1083.2633809009792;1088.1403691083956;30930.381392372026;31489.055328340186;31792.205194870312;31843;32419.513707293936;985.930984831055;1052.4159091704178;1081.0756802933536;1132.7394699219226;1190.6190019193775;15358.1969946593;15398.307076181598;16206.270717817726;16922.984620922784;16966.406175783788;722791;730737;731053;731202;732516;64098;64840.027399589046;65001.02498462527;65266;65293.67353163204;1120.4117838134882;1306.777847765901;1413.3639862061907;1426.2155814301884;1438.7266419380285;31773.682263177074;33138;33213.667863321054;33327.666723332455;33365.49951750774;55362.72318638381;55484;56393.436065638816;56394;56412;665137;676725;678718;678769.4246115149;679033;38339;46397.6080717579;47241.05517889554;47355.28967065428;47414.76292618653;50998.490015100855;51410;51642.48357516527;51748.74125629348;52772.9445411082;35632.82183589065;41988;42012.15975680408;42721.43671379727;43074.569254307055;42458;42460.575394245665;43492.69355943307;43710;44005.77997110122;41101.79449102735;41357.58642413537;41693.16613667649;41959.58040419557;42003.36994945017;31689.841550792098;34365.828170858986;36117.45823812697;36932.07669808276;37445;24132.87933560321;25788.742112579384;26706.866465667546;27119.322016948943;27153.59269610918 11:36:26 INFO - PROCESS | 1963 | |2;jquery.html;356.6095125837211;374.584211525207;383.3081288274665;390.9218156368725;406.9755814651121;10981.399486262004;13599.38802753876;21219.787802121973;21288.148474061018;22569;12145.635630931065;12455.439505222264;20636.69044964323;21492.925353732327;21521.892390538025;5027.673201241917;5459.727013649322;5469.288992430978;5471.069918113911;5485.533729632986;3872.5740168581433;5331.866703332409;5829.417058294158;6118.3269840317525;6135.539834512407;6101.389861013908;6140.662263575501;6143.754249830002;6145.754169833202;6156.415140561639;5799.768009279624;6134.846628834271;6144.477719393857;6184.907226391608;6191.9690401547705;3755.9812200939095;5598.916016259759;5927.466528012456;5938.7624495020145;5953;13673.453061877513;13912.93043534786;13921.164730116225;25560.360990975187;26772.732272677415;2414.0947144820693;2590.430105376814;2769.1000424862;2782.6660800703844;2814.6763122241;10102.949485252526;10224.846627300596;13819.239941803196;15205;15499.845001549953;1855.870089093764;1931.768187817457;1971.822535971755;1973.398113575359;1977.0510155125476;126387.31257093362;134345;134544;137386;137736;10167.491625418847;10432.895671043192;11317.377544234982;11368.431578421047;11644.068474522019;13732.382042808098;13755.587332379844;13993.510227142206;14025.649358765908;14562.980591358502;6546.5744726593575;7245.927540724525;8713.564321783886;8783.5169065702;8802;8686.86969695455;8689.826203475895;8706.608202630898;8819.29445644347;8827.558622068871;4566.452025756864;4620.907581848344;4658.697184682985;4662.020975595163;4683.765811709401;1954.4918321236296;1974.782773894899;1975.424481688149;1976.298414062987;2002.229141780425;800.8947652239872;871.4988881393224;903.3315346643436;1022.381459217163;1039.812833689943;20359.185632574827;20939.162433502795;22167.652416960023;22311.553768924532;23405.41486462852;732.7105793211651;936.7939053408239;973.5521660036462;995.2983146881431;1010.4190090697878;10970;11189.720256993478;11716.297022178696;11765.882341176479;11775.116866235066;584298;612580;618334;624971;627315;128611.71388285997;128629;128996;129868;133164;1061.4798748613123;1073.3291692692067;1106.3970136275589;1126.0878688262533;1133.9433028348549;18407.98756068429;19091.904540477208;19456.44348452149;19900.50248743793;19986.90006549958;51383.22925156201;53422;57072.42927570671;59201.703991479764;59977;87551.56224219094;88366;88680.11319886976;89122.55438723024;91016;8093.635786389509;8316.085230624747;8511.276541494042;8524.74425767228;8681.2186903179;12676.429560669607;13496.86503134956;13603.659908502366;13664.453421863014;13755.31223438844;11395;11669.649910502698;11768.76462470763;11835.704107397383;11933.582324618597;10631.308964917256;10782.784344312913;11343.20597558163;11466.484008219484;11568.190226684052;10344.637937672145;11866.466009029442;11890.940545297219;12041.217320874115;12069.57756478519;8289.668413263644;8389.832203355776;8415.53714545706;8562.871556926775;8615.956920215358;9922;11627.244229125079;11685.357305347947;11727.882721172678;11882.82175767347 11:36:26 INFO - PROCESS | 1963 | |3;mootools.html;1371.8765311122008;1570.8507691769282;1587.2460581223916;1799.5051360875757;1928.6239183359241;6919.238883722793;7574.886376704347;8013.959930200341;8017.95991020044;8020.278174964252;8393.95803020984;8679.47923124613;8691;8806.55967201639;8819.691310804123;2274.4768703198274;2341.964870526935;2342.4261056041296;2346.225745503988;2346.3664810501155;1989.3534601254578;2386.4630458146953;2387.486690361572;2390;2404.2546810488802;2346.3899386159637;2363.5981883079917;2384.0463814474174;2386.284114765572;2393.162393162388;2321.0483701682397;2356.705411823522;2362.2204672458047;2363.72817126031;2366.396568874943;2353.2822489140804;2357.799587035104;2359.6578496118136;2361.551305251997;2363.409147713072;8802;8852.955735221347;8854.424462409923;8868.645254189825;8885.4668719877;4728.787204575802;4934.506549345073;5177.508136727005;5234.319538460014;5334.546563542103;3505.9832648531897;3508.701760350373;3626.7279954003293;3628.7822730636244;3642.3990041643096;1075.8063548561256;1088.8366744988236;1098.2970898624887;1111.4276147783899;1116.0513563471065;11702.005329546999;11828.23116497425;11847.170698051139;11852.466639001179;11852.992495637882;4464.687471876938;4583.166733306704;4774.427068751703;4785.282207668877;4786.401699787527;10105.9494702526;10108.191344692406;10108.747281318027;10121.443320617289;10124.038216369434;5346.8128615499045;5355.678659280456;5358.223057656618;5362.892742145135;5365.704886231217;4724.314974328703;4912.4350699669285;4914.189158788831;4916.237983112624;4945.010997800454;3180.6183258009187;3728.664420202195;3808.847646094125;3814.4659747635355;3852.8073596320073;1165.1785491228663;1166.6558365282092;1166.9299842009507;1177.682025853015;1178.6110583507423;939.5208443693629;942.9292803039663;948.6300342866288;971.9028097190225;998.177457080846;5608.298962629671;5901.262342207224;5947.970260148758;6008.429199226067;6056.36408177135;400.94751277895523;423.367066235973;453.12320659523266;462.5998511287779;463.86779767766023;3929.5677475477673;4039.5354534228354;4065.6340929316502;4122.814473348706;4146.792660366969;9960.908209276133;10440.269181157399;10461.476926153815;11011.779764404828;11053.392063436588;10926.781464370668;10937.945310273557;10947.34315941046;10948.726281843017;10966.616168434226;7036.507444478837;7881.763547093482;8273.503589784632;8387.203215694499;8413.326933845277;6093;6108.816735497942;6163.982942814386;6220.844478888064;6264.812055638338;10087.69736907894;10333.431661258403;10335.793284134426;10359.792804143724;10368.92621475723;9811.215102791617;10037.89962100399;10455.895441045492;10457.424841633783;10478.790424191626;7640.8471830564185;7725.5321488916925;7814.57019863913;7815.218478152139;7818.843623127392;8364.414490985573;8421.15788421153;8425.4944703318;8448.577571121297;8478.491290522341;7536.359409450258;7614.771556853303;7656.808579785327;7735.381169506313;7736;7470.3276705096805;7472.925270747223;7477;7627.161012288755;7642.50323728978;7017.578945263301;7119.964400177966;7201.279872012757;7239.8914016288745;7242.275772422716;5042.218456139304;5075.7969681212335;5097;5252.606054545848;5275.261463395051;4272.722273052242;4867.902641947212;4906.822362633014;5156.845294641167;5368.033753924331 11:36:26 INFO - PROCESS | 1963 | |4;prototype.html;303.70388870850917;309.2423562272432;314.0860097117389;316.99366012679747;319.4186580423627;4877.609791216694;5394.6802874763835;5395.649282796616;5399.757010934512;5406.459354064592;4466.486354069283;4772.854514916412;4909.723471897315;5353.625246232766;5376;3501.579810422753;3849.30712471755;3991.201759648082;4107.527634322061;4113.958860411388;3887.7667339959553;4066.857659981901;4081.530623978251;4083.673306135502;4144.41978123063;4022.054817117975;4024.8993775155564;4045.2516284487315;4052.8986775330704;4059.391091336294;3167.572377729;3625.3836847735947;3939.4878665773554;4066.573009833984;4089.8752842968274;2895.623568936046;3037.3773376457775;3130.311331507065;3491.4937334086417;3561.732870034758;3904.1996390740114;5045.293658887758;5149.536541711264;5263.421023687391;5290.65610735301;3903.551091624471;4456.532064133284;4636.3045543168455;4686.601638860667;4711.562973293144;4689.648276379286;5422.177364957695;5607.495325420691;5637.844241930395;5639.8590035249035;3787.886363409102;3799.8480060797533;3903.0047337928645;3922.17634296798;3961.544422391404;5481.643693159972;5561.721913904329;5901.232839730807;5914.319853216892;5937.476572456689;3953.2488827122756;3987.3819557968563;3993.961569991823;4000.919751667034;4018.578049304839;3356.3958487472;4018.2767101921936;4062.6749860011128;4064.4309796628495;4072.429859819628;3861.4940173332425;4058.512978442606;4624.329472226508;4658.930116048262;4687.789049492781;4927.531884470969;5187.636865419385;5481.643693159932;5629.915551266734;5642.605017648807;1146.5356530605118;1147.2886810177743;1199.5501686867424;1359.714459963399;1368.8288963879515;894.7518212094092;919.8206349761732;930.1907340613709;934.5514153206499;943.3020562986596;4209.91580168401;4904.141775189399;4959.82640607577;5019.573336266385;5184.533391994739;4432.667549933768;5632.352279487829;5765.56758243125;5822.883542329129;5964;3788.753731007476;5194.662401919151;5226.712530810766;5245.816396426183;5284.4187139414635;2895;2922.590837282782;2990.8634718807148;3021.6071910651476;3043.360894212196;5463.426340234298;5648.15277708347;5908.586398952118;5911.970440147772;5987.371326010793;4454.933176002362;4929.3135241293585;5833.325005246667;5874.82631426375;5892.145638882338;4871.464138944784;4950.702957822542;5794.304683438015;5824.446677565709;5856.590038697335;5381.542568881532;5450.00249862566;5551.945130425206;5673.262475878109;5684.573656975661;5271.920921186262;5624.578156638187;5715.399883012224;5730.283714535683;5753.654780713171;4941.308216849716;5174.818881339135;5813.505852002627;5921;5925.318588362394;3630.3102410541915;3793.487879136281;3816.732828701964;3829.712771542201;3851.3645248533676;5109.693418394908;5276.89185271082;5286.709230992333;5726.226959360433;5799.391063938226;4865.805367785249;4918.581920536794;5516.214311772529;5686.744096515584;5720.8283751487525;4959.776810043629;5130.871728206825;5312.495312945264;5430.321209848769;5665.546756259571;5045.419776725724;5493.697846618475;5512.283403157564;5534.889302213853;5539.196816461671;5362.3833259174135;5475.397706252229;5542.251796007487;5670.971645141748;5710.971445142748;4719.914419683423;4862.027594481188;5359.410464848941;5534.05920993424;5578.832635020955 11:36:26 INFO - PROCESS | 1963 | |5;yui.html;735.8822588385858;761.3870833978644;782.0224719101124;843.6119385082858;859.9122110530178;15723;16154.83845161548;16168.919155404206;16222.675546489078;16229.756553651705;11512.827307590373;14748.557543273691;14907.701845963074;14909.925450372733;14943.252837358115;687.089606271692;718.1561665043579;871.8997315308726;896.3008853094597;899.4783025844994;864.844328020956;896.9596368163416;897.5287973813735;899.9865002024975;905.6739573753443;932.1005229953093;943.056943056943;943.170010390855;943.6225509796068;944.5371767833747;742.1650643026595;765.7740966414921;767.5509826751357;938.8591711243334;938.9671361502383;565.9915101273443;569.7692434564008;682.7337338438014;702.620584884162;712.8859382498775;14405.351759170757;14422.35099420518;14576.781348279785;14655.780163297559;14660.340284687214;14119.576412707635;14290.142591444443;14380.424783008668;14392.496262630757;14560.635984100376;13113.672158196121;13156.60530184096;13328.333583320795;13560.254186019765;13613.183209007491;4492.101579684044;4555.817767289304;4579.221532339477;4632.467266264389;4742.407199100113;99237.00762992422;100265.49867250618;101294;101413;101571.49214253956;11142;11456.885431145749;11504.94247528757;11591;11632.883671163348;22997.88501057484;23033;23053.538929221657;23105.3068407948;23367.065317387114;7996.64015119321;8001.799955001055;8022;8130;8265.214804593554;4167.456524558726;4595.701279416827;4678.064387122589;4695.201815691341;4722.693024953367;3520.06718219672;3643.599204087548;3646.690031347312;3652.068722475805;3652.7808331500196;633.6894921488438;644.3427703742157;693.8681650486392;748.7978245873584;749.026265854398;549.1521031728286;600.2976517474565;628.7893555658814;697.4699228586311;705.4638474759117;9118.224950879117;9285.350025498285;9357.766055848659;9435.622575097057;9880.604775809032;634.3783092569216;662.4634046422414;677.579900461707;690.0752990992095;696.6516741629185;4387.6489880810095;4390.1878152541885;4538.614217791524;4561.521040290788;4597.218472859622;116131.8386816138;119843;121853;123188.38405808093;139795.30102349422;110260;112708;113514.86485135043;113779;113852;29711;29714.702852971193;42075.31698732077;95176.04823951672;100986;9070.319726020443;9629.181519570915;9684.32209745311;9705.514724263618;9728.416295022322;49437.75281123715;58650.12024819716;60381;61061.08408373789;61287;78087.6095619541;81780;83128.7530687028;85977;93348.06651933394;13862.306884655929;13946.30268486592;14018.228997404833;14153.864594362642;14599.051061680957;15069.849301506845;15154.318055687741;15439.768403474181;15479.303431345392;16370.345186192419;14368.928155359155;14529.27353632293;14808.037477563925;14884.10695358282;15078.924605376902;14290.57128286153;14424.711505770036;14649.63375915568;14971.101733896001;15123.16822574725;14085.436582536993;14466.493672721404;14501.927490362481;14812.703745925237;14932.402703892158;11208.103351732005;11343.659690209306;11553.709269929359;11686.357250351311;12318.876811231772;9582.856257156009;10139.594416223268;10479.94760026195;11574.363410012193;11634.127440441831 11:36:26 INFO - PROCESS | 1963 | __end_tp_report 11:36:26 INFO - PROCESS | 1963 | __start_cc_report 11:36:26 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1286 11:36:26 INFO - PROCESS | 1963 | __end_cc_report 11:36:26 INFO - PROCESS | 1963 | __startTimestamp1468607786389__endTimestamp 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | ------- Summary: start ------- 11:36:26 INFO - PROCESS | 1963 | Number of tests: 6 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | [#0] dojo.html Cycles:165 Average:5664.85 Median:5850.39 stddev:669.11 (11.4%) stddev-sans-first:632.63 11:36:26 INFO - PROCESS | 1963 | Values: 2812.0 3319.0 3322.7 3349.7 3375.4 5495.7 5593.4 5616.0 5696.4 5726.5 5666.9 5677.9 5790.8 5818.4 5822.9 4419.8 5112.2 5122.6 5189.7 5205.6 5242.9 5280.1 5288.3 5291.6 5292.5 3922.6 4409.1 5144.4 5174.7 5205.9 5141.0 5167.1 5181.4 5208.6 5219.7 5083.5 5128.3 5151.7 5228.4 5247.9 5177.9 5612.7 5631.0 5754.5 5791.3 6001.2 6053.3 6120.1 6192.8 6214.8 5765.9 6191.6 6226.1 6229.8 6252.2 5805.2 5838.7 5846.9 5850.4 5862.7 6122.2 6223.6 6250.8 6268.6 6269.6 6051.6 6134.4 6148.2 6181.0 6188.6 5219.7 6239.9 6246.2 6250.3 6258.7 6019.8 6028.3 6184.5 6195.4 6215.3 5554.5 5884.6 6120.3 6223.1 6251.2 4927.0 4968.7 4970.6 4979.1 5020.3 4443.6 4447.4 4451.9 4469.8 4482.8 5628.4 5676.0 5687.6 5766.2 5776.7 6210.4 6213.3 6215.3 6229.6 6254.2 5626.1 5662.1 5709.5 5714.3 5747.8 5297.5 5330.5 5333.4 5367.5 5392.5 6256.8 6267.6 6269.7 6283.2 6294.1 6212.5 6213.3 6224.1 6254.7 6258.4 6127.8 6243.0 6252.0 6256.9 6259.3 5130.5 6066.4 6117.2 6129.5 6135.3 6224.3 6231.7 6246.9 6251.8 6254.7 5997.7 6052.8 6100.5 6110.6 6116.5 4960.8 4970.7 5184.4 5990.6 6047.7 5930.5 5932.8 5939.3 5943.8 5983.8 6072.3 6085.1 6091.3 6096.6 6108.5 5723.2 5790.2 5861.1 5920.7 5933.2 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | [#1] ext.html Cycles:180 Average:78274.53 Median:21077.53 stddev:174553.48 (828.1%) stddev-sans-first:174945.36 11:36:26 INFO - PROCESS | 1963 | Values: 455.7 516.3 519.7 523.9 563.4 30584.0 43077.8 44017.3 44606.0 46664.3 45508.8 45905.6 45913.8 45940.5 46129.5 7574.9 9832.1 10040.1 10043.6 10067.5 8829.6 12089.9 12326.5 12340.1 12502.1 12247.3 12289.2 12307.0 12327.3 12337.3 7813.3 8773.5 8965.4 12157.8 12371.8 8968.5 11742.0 12059.8 12082.2 12325.3 43267.0 43690.8 43739.8 43760.8 43762.1 3535.9 3617.2 3650.3 3816.1 3868.7 29129.7 33356.7 33689.3 33896.5 34042.8 2597.3 3258.9 3427.4 3455.9 3464.8 507535.0 521760.0 544845.0 550186.0 550221.0 66496.0 66513.7 67202.0 67210.0 67267.7 35635.8 36299.5 36302.0 37683.6 37729.0 17196.7 17224.0 17379.8 17383.2 17398.0 12036.5 12176.0 12197.0 12379.3 12940.8 17878.2 18860.3 21022.1 21052.3 21078.4 8076.3 8196.2 8197.4 8213.7 8250.6 889.6 928.8 1071.0 1083.3 1088.1 30930.4 31489.1 31792.2 31843.0 32419.5 985.9 1052.4 1081.1 1132.7 1190.6 15358.2 15398.3 16206.3 16923.0 16966.4 722791.0 730737.0 731053.0 731202.0 732516.0 64098.0 64840.0 65001.0 65266.0 65293.7 1120.4 1306.8 1413.4 1426.2 1438.7 31773.7 33138.0 33213.7 33327.7 33365.5 55362.7 55484.0 56393.4 56394.0 56412.0 665137.0 676725.0 678718.0 678769.4 679033.0 38339.0 46397.6 47241.1 47355.3 47414.8 50998.5 51410.0 51642.5 51748.7 52772.9 35632.8 41988.0 42012.2 42721.4 43074.6 42458.0 42460.6 43492.7 43710.0 44005.8 41101.8 41357.6 41693.2 41959.6 42003.4 31689.8 34365.8 36117.5 36932.1 37445.0 24132.9 25788.7 26706.9 27119.3 27153.6 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | [#2] jquery.html Cycles:180 Average:36212.51 Median:21844.77 stddev:102903.76 (471.1%) stddev-sans-first:103157.21 11:36:26 INFO - PROCESS | 1963 | Values: 356.6 374.6 383.3 390.9 407.0 10981.4 13599.4 21219.8 21288.1 22569.0 12145.6 12455.4 20636.7 21492.9 21521.9 5027.7 5459.7 5469.3 5471.1 5485.5 3872.6 5331.9 5829.4 6118.3 6135.5 6101.4 6140.7 6143.8 6145.8 6156.4 5799.8 6134.8 6144.5 6184.9 6192.0 3756.0 5598.9 5927.5 5938.8 5953.0 13673.5 13912.9 13921.2 25560.4 26772.7 2414.1 2590.4 2769.1 2782.7 2814.7 10102.9 10224.8 13819.2 15205.0 15499.8 1855.9 1931.8 1971.8 1973.4 1977.1 126387.3 134345.0 134544.0 137386.0 137736.0 10167.5 10432.9 11317.4 11368.4 11644.1 13732.4 13755.6 13993.5 14025.6 14563.0 6546.6 7245.9 8713.6 8783.5 8802.0 8686.9 8689.8 8706.6 8819.3 8827.6 4566.5 4620.9 4658.7 4662.0 4683.8 1954.5 1974.8 1975.4 1976.3 2002.2 800.9 871.5 903.3 1022.4 1039.8 20359.2 20939.2 22167.7 22311.6 23405.4 732.7 936.8 973.6 995.3 1010.4 10970.0 11189.7 11716.3 11765.9 11775.1 584298.0 612580.0 618334.0 624971.0 627315.0 128611.7 128629.0 128996.0 129868.0 133164.0 1061.5 1073.3 1106.4 1126.1 1133.9 18408.0 19091.9 19456.4 19900.5 19986.9 51383.2 53422.0 57072.4 59201.7 59977.0 87551.6 88366.0 88680.1 89122.6 91016.0 8093.6 8316.1 8511.3 8524.7 8681.2 12676.4 13496.9 13603.7 13664.5 13755.3 11395.0 11669.6 11768.8 11835.7 11933.6 10631.3 10782.8 11343.2 11466.5 11568.2 10344.6 11866.5 11890.9 12041.2 12069.6 8289.7 8389.8 8415.5 8562.9 8616.0 9922.0 11627.2 11685.4 11727.9 11882.8 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | [#3] mootools.html Cycles:180 Average:5730.68 Median:2594.09 stddev:3255.81 (125.5%) stddev-sans-first:3248.46 11:36:26 INFO - PROCESS | 1963 | Values: 1371.9 1570.9 1587.2 1799.5 1928.6 6919.2 7574.9 8014.0 8018.0 8020.3 8394.0 8679.5 8691.0 8806.6 8819.7 2274.5 2342.0 2342.4 2346.2 2346.4 1989.4 2386.5 2387.5 2390.0 2404.3 2346.4 2363.6 2384.0 2386.3 2393.2 2321.0 2356.7 2362.2 2363.7 2366.4 2353.3 2357.8 2359.7 2361.6 2363.4 8802.0 8853.0 8854.4 8868.6 8885.5 4728.8 4934.5 5177.5 5234.3 5334.5 3506.0 3508.7 3626.7 3628.8 3642.4 1075.8 1088.8 1098.3 1111.4 1116.1 11702.0 11828.2 11847.2 11852.5 11853.0 4464.7 4583.2 4774.4 4785.3 4786.4 10105.9 10108.2 10108.7 10121.4 10124.0 5346.8 5355.7 5358.2 5362.9 5365.7 4724.3 4912.4 4914.2 4916.2 4945.0 3180.6 3728.7 3808.8 3814.5 3852.8 1165.2 1166.7 1166.9 1177.7 1178.6 939.5 942.9 948.6 971.9 998.2 5608.3 5901.3 5948.0 6008.4 6056.4 400.9 423.4 453.1 462.6 463.9 3929.6 4039.5 4065.6 4122.8 4146.8 9960.9 10440.3 10461.5 11011.8 11053.4 10926.8 10937.9 10947.3 10948.7 10966.6 7036.5 7881.8 8273.5 8387.2 8413.3 6093.0 6108.8 6164.0 6220.8 6264.8 10087.7 10333.4 10335.8 10359.8 10368.9 9811.2 10037.9 10455.9 10457.4 10478.8 7640.8 7725.5 7814.6 7815.2 7818.8 8364.4 8421.2 8425.5 8448.6 8478.5 7536.4 7614.8 7656.8 7735.4 7736.0 7470.3 7472.9 7477.0 7627.2 7642.5 7017.6 7120.0 7201.3 7239.9 7242.3 5042.2 5075.8 5097.0 5252.6 5275.3 4272.7 4867.9 4906.8 5156.8 5368.0 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | [#4] prototype.html Cycles:180 Average:4488.31 Median:4959.80 stddev:1378.68 (27.8%) stddev-sans-first:1346.30 11:36:26 INFO - PROCESS | 1963 | Values: 303.7 309.2 314.1 317.0 319.4 4877.6 5394.7 5395.6 5399.8 5406.5 4466.5 4772.9 4909.7 5353.6 5376.0 3501.6 3849.3 3991.2 4107.5 4114.0 3887.8 4066.9 4081.5 4083.7 4144.4 4022.1 4024.9 4045.3 4052.9 4059.4 3167.6 3625.4 3939.5 4066.6 4089.9 2895.6 3037.4 3130.3 3491.5 3561.7 3904.2 5045.3 5149.5 5263.4 5290.7 3903.6 4456.5 4636.3 4686.6 4711.6 4689.6 5422.2 5607.5 5637.8 5639.9 3787.9 3799.8 3903.0 3922.2 3961.5 5481.6 5561.7 5901.2 5914.3 5937.5 3953.2 3987.4 3994.0 4000.9 4018.6 3356.4 4018.3 4062.7 4064.4 4072.4 3861.5 4058.5 4624.3 4658.9 4687.8 4927.5 5187.6 5481.6 5629.9 5642.6 1146.5 1147.3 1199.6 1359.7 1368.8 894.8 919.8 930.2 934.6 943.3 4209.9 4904.1 4959.8 5019.6 5184.5 4432.7 5632.4 5765.6 5822.9 5964.0 3788.8 5194.7 5226.7 5245.8 5284.4 2895.0 2922.6 2990.9 3021.6 3043.4 5463.4 5648.2 5908.6 5912.0 5987.4 4454.9 4929.3 5833.3 5874.8 5892.1 4871.5 4950.7 5794.3 5824.4 5856.6 5381.5 5450.0 5551.9 5673.3 5684.6 5271.9 5624.6 5715.4 5730.3 5753.7 4941.3 5174.8 5813.5 5921.0 5925.3 3630.3 3793.5 3816.7 3829.7 3851.4 5109.7 5276.9 5286.7 5726.2 5799.4 4865.8 4918.6 5516.2 5686.7 5720.8 4959.8 5130.9 5312.5 5430.3 5665.5 5045.4 5493.7 5512.3 5534.9 5539.2 5362.4 5475.4 5542.3 5671.0 5711.0 4719.9 4862.0 5359.4 5534.1 5578.8 11:36:26 INFO - PROCESS | 1963 | 11:36:26 INFO - PROCESS | 1963 | [#5] yui.html Cycles:180 Average:22061.56 Median:3910.12 stddev:33154.62 (847.9%) stddev-sans-first:33208.96 11:36:26 INFO - PROCESS | 1963 | Values: 735.9 761.4 782.0 843.6 859.9 15723.0 16154.8 16168.9 16222.7 16229.8 11512.8 14748.6 14907.7 14909.9 14943.3 687.1 718.2 871.9 896.3 899.5 864.8 897.0 897.5 900.0 905.7 932.1 943.1 943.2 943.6 944.5 742.2 765.8 767.6 938.9 939.0 566.0 569.8 682.7 702.6 712.9 14405.4 14422.4 14576.8 14655.8 14660.3 14119.6 14290.1 14380.4 14392.5 14560.6 13113.7 13156.6 13328.3 13560.3 13613.2 4492.1 4555.8 4579.2 4632.5 4742.4 99237.0 100265.5 101294.0 101413.0 101571.5 11142.0 11456.9 11504.9 11591.0 11632.9 22997.9 23033.0 23053.5 23105.3 23367.1 7996.6 8001.8 8022.0 8130.0 8265.2 4167.5 4595.7 4678.1 4695.2 4722.7 3520.1 3643.6 3646.7 3652.1 3652.8 633.7 644.3 693.9 748.8 749.0 549.2 600.3 628.8 697.5 705.5 9118.2 9285.4 9357.8 9435.6 9880.6 634.4 662.5 677.6 690.1 696.7 4387.6 4390.2 4538.6 4561.5 4597.2 116131.8 119843.0 121853.0 123188.4 139795.3 110260.0 112708.0 113514.9 113779.0 113852.0 29711.0 29714.7 42075.3 95176.0 100986.0 9070.3 9629.2 9684.3 9705.5 9728.4 49437.8 58650.1 60381.0 61061.1 61287.0 78087.6 81780.0 83128.8 85977.0 93348.1 13862.3 13946.3 14018.2 14153.9 14599.1 15069.8 15154.3 15439.8 15479.3 16370.3 14368.9 14529.3 14808.0 14884.1 15078.9 14290.6 14424.7 14649.6 14971.1 15123.2 14085.4 14466.5 14501.9 14812.7 14932.4 11208.1 11343.7 11553.7 11686.4 12318.9 9582.9 10139.6 10479.9 11574.4 11634.1 11:36:26 INFO - PROCESS | 1963 | -------- Summary: end -------- 11:36:26 INFO - PROCESS | 1963 | 11:36:27 INFO - TEST-INFO | 1963: exit 0 11:36:27 INFO - TEST-OK | dromaeo_css | took 1116512ms 11:36:27 INFO - TEST-START | kraken 11:36:27 INFO - operating with platform_type : mac_ 11:36:27 INFO - Initialising browser for kraken test... 11:36:27 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpCbUu4p/profile http://localhost:49670/getInfo.html) 11:36:29 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 11:36:29 INFO - PROCESS | 1966 | colorDepth:24 11:36:29 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 11:36:29 INFO - PROCESS | 1966 | __metrics 11:36:29 INFO - PROCESS | 1966 | 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" 11:36:29 INFO - PROCESS | 1966 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:30 INFO - TEST-INFO | 1966: exit 0 11:36:30 INFO - Browser initialized. 11:36:30 INFO - Running cycle 1/1 for kraken test... 11:36:30 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpCbUu4p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:42 INFO - PROCESS | 1968 | RSS: Main: 244989952 11:36:42 INFO - PROCESS | 1968 | 11:36:45 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49670/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:45 INFO - PROCESS | 1968 | RSS: Main: 294903808 11:36:45 INFO - PROCESS | 1968 | 11:36:48 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49670/tests/kraken/driver.html?testName=audio-dft) 11:36:49 INFO - PROCESS | 1968 | RSS: Main: 305295360 11:36:49 INFO - PROCESS | 1968 | 11:36:52 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49670/tests/kraken/driver.html?testName=audio-fft) 11:36:53 INFO - PROCESS | 1968 | RSS: Main: 391618560 11:36:53 INFO - PROCESS | 1968 | 11:36:55 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49670/tests/kraken/driver.html?testName=audio-oscillator) 11:36:55 INFO - PROCESS | 1968 | RSS: Main: 291639296 11:36:55 INFO - PROCESS | 1968 | 11:36:57 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49670/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:58 INFO - PROCESS | 1968 | RSS: Main: 295620608 11:36:58 INFO - PROCESS | 1968 | 11:37:01 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49670/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:02 INFO - PROCESS | 1968 | RSS: Main: 333631488 11:37:02 INFO - PROCESS | 1968 | 11:37:04 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49670/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:05 INFO - PROCESS | 1968 | RSS: Main: 334098432 11:37:05 INFO - PROCESS | 1968 | 11:37:08 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49670/tests/kraken/driver.html?testName=json-parse-financial) 11:37:08 INFO - PROCESS | 1968 | RSS: Main: 333537280 11:37:08 INFO - PROCESS | 1968 | 11:37:10 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49670/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:11 INFO - PROCESS | 1968 | RSS: Main: 312184832 11:37:11 INFO - PROCESS | 1968 | 11:37:12 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:13 INFO - PROCESS | 1968 | RSS: Main: 320266240 11:37:13 INFO - PROCESS | 1968 | 11:37:15 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:16 INFO - PROCESS | 1968 | RSS: Main: 317706240 11:37:16 INFO - PROCESS | 1968 | 11:37:19 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:19 INFO - PROCESS | 1968 | RSS: Main: 325464064 11:37:19 INFO - PROCESS | 1968 | 11:37:22 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:23 INFO - PROCESS | 1968 | RSS: Main: 326959104 11:37:23 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49670/tests/kraken/driver.html?testName=ai-astar) 11:37:25 INFO - PROCESS | 1968 | RSS: Main: 370921472 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | __start_tp_report 11:37:25 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 11:37:25 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 11:37:25 INFO - PROCESS | 1968 | |i|pagename|runs| 11:37:25 INFO - PROCESS | 1968 | |0;ai-astar;115;167;162;112;113;115;112;113;112;113 11:37:25 INFO - PROCESS | 1968 | |1;audio-beat-detection;141;107;107;159;106;106;138;103;136;105 11:37:25 INFO - PROCESS | 1968 | |2;audio-dft;185;182;182;180;180;182;195;255;181;183 11:37:25 INFO - PROCESS | 1968 | |3;audio-fft;78;74;57;106;57;57;60;60;96;57 11:37:25 INFO - PROCESS | 1968 | |4;audio-oscillator;82;90;91;70;70;68;96;69;67;99 11:37:25 INFO - PROCESS | 1968 | |5;imaging-gaussian-blur;87;85;87;84;87;84;87;110;85;83 11:37:25 INFO - PROCESS | 1968 | |6;imaging-darkroom;93;92;93;93;93;92;93;93;92;93 11:37:25 INFO - PROCESS | 1968 | |7;imaging-desaturate;85;87;84;85;85;83;84;85;83;83 11:37:25 INFO - PROCESS | 1968 | |8;json-parse-financial;54;54;54;54;54;53;55;53;53;53 11:37:25 INFO - PROCESS | 1968 | |9;json-stringify-tinderbox;66;69;67;76;75;72;70;69;70;73 11:37:25 INFO - PROCESS | 1968 | |10;stanford-crypto-aes;86;83;81;81;83;83;84;87;94;103 11:37:25 INFO - PROCESS | 1968 | |11;stanford-crypto-ccm;138;135;142;148;151;146;135;135;178;137 11:37:25 INFO - PROCESS | 1968 | |12;stanford-crypto-pbkdf2;161;157;228;231;166;166;165;174;161;162 11:37:25 INFO - PROCESS | 1968 | |13;stanford-crypto-sha256-iterative;64;66;67;68;67;67;65;65;64;65 11:37:25 INFO - PROCESS | 1968 | __end_tp_report 11:37:25 INFO - PROCESS | 1968 | __start_cc_report 11:37:25 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,2070 11:37:25 INFO - PROCESS | 1968 | __end_cc_report 11:37:25 INFO - PROCESS | 1968 | __startTimestamp1468607845552__endTimestamp 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | ------- Summary: start ------- 11:37:25 INFO - PROCESS | 1968 | Number of tests: 14 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#0] ai-astar Cycles:10 Average:123.40 Median:114.00 stddev:21.72 (19.1%) stddev-sans-first:22.83 11:37:25 INFO - PROCESS | 1968 | Values: 115.0 167.0 162.0 112.0 113.0 115.0 112.0 113.0 112.0 113.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:121.50 stddev:20.49 (16.9%) stddev-sans-first:20.39 11:37:25 INFO - PROCESS | 1968 | Values: 141.0 107.0 107.0 159.0 106.0 106.0 138.0 103.0 136.0 105.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#2] audio-dft Cycles:10 Average:190.50 Median:182.50 stddev:23.08 (12.6%) stddev-sans-first:24.39 11:37:25 INFO - PROCESS | 1968 | Values: 185.0 182.0 182.0 180.0 180.0 182.0 195.0 255.0 181.0 183.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#3] audio-fft Cycles:10 Average:70.20 Median:60.00 stddev:18.04 (30.1%) stddev-sans-first:18.91 11:37:25 INFO - PROCESS | 1968 | Values: 78.0 74.0 57.0 106.0 57.0 57.0 60.0 60.0 96.0 57.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:86.00 stddev:12.80 (14.9%) stddev-sans-first:13.56 11:37:25 INFO - PROCESS | 1968 | Values: 82.0 90.0 91.0 70.0 70.0 68.0 96.0 69.0 67.0 99.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:86.00 stddev:7.91 (9.2%) stddev-sans-first:8.38 11:37:25 INFO - PROCESS | 1968 | Values: 87.0 85.0 87.0 84.0 87.0 84.0 87.0 110.0 85.0 83.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:37:25 INFO - PROCESS | 1968 | Values: 93.0 92.0 93.0 93.0 93.0 92.0 93.0 93.0 92.0 93.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 11:37:25 INFO - PROCESS | 1968 | Values: 85.0 87.0 84.0 85.0 85.0 83.0 84.0 85.0 83.0 83.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 11:37:25 INFO - PROCESS | 1968 | Values: 54.0 54.0 54.0 54.0 54.0 53.0 55.0 53.0 53.0 53.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:3.27 (4.6%) stddev-sans-first:2.99 11:37:25 INFO - PROCESS | 1968 | Values: 66.0 69.0 67.0 76.0 75.0 72.0 70.0 69.0 70.0 73.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:83.50 stddev:6.93 (8.3%) stddev-sans-first:7.35 11:37:25 INFO - PROCESS | 1968 | Values: 86.0 83.0 81.0 81.0 83.0 83.0 84.0 87.0 94.0 103.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:144.00 stddev:13.14 (9.1%) stddev-sans-first:13.73 11:37:25 INFO - PROCESS | 1968 | Values: 138.0 135.0 142.0 148.0 151.0 146.0 135.0 135.0 178.0 137.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:166.00 stddev:27.99 (16.9%) stddev-sans-first:29.07 11:37:25 INFO - PROCESS | 1968 | Values: 161.0 157.0 228.0 231.0 166.0 166.0 165.0 174.0 161.0 162.0 11:37:25 INFO - PROCESS | 1968 | 11:37:25 INFO - PROCESS | 1968 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.40 (2.1%) stddev-sans-first:1.32 11:37:25 INFO - PROCESS | 1968 | Values: 64.0 66.0 67.0 68.0 67.0 67.0 65.0 65.0 64.0 65.0 11:37:25 INFO - PROCESS | 1968 | -------- Summary: end -------- 11:37:25 INFO - PROCESS | 1968 | 11:37:26 INFO - TEST-INFO | 1968: exit 0 11:37:26 INFO - TEST-OK | kraken | took 59299ms 11:37:26 INFO - SUITE-END | took 1175s 11:37:26 INFO - Completed test suite (00:19:36) 11:37:26 INFO - javascript benchmark 11:37:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2811.957820632691, 3319.0, 3322.6843449872267, 3349.715274201693, 3375.4430518964373, 5495.670259784416, 5593.412691667372, 5616.045272303708, 5696.401877802828, 5726.455986681264, 5666.914996275049, 5677.943220567793, 5790.797322093727, 5818.389069147742, 5822.883542329151, 4419.845305414311, 5112.156494178456, 5122.564582010534, 5189.7405129743365, 5205.635605507616, 5242.947570524303, 5280.102382594949, 5288.338957630296, 5291.5766738661005, 5292.470752924715, 3922.6469617734256, 4409.0520538084465, 5144.382674079097, 5174.689518628894, 5205.947940520584, 5141.048905952411, 5167.121589329823, 5181.404138524081, 5208.635395522315, 5219.71291578963, 5083.466236045199, 5128.282040514331, 5151.716655583941, 5228.424873263938, 5247.895042099137, 5177.896442071137, 5612.719364031782, 5631.0, 5754.510866576305, 5791.276090488689, 6001.2498437695285, 6053.273607167124, 6120.051392034242, 6192.752289908398, 6214.751409943642, 5765.942340576583, 6191.597546159485, 6226.128342032119, 6229.813105606794, 6252.249730032425, 5805.216295800097, 5838.7080645967535, 5846.941530584682, 5850.385709500526, 5862.70686465675, 6122.173506576644, 6223.595466294676, 6250.812475625738, 6268.561200715906, 6269.62382257066, 6051.618790668127, 6134.375358695336, 6148.231471066117, 6180.969095154495, 6188.628682278988, 5219.660722053054, 6239.937600624026, 6246.187995560639, 6250.281217659936, 6258.718357673915, 6019.819405417845, 6028.306744724325, 6184.536159788034, 6195.411435913581, 6215.34738852423, 5554.472325129106, 5884.6469211847425, 6120.294761999531, 6223.1287619733275, 6251.187345645037, 4926.950730492721, 4968.701877887338, 4970.577500912463, 4979.103761322925, 5020.322256495399, 4443.644508439317, 4447.355133505624, 4451.910961780811, 4469.754163520973, 4482.8206871725415, 5628.437156284339, 5676.0, 5687.573431992617, 5766.221560089334, 5776.68228247442, 6210.378962103753, 6213.254409470893, 6215.285242197115, 6229.595076320024, 6254.249490061222, 5626.127950167649, 5662.065759149777, 5709.514691251207, 5714.314282286069, 5747.798827041033, 5297.470252974672, 5330.520253177233, 5333.413324534298, 5367.490088441592, 5392.514673679388, 6256.812295631138, 6267.62394256346, 6269.686515674198, 6283.183186185766, 6294.1188233648245, 6212.534059945612, 6213.285472170758, 6224.097505861715, 6254.687265636791, 6258.43674069336, 6127.769884593299, 6242.968785156045, 6251.99968005117, 6256.874862502816, 6259.3427690091885, 5130.538251557377, 6066.423689749467, 6117.218487018478, 6129.509639228761, 6135.263289243823, 6224.284207316216, 6231.719572619152, 6246.875062498633, 6251.78118765841, 6254.749810007549, 5997.730102145501, 6052.84995850787, 6100.54245931548, 6110.572259941761, 6116.510679145568, 4960.77676504551, 4970.676906001098, 5184.377874655065, 5990.64056156632, 6047.697615119138, 5930.525557955267, 5932.79235226765, 5939.316978547349, 5943.762249509971, 5983.760649573968, 6072.301685306246, 6085.056816193497, 6091.284738969781, 6096.603720758137, 6108.539925731173, 5723.170140329712, 5790.218320526675, 5861.120831875252, 5920.703964801829, 5933.169356290036], "value": 5621.431640631342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.7220095741597, 516.3442428116292, 519.7427273499618, 523.8632168195016, 563.3830955104161, 30584.0, 43077.78461107694, 44017.339739903924, 44606.0, 46664.300035499495, 45508.772456137754, 45905.62283131503, 45913.7704311478, 45940.540594594044, 46129.53870461295, 7574.886376704354, 9832.065953734384, 10040.146587540068, 10043.598256069748, 10067.5469603868, 8829.558522073903, 12089.939550302237, 12326.5069397224, 12340.13619046667, 12502.12485126037, 12247.326397048158, 12289.201201921891, 12307.0, 12327.32199729019, 12337.259764414119, 7813.257740514642, 8773.517456539888, 8965.372423930328, 12157.756844863097, 12371.814422783666, 8968.50673212973, 11742.001929835975, 12059.819102713467, 12082.15424920256, 12325.322107284095, 43267.0, 43690.78154609207, 43739.78130109361, 43760.78119609413, 43762.06141447285, 3535.9469607955903, 3617.1680513482047, 3650.3064417760806, 3816.0644968647193, 3868.6518213360932, 29129.70870291312, 33356.66643333584, 33689.32621347559, 33896.49155262673, 34042.82978585091, 2597.2987293430856, 3258.8859389921477, 3427.365937301582, 3455.948160777565, 3464.8440820163155, 507535.0, 521760.0, 544845.0, 550186.0, 550221.0, 66496.0, 66513.66972660519, 67202.0, 67209.95110440084, 67267.66366168138, 35635.82182089125, 36299.4555081674, 36302.0, 37683.62316376856, 37729.0, 17196.656066878844, 17224.0, 17379.826201737822, 17383.217755201047, 17398.0431076292, 12036.45835937385, 12176.0, 12197.0, 12379.257244565355, 12940.805887911689, 17878.195481203376, 18860.329169756267, 21022.054007569695, 21052.263170789254, 21078.367648970554, 8076.27313541784, 8196.221358970888, 8197.385196110316, 8213.712520061768, 8250.62716760118, 889.58634235081, 928.7538802217283, 1070.9946450267698, 1083.2633809009792, 1088.1403691083956, 30930.381392372026, 31489.055328340186, 31792.205194870312, 31843.0, 32419.513707293936, 985.930984831055, 1052.4159091704178, 1081.0756802933536, 1132.7394699219226, 1190.6190019193775, 15358.1969946593, 15398.307076181598, 16206.270717817726, 16922.984620922784, 16966.406175783788, 722791.0, 730737.0, 731053.0, 731202.0, 732516.0, 64098.0, 64840.027399589046, 65001.02498462527, 65266.0, 65293.67353163204, 1120.4117838134882, 1306.777847765901, 1413.3639862061907, 1426.2155814301884, 1438.7266419380285, 31773.682263177074, 33138.0, 33213.667863321054, 33327.666723332455, 33365.49951750774, 55362.72318638381, 55484.0, 56393.436065638816, 56394.0, 56412.0, 665137.0, 676725.0, 678718.0, 678769.4246115149, 679033.0, 38339.0, 46397.6080717579, 47241.05517889554, 47355.28967065428, 47414.76292618653, 50998.490015100855, 51410.0, 51642.48357516527, 51748.74125629348, 52772.9445411082, 35632.82183589065, 41988.0, 42012.15975680408, 42721.43671379727, 43074.569254307055, 42458.0, 42460.575394245665, 43492.69355943307, 43710.0, 44005.77997110122, 41101.79449102735, 41357.58642413537, 41693.16613667649, 41959.58040419557, 42003.36994945017, 31689.841550792098, 34365.828170858986, 36117.45823812697, 36932.07669808276, 37445.0, 24132.87933560321, 25788.742112579384, 26706.866465667546, 27119.322016948943, 27153.59269610918], "value": 21465.04626212268, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6095125837211, 374.584211525207, 383.3081288274665, 390.9218156368725, 406.9755814651121, 10981.399486262004, 13599.38802753876, 21219.787802121973, 21288.148474061018, 22569.0, 12145.635630931065, 12455.439505222264, 20636.69044964323, 21492.925353732327, 21521.892390538025, 5027.673201241917, 5459.727013649322, 5469.288992430978, 5471.069918113911, 5485.533729632986, 3872.5740168581433, 5331.866703332409, 5829.417058294158, 6118.3269840317525, 6135.539834512407, 6101.389861013908, 6140.662263575501, 6143.754249830002, 6145.754169833202, 6156.415140561639, 5799.768009279624, 6134.846628834271, 6144.477719393857, 6184.907226391608, 6191.9690401547705, 3755.9812200939095, 5598.916016259759, 5927.466528012456, 5938.7624495020145, 5953.0, 13673.453061877513, 13912.93043534786, 13921.164730116225, 25560.360990975187, 26772.732272677415, 2414.0947144820693, 2590.430105376814, 2769.1000424862, 2782.6660800703844, 2814.6763122241, 10102.949485252526, 10224.846627300596, 13819.239941803196, 15205.0, 15499.845001549953, 1855.870089093764, 1931.768187817457, 1971.822535971755, 1973.398113575359, 1977.0510155125476, 126387.31257093362, 134345.0, 134544.0, 137386.0, 137736.0, 10167.491625418847, 10432.895671043192, 11317.377544234982, 11368.431578421047, 11644.068474522019, 13732.382042808098, 13755.587332379844, 13993.510227142206, 14025.649358765908, 14562.980591358502, 6546.5744726593575, 7245.927540724525, 8713.564321783886, 8783.5169065702, 8802.0, 8686.86969695455, 8689.826203475895, 8706.608202630898, 8819.29445644347, 8827.558622068871, 4566.452025756864, 4620.907581848344, 4658.697184682985, 4662.020975595163, 4683.765811709401, 1954.4918321236296, 1974.782773894899, 1975.424481688149, 1976.298414062987, 2002.229141780425, 800.8947652239872, 871.4988881393224, 903.3315346643436, 1022.381459217163, 1039.812833689943, 20359.185632574827, 20939.162433502795, 22167.652416960023, 22311.553768924532, 23405.41486462852, 732.7105793211651, 936.7939053408239, 973.5521660036462, 995.2983146881431, 1010.4190090697878, 10970.0, 11189.720256993478, 11716.297022178696, 11765.882341176479, 11775.116866235066, 584298.0, 612580.0, 618334.0, 624971.0, 627315.0, 128611.71388285997, 128629.0, 128996.0, 129868.0, 133164.0, 1061.4798748613123, 1073.3291692692067, 1106.3970136275589, 1126.0878688262533, 1133.9433028348549, 18407.98756068429, 19091.904540477208, 19456.44348452149, 19900.50248743793, 19986.90006549958, 51383.22925156201, 53422.0, 57072.42927570671, 59201.703991479764, 59977.0, 87551.56224219094, 88366.0, 88680.11319886976, 89122.55438723024, 91016.0, 8093.635786389509, 8316.085230624747, 8511.276541494042, 8524.74425767228, 8681.2186903179, 12676.429560669607, 13496.86503134956, 13603.659908502366, 13664.453421863014, 13755.31223438844, 11395.0, 11669.649910502698, 11768.76462470763, 11835.704107397383, 11933.582324618597, 10631.308964917256, 10782.784344312913, 11343.20597558163, 11466.484008219484, 11568.190226684052, 10344.637937672145, 11866.466009029442, 11890.940545297219, 12041.217320874115, 12069.57756478519, 8289.668413263644, 8389.832203355776, 8415.53714545706, 8562.871556926775, 8615.956920215358, 9922.0, 11627.244229125079, 11685.357305347947, 11727.882721172678, 11882.82175767347], "value": 9728.357080152004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.8765311122008, 1570.8507691769282, 1587.2460581223916, 1799.5051360875757, 1928.6239183359241, 6919.238883722793, 7574.886376704347, 8013.959930200341, 8017.95991020044, 8020.278174964252, 8393.95803020984, 8679.47923124613, 8691.0, 8806.55967201639, 8819.691310804123, 2274.4768703198274, 2341.964870526935, 2342.4261056041296, 2346.225745503988, 2346.3664810501155, 1989.3534601254578, 2386.4630458146953, 2387.486690361572, 2390.0, 2404.2546810488802, 2346.3899386159637, 2363.5981883079917, 2384.0463814474174, 2386.284114765572, 2393.162393162388, 2321.0483701682397, 2356.705411823522, 2362.2204672458047, 2363.72817126031, 2366.396568874943, 2353.2822489140804, 2357.799587035104, 2359.6578496118136, 2361.551305251997, 2363.409147713072, 8802.0, 8852.955735221347, 8854.424462409923, 8868.645254189825, 8885.4668719877, 4728.787204575802, 4934.506549345073, 5177.508136727005, 5234.319538460014, 5334.546563542103, 3505.9832648531897, 3508.701760350373, 3626.7279954003293, 3628.7822730636244, 3642.3990041643096, 1075.8063548561256, 1088.8366744988236, 1098.2970898624887, 1111.4276147783899, 1116.0513563471065, 11702.005329546999, 11828.23116497425, 11847.170698051139, 11852.466639001179, 11852.992495637882, 4464.687471876938, 4583.166733306704, 4774.427068751703, 4785.282207668877, 4786.401699787527, 10105.9494702526, 10108.191344692406, 10108.747281318027, 10121.443320617289, 10124.038216369434, 5346.8128615499045, 5355.678659280456, 5358.223057656618, 5362.892742145135, 5365.704886231217, 4724.314974328703, 4912.4350699669285, 4914.189158788831, 4916.237983112624, 4945.010997800454, 3180.6183258009187, 3728.664420202195, 3808.847646094125, 3814.4659747635355, 3852.8073596320073, 1165.1785491228663, 1166.6558365282092, 1166.9299842009507, 1177.682025853015, 1178.6110583507423, 939.5208443693629, 942.9292803039663, 948.6300342866288, 971.9028097190225, 998.177457080846, 5608.298962629671, 5901.262342207224, 5947.970260148758, 6008.429199226067, 6056.36408177135, 400.94751277895523, 423.367066235973, 453.12320659523266, 462.5998511287779, 463.86779767766023, 3929.5677475477673, 4039.5354534228354, 4065.6340929316502, 4122.814473348706, 4146.792660366969, 9960.908209276133, 10440.269181157399, 10461.476926153815, 11011.779764404828, 11053.392063436588, 10926.781464370668, 10937.945310273557, 10947.34315941046, 10948.726281843017, 10966.616168434226, 7036.507444478837, 7881.763547093482, 8273.503589784632, 8387.203215694499, 8413.326933845277, 6093.0, 6108.816735497942, 6163.982942814386, 6220.844478888064, 6264.812055638338, 10087.69736907894, 10333.431661258403, 10335.793284134426, 10359.792804143724, 10368.92621475723, 9811.215102791617, 10037.89962100399, 10455.895441045492, 10457.424841633783, 10478.790424191626, 7640.8471830564185, 7725.5321488916925, 7814.57019863913, 7815.218478152139, 7818.843623127392, 8364.414490985573, 8421.15788421153, 8425.4944703318, 8448.577571121297, 8478.491290522341, 7536.359409450258, 7614.771556853303, 7656.808579785327, 7735.381169506313, 7736.0, 7470.3276705096805, 7472.925270747223, 7477.0, 7627.161012288755, 7642.50323728978, 7017.578945263301, 7119.964400177966, 7201.279872012757, 7239.8914016288745, 7242.275772422716, 5042.218456139304, 5075.7969681212335, 5097.0, 5252.606054545848, 5275.261463395051, 4272.722273052242, 4867.902641947212, 4906.822362633014, 5156.845294641167, 5368.033753924331], "value": 4514.51524923669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.70388870850917, 309.2423562272432, 314.0860097117389, 316.99366012679747, 319.4186580423627, 4877.609791216694, 5394.6802874763835, 5395.649282796616, 5399.757010934512, 5406.459354064592, 4466.486354069283, 4772.854514916412, 4909.723471897315, 5353.625246232766, 5376.0, 3501.579810422753, 3849.30712471755, 3991.201759648082, 4107.527634322061, 4113.958860411388, 3887.7667339959553, 4066.857659981901, 4081.530623978251, 4083.673306135502, 4144.41978123063, 4022.054817117975, 4024.8993775155564, 4045.2516284487315, 4052.8986775330704, 4059.391091336294, 3167.572377729, 3625.3836847735947, 3939.4878665773554, 4066.573009833984, 4089.8752842968274, 2895.623568936046, 3037.3773376457775, 3130.311331507065, 3491.4937334086417, 3561.732870034758, 3904.1996390740114, 5045.293658887758, 5149.536541711264, 5263.421023687391, 5290.65610735301, 3903.551091624471, 4456.532064133284, 4636.3045543168455, 4686.601638860667, 4711.562973293144, 4689.648276379286, 5422.177364957695, 5607.495325420691, 5637.844241930395, 5639.8590035249035, 3787.886363409102, 3799.8480060797533, 3903.0047337928645, 3922.17634296798, 3961.544422391404, 5481.643693159972, 5561.721913904329, 5901.232839730807, 5914.319853216892, 5937.476572456689, 3953.2488827122756, 3987.3819557968563, 3993.961569991823, 4000.919751667034, 4018.578049304839, 3356.3958487472, 4018.2767101921936, 4062.6749860011128, 4064.4309796628495, 4072.429859819628, 3861.4940173332425, 4058.512978442606, 4624.329472226508, 4658.930116048262, 4687.789049492781, 4927.531884470969, 5187.636865419385, 5481.643693159932, 5629.915551266734, 5642.605017648807, 1146.5356530605118, 1147.2886810177743, 1199.5501686867424, 1359.714459963399, 1368.8288963879515, 894.7518212094092, 919.8206349761732, 930.1907340613709, 934.5514153206499, 943.3020562986596, 4209.91580168401, 4904.141775189399, 4959.82640607577, 5019.573336266385, 5184.533391994739, 4432.667549933768, 5632.352279487829, 5765.56758243125, 5822.883542329129, 5964.0, 3788.753731007476, 5194.662401919151, 5226.712530810766, 5245.816396426183, 5284.4187139414635, 2895.0, 2922.590837282782, 2990.8634718807148, 3021.6071910651476, 3043.360894212196, 5463.426340234298, 5648.15277708347, 5908.586398952118, 5911.970440147772, 5987.371326010793, 4454.933176002362, 4929.3135241293585, 5833.325005246667, 5874.82631426375, 5892.145638882338, 4871.464138944784, 4950.702957822542, 5794.304683438015, 5824.446677565709, 5856.590038697335, 5381.542568881532, 5450.00249862566, 5551.945130425206, 5673.262475878109, 5684.573656975661, 5271.920921186262, 5624.578156638187, 5715.399883012224, 5730.283714535683, 5753.654780713171, 4941.308216849716, 5174.818881339135, 5813.505852002627, 5921.0, 5925.318588362394, 3630.3102410541915, 3793.487879136281, 3816.732828701964, 3829.712771542201, 3851.3645248533676, 5109.693418394908, 5276.89185271082, 5286.709230992333, 5726.226959360433, 5799.391063938226, 4865.805367785249, 4918.581920536794, 5516.214311772529, 5686.744096515584, 5720.8283751487525, 4959.776810043629, 5130.871728206825, 5312.495312945264, 5430.321209848769, 5665.546756259571, 5045.419776725724, 5493.697846618475, 5512.283403157564, 5534.889302213853, 5539.196816461671, 5362.3833259174135, 5475.397706252229, 5542.251796007487, 5670.971645141748, 5710.971445142748, 4719.914419683423, 4862.027594481188, 5359.410464848941, 5534.05920993424, 5578.832635020955], "value": 4055.2032068907392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.8822588385858, 761.3870833978644, 782.0224719101124, 843.6119385082858, 859.9122110530178, 15723.0, 16154.83845161548, 16168.919155404206, 16222.675546489078, 16229.756553651705, 11512.827307590373, 14748.557543273691, 14907.701845963074, 14909.925450372733, 14943.252837358115, 687.089606271692, 718.1561665043579, 871.8997315308726, 896.3008853094597, 899.4783025844994, 864.844328020956, 896.9596368163416, 897.5287973813735, 899.9865002024975, 905.6739573753443, 932.1005229953093, 943.056943056943, 943.170010390855, 943.6225509796068, 944.5371767833747, 742.1650643026595, 765.7740966414921, 767.5509826751357, 938.8591711243334, 938.9671361502383, 565.9915101273443, 569.7692434564008, 682.7337338438014, 702.620584884162, 712.8859382498775, 14405.351759170757, 14422.35099420518, 14576.781348279785, 14655.780163297559, 14660.340284687214, 14119.576412707635, 14290.142591444443, 14380.424783008668, 14392.496262630757, 14560.635984100376, 13113.672158196121, 13156.60530184096, 13328.333583320795, 13560.254186019765, 13613.183209007491, 4492.101579684044, 4555.817767289304, 4579.221532339477, 4632.467266264389, 4742.407199100113, 99237.00762992422, 100265.49867250618, 101294.0, 101413.0, 101571.49214253956, 11142.0, 11456.885431145749, 11504.94247528757, 11591.0, 11632.883671163348, 22997.88501057484, 23033.0, 23053.538929221657, 23105.3068407948, 23367.065317387114, 7996.64015119321, 8001.799955001055, 8022.0, 8130.0, 8265.214804593554, 4167.456524558726, 4595.701279416827, 4678.064387122589, 4695.201815691341, 4722.693024953367, 3520.06718219672, 3643.599204087548, 3646.690031347312, 3652.068722475805, 3652.7808331500196, 633.6894921488438, 644.3427703742157, 693.8681650486392, 748.7978245873584, 749.026265854398, 549.1521031728286, 600.2976517474565, 628.7893555658814, 697.4699228586311, 705.4638474759117, 9118.224950879117, 9285.350025498285, 9357.766055848659, 9435.622575097057, 9880.604775809032, 634.3783092569216, 662.4634046422414, 677.579900461707, 690.0752990992095, 696.6516741629185, 4387.6489880810095, 4390.1878152541885, 4538.614217791524, 4561.521040290788, 4597.218472859622, 116131.8386816138, 119843.0, 121853.0, 123188.38405808093, 139795.30102349422, 110260.0, 112708.0, 113514.86485135043, 113779.0, 113852.0, 29711.0, 29714.702852971193, 42075.31698732077, 95176.04823951672, 100986.0, 9070.319726020443, 9629.181519570915, 9684.32209745311, 9705.514724263618, 9728.416295022322, 49437.75281123715, 58650.12024819716, 60381.0, 61061.08408373789, 61287.0, 78087.6095619541, 81780.0, 83128.7530687028, 85977.0, 93348.06651933394, 13862.306884655929, 13946.30268486592, 14018.228997404833, 14153.864594362642, 14599.051061680957, 15069.849301506845, 15154.318055687741, 15439.768403474181, 15479.303431345392, 16370.345186192419, 14368.928155359155, 14529.27353632293, 14808.037477563925, 14884.10695358282, 15078.924605376902, 14290.57128286153, 14424.711505770036, 14649.63375915568, 14971.101733896001, 15123.16822574725, 14085.436582536993, 14466.493672721404, 14501.927490362481, 14812.703745925237, 14932.402703892158, 11208.103351732005, 11343.659690209306, 11553.709269929359, 11686.357250351311, 12318.876811231772, 9582.856257156009, 10139.594416223268, 10479.94760026195, 11574.363410012193, 11634.127440441831], "value": 7800.418079779771, "unit": "score"}], "name": "dromaeo_css", "value": 7425.659161817372, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 167.0, 162.0, 112.0, 113.0, 115.0, 112.0, 113.0, 112.0, 113.0], "value": 123.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 107.0, 159.0, 106.0, 106.0, 138.0, 103.0, 136.0, 105.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 182.0, 180.0, 180.0, 182.0, 195.0, 255.0, 181.0, 183.0], "value": 190.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 57.0, 106.0, 57.0, 57.0, 60.0, 60.0, 96.0, 57.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 90.0, 91.0, 70.0, 70.0, 68.0, 96.0, 69.0, 67.0, 99.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 87.0, 84.0, 87.0, 110.0, 85.0, 83.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 92.0, 93.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 84.0, 85.0, 85.0, 83.0, 84.0, 85.0, 83.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 53.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 76.0, 75.0, 72.0, 70.0, 69.0, 70.0, 73.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 81.0, 81.0, 83.0, 83.0, 84.0, 87.0, 94.0, 103.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 142.0, 148.0, 151.0, 146.0, 135.0, 135.0, 178.0, 137.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 228.0, 231.0, 166.0, 166.0, 165.0, 174.0, 161.0, 162.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 67.0, 68.0, 67.0, 67.0, 65.0, 65.0, 64.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1448.3999999999999, "alertThreshold": 2.0}]} 11:37:26 INFO - Return code: 0 11:37:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:26 INFO - # TBPL SUCCESS # 11:37:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:37:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:37:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:37:26 INFO - 2016-07-15 11:37:26.871 screenresolution[1972:19932] starting screenresolution argv=screenresolution get 11:37:26 INFO - 2016-07-15 11:37:26.874 screenresolution[1972:19932] Display 0: 1600x1200x32@60 11:37:26 INFO - 2016-07-15 11:37:26.880 screenresolution[1973:19935] starting screenresolution argv=screenresolution list 11:37:26 INFO - Available Modes on Display 0 11:37:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:37:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:37:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:37:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:37:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:37:27 INFO - Intel Iris: 11:37:27 INFO - Chipset Model: Intel Iris 11:37:27 INFO - Type: GPU 11:37:27 INFO - Bus: Built-In 11:37:27 INFO - VRAM (Dynamic, Max): 1536 MB 11:37:27 INFO - Vendor: Intel (0x8086) 11:37:27 INFO - Device ID: 0x0a2e 11:37:27 INFO - Revision ID: 0x0009 11:37:27 INFO - Displays: 11:37:27 INFO - Display: 11:37:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:37:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:37:27 INFO - Display Serial Number: 1600x1200 60 11:37:27 INFO - Main Display: Yes 11:37:27 INFO - Mirror: Off 11:37:27 INFO - Online: Yes 11:37:27 INFO - Rotation: Supported 11:37:27 INFO - Return code: 0 11:37:27 INFO - Running post-action listener: _resource_record_post_action 11:37:27 INFO - ##### 11:37:27 INFO - ##### Finished run-tests step (success) 11:37:27 INFO - ##### 11:37:27 INFO - Running post-run listener: _resource_record_post_run 11:37:27 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 24576; Write bytes: 704410112; Read time: 0; Write time: 1922 11:37:27 INFO - TinderboxPrint: CPU usage
53.0% 11:37:27 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 0 11:37:27 INFO - TinderboxPrint: I/O write bytes / time
704,410,112 / 1,922 11:37:27 INFO - TinderboxPrint: CPU idle
2,275.3 (47.0%) 11:37:27 INFO - TinderboxPrint: CPU system
960.3 (19.8%) 11:37:27 INFO - TinderboxPrint: CPU user
1,610.0 (33.2%) 11:37:27 INFO - TinderboxPrint: Swap in / out
406,548,480 / 0 11:37:27 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396618240; Write bytes: 391291392; Read time: 29352; Write time: 792 11:37:27 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 24576; Write bytes: 293408768; Read time: 0; Write time: 1080 11:37:27 INFO - Running post-run listener: _upload_blobber_files 11:37:27 INFO - Blob upload gear active. 11:37:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:27 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 11:37:27 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'] 11:37:27 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 11:37:27 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:28 INFO - (blobuploader) - INFO - Done attempting. 11:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:29 INFO - (blobuploader) - INFO - Done attempting. 11:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:32 INFO - (blobuploader) - INFO - Done attempting. 11:37:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:32 INFO - Return code: 0 11:37:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2a845ad40e8572723cfd194891c20ea2fb073ac01390d54cf5578ac0672b08e284fc957d49e6f7f05e22f623bfc94cb2493008b4f9f6c1caa8054b3f41c5f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d68e690ef938aef1fc41f4c702c7f845c200d0c6621744b06a74f5e887c804156c989d51fb32df641e64ab758327d95b4842c0141997bc6b912ad4dbffd0f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e287169e0f85bad891968949a8a578ec91daa74a8b4c3f5caf311d3b2c3e9e7f85276cc4b635fb9714e6020a20d8dfd3573ac206ca70817f369c2d272a9e02d6"} 11:37:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:32 INFO - Contents: 11:37:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2a845ad40e8572723cfd194891c20ea2fb073ac01390d54cf5578ac0672b08e284fc957d49e6f7f05e22f623bfc94cb2493008b4f9f6c1caa8054b3f41c5f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d68e690ef938aef1fc41f4c702c7f845c200d0c6621744b06a74f5e887c804156c989d51fb32df641e64ab758327d95b4842c0141997bc6b912ad4dbffd0f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e287169e0f85bad891968949a8a578ec91daa74a8b4c3f5caf311d3b2c3e9e7f85276cc4b635fb9714e6020a20d8dfd3573ac206ca70817f369c2d272a9e02d6"} 11:37:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:32 INFO - Copying logs to upload dir... 11:37:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.629960 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-15 11:37:32.683804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:37:32.687467) ========= 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.z0lYIofERv/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.HaoeGujyBY/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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/c2a845ad40e8572723cfd194891c20ea2fb073ac01390d54cf5578ac0672b08e284fc957d49e6f7f05e22f623bfc94cb2493008b4f9f6c1caa8054b3f41c5f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d68e690ef938aef1fc41f4c702c7f845c200d0c6621744b06a74f5e887c804156c989d51fb32df641e64ab758327d95b4842c0141997bc6b912ad4dbffd0f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e287169e0f85bad891968949a8a578ec91daa74a8b4c3f5caf311d3b2c3e9e7f85276cc4b635fb9714e6020a20d8dfd3573ac206ca70817f369c2d272a9e02d6"} build_url:https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/FICLLhPUQQCjQujG-JnZOw/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/c2a845ad40e8572723cfd194891c20ea2fb073ac01390d54cf5578ac0672b08e284fc957d49e6f7f05e22f623bfc94cb2493008b4f9f6c1caa8054b3f41c5f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d68e690ef938aef1fc41f4c702c7f845c200d0c6621744b06a74f5e887c804156c989d51fb32df641e64ab758327d95b4842c0141997bc6b912ad4dbffd0f6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e287169e0f85bad891968949a8a578ec91daa74a8b4c3f5caf311d3b2c3e9e7f85276cc4b635fb9714e6020a20d8dfd3573ac206ca70817f369c2d272a9e02d6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:37:32.720169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:37:32.720484) ========= 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.z0lYIofERv/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.HaoeGujyBY/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.004965 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:37:32.768987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:37:32.769347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:37:32.769703) ========= ========= Total master_lag: 0.18 =========