builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0319 starttime: 1468010897.91 results: success (0) buildid: 20160708120026 builduid: d4f7ecca9c474fa799b61c6c8c49a443 revision: a5bbe665a0d9677fadcd2a11b14818fd81209968 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.914532) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.915197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:17.915477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.016649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.017001) ========= 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.W2L7Zru872/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.P4P98bBvPw/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-08 13:48:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 190M=0s 2016-07-08 13:48:18 (190 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.511567 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.552025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.552333) ========= 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.W2L7Zru872/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.P4P98bBvPw/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.039782 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:18.611769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 13:48:18.612104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5bbe665a0d9677fadcd2a11b14818fd81209968 --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 a5bbe665a0d9677fadcd2a11b14818fd81209968 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W2L7Zru872/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.P4P98bBvPw/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-08 13:48:18,692 truncating revision to first 12 chars 2016-07-08 13:48:18,692 Setting DEBUG logging. 2016-07-08 13:48:18,692 attempt 1/10 2016-07-08 13:48:18,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5bbe665a0d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 13:48:19,437 unpacking tar archive at: mozilla-central-a5bbe665a0d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.016249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 13:48:19.649389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:19.649700) ========= script_repo_revision: a5bbe665a0d9677fadcd2a11b14818fd81209968 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:19.650091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:19.650355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:48:19.671662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-07-08 13:48:19.671956) ========= /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.W2L7Zru872/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.P4P98bBvPw/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:48:19 INFO - MultiFileLogger online at 20160708 13:48:19 in /builds/slave/test 13:48:19 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 13:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:19 INFO - {'append_to_log': False, 13:48:19 INFO - 'base_work_dir': '/builds/slave/test', 13:48:19 INFO - 'blob_upload_branch': 'Firefox', 13:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:19 INFO - 'branch': 'Firefox', 13:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:19 INFO - 'config_files': ('talos/mac_config.py',), 13:48:19 INFO - 'default_actions': ('clobber', 13:48:19 INFO - 'read-buildbot-config', 13:48:19 INFO - 'download-and-extract', 13:48:19 INFO - 'populate-webroot', 13:48:19 INFO - 'create-virtualenv', 13:48:19 INFO - 'install', 13:48:19 INFO - 'run-tests'), 13:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:19 INFO - 'download_minidump_stackwalk': True, 13:48:19 INFO - 'download_symbols': 'ondemand', 13:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:19 INFO - 'installer_path': 'installer.exe', 13:48:19 INFO - 'log_level': 'info', 13:48:19 INFO - 'log_name': 'talos', 13:48:19 INFO - 'log_to_console': True, 13:48:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:48:19 INFO - 'opt_config_files': (), 13:48:19 INFO - 'pip_index': False, 13:48:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:19 INFO - 'cmd': ('bash', 13:48:19 INFO - '-c', 13:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:19 INFO - 'enabled': True, 13:48:19 INFO - 'halt_on_failure': False, 13:48:19 INFO - 'name': 'check_screen_resolution'},), 13:48:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:19 INFO - 'cmd': ('bash', 13:48:19 INFO - '-c', 13:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:19 INFO - 'enabled': True, 13:48:19 INFO - 'halt_on_failure': False, 13:48:19 INFO - 'name': 'check_screen_resolution'},), 13:48:19 INFO - 'run_cmd_checks_enabled': True, 13:48:19 INFO - 'sps_profile': False, 13:48:19 INFO - 'sps_profile_interval': 0, 13:48:19 INFO - 'suite': 'dromaeojs', 13:48:19 INFO - 'system_bits': '32', 13:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:19 INFO - 'title': 't-yosemite-r7-0319', 13:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:19 INFO - 'use_talos_json': True, 13:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:19 INFO - 'work_dir': 'build'} 13:48:19 INFO - ##### 13:48:19 INFO - ##### Running clobber step. 13:48:19 INFO - ##### 13:48:19 INFO - Running pre-action listener: _resource_record_pre_action 13:48:19 INFO - Running main action method: clobber 13:48:19 INFO - rmtree: /builds/slave/test/build 13:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:21 INFO - Running post-action listener: _resource_record_post_action 13:48:21 INFO - ##### 13:48:21 INFO - ##### Finished clobber step (success) 13:48:21 INFO - ##### 13:48:21 INFO - ##### 13:48:21 INFO - ##### Running read-buildbot-config step. 13:48:21 INFO - ##### 13:48:21 INFO - Running pre-action listener: _resource_record_pre_action 13:48:21 INFO - Running main action method: read_buildbot_config 13:48:21 INFO - Using buildbot properties: 13:48:21 INFO - { 13:48:21 INFO - "project": "", 13:48:21 INFO - "product": "firefox", 13:48:21 INFO - "script_repo_revision": "production", 13:48:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:48:21 INFO - "repository": "", 13:48:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:48:21 INFO - "buildid": "20160708120026", 13:48:21 INFO - "pgo_build": "False", 13:48:21 INFO - "basedir": "/builds/slave/test", 13:48:21 INFO - "buildnumber": 7, 13:48:21 INFO - "slavename": "t-yosemite-r7-0319", 13:48:21 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:48:21 INFO - "platform": "yosemite_r7", 13:48:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:48:21 INFO - "branch": "mozilla-central", 13:48:21 INFO - "repo_path": "mozilla-central", 13:48:21 INFO - "revision": "a5bbe665a0d9677fadcd2a11b14818fd81209968", 13:48:21 INFO - "stage_platform": "macosx64", 13:48:21 INFO - "builduid": "d4f7ecca9c474fa799b61c6c8c49a443", 13:48:21 INFO - "slavebuilddir": "test" 13:48:21 INFO - } 13:48:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 13:48:21 INFO - Running post-action listener: _resource_record_post_action 13:48:21 INFO - ##### 13:48:21 INFO - ##### Finished read-buildbot-config step (success) 13:48:21 INFO - ##### 13:48:21 INFO - ##### 13:48:21 INFO - ##### Running download-and-extract step. 13:48:21 INFO - ##### 13:48:21 INFO - Running pre-action listener: _resource_record_pre_action 13:48:21 INFO - Running main action method: download_and_extract 13:48:21 INFO - mkdir: /builds/slave/test/build/tests 13:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:21 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:48:52 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 13:48:52 INFO - retry: attempt #1 caught exception: timed out 13:48:52 INFO - retry: Failed, sleeping 30 seconds before retrying 13:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 13:49:22 INFO - Downloaded 1199 bytes. 13:49:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:49:22 INFO - Using the following test package requirements: 13:49:22 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:49:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 13:49:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 13:49:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'jsshell-mac.zip'], 13:49:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 13:49:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:49:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 13:49:22 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 13:49:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 13:49:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:49:22 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 13:49:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:22 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:49:26 INFO - Downloaded 18806320 bytes. 13:49:26 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'] 13:49:26 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 13:49:30 INFO - Return code: 0 13:49:30 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 13:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:30 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:49:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:49:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:49:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:49:35 INFO - Downloaded 18806320 bytes. 13:49: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'] 13:49: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 13:49:38 INFO - Return code: 0 13:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:38 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:49:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:49:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:49:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:49:39 INFO - Downloaded 14403333 bytes. 13:49:39 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'] 13:49:39 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 13:49:39 INFO - Return code: 0 13:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:39 INFO - https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 13:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dePeT9xHSWCSRTVsfFMfKg/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 13:49:43 INFO - Downloaded 112482485 bytes. 13:49:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:49:43 INFO - mkdir: /builds/slave/test/properties 13:49:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:49:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:49:43 INFO - Contents: 13:49:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:49:44 INFO - Running post-action listener: _resource_record_post_action 13:49:44 INFO - Running post-action listener: set_extra_try_arguments 13:49:44 INFO - ##### 13:49:44 INFO - ##### Finished download-and-extract step (success) 13:49:44 INFO - ##### 13:49:44 INFO - ##### 13:49:44 INFO - ##### Running populate-webroot step. 13:49:44 INFO - ##### 13:49:44 INFO - Running pre-action listener: _resource_record_pre_action 13:49:44 INFO - Running main action method: populate_webroot 13:49:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:49:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:49:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:49:44 INFO - '--tppagecycles', 13:49:44 INFO - '7'], 13:49:44 INFO - 'tests': ['tsvgm']}}, 13:49:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:49:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:49:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['damp', 'tps']}, 13:49:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'tests': ['damp', 'tps']}, 13:49:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['dromaeo_dom']}, 13:49:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['basic_compositor_video']}, 13:49:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:49:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['a11yr', 13:49:44 INFO - 'ts_paint', 13:49:44 INFO - 'tpaint', 13:49:44 INFO - 'sessionrestore', 13:49:44 INFO - 'sessionrestore_no_auto_restore', 13:49:44 INFO - 'tabpaint']}, 13:49:44 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:44 INFO - 'ts_paint', 13:49:44 INFO - 'tpaint', 13:49:44 INFO - 'sessionrestore', 13:49:44 INFO - 'sessionrestore_no_auto_restore', 13:49:44 INFO - 'tabpaint']}, 13:49:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:49:44 INFO - 'ts_paint', 13:49:44 INFO - 'tpaint', 13:49:44 INFO - 'sessionrestore', 13:49:44 INFO - 'sessionrestore_no_auto_restore', 13:49:44 INFO - 'tabpaint']}, 13:49:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:49:44 INFO - 'ts_paint', 13:49:44 INFO - 'tpaint', 13:49:44 INFO - 'sessionrestore', 13:49:44 INFO - 'sessionrestore_no_auto_restore', 13:49:44 INFO - 'tabpaint']}, 13:49:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['a11yr', 13:49:44 INFO - 'ts_paint', 13:49:44 INFO - 'tpaint', 13:49:44 INFO - 'sessionrestore', 13:49:44 INFO - 'sessionrestore_no_auto_restore', 13:49:44 INFO - 'tabpaint']}, 13:49:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['a11yr', 13:49:44 INFO - 'ts_paint', 13:49:44 INFO - 'tpaint', 13:49:44 INFO - 'sessionrestore', 13:49:44 INFO - 'sessionrestore_no_auto_restore', 13:49:44 INFO - 'tabpaint']}, 13:49:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['tsvgx', 13:49:44 INFO - 'tsvgr_opacity', 13:49:44 INFO - 'tart', 13:49:44 INFO - 'tscrollx', 13:49:44 INFO - 'cart']}, 13:49:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:44 INFO - 'tsvgr_opacity', 13:49:44 INFO - 'tart', 13:49:44 INFO - 'tscrollx', 13:49:44 INFO - 'cart']}, 13:49:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'talos_options': ['--disable-e10s'], 13:49:44 INFO - 'tests': ['tp5o']}, 13:49:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'tests': ['tp5o']}, 13:49:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'talos_options': ['--disable-e10s', 13:49:44 INFO - '--xperf_path', 13:49:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:44 INFO - 'tests': ['tp5n']}, 13:49:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:49:44 INFO - 'talos_options': ['--xperf_path', 13:49:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:44 INFO - 'tests': ['tp5n']}}, 13:49:44 INFO - 'talos.zip': {'path': '', 13:49:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:49:44 INFO - Running post-action listener: _resource_record_post_action 13:49:44 INFO - ##### 13:49:44 INFO - ##### Finished populate-webroot step (success) 13:49:44 INFO - ##### 13:49:44 INFO - ##### 13:49:44 INFO - ##### Running create-virtualenv step. 13:49:44 INFO - ##### 13:49:44 INFO - Running pre-action listener: _resource_record_pre_action 13:49:44 INFO - Running main action method: create_virtualenv 13:49:44 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:44 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 13:49:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:49:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:44 INFO - Using real prefix '/tools/python27' 13:49:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:45 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:48 INFO - Installing pip.................done. 13:49:48 INFO - Return code: 0 13:49:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:49: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 13:49: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 13:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:48 INFO - 'HOME': '/Users/cltbld', 13:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:48 INFO - 'LOGNAME': 'cltbld', 13:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:48 INFO - 'MOZ_NO_REMOTE': '1', 13:49:48 INFO - 'NO_EM_RESTART': '1', 13:49:48 INFO - 'PAGER': '/bin/cat', 13:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:48 INFO - 'PWD': '/builds/slave/test', 13:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:48 INFO - 'SHELL': '/bin/bash', 13:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:49:48 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:48 INFO - 'USER': 'cltbld', 13:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:48 INFO - 'XPC_FLAGS': '0x0', 13:49:48 INFO - 'XPC_SERVICE_NAME': '0', 13:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49: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 13:49:48 INFO - Cleaning up... 13:49:48 INFO - Return code: 0 13:49:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:49: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 13:49: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 13:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:48 INFO - 'HOME': '/Users/cltbld', 13:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:48 INFO - 'LOGNAME': 'cltbld', 13:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:48 INFO - 'MOZ_NO_REMOTE': '1', 13:49:48 INFO - 'NO_EM_RESTART': '1', 13:49:48 INFO - 'PAGER': '/bin/cat', 13:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:48 INFO - 'PWD': '/builds/slave/test', 13:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:48 INFO - 'SHELL': '/bin/bash', 13:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:49:48 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:48 INFO - 'USER': 'cltbld', 13:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:48 INFO - 'XPC_FLAGS': '0x0', 13:49:48 INFO - 'XPC_SERVICE_NAME': '0', 13:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:48 INFO - Downloading/unpacking psutil>=3.1.1 13:49:48 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 13:49:48 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 13:49:48 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 13:49:48 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 13:49:48 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 13:49:48 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 13:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:52 INFO - Installing collected packages: psutil 13:49:52 INFO - Running setup.py install for psutil 13:49:52 INFO - building 'psutil._psutil_osx' extension 13:49: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 13:49: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 13:49: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 13:49:53 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 13:49:53 INFO - building 'psutil._psutil_posix' extension 13:49:53 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 13:49:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:49:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:49:53 INFO - ^ 13:49:53 INFO - 1 warning generated. 13:49:53 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 13:49:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:53 INFO - Successfully installed psutil 13:49:53 INFO - Cleaning up... 13:49:53 INFO - Return code: 0 13:49:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:49: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 13:49: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 13:49:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:49:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:53 INFO - 'HOME': '/Users/cltbld', 13:49:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:53 INFO - 'LOGNAME': 'cltbld', 13:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:53 INFO - 'MOZ_NO_REMOTE': '1', 13:49:53 INFO - 'NO_EM_RESTART': '1', 13:49:53 INFO - 'PAGER': '/bin/cat', 13:49:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:53 INFO - 'PWD': '/builds/slave/test', 13:49:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:53 INFO - 'SHELL': '/bin/bash', 13:49:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:49:53 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:49:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:53 INFO - 'USER': 'cltbld', 13:49:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:53 INFO - 'XPC_FLAGS': '0x0', 13:49:53 INFO - 'XPC_SERVICE_NAME': '0', 13:49:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49: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 13:49:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:56 INFO - Installing collected packages: mozsystemmonitor 13:49:56 INFO - Running setup.py install for mozsystemmonitor 13:49:56 INFO - Successfully installed mozsystemmonitor 13:49:56 INFO - Cleaning up... 13:49:56 INFO - Return code: 0 13:49:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:56 INFO - 'HOME': '/Users/cltbld', 13:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:56 INFO - 'LOGNAME': 'cltbld', 13:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:56 INFO - 'MOZ_NO_REMOTE': '1', 13:49:56 INFO - 'NO_EM_RESTART': '1', 13:49:56 INFO - 'PAGER': '/bin/cat', 13:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:56 INFO - 'PWD': '/builds/slave/test', 13:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:56 INFO - 'SHELL': '/bin/bash', 13:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:49:56 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:56 INFO - 'USER': 'cltbld', 13:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:56 INFO - 'XPC_FLAGS': '0x0', 13:49:56 INFO - 'XPC_SERVICE_NAME': '0', 13:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:56 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:59 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:59 INFO - warning: no files found matching '*.txt' 13:49:59 INFO - no previously-included directories found matching 'build' 13:49:59 INFO - no previously-included directories found matching 'dist' 13:49:59 INFO - no previously-included directories found matching '.git*' 13:49:59 INFO - Installing collected packages: jsonschema, functools32 13:49:59 INFO - Running setup.py install for functools32 13:49:59 INFO - warning: no files found matching '*.txt' 13:49:59 INFO - no previously-included directories found matching 'build' 13:49:59 INFO - no previously-included directories found matching 'dist' 13:49:59 INFO - no previously-included directories found matching '.git*' 13:49:59 INFO - Successfully installed jsonschema functools32 13:49:59 INFO - Cleaning up... 13:50:00 INFO - Return code: 0 13:50:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:00 INFO - 'HOME': '/Users/cltbld', 13:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:00 INFO - 'LOGNAME': 'cltbld', 13:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:00 INFO - 'MOZ_NO_REMOTE': '1', 13:50:00 INFO - 'NO_EM_RESTART': '1', 13:50:00 INFO - 'PAGER': '/bin/cat', 13:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:00 INFO - 'PWD': '/builds/slave/test', 13:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:00 INFO - 'SHELL': '/bin/bash', 13:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:50:00 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:00 INFO - 'USER': 'cltbld', 13:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:00 INFO - 'XPC_FLAGS': '0x0', 13:50:00 INFO - 'XPC_SERVICE_NAME': '0', 13:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:50:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:50:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:50:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:03 INFO - Downloading docopt-0.6.1.tar.gz 13:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:50:04 INFO - Installing collected packages: blobuploader, requests, docopt 13:50:04 INFO - Running setup.py install for blobuploader 13:50:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:50:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:50:04 INFO - Running setup.py install for requests 13:50:04 INFO - Running setup.py install for docopt 13:50:04 INFO - Successfully installed blobuploader requests docopt 13:50:04 INFO - Cleaning up... 13:50:04 INFO - Return code: 0 13:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:50: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 13:50: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 13:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:04 INFO - 'HOME': '/Users/cltbld', 13:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:04 INFO - 'LOGNAME': 'cltbld', 13:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:04 INFO - 'MOZ_NO_REMOTE': '1', 13:50:04 INFO - 'NO_EM_RESTART': '1', 13:50:04 INFO - 'PAGER': '/bin/cat', 13:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:04 INFO - 'PWD': '/builds/slave/test', 13:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:04 INFO - 'SHELL': '/bin/bash', 13:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:50:04 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:04 INFO - 'USER': 'cltbld', 13:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:04 INFO - 'XPC_FLAGS': '0x0', 13:50:04 INFO - 'XPC_SERVICE_NAME': '0', 13:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-4SjBND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-KAUfnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-8q6rFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-OYEoCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-pwWyrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-2qCSG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-xan9cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-oqAw6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:05 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-_0ecNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-kWUP_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-juXOhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-ci7AAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-0xjOF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-vzav5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-PfQW7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-rQ6ccA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:06 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-jT8xxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:50:06 INFO - Running setup.py install for manifestparser 13:50:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:50:07 INFO - Running setup.py install for mozcrash 13:50:07 INFO - Running setup.py install for mozdebug 13:50:07 INFO - Running setup.py install for mozdevice 13:50:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:50:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:50:07 INFO - Running setup.py install for mozfile 13:50:07 INFO - Running setup.py install for mozhttpd 13:50:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:50:07 INFO - Running setup.py install for mozinfo 13:50:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:50:07 INFO - Running setup.py install for mozInstall 13:50:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Running setup.py install for mozleak 13:50:08 INFO - Running setup.py install for mozlog 13:50:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Running setup.py install for moznetwork 13:50:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Running setup.py install for mozprocess 13:50:08 INFO - Running setup.py install for mozprofile 13:50:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:50:08 INFO - Running setup.py install for mozrunner 13:50:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:50:09 INFO - Running setup.py install for mozscreenshot 13:50:09 INFO - Running setup.py install for moztest 13:50:09 INFO - Running setup.py install for mozversion 13:50:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:50:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:50:09 INFO - Cleaning up... 13:50:09 INFO - Return code: 0 13:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:09 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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:50:09 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 13:50:09 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 13:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:09 INFO - 'HOME': '/Users/cltbld', 13:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:09 INFO - 'LOGNAME': 'cltbld', 13:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:09 INFO - 'MOZ_NO_REMOTE': '1', 13:50:09 INFO - 'NO_EM_RESTART': '1', 13:50:09 INFO - 'PAGER': '/bin/cat', 13:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:09 INFO - 'PWD': '/builds/slave/test', 13:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:09 INFO - 'SHELL': '/bin/bash', 13:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:50:09 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:09 INFO - 'USER': 'cltbld', 13:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:09 INFO - 'XPC_FLAGS': '0x0', 13:50:09 INFO - 'XPC_SERVICE_NAME': '0', 13:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:09 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-_crpBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50: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)) 13:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:09 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-AWrE3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50: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)) 13:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:09 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Ei4xSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:10 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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-fw51dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:10 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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SfCRx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:10 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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-JUmsB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:10 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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-erMq5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:10 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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-2PcYRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50: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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-YBBmAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50: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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-2IlaOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50: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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SjCsZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50: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)) 13:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:10 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-bjrsLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:11 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)) 13:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:11 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-apHAeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:11 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)) 13:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:11 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-HqMfSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:11 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)) 13:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:11 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-xIZLv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:11 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)) 13:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:11 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-sxYhiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:11 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)) 13:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:11 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-4NRZPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50: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)) 13:50: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)) 13:50: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)) 13:50: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)) 13:50: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)) 13:50: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)) 13:50:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50: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 13:50:14 INFO - Downloading blessings-1.6.tar.gz 13:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:50:14 INFO - Installing collected packages: blessings 13:50:14 INFO - Running setup.py install for blessings 13:50:14 INFO - Successfully installed blessings 13:50:14 INFO - Cleaning up... 13:50:14 INFO - Return code: 0 13:50:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:14 INFO - Reading from file tmpfile_stdout 13:50:14 INFO - Current package versions: 13:50:14 INFO - blessings == 1.6 13:50:14 INFO - blobuploader == 1.2.4 13:50:14 INFO - docopt == 0.6.1 13:50:14 INFO - functools32 == 3.2.3-2 13:50:14 INFO - jsonschema == 2.5.1 13:50:14 INFO - manifestparser == 1.1 13:50:14 INFO - mozInstall == 1.12 13:50:14 INFO - mozcrash == 0.17 13:50:14 INFO - mozdebug == 0.1 13:50:14 INFO - mozdevice == 0.48 13:50:14 INFO - mozfile == 1.2 13:50:14 INFO - mozhttpd == 0.7 13:50:14 INFO - mozinfo == 0.9 13:50:14 INFO - mozleak == 0.1 13:50:14 INFO - mozlog == 3.2 13:50:14 INFO - moznetwork == 0.27 13:50:14 INFO - mozprocess == 0.23 13:50:14 INFO - mozprofile == 0.28 13:50:14 INFO - mozrunner == 6.12 13:50:14 INFO - mozscreenshot == 0.1 13:50:14 INFO - mozsystemmonitor == 0.3 13:50:14 INFO - moztest == 0.7 13:50:14 INFO - mozversion == 1.4 13:50:14 INFO - psutil == 3.1.1 13:50:14 INFO - requests == 1.2.3 13:50:14 INFO - wsgiref == 0.1.2 13:50:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:50: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 13:50: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 13:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:14 INFO - 'HOME': '/Users/cltbld', 13:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:14 INFO - 'LOGNAME': 'cltbld', 13:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:14 INFO - 'MOZ_NO_REMOTE': '1', 13:50:14 INFO - 'NO_EM_RESTART': '1', 13:50:14 INFO - 'PAGER': '/bin/cat', 13:50:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:14 INFO - 'PWD': '/builds/slave/test', 13:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:14 INFO - 'SHELL': '/bin/bash', 13:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:50:14 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:14 INFO - 'USER': 'cltbld', 13:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:14 INFO - 'XPC_FLAGS': '0x0', 13:50:14 INFO - 'XPC_SERVICE_NAME': '0', 13:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 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)) 13:50:14 INFO - Cleaning up... 13:50:14 INFO - Return code: 0 13:50:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:50: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')]} 13:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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')]} 13:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50: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 0x100e81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f16618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff33049d9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, '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.W2L7Zru872/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.P4P98bBvPw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 13:50: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 13:50: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 13:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:15 INFO - 'HOME': '/Users/cltbld', 13:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:15 INFO - 'LOGNAME': 'cltbld', 13:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:15 INFO - 'MOZ_NO_REMOTE': '1', 13:50:15 INFO - 'NO_EM_RESTART': '1', 13:50:15 INFO - 'PAGER': '/bin/cat', 13:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:15 INFO - 'PWD': '/builds/slave/test', 13:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:15 INFO - 'SHELL': '/bin/bash', 13:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:50:15 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:15 INFO - 'USER': 'cltbld', 13:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:15 INFO - 'XPC_FLAGS': '0x0', 13:50:15 INFO - 'XPC_SERVICE_NAME': '0', 13:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:50:15 INFO - Cleaning up... 13:50:15 INFO - Return code: 0 13:50:15 INFO - Running post-action listener: _resource_record_post_action 13:50:15 INFO - Running post-action listener: _start_resource_monitoring 13:50:15 INFO - Starting resource monitoring. 13:50:15 INFO - ##### 13:50:15 INFO - ##### Finished create-virtualenv step (success) 13:50:15 INFO - ##### 13:50:15 INFO - ##### 13:50:15 INFO - ##### Running install step. 13:50:15 INFO - ##### 13:50:15 INFO - Running pre-action listener: _resource_record_pre_action 13:50:15 INFO - Running main action method: install 13:50:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:15 INFO - Reading from file tmpfile_stdout 13:50:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:50:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:50:15 INFO - Reading from file tmpfile_stdout 13:50:15 INFO - Output received: 13:50:15 INFO - Usage: mozinstall [options] installer 13:50:15 INFO - Options: 13:50:15 INFO - -h, --help show this help message and exit 13:50:15 INFO - -d DEST, --destination=DEST 13:50:15 INFO - Directory to install application into. [default: 13:50:15 INFO - "/builds/slave/test"] 13:50:15 INFO - --app=APP Application being installed. [default: firefox] 13:50:15 INFO - mkdir: /builds/slave/test/build/application 13:50: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'] 13:50: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 13:50:50 INFO - Reading from file tmpfile_stdout 13:50:50 INFO - Output received: 13:50:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:50:50 INFO - Running post-action listener: _resource_record_post_action 13:50:50 INFO - ##### 13:50:50 INFO - ##### Finished install step (success) 13:50:50 INFO - ##### 13:50:50 INFO - ##### 13:50:50 INFO - ##### Running run-tests step. 13:50:50 INFO - ##### 13:50:50 INFO - Running pre-action listener: _resource_record_pre_action 13:50:50 INFO - Running main action method: run_tests 13:50:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:50:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:50:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:50:50 INFO - 2016-07-08 13:50:50.052 screenresolution[1640:7929] starting screenresolution argv=screenresolution get 13:50:50 INFO - 2016-07-08 13:50:50.054 screenresolution[1640:7929] Display 0: 1600x1200x32@60 13:50:50 INFO - 2016-07-08 13:50:50.060 screenresolution[1641:7931] starting screenresolution argv=screenresolution list 13:50:50 INFO - Available Modes on Display 0 13:50:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:50:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:50:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:50:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:50:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:50:50 INFO - Intel Iris: 13:50:50 INFO - Chipset Model: Intel Iris 13:50:50 INFO - Type: GPU 13:50:50 INFO - Bus: Built-In 13:50:50 INFO - VRAM (Dynamic, Max): 1536 MB 13:50:50 INFO - Vendor: Intel (0x8086) 13:50:50 INFO - Device ID: 0x0a2e 13:50:50 INFO - Revision ID: 0x0009 13:50:50 INFO - Displays: 13:50:50 INFO - Display: 13:50:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:50:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:50:50 INFO - Display Serial Number: 1600x1200 60 13:50:50 INFO - Main Display: Yes 13:50:50 INFO - Mirror: Off 13:50:50 INFO - Online: Yes 13:50:50 INFO - Rotation: Supported 13:50:50 INFO - Return code: 0 13:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:50 INFO - Python 2.7.3 13:50:50 INFO - Return code: 0 13:50:50 INFO - grabbing minidump binary from tooltool 13:50: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')]} 13:50: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 0x100de5d30>, '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 0x100b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dddb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50: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 13:50: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 13:50: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 13:50:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:50 INFO - Return code: 0 13:50:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:50:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:50:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--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 13:50: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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0319 --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 13:50:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W2L7Zru872/Render', 13:50:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:50 INFO - 'HOME': '/Users/cltbld', 13:50:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:50 INFO - 'LOGNAME': 'cltbld', 13:50:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:50 INFO - 'MOZ_NO_REMOTE': '1', 13:50:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:50 INFO - 'NO_EM_RESTART': '1', 13:50:50 INFO - 'PAGER': '/bin/cat', 13:50:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:50 INFO - 'PWD': '/builds/slave/test', 13:50:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:50 INFO - 'SHELL': '/bin/bash', 13:50:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P4P98bBvPw/Listeners', 13:50:50 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 13:50:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:50 INFO - 'USER': 'cltbld', 13:50:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:50 INFO - 'XPC_FLAGS': '0x0', 13:50:50 INFO - 'XPC_SERVICE_NAME': '0', 13:50:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--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 13:50:50 INFO - mozversion application_buildid: 20160708120026 13:50:50 INFO - mozversion application_changeset: a5bbe665a0d9677fadcd2a11b14818fd81209968 13:50:50 INFO - mozversion application_display_name: Nightly 13:50:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:50 INFO - mozversion application_name: Firefox 13:50:50 INFO - mozversion application_remotingname: firefox 13:50:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:50:50 INFO - mozversion application_vendor: Mozilla 13:50:50 INFO - mozversion application_version: 50.0a1 13:50:50 INFO - mozversion platform_buildid: 20160708120026 13:50:50 INFO - mozversion platform_changeset: a5bbe665a0d9677fadcd2a11b14818fd81209968 13:50:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:50:50 INFO - mozversion platform_version: 50.0a1 13:50:50 INFO - using testdate: 1468011050 13:50:50 INFO - actual date: 1468011050 13:50:50 INFO - starting webserver on 'localhost:49266' 13:50:50 INFO - SUITE-START | Running 2 tests 13:50:50 INFO - TEST-START | dromaeo_css 13:50:50 INFO - operating with platform_type : mac_ 13:50:50 INFO - Initialising browser for dromaeo_css test... 13:50:50 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpC70Twn/profile http://localhost:49266/getInfo.html) 13:50:53 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 13:50:53 INFO - PROCESS | 1651 | colorDepth:24 13:50:53 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 13:50:53 INFO - PROCESS | 1651 | __metrics 13:50:53 INFO - PROCESS | 1651 | 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" 13:50:53 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:50:53 INFO - TEST-INFO | 1651: exit 0 13:50:53 INFO - Browser initialized. 13:50:53 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:53 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpC70Twn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:05 INFO - PROCESS | 1654 | RSS: Main: 243818496 13:51:05 INFO - PROCESS | 1654 | 13:51:57 INFO - PROCESS | 1654 | 1468011117097 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] 13:54:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 13:54:09 INFO - PROCESS | 1654 | RSS: Main: 357044224 13:54:09 INFO - PROCESS | 1654 | 13:57:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 13:57:13 INFO - PROCESS | 1654 | RSS: Main: 367882240 13:57:13 INFO - PROCESS | 1654 | 14:00:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 14:00:16 INFO - PROCESS | 1654 | RSS: Main: 371245056 14:00:16 INFO - PROCESS | 1654 | 14:03:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 14:03:19 INFO - PROCESS | 1654 | RSS: Main: 371744768 14:03:19 INFO - PROCESS | 1654 | 14:06:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 14:06:23 INFO - PROCESS | 1654 | RSS: Main: 341602304 14:06:23 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 14:09:26 INFO - PROCESS | 1654 | RSS: Main: 418451456 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | __start_tp_report 14:09:26 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 14:09:26 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 14:09:26 INFO - PROCESS | 1654 | |i|pagename|runs| 14:09:26 INFO - PROCESS | 1654 | |0;dojo.html;3316.756216418843;3362.3107263011084;3376.9999999999986;3387.0516255448483;3435.8625654973803;5583.3300003999475;5681.545476361892;5712.742926568304;5741.138829175626;5777.277840269971;4883.291922671219;5372.764264219232;5486.945130548704;5694.6867922264255;5775.480206781389;5181.145111056671;5197.506236907488;5261.421243663194;5271.130263506517;5332.813351532697;4689.2966055091665;5350.117230656937;5389.757460914248;5393.865153371158;5423.538999185074;4599.816007359702;5091.210862316347;5157.690538567698;5158.92261616076;5172.741362931876;5208.5051920067535;5213.983273261715;5218.504242096995;5220.843374698765;5222.582193424555;5142.202958541432;5142.408623008365;5186.481351864821;5203.713795741232;5211;5625.915611265835;5631.183478395651;5719.170720245541;5750.6262092963825;5812.564057695689;6164.87670246597;6206.844828879269;6214.937850621481;6215.974364229896;6228.875422491525;6251.249850017982;6283.403076707706;6324.841878953017;6333.050042493663;6345.87308253837;4827.468978412372;5661.179129026268;5727.541796656257;5762;5832.154337621021;6270.090836828635;6289.842753931189;6304.495640348761;6327.114204011442;6330.746770129143;6188.721507532172;6205.751769929152;6212.9068063979075;6217.96891015542;6221.782237621662;6118.174046503754;6131.816045518642;6163.260408750979;6216.595921265103;6310.5267104967315;6098.603590766586;6117.827404800917;6122.459144589048;6125.052321061979;6187.690615469209;6137.5703700741415;6170.259568851767;6194.101855230966;6201.937980620226;6210.161628180228;4981.526754958273;4981.701097934136;4987.950120498821;5004.074246264453;5018.3476148101245;4393.428854248928;4395.538468460765;4417.514073451917;4448.110377924428;4458.398116254264;5694.259746232963;5699.145128230799;5703.258576385127;5728.169415434739;5774.94225057744;6112.807455516588;6274.937250627435;6305.653189074645;6326.49388048955;6328.240611126695;5604.775808967677;5663.943360566424;5698.2592263005545;5736.885262294731;5791.189233507313;5446.564274858002;5464;5468.589855760833;5479;5519;6269.811905642838;6293.181886354836;6306.842328941813;6307.873842523216;6309.211348581335;6117.3707050999965;6154.723037463415;6213.068039794067;6245.750169993149;6332.0818481320875;6277.372262773686;6298.653574053471;6299.118123462627;6310.05349197624;6320.178376810985;6069.089636554376;6069.119977603311;6100.847478813065;6149.631022138686;6153.938460615336;5861.443162899518;5904.881902362014;6113.65874523782;6230.844228894314;6264.874702505833;6198.349173336735;6205.2553693557065;6215.96892015537;6228;6247.375262473716;5942.078977758454;6145.754169833335;6161.045038019114;6182.350853160354;6191.133241346125;5858;5899.056151015817;5937.524998000236;5939.138824870456;6024.487918526975;6100.442838135803;6105.15650299495;6109.84757800648;6117.694115294128;6131.54013449002;5690.630109042899;5832.562557808096;5918.467337939606;5922.437368449991;5928.970355148197 14:09:26 INFO - PROCESS | 1654 | |1;ext.html;480.88434831191626;497.8332258693338;538.5503104907402;543.1282791120252;548.0518702644425;26303.210903672873;41635.79182104089;43234.78382608091;43349;45635.54364456354;44383.55616443835;44738;44860.77569612156;44969.325460118125;44971.77514112433;8852.468851868876;9766.511674416268;9915.652952146676;9918.355306905065;9924.90075099247;8241.134680858513;11887.167898247126;12069.09481788865;12072.758544829097;12374;12197.45111469986;12260.75478490434;12262.509499620004;12265.509379624804;12291.631251062483;8788.077251888524;8937.106289371075;8946.329025323126;12104.27374357537;12182.208156469846;8935.597898094602;11740.412979350998;11940.164188506807;11945.880541194563;12237.082218833533;41875.58124418747;42346.57653423457;42359.57640423618;42431.57568424307;42431.787841060905;2929.4580502607087;3473.7915725056578;3500.2124521982605;3581.5344005279408;3953.9522026662958;31875.84062079698;32156.83921580377;32963.67036329654;32964.6703532964;33067.83466082654;3270.1988012936745;3388.254583991518;3419.5212670226188;3428.5542879425516;3454;516848;517411;517807;518791.40604296734;521576;64520.354796452375;64617.35382646207;64753.67623161854;64796.02805957914;64981.675091625184;67804.66097669578;68007;68176.97734533987;68258;68323.97514037293;15208.163551004802;16724.58188545296;16957.660846782994;16969.0667013313;16991.32034718622;11324.037456816262;11828.52685892572;12865.614031579067;13081.345932703327;13097.541586044443;14296.922038351306;18357.3574924877;18765.78022428538;19331.806681933;19344.936028518565;8026.357891368676;8087.110417854032;8154;8293.668253269921;8310.174540656206;907.7685190276437;926.9026752190923;987.5605355616825;1034.1726618705006;1045.7699306152633;29441.55837662437;29641.110766677033;31286.061418157493;31655;31766;1087.8251488392516;1119.283658458587;1148.718563951837;1191.3149938785234;1240.2930329711978;15742.212889355487;16350.918245408697;16352.509424717278;16397.180140992903;16643.83356166423;692427;699684;701139;701651;703471;59619.701901491084;61208.38791612116;61351.38648613546;61385;61754;1276.2023735165521;1308.241220092344;1427.6074079627979;1428.5642878922029;1452.9709405812036;30443;30785.692143078282;32187.195320117185;32414;32995.67004329926;52265.47734522606;53007.734961324946;53381.733091334296;53446.46553534415;53469.7326513365;641484;651124;653105;654045;654329;37691.86924392272;44491.55508445004;45256;46169;46310.7684461589;49099.75450122727;49798;50113.498865010886;50810;51044;40188.79905600454;40375;40789.98025049397;41527.792361038;41603.1679366417;40231.79884100678;41043;41849.79075104605;42585.361219581115;43711.344329835716;39398;39777.12336182227;40132;40164.1967160661;40222.79331620056;30164.84917575398;31230.687693122778;34154;34402.655973440946;35753.82123089368;23146.074157034203;25862.870685647205;26586;26706.59940100861;26722.292582383317 14:09:26 INFO - PROCESS | 1654 | |2;jquery.html;382.44354464254513;388.3708392404305;390.095737236276;391.44610376317496;413.4356603236583;14135.71728565428;20682.172713091477;21340.786592134074;21708.99999999998;21737;15376.769348459782;18025;20148.798512014877;21273.36179914605;21426.678599820978;5474.452554744524;6194.69026548673;6234.625922444668;6241.843953901166;6254.405831446028;5881.176635271066;6095.177151084613;6142.754289828424;6151.692415379235;6201.224846894138;6050.788222412217;6070.332263451039;6084.574079814415;6089.208402907616;6094.390560943914;5824.359320474744;6059;6069.878602427927;6070.96964515179;6081.695915204222;5257.158854583248;5285.942811437728;5290.418054014055;5292.92060619091;5293.470652934714;25568.616470752953;25911;26572.601410978852;26977.595336069975;27140.864295678395;2271.341311019802;2302.2172461363048;2364.4060235349953;2423.9272821815375;2466.1738317663603;15587.766183507256;15968.441104561285;16088;16542.503724888273;16821.831781682147;1805.8916465012142;1888.8016758240324;1896.5163883209693;1907.9236830526763;1915.1764741161296;99719;124207.37896310551;130764.34617826945;131520.3423982874;132038;9336.439813611205;11738.647840564796;11759;11765.647030588925;11884;14569.344379502947;14681.045732027384;14701.191434471206;14710.779338309934;14711.926440367944;7608.733694320672;8010.399220058519;8266.793330166674;8575.142485751376;8702.695405660772;8793.340499462565;8814.955925220333;8821.647134114564;8914.153155450222;8918.19736223743;4637.188492013952;4643.907121857544;4647.140279048387;4660.300954856799;4726.3146843708155;1930.9517262068562;1952.2386269354963;1952.7851936286997;1957.148640341456;1964.116147733497;902.873597696323;917.7613820406742;1013.7414959185508;1022.9335093219066;1023.9488025598839;21495.97031599111;21814.56370872574;21840.781592184194;21861.344159674918;22206.222782202545;861.9612117454604;954.7040417470606;979.5494072726625;984.6602921991902;1086.8043752124693;11136.38749868765;11432.028277596497;11545.480453379618;11646.301221926711;11694.941525292319;627333;633721;637029;645192;645718;121840;131997;133508;135302;135971;972.9589339406908;1012.1447376966452;1057.49768859791;1059.7403636109202;1087.472575800736;19347;19618.50953726168;19633.901830490755;19710.310139145062;19854.305099321453;46611.669416529716;47653.523464764905;55491.61270968258;56799.43200567942;56871;63656.04515932172;85261;85929;86817;87236;7203.747868824776;8149.796255093433;8209.548474833942;8367.581620918809;8617.353698472765;13085.018623603077;13283.468661253442;13387.598372048855;13603.79594306106;13706.314684265548;11653.708657283636;11672.533098676298;11684.766304674029;11730.354830484406;11900.285982841056;9563.521823908915;9933;10853.565857365616;11439.656810295704;11692.532298707956;11784.76430471403;11824.054075674097;12001.759964800829;12077.39613019363;12117.151799374311;7498.850022999401;7529.247075292427;7564.167941526318;7587.317141457295;7696.999390079478;10626.256162068581;11644.825327619923;11690;11835.171537992257;11851.585194518151 14:09:26 INFO - PROCESS | 1654 | |3;mootools.html;1399.0905911157752;1569.364407414997;1596.6806638672265;1832.37699182278;1966.3707613563656;7973.92026079739;8758.38691291609;9018.72943811685;9022.368434209591;9171.816563668739;8491.85359976403;8795;9109.59006844692;9113.225375843062;9121.908780912188;2089.320970684526;2158.4927542027613;2217.756046834851;2337.3221765688013;2418.056957786465;2433.85396876188;2456.5946618807875;2464.617984212441;2465.457599328145;2465.704115506133;2058.732364792575;2346.401667574766;2412.433078226615;2417.6494408310787;2419.7822196002357;2114.598226336991;2326.162581470669;2398.8560686358874;2400.4838959623676;2403.2790162951046;2420.4674971506242;2443.2670198940423;2447.510497900409;2447.8776061197045;2451.6199989001734;9059.320550958639;9122.589483473259;9135.132162444557;9151.77120571991;9172.8624070639;5219.791208351699;5386.8383948481605;5452.645578037414;5455.372632147314;5458.61789674723;3543.85824567017;3636.090977255686;3704.74066815323;3706.629337066299;3718.7396882218254;984.7981163861391;1106.1869525898458;1115.219346457483;1127.115214556569;1128.8701799293103;10298.9485052575;12088.818667719992;12110.576129835414;12134.514619415213;12160.939195303967;4669.41632295963;4780.464989378866;4793.089313030513;4895.143349913751;4904.8038078477175;10121.645742398981;10180.898191018143;10185.439800811026;10198.490075496196;10205.336653117523;5485.890282194334;5486.341639003345;5487.149491828773;5487.341519017664;5500.779968801283;4459.866204013885;4606.654500912445;4824.421069471686;4986.501349865057;4997.375328083989;3966.9371926598005;3986.282469155522;4076.7961601919787;4116.485439320085;4118.75287482746;1205.180477275461;1210.904131760758;1308.3523655790445;1315.105728104898;1322.444573279225;667.2960027171381;809.9838003239902;827.4952279109739;889.106448019736;966.3911735606523;5953.76184952597;6051.515878729691;6077.301110372364;6078;6201;960.9183219426427;993.7565296502403;996.0985308296003;1000.8748906386702;1016.3749294184023;3970.265500882346;4116.835326586963;4123.824709957647;4170.311898536768;4177.26897792885;10740.73148171302;10898.782024359469;11094.167937404727;11101.722456938642;11107.278371852375;10947.397893115955;11060.446977651085;11076.612318568812;11087.50106245221;11093.445327733742;7303.744368947061;8363.790905227297;8520.19058189471;8526.40315177944;8548;6097.634141951497;6124.326324104256;6173.888700034037;6232.844178895564;6291.245050593958;10038.799224015625;10280.742981425525;10396.740081498023;10449.111825494918;10477.895221047693;10142.746431339276;10381.797222483436;10590.364578125336;10594.417307047877;10601.310914790514;7358.816029599303;8529.061803201766;8716.43343182691;8722.956385218287;8745.693900713444;8207.384446166681;8484.533350665773;8700.216980471789;8754.47473151613;8759.956200218958;7741.883871742041;7748.302652761278;7750.612469376396;7817;7817.452778305464;7586.165521792488;7609.923900760921;7650.081990161217;7699.230076992256;7714.498557593738;6922.5154239202775;7115.679794409368;7190.532615379983;7250.419966402781;7257.383122434441;5073.670211436245;5129.128048231884;5143.819966301162;5149.510796474329;5291.417944026231;5101.336826212569;5137.280780690781;5205.557527610044;5240.89518209626;5326.25432439451 14:09:26 INFO - PROCESS | 1654 | |4;prototype.html;300.14309147384216;304.4626234695762;314.6051705110086;316.3009748455912;320.0271175626097;4295.055087880665;4416.867493975178;4555.088982203564;5135.204043373274;5359.732013399329;4604.884877878055;4992.500749925006;5179.974100129494;5257.634064670894;5359.892802143955;3578.8210589470555;3640.981795091021;3734.253149370123;4086.264472394968;4110.671146308288;3702.2965636529107;3801.3727734923705;3942.960570394288;4122.670186385097;4168.854090106847;3585.4442561403025;4076.8776936691797;4101.810474962273;4141.937870931938;4150.875473735778;3390.186355274741;4077.7961101944934;4108.753474791507;4124.4019617155345;4151.232022075926;3026.636803583562;3611.674949254553;3613.4579813027995;3618.8914332570066;3622.9275414491826;5086.643934924557;5169.922451163236;5215.3741551013745;5233.633645644806;5258.526732594047;4076.735012224196;4640.628749700016;4650.7209567425725;4685.484596694395;4690.614275652276;4880.267959806022;5377.435369286247;5564.86087847803;5569.582281328876;5652.830415087513;3706;3935.783531905744;3941.364333801469;3959.5050618672667;3984.302747019289;5890.440408161217;5926.614770039977;5945.791897283574;5948.453402115481;5950.256217972754;4029.8992525187105;4036.8587099451966;4039.7980100994832;4051.9392209116886;4058.979705101515;3343.592613318407;4059.7361171523758;4064.248114098901;4068.7558746475306;4076.8369265229057;4082.8363916283715;4608.331791890158;4613.515580863961;4630.467496237976;4650.441946966385;5416.241726158262;5556.749946252428;5581.553475721932;5589.273394458694;5613.663180209201;1187.8277649740912;1214.3442541027746;1247.650657815813;1283.6534135783286;1349.6693310139078;717.4654882112756;805.4321703199231;831.8793774902605;834.3033566971646;837.7444879311869;3910.511186101737;4090.4477895484324;4383.583559561836;4419.039243706724;4449.621782148489;4161.817373539573;4253.97873010633;4462.9107417851465;4664.720116793003;4818.855434336975;4138.79306034697;4199.622034016953;4386.978065109718;4743.786529606176;5314.468553144732;2906.9273268168463;2996.955045674317;3021.5920850684874;3025.4267780753885;3037.9797434706115;4824.95337270748;5996.340402555716;6025.8192254232445;6047.427668806142;6054.969725151346;5146.992672857588;5161.090396553299;5250.579953603703;5590.748416321276;5914.645121292736;4918.409790825124;5123.359580052494;5939.732712027969;5984.401559844068;6018;4727.432708075053;4757.666963312535;5590.44095590454;5731.254936858182;5736.168255602831;5302.761375738024;5402.6758394496455;5580.888382232414;5653.321601407857;5657.462541058593;5654.349749778664;5900.144479050427;5948.196993405835;5993.850153746017;5995.760169593342;3707.4253490708984;3822.7897465639658;3829.751066180689;3849.2301539692735;3872.593377695414;4971;5262.289590905332;5721.771129154788;5753.252077229933;5769.278840144982;4471.4796969030685;5296.602754793329;5306.336707911511;5363.785448582169;5592.644413352119;4477.216487114807;4484.417025786627;5566.749496272597;5660.688662123623;5670.404607516151;5486.945130548644;5493.807716729895;5507.146392309199;5518.227448157341;5566.4990150886615;5289.545375021899;5621.189405297351;5650.3219613646625;5656.43435656431;5692.402297758841;4653.697509661861;5420.186971954081;5440.347158341025;5524.530414914777;5526.917096243479 14:09:26 INFO - PROCESS | 1654 | |5;yui.html;739.4269441183084;761.7257787196612;792.3146478296272;843.8692002739577;846.8010017645854;17667.55831104223;18179.27282908682;18180.545486362847;18202.5449363766;18230;16905.49283521496;16964.660706785857;17060.658786824286;17073.658526829488;17081.914590427063;722.12622726501;895.8566629339307;921.1157289002566;925.0564424287223;925.1765928323764;658.1904257762955;805.814662627596;914.9725508234731;920.7145784806698;923.9029901860308;950.4344914775697;956.7034219391976;962.4225464721181;962.8700125483075;964.6382606522554;749.4491548711693;954.4178051388648;955.2739917662592;956.1442508954482;958.1376760915163;693.8785712500343;714.7641278378122;714.9821254468628;715.1918332284486;716.5557354440281;12834.101612887102;15454.845451545452;15483.303251353716;15493.225338733018;15535.689286214325;13749.31253437324;14087.577372678836;14098.577042688736;14112.435502579885;14126.50557230492;13369.933150334284;13384.866151338556;13449.66375840602;13737.381817818223;13988.300584970813;4562.8631141065825;4567.200739870509;4592.196365636;4778.2115950868065;4802.135615589193;115677;117444.41277793642;118197.40901295439;118633.40683296615;118678;10664.680059598224;10706.73233169177;10945.83581246282;11045.116390688725;11223.55105795759;21588;21608.675869861963;21679.024443900063;22338.441538961655;22429.32712018642;8194.139615340422;8207.302379297707;8222.17778222173;8323.66705331792;8434.915650843535;4533;4561.977190114095;4600.539946005372;4655.231886738718;4741.928871066937;3579.6420357964516;3695.630436956337;3697.242065376591;3698.7595806272507;3704.870329538453;678.4165617568887;684.948628852838;690.944724422045;700.8493173967621;709.202147583968;655.6295692933477;689.5621280486927;696.3628280123731;702.8207807009283;709.8225443639091;8795.824083518293;9493.736977936553;9504.192143667866;9826.656067037762;9953.063846165254;601.0563415437808;619.5632079384023;676.7529851604129;688.0436193690774;692.2454524568245;4510.864674059783;4623.428034468297;4626.56047675477;4775.13983840895;4781.2350023996;97334.07997760079;97608;135158;147621;165310.3468965319;135373;136351.31824340814;137126.3143684295;137208;142206.2889685545;114352.28471572933;114713;117136.41431792786;118041.99999999828;120485.39757301158;9075.092490750872;9196.816063678823;9218.354715169873;9223.44659320443;9263.490508022123;62060.68969655123;62069.68965155145;62674.74650506873;63139.6843015782;63892.3610763905;84138.57930710308;89530.55234723784;93340;93698;94116.52941735247;11785.646430607096;11941.865522775322;11981.221220620631;12063.879361206627;12425.751484970431;13426.395812188279;13522.323883805573;13654.658633534242;13671;13989.370478328703;12304.692382690504;12488.812667810173;12513.687157821127;12898.41957111951;12983.675408114872;12549.121561490609;12559.434825432694;12836.422360993964;13030.08789384734;13191.291709743758;12071.517139314328;12377.381130943597;12412.689682758004;12780.552680656505;12781.360931953552;10553.41956192386;10582.841257380991;10728.946355268487;10895.836562451728;10982.450877456255;10529.684109476728;10698.197635177548;10905.18211134184;10958.452077396258;11010.724731881446 14:09:26 INFO - PROCESS | 1654 | __end_tp_report 14:09:26 INFO - PROCESS | 1654 | __start_cc_report 14:09:26 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1131 14:09:26 INFO - PROCESS | 1654 | __end_cc_report 14:09:26 INFO - PROCESS | 1654 | __startTimestamp1468012166853__endTimestamp 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | ------- Summary: start ------- 14:09:26 INFO - PROCESS | 1654 | Number of tests: 6 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5729.32 Median:5922.44 stddev:645.52 (10.9%) stddev-sans-first:619.13 14:09:26 INFO - PROCESS | 1654 | Values: 3316.8 3362.3 3377.0 3387.1 3435.9 5583.3 5681.5 5712.7 5741.1 5777.3 4883.3 5372.8 5486.9 5694.7 5775.5 5181.1 5197.5 5261.4 5271.1 5332.8 4689.3 5350.1 5389.8 5393.9 5423.5 4599.8 5091.2 5157.7 5158.9 5172.7 5208.5 5214.0 5218.5 5220.8 5222.6 5142.2 5142.4 5186.5 5203.7 5211.0 5625.9 5631.2 5719.2 5750.6 5812.6 6164.9 6206.8 6214.9 6216.0 6228.9 6251.2 6283.4 6324.8 6333.1 6345.9 4827.5 5661.2 5727.5 5762.0 5832.2 6270.1 6289.8 6304.5 6327.1 6330.7 6188.7 6205.8 6212.9 6218.0 6221.8 6118.2 6131.8 6163.3 6216.6 6310.5 6098.6 6117.8 6122.5 6125.1 6187.7 6137.6 6170.3 6194.1 6201.9 6210.2 4981.5 4981.7 4988.0 5004.1 5018.3 4393.4 4395.5 4417.5 4448.1 4458.4 5694.3 5699.1 5703.3 5728.2 5774.9 6112.8 6274.9 6305.7 6326.5 6328.2 5604.8 5663.9 5698.3 5736.9 5791.2 5446.6 5464.0 5468.6 5479.0 5519.0 6269.8 6293.2 6306.8 6307.9 6309.2 6117.4 6154.7 6213.1 6245.8 6332.1 6277.4 6298.7 6299.1 6310.1 6320.2 6069.1 6069.1 6100.8 6149.6 6153.9 5861.4 5904.9 6113.7 6230.8 6264.9 6198.3 6205.3 6216.0 6228.0 6247.4 5942.1 6145.8 6161.0 6182.4 6191.1 5858.0 5899.1 5937.5 5939.1 6024.5 6100.4 6105.2 6109.8 6117.7 6131.5 5690.6 5832.6 5918.5 5922.4 5929.0 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:76424.77 Median:40303.40 stddev:167844.06 (416.5%) stddev-sans-first:168218.05 14:09:26 INFO - PROCESS | 1654 | Values: 480.9 497.8 538.6 543.1 548.1 26303.2 41635.8 43234.8 43349.0 45635.5 44383.6 44738.0 44860.8 44969.3 44971.8 8852.5 9766.5 9915.7 9918.4 9924.9 8241.1 11887.2 12069.1 12072.8 12374.0 12197.5 12260.8 12262.5 12265.5 12291.6 8788.1 8937.1 8946.3 12104.3 12182.2 8935.6 11740.4 11940.2 11945.9 12237.1 41875.6 42346.6 42359.6 42431.6 42431.8 2929.5 3473.8 3500.2 3581.5 3954.0 31875.8 32156.8 32963.7 32964.7 33067.8 3270.2 3388.3 3419.5 3428.6 3454.0 516848.0 517411.0 517807.0 518791.4 521576.0 64520.4 64617.4 64753.7 64796.0 64981.7 67804.7 68007.0 68177.0 68258.0 68324.0 15208.2 16724.6 16957.7 16969.1 16991.3 11324.0 11828.5 12865.6 13081.3 13097.5 14296.9 18357.4 18765.8 19331.8 19344.9 8026.4 8087.1 8154.0 8293.7 8310.2 907.8 926.9 987.6 1034.2 1045.8 29441.6 29641.1 31286.1 31655.0 31766.0 1087.8 1119.3 1148.7 1191.3 1240.3 15742.2 16350.9 16352.5 16397.2 16643.8 692427.0 699684.0 701139.0 701651.0 703471.0 59619.7 61208.4 61351.4 61385.0 61754.0 1276.2 1308.2 1427.6 1428.6 1453.0 30443.0 30785.7 32187.2 32414.0 32995.7 52265.5 53007.7 53381.7 53446.5 53469.7 641484.0 651124.0 653105.0 654045.0 654329.0 37691.9 44491.6 45256.0 46169.0 46310.8 49099.8 49798.0 50113.5 50810.0 51044.0 40188.8 40375.0 40790.0 41527.8 41603.2 40231.8 41043.0 41849.8 42585.4 43711.3 39398.0 39777.1 40132.0 40164.2 40222.8 30164.8 31230.7 34154.0 34402.7 35753.8 23146.1 25862.9 26586.0 26706.6 26722.3 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:36785.65 Median:2333.31 stddev:106332.95 (4557.2%) stddev-sans-first:106596.11 14:09:26 INFO - PROCESS | 1654 | Values: 382.4 388.4 390.1 391.4 413.4 14135.7 20682.2 21340.8 21709.0 21737.0 15376.8 18025.0 20148.8 21273.4 21426.7 5474.5 6194.7 6234.6 6241.8 6254.4 5881.2 6095.2 6142.8 6151.7 6201.2 6050.8 6070.3 6084.6 6089.2 6094.4 5824.4 6059.0 6069.9 6071.0 6081.7 5257.2 5285.9 5290.4 5292.9 5293.5 25568.6 25911.0 26572.6 26977.6 27140.9 2271.3 2302.2 2364.4 2423.9 2466.2 15587.8 15968.4 16088.0 16542.5 16821.8 1805.9 1888.8 1896.5 1907.9 1915.2 99719.0 124207.4 130764.3 131520.3 132038.0 9336.4 11738.6 11759.0 11765.6 11884.0 14569.3 14681.0 14701.2 14710.8 14711.9 7608.7 8010.4 8266.8 8575.1 8702.7 8793.3 8815.0 8821.6 8914.2 8918.2 4637.2 4643.9 4647.1 4660.3 4726.3 1931.0 1952.2 1952.8 1957.1 1964.1 902.9 917.8 1013.7 1022.9 1023.9 21496.0 21814.6 21840.8 21861.3 22206.2 862.0 954.7 979.5 984.7 1086.8 11136.4 11432.0 11545.5 11646.3 11694.9 627333.0 633721.0 637029.0 645192.0 645718.0 121840.0 131997.0 133508.0 135302.0 135971.0 973.0 1012.1 1057.5 1059.7 1087.5 19347.0 19618.5 19633.9 19710.3 19854.3 46611.7 47653.5 55491.6 56799.4 56871.0 63656.0 85261.0 85929.0 86817.0 87236.0 7203.7 8149.8 8209.5 8367.6 8617.4 13085.0 13283.5 13387.6 13603.8 13706.3 11653.7 11672.5 11684.8 11730.4 11900.3 9563.5 9933.0 10853.6 11439.7 11692.5 11784.8 11824.1 12001.8 12077.4 12117.2 7498.9 7529.2 7564.2 7587.3 7697.0 10626.3 11644.8 11690.0 11835.2 11851.6 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5889.25 Median:4808.76 stddev:3312.09 (68.9%) stddev-sans-first:3304.19 14:09:26 INFO - PROCESS | 1654 | Values: 1399.1 1569.4 1596.7 1832.4 1966.4 7973.9 8758.4 9018.7 9022.4 9171.8 8491.9 8795.0 9109.6 9113.2 9121.9 2089.3 2158.5 2217.8 2337.3 2418.1 2433.9 2456.6 2464.6 2465.5 2465.7 2058.7 2346.4 2412.4 2417.6 2419.8 2114.6 2326.2 2398.9 2400.5 2403.3 2420.5 2443.3 2447.5 2447.9 2451.6 9059.3 9122.6 9135.1 9151.8 9172.9 5219.8 5386.8 5452.6 5455.4 5458.6 3543.9 3636.1 3704.7 3706.6 3718.7 984.8 1106.2 1115.2 1127.1 1128.9 10298.9 12088.8 12110.6 12134.5 12160.9 4669.4 4780.5 4793.1 4895.1 4904.8 10121.6 10180.9 10185.4 10198.5 10205.3 5485.9 5486.3 5487.1 5487.3 5500.8 4459.9 4606.7 4824.4 4986.5 4997.4 3966.9 3986.3 4076.8 4116.5 4118.8 1205.2 1210.9 1308.4 1315.1 1322.4 667.3 810.0 827.5 889.1 966.4 5953.8 6051.5 6077.3 6078.0 6201.0 960.9 993.8 996.1 1000.9 1016.4 3970.3 4116.8 4123.8 4170.3 4177.3 10740.7 10898.8 11094.2 11101.7 11107.3 10947.4 11060.4 11076.6 11087.5 11093.4 7303.7 8363.8 8520.2 8526.4 8548.0 6097.6 6124.3 6173.9 6232.8 6291.2 10038.8 10280.7 10396.7 10449.1 10477.9 10142.7 10381.8 10590.4 10594.4 10601.3 7358.8 8529.1 8716.4 8723.0 8745.7 8207.4 8484.5 8700.2 8754.5 8760.0 7741.9 7748.3 7750.6 7817.0 7817.5 7586.2 7609.9 7650.1 7699.2 7714.5 6922.5 7115.7 7190.5 7250.4 7257.4 5073.7 5129.1 5143.8 5149.5 5291.4 5101.3 5137.3 5205.6 5240.9 5326.3 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4455.25 Median:4735.61 stddev:1370.38 (28.9%) stddev-sans-first:1338.27 14:09:26 INFO - PROCESS | 1654 | Values: 300.1 304.5 314.6 316.3 320.0 4295.1 4416.9 4555.1 5135.2 5359.7 4604.9 4992.5 5180.0 5257.6 5359.9 3578.8 3641.0 3734.3 4086.3 4110.7 3702.3 3801.4 3943.0 4122.7 4168.9 3585.4 4076.9 4101.8 4141.9 4150.9 3390.2 4077.8 4108.8 4124.4 4151.2 3026.6 3611.7 3613.5 3618.9 3622.9 5086.6 5169.9 5215.4 5233.6 5258.5 4076.7 4640.6 4650.7 4685.5 4690.6 4880.3 5377.4 5564.9 5569.6 5652.8 3706.0 3935.8 3941.4 3959.5 3984.3 5890.4 5926.6 5945.8 5948.5 5950.3 4029.9 4036.9 4039.8 4051.9 4059.0 3343.6 4059.7 4064.2 4068.8 4076.8 4082.8 4608.3 4613.5 4630.5 4650.4 5416.2 5556.7 5581.6 5589.3 5613.7 1187.8 1214.3 1247.7 1283.7 1349.7 717.5 805.4 831.9 834.3 837.7 3910.5 4090.4 4383.6 4419.0 4449.6 4161.8 4254.0 4462.9 4664.7 4818.9 4138.8 4199.6 4387.0 4743.8 5314.5 2906.9 2997.0 3021.6 3025.4 3038.0 4825.0 5996.3 6025.8 6047.4 6055.0 5147.0 5161.1 5250.6 5590.7 5914.6 4918.4 5123.4 5939.7 5984.4 6018.0 4727.4 4757.7 5590.4 5731.3 5736.2 5302.8 5402.7 5580.9 5653.3 5657.5 5654.3 5900.1 5948.2 5993.9 5995.8 3707.4 3822.8 3829.8 3849.2 3872.6 4971.0 5262.3 5721.8 5753.3 5769.3 4471.5 5296.6 5306.3 5363.8 5592.6 4477.2 4484.4 5566.7 5660.7 5670.4 5486.9 5493.8 5507.1 5518.2 5566.5 5289.5 5621.2 5650.3 5656.4 5692.4 4653.7 5420.2 5440.3 5524.5 5526.9 14:09:26 INFO - PROCESS | 1654 | 14:09:26 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:25060.14 Median:3698.00 stddev:39758.61 (1075.1%) stddev-sans-first:39828.21 14:09:26 INFO - PROCESS | 1654 | Values: 739.4 761.7 792.3 843.9 846.8 17667.6 18179.3 18180.5 18202.5 18230.0 16905.5 16964.7 17060.7 17073.7 17081.9 722.1 895.9 921.1 925.1 925.2 658.2 805.8 915.0 920.7 923.9 950.4 956.7 962.4 962.9 964.6 749.4 954.4 955.3 956.1 958.1 693.9 714.8 715.0 715.2 716.6 12834.1 15454.8 15483.3 15493.2 15535.7 13749.3 14087.6 14098.6 14112.4 14126.5 13369.9 13384.9 13449.7 13737.4 13988.3 4562.9 4567.2 4592.2 4778.2 4802.1 115677.0 117444.4 118197.4 118633.4 118678.0 10664.7 10706.7 10945.8 11045.1 11223.6 21588.0 21608.7 21679.0 22338.4 22429.3 8194.1 8207.3 8222.2 8323.7 8434.9 4533.0 4562.0 4600.5 4655.2 4741.9 3579.6 3695.6 3697.2 3698.8 3704.9 678.4 684.9 690.9 700.8 709.2 655.6 689.6 696.4 702.8 709.8 8795.8 9493.7 9504.2 9826.7 9953.1 601.1 619.6 676.8 688.0 692.2 4510.9 4623.4 4626.6 4775.1 4781.2 97334.1 97608.0 135158.0 147621.0 165310.3 135373.0 136351.3 137126.3 137208.0 142206.3 114352.3 114713.0 117136.4 118042.0 120485.4 9075.1 9196.8 9218.4 9223.4 9263.5 62060.7 62069.7 62674.7 63139.7 63892.4 84138.6 89530.6 93340.0 93698.0 94116.5 11785.6 11941.9 11981.2 12063.9 12425.8 13426.4 13522.3 13654.7 13671.0 13989.4 12304.7 12488.8 12513.7 12898.4 12983.7 12549.1 12559.4 12836.4 13030.1 13191.3 12071.5 12377.4 12412.7 12780.6 12781.4 10553.4 10582.8 10728.9 10895.8 10982.5 10529.7 10698.2 10905.2 10958.5 11010.7 14:09:26 INFO - PROCESS | 1654 | -------- Summary: end -------- 14:09:26 INFO - PROCESS | 1654 | 14:09:27 INFO - TEST-INFO | 1654: exit 0 14:09:27 INFO - TEST-OK | dromaeo_css | took 1116797ms 14:09:27 INFO - TEST-START | kraken 14:09:27 INFO - operating with platform_type : mac_ 14:09:27 INFO - Initialising browser for kraken test... 14:09:27 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpNI2Gzv/profile http://localhost:49266/getInfo.html) 14:09:29 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 14:09:29 INFO - PROCESS | 1660 | colorDepth:24 14:09:29 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 14:09:29 INFO - PROCESS | 1660 | __metrics 14:09:29 INFO - PROCESS | 1660 | 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" 14:09:29 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:09:30 INFO - TEST-INFO | 1660: exit 0 14:09:30 INFO - Browser initialized. 14:09:30 INFO - Running cycle 1/1 for kraken test... 14:09:30 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpNI2Gzv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:42 INFO - PROCESS | 1661 | RSS: Main: 243699712 14:09:42 INFO - PROCESS | 1661 | 14:09:45 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:46 INFO - PROCESS | 1661 | RSS: Main: 294502400 14:09:46 INFO - PROCESS | 1661 | 14:09:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 14:09:49 INFO - PROCESS | 1661 | RSS: Main: 304861184 14:09:49 INFO - PROCESS | 1661 | 14:09:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 14:09:53 INFO - PROCESS | 1661 | RSS: Main: 390385664 14:09:53 INFO - PROCESS | 1661 | 14:09:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 14:09:56 INFO - PROCESS | 1661 | RSS: Main: 290607104 14:09:56 INFO - PROCESS | 1661 | 14:09:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:58 INFO - PROCESS | 1661 | RSS: Main: 294313984 14:09:58 INFO - PROCESS | 1661 | 14:10:01 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 14:10:02 INFO - PROCESS | 1661 | RSS: Main: 332857344 14:10:02 INFO - PROCESS | 1661 | 14:10:05 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 14:10:05 INFO - PROCESS | 1661 | RSS: Main: 333455360 14:10:05 INFO - PROCESS | 1661 | 14:10:08 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 14:10:09 INFO - PROCESS | 1661 | RSS: Main: 332734464 14:10:09 INFO - PROCESS | 1661 | 14:10:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:10:11 INFO - PROCESS | 1661 | RSS: Main: 312102912 14:10:11 INFO - PROCESS | 1661 | 14:10:13 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:10:13 INFO - PROCESS | 1661 | RSS: Main: 319004672 14:10:13 INFO - PROCESS | 1661 | 14:10:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:10:16 INFO - PROCESS | 1661 | RSS: Main: 317591552 14:10:16 INFO - PROCESS | 1661 | 14:10:19 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:10:20 INFO - PROCESS | 1661 | RSS: Main: 325115904 14:10:20 INFO - PROCESS | 1661 | 14:10:23 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:10:23 INFO - PROCESS | 1661 | RSS: Main: 327806976 14:10:23 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 14:10:25 INFO - PROCESS | 1661 | RSS: Main: 371126272 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | __start_tp_report 14:10:25 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 14:10:25 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 14:10:25 INFO - PROCESS | 1661 | |i|pagename|runs| 14:10:25 INFO - PROCESS | 1661 | |0;ai-astar;101;113;112;112;114;111;112;110;113;116 14:10:25 INFO - PROCESS | 1661 | |1;audio-beat-detection;144;105;107;156;108;108;130;105;139;106 14:10:25 INFO - PROCESS | 1661 | |2;audio-dft;182;183;185;184;182;182;182;184;183;180 14:10:25 INFO - PROCESS | 1661 | |3;audio-fft;79;73;56;107;57;56;61;63;96;56 14:10:25 INFO - PROCESS | 1661 | |4;audio-oscillator;81;86;92;71;71;68;96;69;67;98 14:10:25 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;90;86;88;86;88;84;89;86;89;86 14:10:25 INFO - PROCESS | 1661 | |6;imaging-darkroom;94;94;95;95;93;94;96;94;106;148 14:10:25 INFO - PROCESS | 1661 | |7;imaging-desaturate;87;85;86;84;83;85;84;85;84;84 14:10:25 INFO - PROCESS | 1661 | |8;json-parse-financial;52;54;55;55;54;53;53;55;54;53 14:10:25 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;65;69;78;81;71;71;70;71;69;71 14:10:25 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;86;82;83;82;79;81;83;83;85;84 14:10:25 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;128;140;149;141;127;141;141;146;229;137 14:10:25 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;165;190;165;164;163;167;161;161;162;165 14:10:25 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;63;69;65;66;67;64;67;66;65;65 14:10:25 INFO - PROCESS | 1661 | __end_tp_report 14:10:25 INFO - PROCESS | 1661 | __start_cc_report 14:10:25 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2048 14:10:25 INFO - PROCESS | 1661 | __end_cc_report 14:10:25 INFO - PROCESS | 1661 | __startTimestamp1468012225638__endTimestamp 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | ------- Summary: start ------- 14:10:25 INFO - PROCESS | 1661 | Number of tests: 14 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:4.01 (3.6%) stddev-sans-first:1.74 14:10:25 INFO - PROCESS | 1661 | Values: 101.0 113.0 112.0 112.0 114.0 111.0 112.0 110.0 113.0 116.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:119.00 stddev:19.52 (16.4%) stddev-sans-first:18.81 14:10:25 INFO - PROCESS | 1661 | Values: 144.0 105.0 107.0 156.0 108.0 108.0 130.0 105.0 139.0 106.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.42 (0.8%) stddev-sans-first:1.48 14:10:25 INFO - PROCESS | 1661 | Values: 182.0 183.0 185.0 184.0 182.0 182.0 182.0 184.0 183.0 180.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:70.40 Median:62.00 stddev:18.32 (29.5%) stddev-sans-first:19.16 14:10:25 INFO - PROCESS | 1661 | Values: 79.0 73.0 56.0 107.0 57.0 56.0 61.0 63.0 96.0 56.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:83.50 stddev:12.28 (14.7%) stddev-sans-first:13.02 14:10:25 INFO - PROCESS | 1661 | Values: 81.0 86.0 92.0 71.0 71.0 68.0 96.0 69.0 67.0 98.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:1.87 (2.1%) stddev-sans-first:1.69 14:10:25 INFO - PROCESS | 1661 | Values: 90.0 86.0 88.0 86.0 88.0 84.0 89.0 86.0 89.0 86.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:94.00 stddev:16.97 (18.0%) stddev-sans-first:17.81 14:10:25 INFO - PROCESS | 1661 | Values: 94.0 94.0 95.0 95.0 93.0 94.0 96.0 94.0 106.0 148.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:0.88 14:10:25 INFO - PROCESS | 1661 | Values: 87.0 85.0 86.0 84.0 83.0 85.0 84.0 85.0 84.0 84.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:0.87 14:10:25 INFO - PROCESS | 1661 | Values: 52.0 54.0 55.0 55.0 54.0 53.0 53.0 55.0 54.0 53.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:4.60 (6.5%) stddev-sans-first:4.21 14:10:25 INFO - PROCESS | 1661 | Values: 65.0 69.0 78.0 81.0 71.0 71.0 70.0 71.0 69.0 71.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.99 (2.4%) stddev-sans-first:1.74 14:10:25 INFO - PROCESS | 1661 | Values: 86.0 82.0 83.0 82.0 79.0 81.0 83.0 83.0 85.0 84.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:141.00 stddev:29.32 (20.8%) stddev-sans-first:30.21 14:10:25 INFO - PROCESS | 1661 | Values: 128.0 140.0 149.0 141.0 127.0 141.0 141.0 146.0 229.0 137.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:165.00 stddev:8.55 (5.2%) stddev-sans-first:9.06 14:10:25 INFO - PROCESS | 1661 | Values: 165.0 190.0 165.0 164.0 163.0 167.0 161.0 161.0 162.0 165.0 14:10:25 INFO - PROCESS | 1661 | 14:10:25 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.50 14:10:25 INFO - PROCESS | 1661 | Values: 63.0 69.0 65.0 66.0 67.0 64.0 67.0 66.0 65.0 65.0 14:10:25 INFO - PROCESS | 1661 | -------- Summary: end -------- 14:10:25 INFO - PROCESS | 1661 | 14:10:26 INFO - TEST-INFO | 1661: exit 0 14:10:26 INFO - TEST-OK | kraken | took 59037ms 14:10:26 INFO - SUITE-END | took 1175s 14:10:26 INFO - Completed test suite (00:19:36) 14:10:26 INFO - javascript benchmark 14:10:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.756216418843, 3362.3107263011084, 3376.9999999999986, 3387.0516255448483, 3435.8625654973803, 5583.3300003999475, 5681.545476361892, 5712.742926568304, 5741.138829175626, 5777.277840269971, 4883.291922671219, 5372.764264219232, 5486.945130548704, 5694.6867922264255, 5775.480206781389, 5181.145111056671, 5197.506236907488, 5261.421243663194, 5271.130263506517, 5332.813351532697, 4689.2966055091665, 5350.117230656937, 5389.757460914248, 5393.865153371158, 5423.538999185074, 4599.816007359702, 5091.210862316347, 5157.690538567698, 5158.92261616076, 5172.741362931876, 5208.5051920067535, 5213.983273261715, 5218.504242096995, 5220.843374698765, 5222.582193424555, 5142.202958541432, 5142.408623008365, 5186.481351864821, 5203.713795741232, 5211.0, 5625.915611265835, 5631.183478395651, 5719.170720245541, 5750.6262092963825, 5812.564057695689, 6164.87670246597, 6206.844828879269, 6214.937850621481, 6215.974364229896, 6228.875422491525, 6251.249850017982, 6283.403076707706, 6324.841878953017, 6333.050042493663, 6345.87308253837, 4827.468978412372, 5661.179129026268, 5727.541796656257, 5762.0, 5832.154337621021, 6270.090836828635, 6289.842753931189, 6304.495640348761, 6327.114204011442, 6330.746770129143, 6188.721507532172, 6205.751769929152, 6212.9068063979075, 6217.96891015542, 6221.782237621662, 6118.174046503754, 6131.816045518642, 6163.260408750979, 6216.595921265103, 6310.5267104967315, 6098.603590766586, 6117.827404800917, 6122.459144589048, 6125.052321061979, 6187.690615469209, 6137.5703700741415, 6170.259568851767, 6194.101855230966, 6201.937980620226, 6210.161628180228, 4981.526754958273, 4981.701097934136, 4987.950120498821, 5004.074246264453, 5018.3476148101245, 4393.428854248928, 4395.538468460765, 4417.514073451917, 4448.110377924428, 4458.398116254264, 5694.259746232963, 5699.145128230799, 5703.258576385127, 5728.169415434739, 5774.94225057744, 6112.807455516588, 6274.937250627435, 6305.653189074645, 6326.49388048955, 6328.240611126695, 5604.775808967677, 5663.943360566424, 5698.2592263005545, 5736.885262294731, 5791.189233507313, 5446.564274858002, 5464.0, 5468.589855760833, 5479.0, 5519.0, 6269.811905642838, 6293.181886354836, 6306.842328941813, 6307.873842523216, 6309.211348581335, 6117.3707050999965, 6154.723037463415, 6213.068039794067, 6245.750169993149, 6332.0818481320875, 6277.372262773686, 6298.653574053471, 6299.118123462627, 6310.05349197624, 6320.178376810985, 6069.089636554376, 6069.119977603311, 6100.847478813065, 6149.631022138686, 6153.938460615336, 5861.443162899518, 5904.881902362014, 6113.65874523782, 6230.844228894314, 6264.874702505833, 6198.349173336735, 6205.2553693557065, 6215.96892015537, 6228.0, 6247.375262473716, 5942.078977758454, 6145.754169833335, 6161.045038019114, 6182.350853160354, 6191.133241346125, 5858.0, 5899.056151015817, 5937.524998000236, 5939.138824870456, 6024.487918526975, 6100.442838135803, 6105.15650299495, 6109.84757800648, 6117.694115294128, 6131.54013449002, 5690.630109042899, 5832.562557808096, 5918.467337939606, 5922.437368449991, 5928.970355148197], "value": 5687.9374235993455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.88434831191626, 497.8332258693338, 538.5503104907402, 543.1282791120252, 548.0518702644425, 26303.210903672873, 41635.79182104089, 43234.78382608091, 43349.0, 45635.54364456354, 44383.55616443835, 44738.0, 44860.77569612156, 44969.325460118125, 44971.77514112433, 8852.468851868876, 9766.511674416268, 9915.652952146676, 9918.355306905065, 9924.90075099247, 8241.134680858513, 11887.167898247126, 12069.09481788865, 12072.758544829097, 12374.0, 12197.45111469986, 12260.75478490434, 12262.509499620004, 12265.509379624804, 12291.631251062483, 8788.077251888524, 8937.106289371075, 8946.329025323126, 12104.27374357537, 12182.208156469846, 8935.597898094602, 11740.412979350998, 11940.164188506807, 11945.880541194563, 12237.082218833533, 41875.58124418747, 42346.57653423457, 42359.57640423618, 42431.57568424307, 42431.787841060905, 2929.4580502607087, 3473.7915725056578, 3500.2124521982605, 3581.5344005279408, 3953.9522026662958, 31875.84062079698, 32156.83921580377, 32963.67036329654, 32964.6703532964, 33067.83466082654, 3270.1988012936745, 3388.254583991518, 3419.5212670226188, 3428.5542879425516, 3454.0, 516848.0, 517411.0, 517807.0, 518791.40604296734, 521576.0, 64520.354796452375, 64617.35382646207, 64753.67623161854, 64796.02805957914, 64981.675091625184, 67804.66097669578, 68007.0, 68176.97734533987, 68258.0, 68323.97514037293, 15208.163551004802, 16724.58188545296, 16957.660846782994, 16969.0667013313, 16991.32034718622, 11324.037456816262, 11828.52685892572, 12865.614031579067, 13081.345932703327, 13097.541586044443, 14296.922038351306, 18357.3574924877, 18765.78022428538, 19331.806681933, 19344.936028518565, 8026.357891368676, 8087.110417854032, 8154.0, 8293.668253269921, 8310.174540656206, 907.7685190276437, 926.9026752190923, 987.5605355616825, 1034.1726618705006, 1045.7699306152633, 29441.55837662437, 29641.110766677033, 31286.061418157493, 31655.0, 31766.0, 1087.8251488392516, 1119.283658458587, 1148.718563951837, 1191.3149938785234, 1240.2930329711978, 15742.212889355487, 16350.918245408697, 16352.509424717278, 16397.180140992903, 16643.83356166423, 692427.0, 699684.0, 701139.0, 701651.0, 703471.0, 59619.701901491084, 61208.38791612116, 61351.38648613546, 61385.0, 61754.0, 1276.2023735165521, 1308.241220092344, 1427.6074079627979, 1428.5642878922029, 1452.9709405812036, 30443.0, 30785.692143078282, 32187.195320117185, 32414.0, 32995.67004329926, 52265.47734522606, 53007.734961324946, 53381.733091334296, 53446.46553534415, 53469.7326513365, 641484.0, 651124.0, 653105.0, 654045.0, 654329.0, 37691.86924392272, 44491.55508445004, 45256.0, 46169.0, 46310.7684461589, 49099.75450122727, 49798.0, 50113.498865010886, 50810.0, 51044.0, 40188.79905600454, 40375.0, 40789.98025049397, 41527.792361038, 41603.1679366417, 40231.79884100678, 41043.0, 41849.79075104605, 42585.361219581115, 43711.344329835716, 39398.0, 39777.12336182227, 40132.0, 40164.1967160661, 40222.79331620056, 30164.84917575398, 31230.687693122778, 34154.0, 34402.655973440946, 35753.82123089368, 23146.074157034203, 25862.870685647205, 26586.0, 26706.59940100861, 26722.292582383317], "value": 21400.83119710172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.44354464254513, 388.3708392404305, 390.095737236276, 391.44610376317496, 413.4356603236583, 14135.71728565428, 20682.172713091477, 21340.786592134074, 21708.99999999998, 21737.0, 15376.769348459782, 18025.0, 20148.798512014877, 21273.36179914605, 21426.678599820978, 5474.452554744524, 6194.69026548673, 6234.625922444668, 6241.843953901166, 6254.405831446028, 5881.176635271066, 6095.177151084613, 6142.754289828424, 6151.692415379235, 6201.224846894138, 6050.788222412217, 6070.332263451039, 6084.574079814415, 6089.208402907616, 6094.390560943914, 5824.359320474744, 6059.0, 6069.878602427927, 6070.96964515179, 6081.695915204222, 5257.158854583248, 5285.942811437728, 5290.418054014055, 5292.92060619091, 5293.470652934714, 25568.616470752953, 25911.0, 26572.601410978852, 26977.595336069975, 27140.864295678395, 2271.341311019802, 2302.2172461363048, 2364.4060235349953, 2423.9272821815375, 2466.1738317663603, 15587.766183507256, 15968.441104561285, 16088.0, 16542.503724888273, 16821.831781682147, 1805.8916465012142, 1888.8016758240324, 1896.5163883209693, 1907.9236830526763, 1915.1764741161296, 99719.0, 124207.37896310551, 130764.34617826945, 131520.3423982874, 132038.0, 9336.439813611205, 11738.647840564796, 11759.0, 11765.647030588925, 11884.0, 14569.344379502947, 14681.045732027384, 14701.191434471206, 14710.779338309934, 14711.926440367944, 7608.733694320672, 8010.399220058519, 8266.793330166674, 8575.142485751376, 8702.695405660772, 8793.340499462565, 8814.955925220333, 8821.647134114564, 8914.153155450222, 8918.19736223743, 4637.188492013952, 4643.907121857544, 4647.140279048387, 4660.300954856799, 4726.3146843708155, 1930.9517262068562, 1952.2386269354963, 1952.7851936286997, 1957.148640341456, 1964.116147733497, 902.873597696323, 917.7613820406742, 1013.7414959185508, 1022.9335093219066, 1023.9488025598839, 21495.97031599111, 21814.56370872574, 21840.781592184194, 21861.344159674918, 22206.222782202545, 861.9612117454604, 954.7040417470606, 979.5494072726625, 984.6602921991902, 1086.8043752124693, 11136.38749868765, 11432.028277596497, 11545.480453379618, 11646.301221926711, 11694.941525292319, 627333.0, 633721.0, 637029.0, 645192.0, 645718.0, 121840.0, 131997.0, 133508.0, 135302.0, 135971.0, 972.9589339406908, 1012.1447376966452, 1057.49768859791, 1059.7403636109202, 1087.472575800736, 19347.0, 19618.50953726168, 19633.901830490755, 19710.310139145062, 19854.305099321453, 46611.669416529716, 47653.523464764905, 55491.61270968258, 56799.43200567942, 56871.0, 63656.04515932172, 85261.0, 85929.0, 86817.0, 87236.0, 7203.747868824776, 8149.796255093433, 8209.548474833942, 8367.581620918809, 8617.353698472765, 13085.018623603077, 13283.468661253442, 13387.598372048855, 13603.79594306106, 13706.314684265548, 11653.708657283636, 11672.533098676298, 11684.766304674029, 11730.354830484406, 11900.285982841056, 9563.521823908915, 9933.0, 10853.565857365616, 11439.656810295704, 11692.532298707956, 11784.76430471403, 11824.054075674097, 12001.759964800829, 12077.39613019363, 12117.151799374311, 7498.850022999401, 7529.247075292427, 7564.167941526318, 7587.317141457295, 7696.999390079478, 10626.256162068581, 11644.825327619923, 11690.0, 11835.171537992257, 11851.585194518151], "value": 9904.138844165493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.0905911157752, 1569.364407414997, 1596.6806638672265, 1832.37699182278, 1966.3707613563656, 7973.92026079739, 8758.38691291609, 9018.72943811685, 9022.368434209591, 9171.816563668739, 8491.85359976403, 8795.0, 9109.59006844692, 9113.225375843062, 9121.908780912188, 2089.320970684526, 2158.4927542027613, 2217.756046834851, 2337.3221765688013, 2418.056957786465, 2433.85396876188, 2456.5946618807875, 2464.617984212441, 2465.457599328145, 2465.704115506133, 2058.732364792575, 2346.401667574766, 2412.433078226615, 2417.6494408310787, 2419.7822196002357, 2114.598226336991, 2326.162581470669, 2398.8560686358874, 2400.4838959623676, 2403.2790162951046, 2420.4674971506242, 2443.2670198940423, 2447.510497900409, 2447.8776061197045, 2451.6199989001734, 9059.320550958639, 9122.589483473259, 9135.132162444557, 9151.77120571991, 9172.8624070639, 5219.791208351699, 5386.8383948481605, 5452.645578037414, 5455.372632147314, 5458.61789674723, 3543.85824567017, 3636.090977255686, 3704.74066815323, 3706.629337066299, 3718.7396882218254, 984.7981163861391, 1106.1869525898458, 1115.219346457483, 1127.115214556569, 1128.8701799293103, 10298.9485052575, 12088.818667719992, 12110.576129835414, 12134.514619415213, 12160.939195303967, 4669.41632295963, 4780.464989378866, 4793.089313030513, 4895.143349913751, 4904.8038078477175, 10121.645742398981, 10180.898191018143, 10185.439800811026, 10198.490075496196, 10205.336653117523, 5485.890282194334, 5486.341639003345, 5487.149491828773, 5487.341519017664, 5500.779968801283, 4459.866204013885, 4606.654500912445, 4824.421069471686, 4986.501349865057, 4997.375328083989, 3966.9371926598005, 3986.282469155522, 4076.7961601919787, 4116.485439320085, 4118.75287482746, 1205.180477275461, 1210.904131760758, 1308.3523655790445, 1315.105728104898, 1322.444573279225, 667.2960027171381, 809.9838003239902, 827.4952279109739, 889.106448019736, 966.3911735606523, 5953.76184952597, 6051.515878729691, 6077.301110372364, 6078.0, 6201.0, 960.9183219426427, 993.7565296502403, 996.0985308296003, 1000.8748906386702, 1016.3749294184023, 3970.265500882346, 4116.835326586963, 4123.824709957647, 4170.311898536768, 4177.26897792885, 10740.73148171302, 10898.782024359469, 11094.167937404727, 11101.722456938642, 11107.278371852375, 10947.397893115955, 11060.446977651085, 11076.612318568812, 11087.50106245221, 11093.445327733742, 7303.744368947061, 8363.790905227297, 8520.19058189471, 8526.40315177944, 8548.0, 6097.634141951497, 6124.326324104256, 6173.888700034037, 6232.844178895564, 6291.245050593958, 10038.799224015625, 10280.742981425525, 10396.740081498023, 10449.111825494918, 10477.895221047693, 10142.746431339276, 10381.797222483436, 10590.364578125336, 10594.417307047877, 10601.310914790514, 7358.816029599303, 8529.061803201766, 8716.43343182691, 8722.956385218287, 8745.693900713444, 8207.384446166681, 8484.533350665773, 8700.216980471789, 8754.47473151613, 8759.956200218958, 7741.883871742041, 7748.302652761278, 7750.612469376396, 7817.0, 7817.452778305464, 7586.165521792488, 7609.923900760921, 7650.081990161217, 7699.230076992256, 7714.498557593738, 6922.5154239202775, 7115.679794409368, 7190.532615379983, 7250.419966402781, 7257.383122434441, 5073.670211436245, 5129.128048231884, 5143.819966301162, 5149.510796474329, 5291.417944026231, 5101.336826212569, 5137.280780690781, 5205.557527610044, 5240.89518209626, 5326.25432439451], "value": 4708.927323836459, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.14309147384216, 304.4626234695762, 314.6051705110086, 316.3009748455912, 320.0271175626097, 4295.055087880665, 4416.867493975178, 4555.088982203564, 5135.204043373274, 5359.732013399329, 4604.884877878055, 4992.500749925006, 5179.974100129494, 5257.634064670894, 5359.892802143955, 3578.8210589470555, 3640.981795091021, 3734.253149370123, 4086.264472394968, 4110.671146308288, 3702.2965636529107, 3801.3727734923705, 3942.960570394288, 4122.670186385097, 4168.854090106847, 3585.4442561403025, 4076.8776936691797, 4101.810474962273, 4141.937870931938, 4150.875473735778, 3390.186355274741, 4077.7961101944934, 4108.753474791507, 4124.4019617155345, 4151.232022075926, 3026.636803583562, 3611.674949254553, 3613.4579813027995, 3618.8914332570066, 3622.9275414491826, 5086.643934924557, 5169.922451163236, 5215.3741551013745, 5233.633645644806, 5258.526732594047, 4076.735012224196, 4640.628749700016, 4650.7209567425725, 4685.484596694395, 4690.614275652276, 4880.267959806022, 5377.435369286247, 5564.86087847803, 5569.582281328876, 5652.830415087513, 3706.0, 3935.783531905744, 3941.364333801469, 3959.5050618672667, 3984.302747019289, 5890.440408161217, 5926.614770039977, 5945.791897283574, 5948.453402115481, 5950.256217972754, 4029.8992525187105, 4036.8587099451966, 4039.7980100994832, 4051.9392209116886, 4058.979705101515, 3343.592613318407, 4059.7361171523758, 4064.248114098901, 4068.7558746475306, 4076.8369265229057, 4082.8363916283715, 4608.331791890158, 4613.515580863961, 4630.467496237976, 4650.441946966385, 5416.241726158262, 5556.749946252428, 5581.553475721932, 5589.273394458694, 5613.663180209201, 1187.8277649740912, 1214.3442541027746, 1247.650657815813, 1283.6534135783286, 1349.6693310139078, 717.4654882112756, 805.4321703199231, 831.8793774902605, 834.3033566971646, 837.7444879311869, 3910.511186101737, 4090.4477895484324, 4383.583559561836, 4419.039243706724, 4449.621782148489, 4161.817373539573, 4253.97873010633, 4462.9107417851465, 4664.720116793003, 4818.855434336975, 4138.79306034697, 4199.622034016953, 4386.978065109718, 4743.786529606176, 5314.468553144732, 2906.9273268168463, 2996.955045674317, 3021.5920850684874, 3025.4267780753885, 3037.9797434706115, 4824.95337270748, 5996.340402555716, 6025.8192254232445, 6047.427668806142, 6054.969725151346, 5146.992672857588, 5161.090396553299, 5250.579953603703, 5590.748416321276, 5914.645121292736, 4918.409790825124, 5123.359580052494, 5939.732712027969, 5984.401559844068, 6018.0, 4727.432708075053, 4757.666963312535, 5590.44095590454, 5731.254936858182, 5736.168255602831, 5302.761375738024, 5402.6758394496455, 5580.888382232414, 5653.321601407857, 5657.462541058593, 5654.349749778664, 5900.144479050427, 5948.196993405835, 5993.850153746017, 5995.760169593342, 3707.4253490708984, 3822.7897465639658, 3829.751066180689, 3849.2301539692735, 3872.593377695414, 4971.0, 5262.289590905332, 5721.771129154788, 5753.252077229933, 5769.278840144982, 4471.4796969030685, 5296.602754793329, 5306.336707911511, 5363.785448582169, 5592.644413352119, 4477.216487114807, 4484.417025786627, 5566.749496272597, 5660.688662123623, 5670.404607516151, 5486.945130548644, 5493.807716729895, 5507.146392309199, 5518.227448157341, 5566.4990150886615, 5289.545375021899, 5621.189405297351, 5650.3219613646625, 5656.43435656431, 5692.402297758841, 4653.697509661861, 5420.186971954081, 5440.347158341025, 5524.530414914777, 5526.917096243479], "value": 4016.972101087874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.4269441183084, 761.7257787196612, 792.3146478296272, 843.8692002739577, 846.8010017645854, 17667.55831104223, 18179.27282908682, 18180.545486362847, 18202.5449363766, 18230.0, 16905.49283521496, 16964.660706785857, 17060.658786824286, 17073.658526829488, 17081.914590427063, 722.12622726501, 895.8566629339307, 921.1157289002566, 925.0564424287223, 925.1765928323764, 658.1904257762955, 805.814662627596, 914.9725508234731, 920.7145784806698, 923.9029901860308, 950.4344914775697, 956.7034219391976, 962.4225464721181, 962.8700125483075, 964.6382606522554, 749.4491548711693, 954.4178051388648, 955.2739917662592, 956.1442508954482, 958.1376760915163, 693.8785712500343, 714.7641278378122, 714.9821254468628, 715.1918332284486, 716.5557354440281, 12834.101612887102, 15454.845451545452, 15483.303251353716, 15493.225338733018, 15535.689286214325, 13749.31253437324, 14087.577372678836, 14098.577042688736, 14112.435502579885, 14126.50557230492, 13369.933150334284, 13384.866151338556, 13449.66375840602, 13737.381817818223, 13988.300584970813, 4562.8631141065825, 4567.200739870509, 4592.196365636, 4778.2115950868065, 4802.135615589193, 115677.0, 117444.41277793642, 118197.40901295439, 118633.40683296615, 118678.0, 10664.680059598224, 10706.73233169177, 10945.83581246282, 11045.116390688725, 11223.55105795759, 21588.0, 21608.675869861963, 21679.024443900063, 22338.441538961655, 22429.32712018642, 8194.139615340422, 8207.302379297707, 8222.17778222173, 8323.66705331792, 8434.915650843535, 4533.0, 4561.977190114095, 4600.539946005372, 4655.231886738718, 4741.928871066937, 3579.6420357964516, 3695.630436956337, 3697.242065376591, 3698.7595806272507, 3704.870329538453, 678.4165617568887, 684.948628852838, 690.944724422045, 700.8493173967621, 709.202147583968, 655.6295692933477, 689.5621280486927, 696.3628280123731, 702.8207807009283, 709.8225443639091, 8795.824083518293, 9493.736977936553, 9504.192143667866, 9826.656067037762, 9953.063846165254, 601.0563415437808, 619.5632079384023, 676.7529851604129, 688.0436193690774, 692.2454524568245, 4510.864674059783, 4623.428034468297, 4626.56047675477, 4775.13983840895, 4781.2350023996, 97334.07997760079, 97608.0, 135158.0, 147621.0, 165310.3468965319, 135373.0, 136351.31824340814, 137126.3143684295, 137208.0, 142206.2889685545, 114352.28471572933, 114713.0, 117136.41431792786, 118041.99999999828, 120485.39757301158, 9075.092490750872, 9196.816063678823, 9218.354715169873, 9223.44659320443, 9263.490508022123, 62060.68969655123, 62069.68965155145, 62674.74650506873, 63139.6843015782, 63892.3610763905, 84138.57930710308, 89530.55234723784, 93340.0, 93698.0, 94116.52941735247, 11785.646430607096, 11941.865522775322, 11981.221220620631, 12063.879361206627, 12425.751484970431, 13426.395812188279, 13522.323883805573, 13654.658633534242, 13671.0, 13989.370478328703, 12304.692382690504, 12488.812667810173, 12513.687157821127, 12898.41957111951, 12983.675408114872, 12549.121561490609, 12559.434825432694, 12836.422360993964, 13030.08789384734, 13191.291709743758, 12071.517139314328, 12377.381130943597, 12412.689682758004, 12780.552680656505, 12781.360931953552, 10553.41956192386, 10582.841257380991, 10728.946355268487, 10895.836562451728, 10982.450877456255, 10529.684109476728, 10698.197635177548, 10905.18211134184, 10958.452077396258, 11010.724731881446], "value": 8018.944137307449, "unit": "score"}], "name": "dromaeo_css", "value": 7534.102899539582, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 112.0, 112.0, 114.0, 111.0, 112.0, 110.0, 113.0, 116.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 105.0, 107.0, 156.0, 108.0, 108.0, 130.0, 105.0, 139.0, 106.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 185.0, 184.0, 182.0, 182.0, 182.0, 184.0, 183.0, 180.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 56.0, 107.0, 57.0, 56.0, 61.0, 63.0, 96.0, 56.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 92.0, 71.0, 71.0, 68.0, 96.0, 69.0, 67.0, 98.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 86.0, 88.0, 84.0, 89.0, 86.0, 89.0, 86.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 93.0, 94.0, 96.0, 94.0, 106.0, 148.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 83.0, 85.0, 84.0, 85.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 55.0, 55.0, 54.0, 53.0, 53.0, 55.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 78.0, 81.0, 71.0, 71.0, 70.0, 71.0, 69.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 82.0, 79.0, 81.0, 83.0, 83.0, 85.0, 84.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 140.0, 149.0, 141.0, 127.0, 141.0, 141.0, 146.0, 229.0, 137.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 190.0, 165.0, 164.0, 163.0, 167.0, 161.0, 161.0, 162.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 65.0, 66.0, 67.0, 64.0, 67.0, 66.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1426.1000000000001, "alertThreshold": 2.0}]} 14:10:26 INFO - Return code: 0 14:10:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:10:26 INFO - # TBPL SUCCESS # 14:10:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:10:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:10:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:10:26 INFO - 2016-07-08 14:10:26.961 screenresolution[1665:10164] starting screenresolution argv=screenresolution get 14:10:26 INFO - 2016-07-08 14:10:26.963 screenresolution[1665:10164] Display 0: 1600x1200x32@60 14:10:26 INFO - 2016-07-08 14:10:26.969 screenresolution[1666:10167] starting screenresolution argv=screenresolution list 14:10:26 INFO - Available Modes on Display 0 14:10:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:10:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:10:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:10:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:10:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:10:27 INFO - Intel Iris: 14:10:27 INFO - Chipset Model: Intel Iris 14:10:27 INFO - Type: GPU 14:10:27 INFO - Bus: Built-In 14:10:27 INFO - VRAM (Dynamic, Max): 1536 MB 14:10:27 INFO - Vendor: Intel (0x8086) 14:10:27 INFO - Device ID: 0x0a2e 14:10:27 INFO - Revision ID: 0x0009 14:10:27 INFO - Displays: 14:10:27 INFO - Display: 14:10:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:10:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:10:27 INFO - Display Serial Number: 1600x1200 60 14:10:27 INFO - Main Display: Yes 14:10:27 INFO - Mirror: Off 14:10:27 INFO - Online: Yes 14:10:27 INFO - Rotation: Supported 14:10:27 INFO - Return code: 0 14:10:27 INFO - Running post-action listener: _resource_record_post_action 14:10:27 INFO - ##### 14:10:27 INFO - ##### Finished run-tests step (success) 14:10:27 INFO - ##### 14:10:27 INFO - Running post-run listener: _resource_record_post_run 14:10:27 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 31649280; Write bytes: 706231296; Read time: 192; Write time: 1942 14:10:27 INFO - TinderboxPrint: CPU usage
53.5% 14:10:27 INFO - TinderboxPrint: I/O read bytes / time
31,649,280 / 192 14:10:27 INFO - TinderboxPrint: I/O write bytes / time
706,231,296 / 1,942 14:10:27 INFO - TinderboxPrint: CPU idle
2,255.1 (46.5%) 14:10:27 INFO - TinderboxPrint: CPU system
964.3 (19.9%) 14:10:27 INFO - TinderboxPrint: CPU user
1,626.2 (33.6%) 14:10:27 INFO - TinderboxPrint: Swap in / out
434,638,848 / 0 14:10:27 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392454656; Write bytes: 386672128; Read time: 29460; Write time: 794 14:10:27 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30723584; Write bytes: 296527360; Read time: 180; Write time: 1094 14:10:27 INFO - Running post-run listener: _upload_blobber_files 14:10:27 INFO - Blob upload gear active. 14:10:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:10: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 14:10: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'] 14:10: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 14:10:28 INFO - (blobuploader) - INFO - Open directory for files ... 14:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:29 INFO - (blobuploader) - INFO - Done attempting. 14:10:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:10:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:31 INFO - (blobuploader) - INFO - Done attempting. 14:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:10:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:33 INFO - (blobuploader) - INFO - Done attempting. 14:10:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:33 INFO - Return code: 0 14:10:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86ec0a7ae7f14f70ea294331874b3ad61281c84cb5ecfb20a9d2b04226522545716fe5138a31eb7320d24bf3caeb9806a362e74f8863613b359c11daa5837390", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33f9a88fbcde2eb68532fea4432147352f8172b0e10e6b7a4b666c252f36720f533d15eaa02ba3c5968f0622c58ae4740a7b2f06b3210ab4de6d46ba86b26f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5666771dd14d2711906b1d41bab9ec4fe96dae2b753f5bf3ca9ef3614528fae6aab41d63fb5db41213e311a0180d0b5dd5754387188bd4930de28a9990f12c3"} 14:10:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:33 INFO - Contents: 14:10:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86ec0a7ae7f14f70ea294331874b3ad61281c84cb5ecfb20a9d2b04226522545716fe5138a31eb7320d24bf3caeb9806a362e74f8863613b359c11daa5837390", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33f9a88fbcde2eb68532fea4432147352f8172b0e10e6b7a4b666c252f36720f533d15eaa02ba3c5968f0622c58ae4740a7b2f06b3210ab4de6d46ba86b26f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5666771dd14d2711906b1d41bab9ec4fe96dae2b753f5bf3ca9ef3614528fae6aab41d63fb5db41213e311a0180d0b5dd5754387188bd4930de28a9990f12c3"} 14:10:33 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:33 INFO - Copying logs to upload dir... 14:10:33 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1333.860839 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-07-08 14:10:33.569049) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 14:10:33.572133) ========= 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.W2L7Zru872/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.P4P98bBvPw/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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/86ec0a7ae7f14f70ea294331874b3ad61281c84cb5ecfb20a9d2b04226522545716fe5138a31eb7320d24bf3caeb9806a362e74f8863613b359c11daa5837390", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33f9a88fbcde2eb68532fea4432147352f8172b0e10e6b7a4b666c252f36720f533d15eaa02ba3c5968f0622c58ae4740a7b2f06b3210ab4de6d46ba86b26f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5666771dd14d2711906b1d41bab9ec4fe96dae2b753f5bf3ca9ef3614528fae6aab41d63fb5db41213e311a0180d0b5dd5754387188bd4930de28a9990f12c3"} build_url:https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010909 build_url: 'https://queue.taskcluster.net/v1/task/dePeT9xHSWCSRTVsfFMfKg/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/86ec0a7ae7f14f70ea294331874b3ad61281c84cb5ecfb20a9d2b04226522545716fe5138a31eb7320d24bf3caeb9806a362e74f8863613b359c11daa5837390", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33f9a88fbcde2eb68532fea4432147352f8172b0e10e6b7a4b666c252f36720f533d15eaa02ba3c5968f0622c58ae4740a7b2f06b3210ab4de6d46ba86b26f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5666771dd14d2711906b1d41bab9ec4fe96dae2b753f5bf3ca9ef3614528fae6aab41d63fb5db41213e311a0180d0b5dd5754387188bd4930de28a9990f12c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 14:10:33.603600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:10:33.603917) ========= 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.W2L7Zru872/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.P4P98bBvPw/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.004952 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 14:10:33.652438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 14:10:33.652757) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 14:10:33.653067) ========= ========= Total master_lag: 0.16 =========