builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0242 starttime: 1467676154.18 results: success (0) buildid: 20160704150324 builduid: 4e86acde70c8419fbc661dbebb014130 revision: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.178263) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.178726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.179013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.500984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:49:14.501546) ========= 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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-04 16:49:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-07-04 16:49:15 (18.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.463862 ========= master_lag: 0.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:49:15.660626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:15.660928) ========= 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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.026155 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:15.707793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:49:15.708099) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 --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 c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4xZSyvMTzv/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.JPLg6F9mCX/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-04 16:49:15,789 truncating revision to first 12 chars 2016-07-04 16:49:15,789 Setting DEBUG logging. 2016-07-04 16:49:15,789 attempt 1/10 2016-07-04 16:49:15,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c9a70b64f2fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 16:49:16,569 unpacking tar archive at: mozilla-central-c9a70b64f2fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.066989 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:49:16.797066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.797374) ========= script_repo_revision: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.800801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.801097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.819243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-07-04 16:49:16.819530) ========= /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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:49:17 INFO - MultiFileLogger online at 20160704 16:49:17 in /builds/slave/test 16:49:17 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 16:49:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:49:17 INFO - {'append_to_log': False, 16:49:17 INFO - 'base_work_dir': '/builds/slave/test', 16:49:17 INFO - 'blob_upload_branch': 'Firefox', 16:49:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:49:17 INFO - 'branch': 'Firefox', 16:49:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:17 INFO - 'config_files': ('talos/mac_config.py',), 16:49:17 INFO - 'default_actions': ('clobber', 16:49:17 INFO - 'read-buildbot-config', 16:49:17 INFO - 'download-and-extract', 16:49:17 INFO - 'populate-webroot', 16:49:17 INFO - 'create-virtualenv', 16:49:17 INFO - 'install', 16:49:17 INFO - 'run-tests'), 16:49:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:17 INFO - 'download_minidump_stackwalk': True, 16:49:17 INFO - 'download_symbols': 'ondemand', 16:49:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:17 INFO - 'installer_path': 'installer.exe', 16:49:17 INFO - 'log_level': 'info', 16:49:17 INFO - 'log_name': 'talos', 16:49:17 INFO - 'log_to_console': True, 16:49:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:49:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:49:17 INFO - 'opt_config_files': (), 16:49:17 INFO - 'pip_index': False, 16:49:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:49:17 INFO - 'cmd': ('bash', 16:49:17 INFO - '-c', 16:49:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:49:17 INFO - 'enabled': True, 16:49:17 INFO - 'halt_on_failure': False, 16:49:17 INFO - 'name': 'check_screen_resolution'},), 16:49:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:49:17 INFO - 'cmd': ('bash', 16:49:17 INFO - '-c', 16:49:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:49:17 INFO - 'enabled': True, 16:49:17 INFO - 'halt_on_failure': False, 16:49:17 INFO - 'name': 'check_screen_resolution'},), 16:49:17 INFO - 'run_cmd_checks_enabled': True, 16:49:17 INFO - 'sps_profile': False, 16:49:17 INFO - 'sps_profile_interval': 0, 16:49:17 INFO - 'suite': 'dromaeojs', 16:49:17 INFO - 'system_bits': '32', 16:49:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:17 INFO - 'title': 't-yosemite-r7-0242', 16:49:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:17 INFO - 'use_talos_json': True, 16:49:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:49:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:17 INFO - 'work_dir': 'build'} 16:49:17 INFO - ##### 16:49:17 INFO - ##### Running clobber step. 16:49:17 INFO - ##### 16:49:17 INFO - Running pre-action listener: _resource_record_pre_action 16:49:17 INFO - Running main action method: clobber 16:49:17 INFO - rmtree: /builds/slave/test/build 16:49:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:49:19 INFO - Running post-action listener: _resource_record_post_action 16:49:19 INFO - ##### 16:49:19 INFO - ##### Finished clobber step (success) 16:49:19 INFO - ##### 16:49:19 INFO - ##### 16:49:19 INFO - ##### Running read-buildbot-config step. 16:49:19 INFO - ##### 16:49:19 INFO - Running pre-action listener: _resource_record_pre_action 16:49:19 INFO - Running main action method: read_buildbot_config 16:49:19 INFO - Using buildbot properties: 16:49:19 INFO - { 16:49:19 INFO - "project": "", 16:49:19 INFO - "product": "firefox", 16:49:19 INFO - "script_repo_revision": "production", 16:49:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:49:19 INFO - "repository": "", 16:49:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:49:19 INFO - "buildid": "20160704150324", 16:49:19 INFO - "pgo_build": "False", 16:49:19 INFO - "basedir": "/builds/slave/test", 16:49:19 INFO - "buildnumber": 2, 16:49:19 INFO - "slavename": "t-yosemite-r7-0242", 16:49:19 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:49:19 INFO - "platform": "yosemite_r7", 16:49:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:49:19 INFO - "branch": "mozilla-central", 16:49:19 INFO - "repo_path": "mozilla-central", 16:49:19 INFO - "revision": "c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5", 16:49:19 INFO - "stage_platform": "macosx64", 16:49:19 INFO - "builduid": "4e86acde70c8419fbc661dbebb014130", 16:49:19 INFO - "slavebuilddir": "test" 16:49:19 INFO - } 16:49:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 16:49:19 INFO - Running post-action listener: _resource_record_post_action 16:49:19 INFO - ##### 16:49:19 INFO - ##### Finished read-buildbot-config step (success) 16:49:19 INFO - ##### 16:49:19 INFO - ##### 16:49:19 INFO - ##### Running download-and-extract step. 16:49:19 INFO - ##### 16:49:19 INFO - Running pre-action listener: _resource_record_pre_action 16:49:19 INFO - Running main action method: download_and_extract 16:49:19 INFO - mkdir: /builds/slave/test/build/tests 16:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:19 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:49:49 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 16:49:49 INFO - retry: attempt #1 caught exception: timed out 16:49:49 INFO - retry: Failed, sleeping 30 seconds before retrying 16:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:34 INFO - Downloaded 1199 bytes. 16:50:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 16:50:34 INFO - Using the following test package requirements: 16:50:34 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:50:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 16:50:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 16:50:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'jsshell-mac.zip'], 16:50:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 16:50:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:50:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 16:50:34 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 16:50:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 16:50:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:34 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 16:50:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:34 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:50:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:36 INFO - Downloaded 18800185 bytes. 16:50:36 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'] 16:50:36 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 16:50:39 INFO - Return code: 0 16:50:39 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 16:50: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')]} 16:50:39 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:44 INFO - Downloaded 18800185 bytes. 16:50:44 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'] 16:50:44 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 16:50:47 INFO - Return code: 0 16:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:47 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:49 INFO - Downloaded 14403333 bytes. 16:50:49 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'] 16:50:49 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 16:50:49 INFO - Return code: 0 16:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:49 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 16:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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 16:50:52 INFO - Downloaded 112424182 bytes. 16:50:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:52 INFO - mkdir: /builds/slave/test/properties 16:50:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:50:52 INFO - Writing to file /builds/slave/test/properties/build_url 16:50:52 INFO - Contents: 16:50:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:53 INFO - Running post-action listener: _resource_record_post_action 16:50:53 INFO - Running post-action listener: set_extra_try_arguments 16:50:53 INFO - ##### 16:50:53 INFO - ##### Finished download-and-extract step (success) 16:50:53 INFO - ##### 16:50:53 INFO - ##### 16:50:53 INFO - ##### Running populate-webroot step. 16:50:53 INFO - ##### 16:50:53 INFO - Running pre-action listener: _resource_record_pre_action 16:50:53 INFO - Running main action method: populate_webroot 16:50:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:53 INFO - '--tppagecycles', 16:50:53 INFO - '7'], 16:50:53 INFO - 'tests': ['tsvgm']}}, 16:50:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:50:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:50:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:50:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['damp', 'tps']}, 16:50:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'tests': ['damp', 'tps']}, 16:50:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['dromaeo_dom']}, 16:50:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['basic_compositor_video']}, 16:50:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:50:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['a11yr', 16:50:53 INFO - 'ts_paint', 16:50:53 INFO - 'tpaint', 16:50:53 INFO - 'sessionrestore', 16:50:53 INFO - 'sessionrestore_no_auto_restore', 16:50:53 INFO - 'tabpaint']}, 16:50:53 INFO - 'other-e10s': {'tests': ['a11yr', 16:50:53 INFO - 'ts_paint', 16:50:53 INFO - 'tpaint', 16:50:53 INFO - 'sessionrestore', 16:50:53 INFO - 'sessionrestore_no_auto_restore', 16:50:53 INFO - 'tabpaint']}, 16:50:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:50:53 INFO - 'ts_paint', 16:50:53 INFO - 'tpaint', 16:50:53 INFO - 'sessionrestore', 16:50:53 INFO - 'sessionrestore_no_auto_restore', 16:50:53 INFO - 'tabpaint']}, 16:50:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:50:53 INFO - 'ts_paint', 16:50:53 INFO - 'tpaint', 16:50:53 INFO - 'sessionrestore', 16:50:53 INFO - 'sessionrestore_no_auto_restore', 16:50:53 INFO - 'tabpaint']}, 16:50:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['a11yr', 16:50:53 INFO - 'ts_paint', 16:50:53 INFO - 'tpaint', 16:50:53 INFO - 'sessionrestore', 16:50:53 INFO - 'sessionrestore_no_auto_restore', 16:50:53 INFO - 'tabpaint']}, 16:50:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['a11yr', 16:50:53 INFO - 'ts_paint', 16:50:53 INFO - 'tpaint', 16:50:53 INFO - 'sessionrestore', 16:50:53 INFO - 'sessionrestore_no_auto_restore', 16:50:53 INFO - 'tabpaint']}, 16:50:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['tsvgx', 16:50:53 INFO - 'tsvgr_opacity', 16:50:53 INFO - 'tart', 16:50:53 INFO - 'tscrollx', 16:50:53 INFO - 'cart']}, 16:50:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:50:53 INFO - 'tsvgr_opacity', 16:50:53 INFO - 'tart', 16:50:53 INFO - 'tscrollx', 16:50:53 INFO - 'cart']}, 16:50:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'talos_options': ['--disable-e10s'], 16:50:53 INFO - 'tests': ['tp5o']}, 16:50:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'tests': ['tp5o']}, 16:50:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'talos_options': ['--disable-e10s', 16:50:53 INFO - '--xperf_path', 16:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:53 INFO - 'tests': ['tp5n']}, 16:50:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:53 INFO - 'talos_options': ['--xperf_path', 16:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:53 INFO - 'tests': ['tp5n']}}, 16:50:53 INFO - 'talos.zip': {'path': '', 16:50:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:53 INFO - Running post-action listener: _resource_record_post_action 16:50:53 INFO - ##### 16:50:53 INFO - ##### Finished populate-webroot step (success) 16:50:53 INFO - ##### 16:50:53 INFO - ##### 16:50:53 INFO - ##### Running create-virtualenv step. 16:50:53 INFO - ##### 16:50:53 INFO - Running pre-action listener: _resource_record_pre_action 16:50:53 INFO - Running main action method: create_virtualenv 16:50:53 INFO - Creating virtualenv /builds/slave/test/build/venv 16:50:53 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 16:50:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:50:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:53 INFO - Using real prefix '/tools/python27' 16:50:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:50:54 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:57 INFO - Installing pip.................done. 16:50:57 INFO - Return code: 0 16:50:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:50:57 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')]} 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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')]} 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:50:57 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 16:50:57 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 16:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:50:57 INFO - 'HOME': '/Users/cltbld', 16:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:50:57 INFO - 'LOGNAME': 'cltbld', 16:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:57 INFO - 'MOZ_NO_REMOTE': '1', 16:50:57 INFO - 'NO_EM_RESTART': '1', 16:50:57 INFO - 'PAGER': '/bin/cat', 16:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:57 INFO - 'PWD': '/builds/slave/test', 16:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:50:57 INFO - 'SHELL': '/bin/bash', 16:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:50:57 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:50:57 INFO - 'USER': 'cltbld', 16:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:57 INFO - 'XPC_FLAGS': '0x0', 16:50:57 INFO - 'XPC_SERVICE_NAME': '0', 16:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:57 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 16:50:57 INFO - Cleaning up... 16:50:57 INFO - Return code: 0 16:50:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:50:57 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')]} 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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')]} 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:50:57 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 16:50:57 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 16:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:50:57 INFO - 'HOME': '/Users/cltbld', 16:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:50:57 INFO - 'LOGNAME': 'cltbld', 16:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:57 INFO - 'MOZ_NO_REMOTE': '1', 16:50:57 INFO - 'NO_EM_RESTART': '1', 16:50:57 INFO - 'PAGER': '/bin/cat', 16:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:57 INFO - 'PWD': '/builds/slave/test', 16:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:50:57 INFO - 'SHELL': '/bin/bash', 16:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:50:57 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:50:57 INFO - 'USER': 'cltbld', 16:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:57 INFO - 'XPC_FLAGS': '0x0', 16:50:57 INFO - 'XPC_SERVICE_NAME': '0', 16:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:58 INFO - Downloading/unpacking psutil>=3.1.1 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:01 INFO - Installing collected packages: psutil 16:51:01 INFO - Running setup.py install for psutil 16:51:01 INFO - building 'psutil._psutil_osx' extension 16:51:01 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 16:51:02 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 16:51:02 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 16:51:02 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 16:51:02 INFO - building 'psutil._psutil_posix' extension 16:51:02 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 16:51:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:51:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:51:02 INFO - ^ 16:51:02 INFO - 1 warning generated. 16:51:02 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 16:51:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:02 INFO - Successfully installed psutil 16:51:02 INFO - Cleaning up... 16:51:02 INFO - Return code: 0 16:51:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:02 INFO - 'HOME': '/Users/cltbld', 16:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:02 INFO - 'LOGNAME': 'cltbld', 16:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:02 INFO - 'MOZ_NO_REMOTE': '1', 16:51:02 INFO - 'NO_EM_RESTART': '1', 16:51:02 INFO - 'PAGER': '/bin/cat', 16:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:02 INFO - 'PWD': '/builds/slave/test', 16:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:02 INFO - 'SHELL': '/bin/bash', 16:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:02 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:02 INFO - 'USER': 'cltbld', 16:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:02 INFO - 'XPC_FLAGS': '0x0', 16:51:02 INFO - 'XPC_SERVICE_NAME': '0', 16:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:51:05 INFO - Installing collected packages: mozsystemmonitor 16:51:05 INFO - Running setup.py install for mozsystemmonitor 16:51:05 INFO - Successfully installed mozsystemmonitor 16:51:05 INFO - Cleaning up... 16:51:05 INFO - Return code: 0 16:51:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 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 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:51:05 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 16:51:05 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 16:51:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:05 INFO - 'HOME': '/Users/cltbld', 16:51:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:05 INFO - 'LOGNAME': 'cltbld', 16:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:05 INFO - 'MOZ_NO_REMOTE': '1', 16:51:05 INFO - 'NO_EM_RESTART': '1', 16:51:05 INFO - 'PAGER': '/bin/cat', 16:51:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:05 INFO - 'PWD': '/builds/slave/test', 16:51:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:05 INFO - 'SHELL': '/bin/bash', 16:51:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:05 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:05 INFO - 'USER': 'cltbld', 16:51:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:05 INFO - 'XPC_FLAGS': '0x0', 16:51:05 INFO - 'XPC_SERVICE_NAME': '0', 16:51:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:05 INFO - Downloading/unpacking jsonschema==2.5.1 16:51:05 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 16:51:05 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 16:51:05 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 16:51:05 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 16:51:05 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 16:51:05 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 16:51:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:51:08 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 16:51:08 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 16:51:08 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 16:51:08 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 16:51:08 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 16:51:08 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 16:51:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:08 INFO - warning: no files found matching '*.txt' 16:51:08 INFO - no previously-included directories found matching 'build' 16:51:08 INFO - no previously-included directories found matching 'dist' 16:51:08 INFO - no previously-included directories found matching '.git*' 16:51:08 INFO - Installing collected packages: jsonschema, functools32 16:51:08 INFO - Running setup.py install for functools32 16:51:09 INFO - warning: no files found matching '*.txt' 16:51:09 INFO - no previously-included directories found matching 'build' 16:51:09 INFO - no previously-included directories found matching 'dist' 16:51:09 INFO - no previously-included directories found matching '.git*' 16:51:09 INFO - Successfully installed jsonschema functools32 16:51:09 INFO - Cleaning up... 16:51:09 INFO - Return code: 0 16:51:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:51: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')]} 16:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:09 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 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:51:09 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 16:51:09 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 16:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:09 INFO - 'HOME': '/Users/cltbld', 16:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:09 INFO - 'LOGNAME': 'cltbld', 16:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:09 INFO - 'MOZ_NO_REMOTE': '1', 16:51:09 INFO - 'NO_EM_RESTART': '1', 16:51:09 INFO - 'PAGER': '/bin/cat', 16:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:09 INFO - 'PWD': '/builds/slave/test', 16:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:09 INFO - 'SHELL': '/bin/bash', 16:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:09 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:09 INFO - 'USER': 'cltbld', 16:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:09 INFO - 'XPC_FLAGS': '0x0', 16:51:09 INFO - 'XPC_SERVICE_NAME': '0', 16:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:09 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 16:51:09 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 16:51:09 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 16:51:09 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 16:51:09 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 16:51:09 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 16:51:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:51:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:13 INFO - Downloading docopt-0.6.1.tar.gz 16:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:13 INFO - Running setup.py install for blobuploader 16:51:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:51:13 INFO - Running setup.py install for requests 16:51:13 INFO - Running setup.py install for docopt 16:51:14 INFO - Successfully installed blobuploader requests docopt 16:51:14 INFO - Cleaning up... 16:51:14 INFO - Return code: 0 16:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51: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')]} 16:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:14 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 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:51:14 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 16:51:14 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 16:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:14 INFO - 'HOME': '/Users/cltbld', 16:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:14 INFO - 'LOGNAME': 'cltbld', 16:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:14 INFO - 'MOZ_NO_REMOTE': '1', 16:51:14 INFO - 'NO_EM_RESTART': '1', 16:51:14 INFO - 'PAGER': '/bin/cat', 16:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:14 INFO - 'PWD': '/builds/slave/test', 16:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:14 INFO - 'SHELL': '/bin/bash', 16:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:14 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:14 INFO - 'USER': 'cltbld', 16:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:14 INFO - 'XPC_FLAGS': '0x0', 16:51:14 INFO - 'XPC_SERVICE_NAME': '0', 16:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-6LOfne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Np7Z6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-m7ZBfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Bitq9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-x5jC_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-d_7yBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Takof5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-gZeY07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-K4UqMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-IKcZTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-TCVFxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Cy0LsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-rT5_4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-yu1HSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-J0xGiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Kbnwlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:16 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Y1keYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:16 INFO - Running setup.py install for manifestparser 16:51:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:51:16 INFO - Running setup.py install for mozcrash 16:51:16 INFO - Running setup.py install for mozdebug 16:51:16 INFO - Running setup.py install for mozdevice 16:51:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:51:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:51:16 INFO - Running setup.py install for mozfile 16:51:16 INFO - Running setup.py install for mozhttpd 16:51:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Running setup.py install for mozinfo 16:51:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Running setup.py install for mozInstall 16:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Running setup.py install for mozleak 16:51:17 INFO - Running setup.py install for mozlog 16:51:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Running setup.py install for moznetwork 16:51:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:51:17 INFO - Running setup.py install for mozprocess 16:51:17 INFO - Running setup.py install for mozprofile 16:51:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:51:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:51:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:51:18 INFO - Running setup.py install for mozrunner 16:51:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:51:18 INFO - Running setup.py install for mozscreenshot 16:51:18 INFO - Running setup.py install for moztest 16:51:18 INFO - Running setup.py install for mozversion 16:51:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:51:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:18 INFO - Cleaning up... 16:51:18 INFO - Return code: 0 16:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:18 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 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:51:18 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 16:51:18 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 16:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:18 INFO - 'HOME': '/Users/cltbld', 16:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:18 INFO - 'LOGNAME': 'cltbld', 16:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:18 INFO - 'MOZ_NO_REMOTE': '1', 16:51:18 INFO - 'NO_EM_RESTART': '1', 16:51:18 INFO - 'PAGER': '/bin/cat', 16:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:18 INFO - 'PWD': '/builds/slave/test', 16:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:18 INFO - 'SHELL': '/bin/bash', 16:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:18 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:18 INFO - 'USER': 'cltbld', 16:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:18 INFO - 'XPC_FLAGS': '0x0', 16:51:18 INFO - 'XPC_SERVICE_NAME': '0', 16:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-nKtDyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-iSLyVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-joEAV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Ldx7mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-sKuYyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-iEXkKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Nd5FUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-ZvFbO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-8XvBZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:19 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)) 16:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-n07HWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:20 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)) 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-YYJPDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:20 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)) 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-3Z5BRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-1N5njY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:20 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)) 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-ObJSRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-GCuAet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:20 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)) 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-oeqy6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:20 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)) 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-KFZRZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:20 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)) 16:51:20 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)) 16:51:20 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)) 16:51:20 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)) 16:51:20 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)) 16:51:20 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)) 16:51:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:23 INFO - Downloading blessings-1.6.tar.gz 16:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:23 INFO - Installing collected packages: blessings 16:51:23 INFO - Running setup.py install for blessings 16:51:23 INFO - Successfully installed blessings 16:51:23 INFO - Cleaning up... 16:51:23 INFO - Return code: 0 16:51:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:23 INFO - Reading from file tmpfile_stdout 16:51:23 INFO - Current package versions: 16:51:23 INFO - blessings == 1.6 16:51:23 INFO - blobuploader == 1.2.4 16:51:23 INFO - docopt == 0.6.1 16:51:23 INFO - functools32 == 3.2.3-2 16:51:23 INFO - jsonschema == 2.5.1 16:51:23 INFO - manifestparser == 1.1 16:51:23 INFO - mozInstall == 1.12 16:51:23 INFO - mozcrash == 0.17 16:51:23 INFO - mozdebug == 0.1 16:51:23 INFO - mozdevice == 0.48 16:51:23 INFO - mozfile == 1.2 16:51:23 INFO - mozhttpd == 0.7 16:51:23 INFO - mozinfo == 0.9 16:51:23 INFO - mozleak == 0.1 16:51:23 INFO - mozlog == 3.2 16:51:23 INFO - moznetwork == 0.27 16:51:23 INFO - mozprocess == 0.22 16:51:23 INFO - mozprofile == 0.28 16:51:23 INFO - mozrunner == 6.11 16:51:23 INFO - mozscreenshot == 0.1 16:51:23 INFO - mozsystemmonitor == 0.3 16:51:23 INFO - moztest == 0.7 16:51:23 INFO - mozversion == 1.4 16:51:23 INFO - psutil == 3.1.1 16:51:23 INFO - requests == 1.2.3 16:51:23 INFO - wsgiref == 0.1.2 16:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:23 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')]} 16:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:23 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')]} 16:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:23 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 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:51:23 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 16:51:23 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 16:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:23 INFO - 'HOME': '/Users/cltbld', 16:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:23 INFO - 'LOGNAME': 'cltbld', 16:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:23 INFO - 'MOZ_NO_REMOTE': '1', 16:51:23 INFO - 'NO_EM_RESTART': '1', 16:51:23 INFO - 'PAGER': '/bin/cat', 16:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:23 INFO - 'PWD': '/builds/slave/test', 16:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:23 INFO - 'SHELL': '/bin/bash', 16:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:23 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:23 INFO - 'USER': 'cltbld', 16:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:23 INFO - 'XPC_FLAGS': '0x0', 16:51:23 INFO - 'XPC_SERVICE_NAME': '0', 16:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 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)) 16:51:24 INFO - Cleaning up... 16:51:24 INFO - Return code: 0 16:51:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aea6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af3b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f892349f010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, '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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:24 INFO - 'HOME': '/Users/cltbld', 16:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:24 INFO - 'LOGNAME': 'cltbld', 16:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:24 INFO - 'MOZ_NO_REMOTE': '1', 16:51:24 INFO - 'NO_EM_RESTART': '1', 16:51:24 INFO - 'PAGER': '/bin/cat', 16:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:24 INFO - 'PWD': '/builds/slave/test', 16:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:24 INFO - 'SHELL': '/bin/bash', 16:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:24 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:24 INFO - 'USER': 'cltbld', 16:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:24 INFO - 'XPC_FLAGS': '0x0', 16:51:24 INFO - 'XPC_SERVICE_NAME': '0', 16:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:51:24 INFO - Cleaning up... 16:51:24 INFO - Return code: 0 16:51:24 INFO - Running post-action listener: _resource_record_post_action 16:51:24 INFO - Running post-action listener: _start_resource_monitoring 16:51:24 INFO - Starting resource monitoring. 16:51:24 INFO - ##### 16:51:24 INFO - ##### Finished create-virtualenv step (success) 16:51:24 INFO - ##### 16:51:24 INFO - ##### 16:51:24 INFO - ##### Running install step. 16:51:24 INFO - ##### 16:51:24 INFO - Running pre-action listener: _resource_record_pre_action 16:51:24 INFO - Running main action method: install 16:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:24 INFO - Reading from file tmpfile_stdout 16:51:24 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:51:24 INFO - Reading from file tmpfile_stdout 16:51:24 INFO - Output received: 16:51:24 INFO - Usage: mozinstall [options] installer 16:51:24 INFO - Options: 16:51:24 INFO - -h, --help show this help message and exit 16:51:24 INFO - -d DEST, --destination=DEST 16:51:24 INFO - Directory to install application into. [default: 16:51:24 INFO - "/builds/slave/test"] 16:51:24 INFO - --app=APP Application being installed. [default: firefox] 16:51:24 INFO - mkdir: /builds/slave/test/build/application 16:51:24 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'] 16:51:24 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 16:51:58 INFO - Reading from file tmpfile_stdout 16:51:58 INFO - Output received: 16:51:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:51:58 INFO - Running post-action listener: _resource_record_post_action 16:51:58 INFO - ##### 16:51:58 INFO - ##### Finished install step (success) 16:51:58 INFO - ##### 16:51:58 INFO - ##### 16:51:58 INFO - ##### Running run-tests step. 16:51:58 INFO - ##### 16:51:58 INFO - Running pre-action listener: _resource_record_pre_action 16:51:58 INFO - Running main action method: run_tests 16:51:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:51:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:51:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:51:58 INFO - 2016-07-04 16:51:58.877 screenresolution[1641:8395] starting screenresolution argv=screenresolution get 16:51:58 INFO - 2016-07-04 16:51:58.880 screenresolution[1641:8395] Display 0: 1600x1200x32@60 16:51:58 INFO - 2016-07-04 16:51:58.886 screenresolution[1642:8397] starting screenresolution argv=screenresolution list 16:51:58 INFO - Available Modes on Display 0 16:51:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:51:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:51:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:51:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:51:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:51:59 INFO - Intel Iris: 16:51:59 INFO - Chipset Model: Intel Iris 16:51:59 INFO - Type: GPU 16:51:59 INFO - Bus: Built-In 16:51:59 INFO - VRAM (Dynamic, Max): 1536 MB 16:51:59 INFO - Vendor: Intel (0x8086) 16:51:59 INFO - Device ID: 0x0a2e 16:51:59 INFO - Revision ID: 0x0009 16:51:59 INFO - Displays: 16:51:59 INFO - Display: 16:51:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:51:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:51:59 INFO - Display Serial Number: 1600x1200 60 16:51:59 INFO - Main Display: Yes 16:51:59 INFO - Mirror: Off 16:51:59 INFO - Online: Yes 16:51:59 INFO - Rotation: Supported 16:51:59 INFO - Return code: 0 16:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:51:59 INFO - Python 2.7.3 16:51:59 INFO - Return code: 0 16:51:59 INFO - grabbing minidump binary from tooltool 16:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae0ad30>, '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 0x10ab6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae02b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:51:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:51:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:51:59 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 16:51:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:59 INFO - Return code: 0 16:51:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:51:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:51:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:51:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:51:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:51:59 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/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 16:51:59 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/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0242 --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 16:51:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xZSyvMTzv/Render', 16:51:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:59 INFO - 'HOME': '/Users/cltbld', 16:51:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:59 INFO - 'LOGNAME': 'cltbld', 16:51:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:51:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:59 INFO - 'MOZ_NO_REMOTE': '1', 16:51:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:51:59 INFO - 'NO_EM_RESTART': '1', 16:51:59 INFO - 'PAGER': '/bin/cat', 16:51:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:59 INFO - 'PWD': '/builds/slave/test', 16:51:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:51:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:59 INFO - 'SHELL': '/bin/bash', 16:51:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JPLg6F9mCX/Listeners', 16:51:59 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:51:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:59 INFO - 'USER': 'cltbld', 16:51:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:59 INFO - 'XPC_FLAGS': '0x0', 16:51:59 INFO - 'XPC_SERVICE_NAME': '0', 16:51:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:59 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/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 16:51:59 INFO - mozversion application_buildid: 20160704150324 16:51:59 INFO - mozversion application_changeset: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 16:51:59 INFO - mozversion application_display_name: Nightly 16:51:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:59 INFO - mozversion application_name: Firefox 16:51:59 INFO - mozversion application_remotingname: firefox 16:51:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:51:59 INFO - mozversion application_vendor: Mozilla 16:51:59 INFO - mozversion application_version: 50.0a1 16:51:59 INFO - mozversion platform_buildid: 20160704150324 16:51:59 INFO - mozversion platform_changeset: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 16:51:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:51:59 INFO - mozversion platform_version: 50.0a1 16:51:59 INFO - using testdate: 1467676319 16:51:59 INFO - actual date: 1467676319 16:51:59 INFO - starting webserver on 'localhost:49279' 16:51:59 INFO - SUITE-START | Running 2 tests 16:51:59 INFO - TEST-START | dromaeo_css 16:51:59 INFO - operating with platform_type : mac_ 16:51:59 INFO - Initialising browser for dromaeo_css test... 16:51:59 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmp2zUoOw/profile http://localhost:49279/getInfo.html) 16:52:01 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 16:52:01 INFO - PROCESS | 1652 | colorDepth:24 16:52:01 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 16:52:01 INFO - PROCESS | 1652 | __metrics 16:52:01 INFO - PROCESS | 1652 | 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" 16:52:01 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:52:02 INFO - TEST-INFO | 1652: exit 0 16:52:02 INFO - Browser initialized. 16:52:02 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:02 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmp2zUoOw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:14 INFO - PROCESS | 1655 | RSS: Main: 244682752 16:52:14 INFO - PROCESS | 1655 | 16:53:06 INFO - PROCESS | 1655 | 1467676386389 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] 16:55:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 16:55:18 INFO - PROCESS | 1655 | RSS: Main: 381698048 16:55:18 INFO - PROCESS | 1655 | 16:58:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 16:58:22 INFO - PROCESS | 1655 | RSS: Main: 374730752 16:58:22 INFO - PROCESS | 1655 | 17:01:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 17:01:25 INFO - PROCESS | 1655 | RSS: Main: 371306496 17:01:25 INFO - PROCESS | 1655 | 17:04:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 17:04:28 INFO - PROCESS | 1655 | RSS: Main: 372301824 17:04:28 INFO - PROCESS | 1655 | 17:07:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 17:07:32 INFO - PROCESS | 1655 | RSS: Main: 341454848 17:07:32 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 17:10:36 INFO - PROCESS | 1655 | RSS: Main: 381992960 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | __start_tp_report 17:10:36 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 17:10:36 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 17:10:36 INFO - PROCESS | 1655 | |i|pagename|runs| 17:10:36 INFO - PROCESS | 1655 | |0;dojo.html;2767.2251769504533;3338.0987133473964;3385.6445073267323;3388.3392738416005;3388.593368795745;5603.80386686466;5672.120821272704;5709.486146246837;5723.313202415716;5756.079027355619;5730.398308177644;5757.510611598019;5763.884722305552;5770.711464426772;5791.594588378815;4375.299952007664;5115.923261151076;5160.716160611165;5182.507661772125;5188.299579556769;5228.111221092423;5247.1866860636665;5251.868703282429;5253.57971362292;5255.211718242256;5126.512981266774;5133.127368347371;5134;5151.201563757623;5228.529432351088;5220.086484865172;5227.738613069331;5244.711540865251;5247.23915032322;5295.973520132375;5057.4689657585795;5072.67027643202;5081.212412076134;5155.587552995788;5180.300659410969;5604.215409842625;5630.071038278679;5640.689762063085;5663.178839068353;5728.971355143198;6177.320494745574;6190.288116866573;6199.349068347804;6200.720967556471;6214.5649804513705;6124.871567228937;6185.010398336244;6240.750369985195;6243;6243.875122497525;5831.825045248649;5842.678652674102;5856.0630299151935;5859.7949071782705;5864.912026319608;6241.7191226394925;6255.186825712628;6273.9372606273355;6274.717637706314;6276.6547839869245;6006.699665016732;6051.703003022374;6074.9392506075255;6145.262568491809;6162.044883043135;6115.84710382244;6142.232220972379;6180.845478863064;6181.783637572664;6195.070739389038;6166.599171053867;6178;6183.659898705524;6188.628682279078;6197.03945888388;6161.291451483136;6163.7842675506145;6180.072989051589;6215.595986260879;6230.532710046765;4838.854834354975;4866.537678920497;4894.021195760862;4934.481879402683;4956.5786908112495;4363.2800587903275;4425.867223983286;4429.136318417942;4479.776011199492;4593.977030114895;5824.0390335595;5827.533797296206;5831.562632802556;5857.88284234313;5878.412158784087;6204.534659900525;6232.004415911194;6247.219097612799;6252.437280644673;6305.274893387227;5549.667019978733;5585.888282234332;5602.243697100921;5644.8306550803545;5906.645601263938;5307.708076055854;5362.544183744348;5423.18652202165;5423.403425623178;5463;6283.277423096311;6285.120083188357;6286.52851036165;6294.8426289342215;6299.842503937438;5475.671459712271;6041.003234466264;6285.811425657238;6299.307076221704;6353.555251132377;6208.192934918432;6256.5620406572925;6264.812055638338;6283.622982621057;6297.275813281532;6128.564234752123;6144.3717414884195;6184;6191.84520386994;6259.155014073224;6278.058291256348;6310.242770867341;6319.6840157991;6322.715477803418;6338.619682819046;6142.662153581596;6161.72272247741;6172.783952561639;6176.444120029039;6179.0422484514975;5741.91387129185;5948.821535353946;5985.910211346746;6055.969720151371;6060.000099983454;5907.32065812437;5963.91054134197;5969.462748352669;6044.969775151096;6047.244094488189;6106.908396374147;6107.870044041866;6114.877702445837;6120.693965301628;6128.5597884498;5359.383670877899;5675.829725108253;5962.761489540543;5973.731182096729;5997.16039754426 17:10:36 INFO - PROCESS | 1655 | |1;ext.html;483.38609965343994;494.67104375590213;520.6927912531605;529.9258103865462;563.0681222576636;30695.539566906486;32687.1828204295;42870.78564607177;44136.77931610346;44222.55777442225;45819.77090114545;45890.311645325266;46027.079458410815;46137;46256;9843.163331116846;10030.097291243786;10033.59865605375;10042.74893127674;10047.689031522754;8806.823863522726;9024.684136055239;11983.041356691443;12235.204711693756;12264;12118.697032574211;12182.086343524226;12199.573014944479;12208.877911220863;12224.388780560981;8849.513276769776;12029.218100823418;12092.818607720892;12101.93949030258;12107.757844843141;8773.912260877374;8964.072724364292;8964.744935709006;11694.590689325918;12027.699307517294;42804.57195428037;43246;43301.700948971265;43303.56696433027;43357;3083.444979903639;3498.8950331490096;3547.946780798264;3702.5253529528627;3885;31700.682993170005;33267.55821098345;33675.831620841986;33685.49471757901;33690;3257.397381484433;3410.6077801052948;3433.4334834752235;3435.2270739083506;3435.7423193260606;497362;503031;503668;506144;514826.42586786824;65099.34900650933;65439.34560654428;65551.34448655548;65558;65617.67191164014;71007.64496177486;71124.28875711176;71148;71178.28821711717;71254.29965602739;13443.932780336232;14803.259837008321;15134.697306053817;15143.621409464851;15165.24173791306;10249.180065594735;10483.266171368083;10535.578576856993;11124.443777811077;11505.079593632488;14653.302416037164;16834;19877.701834472493;19893.701594476093;19908.402747917586;6659.467242620675;7722.6910923563555;7912.4065695073095;8044.758657240292;8048.758537243892;876.250805561236;958.2621381536178;1001.5893483671659;1045.4772613693153;1174.4304012553905;29510.852445738063;31164.974276671943;31238.53142202869;31568;31870;1056.6460235820932;1066.648006157966;1076.8707755069443;1086.1148164246115;1093.557109370706;16437.342506299854;16463.506094817174;16513.6697266054;16555.337786488646;16887.746683799753;701850;704730;708090;709640;710733;63591.6820415895;64111.35888641147;64151;64276.678616606616;64316.67841660762;1279.6225113591513;1394.6304229379425;1411.8588141186005;1438.4390087865531;1441.819772528434;32564.674353256163;32641.347173055932;32733.67266327306;32781.50827737538;33549.49675754817;54205;54229.45770542244;54927;55060.174097389376;55243.447565525435;585742;588131;588196;590124;590642;24648.383790405383;27527.449451011267;27936.44127117487;28146.155615331572;28210.43579128447;50515.747421262655;51328.74335628298;52183;52351.69120772011;52473.47526524686;36507.634923650425;36942.815285923396;38315.2336953265;38421;41695.37456938209;41339.24598671191;42093.73718788319;42317;42393.709262691904;43052.56947430486;39375.60624393834;39817.2036559273;40156.79921600373;40504.3924341141;40941.56704515328;35756.82121589375;35980;36042.557858944994;36493.27013459769;36835.815820920725;22473.775262247167;23670.52658946777;24859.62710559307;25852.612210817228;26559.90421312641 17:10:36 INFO - PROCESS | 1655 | |2;jquery.html;356.0262681565918;374.7919904453028;385.99614003859955;386.61338661338664;404.10289158069077;12921.741565168702;15574.688506229868;20562.97185140741;21170.788292117057;21201.257955971505;16207.83792162078;19646.410607681755;21119.15523379063;21497.57004859902;21508.354749357506;5563.082091454915;5603.411641777616;5746.425357464262;5754.367019627837;6293.118963345135;4019.4573732546023;4213.052063285767;5924.674142922137;6024.126501657257;6214.720337584819;6240.656763878008;6244.56288059836;6256.280527739323;6259.561830671855;6266.655333956631;5008.824691135811;6266.060090986343;6269.96865015672;6277.058441233806;6282.717277722513;3852.171783066654;5742.97128514359;6083.695815209222;6097.268327800648;6101.420365065312;13829.585112446543;13981;13986.510472133528;24970.5005899881;26127.477450450886;2201.8348623853276;2232.9218477353215;2251.538434620899;2434.805215582749;2842.4315136972687;9690.176335011533;9964.302498825013;10106.782825140013;10654.573817047309;10793.352398856094;1871.8502519798383;1900.4963684623585;1957.549763554376;1961.0684924660814;1961.1567026178736;121648;124117;125392.22254442192;128150.3592482041;130659;11436.885631143748;11614.593489227836;11684.006859416875;11703;11800.46897889597;14873.925630371996;14963.925180374028;14985.175815330262;15010.624734381729;15013.924930375279;7394.853797661371;7468.589227592426;8044.678212871537;8046.316063134582;8199.22107399796;7760.728374506865;7779.572123533147;7818.14000459949;7910.16943220965;7951.642176102089;3885.9805700971315;4560.521145279764;4662.347271382009;4669;4692.41344831896;1617.9352825886833;1757.4374198836483;1787.4816303272166;1824.6917649173806;1934.35199208264;922.2990527199377;980.6273616025865;989.248171389749;1013.6654903881702;1015.5836107196014;16539.586510337336;21402;22061.33815985491;22074.558508829734;22139.667904981437;923.1922068190333;937.2642475656713;959.8800149981253;962.2782912815388;1004.3271008424227;11174.27367221128;11264.211505194722;11432.371219582836;11530.01994830432;11537.538498460135;583155;611139;618673;626536.8673156605;628097;130107;130947;132140;133525;136648;714.8034290570134;842.3429724814777;955.3121752338305;975.7560609847538;979.5689896445541;16296.755548666542;17249.223784929458;17411.651766964842;17448.82551174472;18696.7195492065;42644.999999998756;54110.18834717404;54268;54760.72619636876;55631.443685562626;64002.039969399564;78088.60955695185;78225.60887195528;78582;79100;8213.753587392388;8249.257566819015;8335.374846886387;8401.327893768606;8726.563671816511;11970.22193557416;12232.654408014932;12440.688982775502;13383;13574.79637805414;5979.671118088373;9463.722397476253;9589.616415343307;11105.722356940818;11885.702857428634;10577.62978295756;10794.892051079389;11101.945315195366;11653;12047.939760301142;11382.14633902444;12040.976516995803;12082.154249202471;12112.333821639895;12175.45210465549;8370.53962032094;8454;8559.914400855912;8640.963084429908;8748.69379571712;10107.848382274418;11080.667579972614;11210.43947802623;11766.352850592957;11916.940415297868 17:10:36 INFO - PROCESS | 1655 | |3;mootools.html;1563.7888885000525;1609.1230279497672;1828.908554572271;1952.7559055118102;1956.8630195886276;8767.824643507127;9054.456732596049;9225.031371705974;9248.982611912692;9252.629894804217;7935.285824275814;8173.468724532916;8177.959110204455;8552.35857310701;9027.00702922678;2324.662923876033;2379.7739214774656;2380.3811009137576;2385.4632707640817;2388.0328466970905;2368.7157541095094;2370.2059809963685;2411.2645643078854;2414.4326083370393;2415.372003279151;2079.7504299484085;2307.2040146149634;2370.9170179043736;2373.335466069503;2386.1409892438796;2372.525494901027;2386.4749755054036;2388.4625959159225;2389.952200955971;2399.748026457214;2340.508493216427;2376.65538496917;2377.322463098026;2380.4286971126803;2380.940476488084;8738.606762695694;8811.603477843513;8812.515311657857;8822.073682263399;8839.734807955772;5108.693478391308;5235.057689615867;5260.289860868772;5292.285541451894;5295;3446.327966046622;3527.9118022049397;3638.381475149231;3643.344198044351;3653.598104208535;1058.8570542976754;1063.643679367413;1066.5520481397832;1074.9355038697704;1081.9567217311298;10233.795324093551;11880.702982425422;11930.701732456671;11942.402879855972;11945.462454189495;4074.7758873262255;4719.244920812722;4795.112904112751;4845.152098382769;4921.483244259372;10347.689569312932;10367.533460994273;10387.117095046855;10387.94806025965;10412.635557755593;5325.920111198335;5328.49379308965;5329.067413202674;5329.413764485981;5335.86660333487;4275.273203555403;4421.336799480039;4660.370849935283;4730.88172795676;4835.468098509161;3965.345717956505;4015.357542793139;4084.1627466369323;4116.547179810218;4120.979395103005;1269.796832506813;1295.6890346316816;1298.5974347952165;1304.1588175626669;1310.7444048410468;656.9638669873108;795.8845967334704;799.2926260259596;925.7037747920601;982.7936133411921;5909.172715819789;5975.790847320323;6020.608660437058;6071.210742603434;6233.937660623426;488.14330849359146;489.6254365410464;490.70067258972;627.4729227448873;830.6552780596106;3651.799151046665;4062.959370406258;4078.6940979426663;4153.7507749535125;4158.500979882373;10420.68737937863;10701.357918524913;10827.242093053568;10839.566417343376;10862.565497380174;10796.352218866894;10821.134309255242;10833.512491937881;10844.29512081728;10852.348859068481;7850.2542258485355;8222.013358397151;8274.379421543408;8404.663813447516;8425.578721063923;5825.300963884361;6029.698515074317;6053.424924632153;6136.723847426966;6150.723217455315;9069.682561110329;10045.547950342107;10140.543675534765;10161.136303413998;10170.186385089322;9777.168940640126;10136.543855526372;10223.335483193569;10226.6420675276;10275.02387273208;7594.278543538355;7666.884996725165;7791.415643826623;7791.4935529190425;7818.843623127619;8358.414910956175;8404.957975210085;8407;8478.922663947373;8494.617742201492;7639.961800190964;7666.310032096915;7729.227077292226;7812.062552493737;7828.960855195915;7419.740309089156;7518.699252029857;7585.544867307979;7633.084029916446;7655.0813902332075;7104.857902841811;7125.18060423058;7183.389411900047;7206.423486121203;7211.891821622575;4335.934960975651;5057.039162559102;5064.987002599421;5079.568236699922;5225.033368826779;5119.129747942933;5144.331236939174;5161.380634323755;5245.737713114406;5309.442508536548 17:10:36 INFO - PROCESS | 1655 | |4;prototype.html;300.3392536419877;302.895501052137;315.08939165810796;319.8129094479729;321.7297470125096;4795.7602119894;4897.828575999841;5279.762410691518;5340.332458442695;5355.98236335097;3920.8825484736853;4199.643030342425;4953.653244272902;5048.466073748373;5251.842444726654;3489.441689329708;3676.6285745694013;3700.278445703089;3974.403839424095;4009.7794621295816;4019.356902895537;4026.262141743613;4031.9596804032026;4052.3111071117983;4067.9186416271655;3442.3803715331233;3755.6807671347833;3776.2825063238033;3969.24584328978;3972.36442169253;3702.2410405866867;3910.452536644872;3973.4834471518807;3981.4824072870633;3997.700747257124;3198.896380748638;3378.476336167898;3493.449781659403;3510.7717998330027;3523.612402635708;4444.466664000308;4456.509783923766;4879.585235255007;5154.974225128888;5229.241759944786;4515.525869783658;4565.794539245742;4573.565511276423;4580.290055041441;4592.7933243004145;4785.880352991168;5157.58739300855;5478;5483.396826349099;5556.722163891789;3371.342588195303;3823.808809559511;3841.481400010991;3852.8844134675724;3868;4626.953730462719;4827.468978412372;5782.380933338672;5805.564582656276;5813.09896965971;3655.597884232732;3824.808759562011;3838.692904567628;3884.3392276290265;3907.355286377716;3489.65103489649;3607.3687104756564;3927.9410808837893;3948.9012774680864;3965.72239943207;3659.432787917877;4237.576242375738;4481.910361792746;4515.029268707243;4559.886002849889;4683.672142949961;5539.861503462365;5568.860778480571;5569.721513924287;5600.831975040755;1246.1028059796931;1282.6724340307737;1285.4087119924752;1313.934303284832;1352.384664977433;798.3932211519171;876.487254955858;878.9780255493664;899.9010108888017;906.7143849687327;5138.741008452878;5149.914284714697;5153.871153221199;5193.545807173998;5206.71363075027;5602.386460732804;5621.690807005654;5626.887462250732;5659.858503537363;5676.347220069745;4349.456317960255;4543.66001509223;4968.72672003036;5151.304573882553;5196.012292931579;2185.7650427508406;2244;2497.325722055035;2521.369657585604;2568.7284794026705;4450.198964186413;4494.258447356215;4728.361671174347;4771.328056288489;4961.975190124026;4248.129133527619;4574.679772415965;4670.7664616769025;4761.6904901181315;4808.93215917152;4542.591166795004;4834.564889159992;4928.211486162197;4932.210846264652;4973;4323.287616498033;4667.8330417395655;4735.573798358164;4750.460906624587;4859.2788038698445;4445.777711114496;4640.930386044144;4693.647976401715;4701.412323459567;4715.6463265255925;4187.350960601112;4870.90258194827;4891.5353041461;4895.926561101515;4947.579455746158;3304.256542277968;3315.088350703576;3335.5997280326515;3341.4914339942475;3374.645662205531;4231.87304380869;4450.420100864147;4596.632269418372;4741.67657847659;5407.432219616883;4988.27669987857;5490.450954904637;5494.587905906993;5517.144842549411;5632.3246457932155;4643.814247430065;4992.800287988585;5478.01395748769;5539.695316757617;5550.278463799842;4863.489333619919;4910.558049775537;5468.617196796186;5477.1510415885605;5513.972430137824;4781.976090119527;4869.878253043702;5205.037068142255;5613;5628.409017053151;4360.36774667665;4957.554499622727;5290.497402746733;5514.448555144453;5580.944190558205 17:10:36 INFO - PROCESS | 1655 | |5;yui.html;687.2783577243893;726.560430939282;734.3170851108468;755.0373274075553;843.7899240390998;14852.40590376385;16154.757678634829;16171.91914040431;16181.190940452989;16203.675926481463;14215.360308786103;14562.490312839052;14934.477293294736;14964.625884352896;14966.625834354147;721.754603434832;746.981325466865;748.5508694783141;919.6965001549472;927.2720914082413;895.1048951048951;932.8600709893502;933.6592143867473;936.442816524167;938.2212763406357;983.3362480325787;986.2307400227834;986.4919566423262;988.199558357729;990.2375171118234;760.3081196111511;949.6723630347519;976.6484065736329;982.003266684316;989.3124278626358;727.0366764037672;728.9416846652255;729.8832186850078;730.0582248898914;731.2650785960129;15202.543923682308;15230.314635841303;15233.847661523354;15234.162121083336;15248.161351125684;14029.64925876851;14157.433702651882;14167.574972750834;14203.502877399242;14317.898619349133;12789.808152877715;12988.220706757531;13195.60413187606;13270.800937985938;13437.865621343759;4007.519097708294;4567.680262381635;4687.156311863863;4695.5069717679835;4861.756912154414;103442.48278758633;103760.48119759353;104255.43616845753;104570.99999999924;104700.47649761703;11061.72345691348;11258.943705281421;11450.471930481435;11711.941440292743;11780.764384712258;22453.887730561568;22458.663120053214;22471.887640561694;22479.32562023142;22488.98799554024;7645.464817462725;7706.07527096752;7755.146933837386;7874.803129921684;7914.881276780853;4450.525209563371;4452.109578084396;4527.253003254426;4535.206338890747;4652.930206046912;3533.982330088333;3659.524261845943;3661.139632186434;3666.5783434904793;3671.045528162697;497.48261807719564;653.5621133840339;672.542670983726;689.5207830557714;692.4079911675545;553.5709824885665;629.9086632438363;649.1820306413953;676.67857767561;693.2166651683666;7424;9214.953925230331;9330.253579713743;9430.245580353556;9541.093596108358;541.5315751874679;565.4797586220686;613.8649497110629;647.5726020826232;680.4692339974828;4467.441569803775;4551.544845515422;4571.405717256802;4593.402857628487;4692.1084993851055;85318.57340713381;89546.55226723825;117175.82824171819;118346.4082679581;137333.13334333245;119502.2113954249;123633;123911;125303.373483132;125732.1987460869;69137.30862691309;101381.49309253554;103410.48294758628;107282.46358768156;112727;8954;9239.72280831576;9798.971108033838;9821.459819709984;9830.213582913493;52560.21159682531;56347.59131021757;56862.43137568737;60528.486787830654;63816;27727;27727.029553965513;27754.02860899859;27779.722202777713;85801.57099214464;14086.15483071019;14484.989185864204;14627.414903404171;14833.703325933637;14950.476733314283;12036.578719744766;14879.404823806926;15019.624509386915;15457.227138643248;15728.842711572737;13679.452821887411;13684.45262189541;13692.65768355799;13769.793453098411;14063.789043164155;12651.810222846849;13283.933580332037;13737.789408498069;13962.022658413813;13979.161250325013;13301.334933253105;13430.597082087554;13782.793258100935;13805.24071176095;13812.930935345259;10630.574777009142;10945.726356841144;11062.944685276521;11195.216334856808;11495.195336326376;10809.945950270197;10910.181736369645;10944.343339399662;11011.724706882393;11102.944485277521 17:10:36 INFO - PROCESS | 1655 | __end_tp_report 17:10:36 INFO - PROCESS | 1655 | __start_cc_report 17:10:36 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1396 17:10:36 INFO - PROCESS | 1655 | __end_cc_report 17:10:36 INFO - PROCESS | 1655 | __startTimestamp1467677436528__endTimestamp 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | ------- Summary: start ------- 17:10:36 INFO - PROCESS | 1655 | Number of tests: 6 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5725.21 Median:5963.91 stddev:657.06 (11.0%) stddev-sans-first:616.74 17:10:36 INFO - PROCESS | 1655 | Values: 2767.2 3338.1 3385.6 3388.3 3388.6 5603.8 5672.1 5709.5 5723.3 5756.1 5730.4 5757.5 5763.9 5770.7 5791.6 4375.3 5115.9 5160.7 5182.5 5188.3 5228.1 5247.2 5251.9 5253.6 5255.2 5126.5 5133.1 5134.0 5151.2 5228.5 5220.1 5227.7 5244.7 5247.2 5296.0 5057.5 5072.7 5081.2 5155.6 5180.3 5604.2 5630.1 5640.7 5663.2 5729.0 6177.3 6190.3 6199.3 6200.7 6214.6 6124.9 6185.0 6240.8 6243.0 6243.9 5831.8 5842.7 5856.1 5859.8 5864.9 6241.7 6255.2 6273.9 6274.7 6276.7 6006.7 6051.7 6074.9 6145.3 6162.0 6115.8 6142.2 6180.8 6181.8 6195.1 6166.6 6178.0 6183.7 6188.6 6197.0 6161.3 6163.8 6180.1 6215.6 6230.5 4838.9 4866.5 4894.0 4934.5 4956.6 4363.3 4425.9 4429.1 4479.8 4594.0 5824.0 5827.5 5831.6 5857.9 5878.4 6204.5 6232.0 6247.2 6252.4 6305.3 5549.7 5585.9 5602.2 5644.8 5906.6 5307.7 5362.5 5423.2 5423.4 5463.0 6283.3 6285.1 6286.5 6294.8 6299.8 5475.7 6041.0 6285.8 6299.3 6353.6 6208.2 6256.6 6264.8 6283.6 6297.3 6128.6 6144.4 6184.0 6191.8 6259.2 6278.1 6310.2 6319.7 6322.7 6338.6 6142.7 6161.7 6172.8 6176.4 6179.0 5741.9 5948.8 5985.9 6056.0 6060.0 5907.3 5963.9 5969.5 6045.0 6047.2 6106.9 6107.9 6114.9 6120.7 6128.6 5359.4 5675.8 5962.8 5973.7 5997.2 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:74320.31 Median:36671.73 stddev:161996.96 (441.7%) stddev-sans-first:162356.54 17:10:36 INFO - PROCESS | 1655 | Values: 483.4 494.7 520.7 529.9 563.1 30695.5 32687.2 42870.8 44136.8 44222.6 45819.8 45890.3 46027.1 46137.0 46256.0 9843.2 10030.1 10033.6 10042.7 10047.7 8806.8 9024.7 11983.0 12235.2 12264.0 12118.7 12182.1 12199.6 12208.9 12224.4 8849.5 12029.2 12092.8 12101.9 12107.8 8773.9 8964.1 8964.7 11694.6 12027.7 42804.6 43246.0 43301.7 43303.6 43357.0 3083.4 3498.9 3547.9 3702.5 3885.0 31700.7 33267.6 33675.8 33685.5 33690.0 3257.4 3410.6 3433.4 3435.2 3435.7 497362.0 503031.0 503668.0 506144.0 514826.4 65099.3 65439.3 65551.3 65558.0 65617.7 71007.6 71124.3 71148.0 71178.3 71254.3 13443.9 14803.3 15134.7 15143.6 15165.2 10249.2 10483.3 10535.6 11124.4 11505.1 14653.3 16834.0 19877.7 19893.7 19908.4 6659.5 7722.7 7912.4 8044.8 8048.8 876.3 958.3 1001.6 1045.5 1174.4 29510.9 31165.0 31238.5 31568.0 31870.0 1056.6 1066.6 1076.9 1086.1 1093.6 16437.3 16463.5 16513.7 16555.3 16887.7 701850.0 704730.0 708090.0 709640.0 710733.0 63591.7 64111.4 64151.0 64276.7 64316.7 1279.6 1394.6 1411.9 1438.4 1441.8 32564.7 32641.3 32733.7 32781.5 33549.5 54205.0 54229.5 54927.0 55060.2 55243.4 585742.0 588131.0 588196.0 590124.0 590642.0 24648.4 27527.4 27936.4 28146.2 28210.4 50515.7 51328.7 52183.0 52351.7 52473.5 36507.6 36942.8 38315.2 38421.0 41695.4 41339.2 42093.7 42317.0 42393.7 43052.6 39375.6 39817.2 40156.8 40504.4 40941.6 35756.8 35980.0 36042.6 36493.3 36835.8 22473.8 23670.5 24859.6 25852.6 26559.9 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35431.43 Median:25548.99 stddev:102628.87 (401.7%) stddev-sans-first:102882.97 17:10:36 INFO - PROCESS | 1655 | Values: 356.0 374.8 386.0 386.6 404.1 12921.7 15574.7 20563.0 21170.8 21201.3 16207.8 19646.4 21119.2 21497.6 21508.4 5563.1 5603.4 5746.4 5754.4 6293.1 4019.5 4213.1 5924.7 6024.1 6214.7 6240.7 6244.6 6256.3 6259.6 6266.7 5008.8 6266.1 6270.0 6277.1 6282.7 3852.2 5743.0 6083.7 6097.3 6101.4 13829.6 13981.0 13986.5 24970.5 26127.5 2201.8 2232.9 2251.5 2434.8 2842.4 9690.2 9964.3 10106.8 10654.6 10793.4 1871.9 1900.5 1957.5 1961.1 1961.2 121648.0 124117.0 125392.2 128150.4 130659.0 11436.9 11614.6 11684.0 11703.0 11800.5 14873.9 14963.9 14985.2 15010.6 15013.9 7394.9 7468.6 8044.7 8046.3 8199.2 7760.7 7779.6 7818.1 7910.2 7951.6 3886.0 4560.5 4662.3 4669.0 4692.4 1617.9 1757.4 1787.5 1824.7 1934.4 922.3 980.6 989.2 1013.7 1015.6 16539.6 21402.0 22061.3 22074.6 22139.7 923.2 937.3 959.9 962.3 1004.3 11174.3 11264.2 11432.4 11530.0 11537.5 583155.0 611139.0 618673.0 626536.9 628097.0 130107.0 130947.0 132140.0 133525.0 136648.0 714.8 842.3 955.3 975.8 979.6 16296.8 17249.2 17411.7 17448.8 18696.7 42645.0 54110.2 54268.0 54760.7 55631.4 64002.0 78088.6 78225.6 78582.0 79100.0 8213.8 8249.3 8335.4 8401.3 8726.6 11970.2 12232.7 12440.7 13383.0 13574.8 5979.7 9463.7 9589.6 11105.7 11885.7 10577.6 10794.9 11101.9 11653.0 12047.9 11382.1 12041.0 12082.2 12112.3 12175.5 8370.5 8454.0 8559.9 8641.0 8748.7 10107.8 11080.7 11210.4 11766.4 11916.9 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5773.13 Median:4815.29 stddev:3250.34 (67.5%) stddev-sans-first:3244.06 17:10:36 INFO - PROCESS | 1655 | Values: 1563.8 1609.1 1828.9 1952.8 1956.9 8767.8 9054.5 9225.0 9249.0 9252.6 7935.3 8173.5 8178.0 8552.4 9027.0 2324.7 2379.8 2380.4 2385.5 2388.0 2368.7 2370.2 2411.3 2414.4 2415.4 2079.8 2307.2 2370.9 2373.3 2386.1 2372.5 2386.5 2388.5 2390.0 2399.7 2340.5 2376.7 2377.3 2380.4 2380.9 8738.6 8811.6 8812.5 8822.1 8839.7 5108.7 5235.1 5260.3 5292.3 5295.0 3446.3 3527.9 3638.4 3643.3 3653.6 1058.9 1063.6 1066.6 1074.9 1082.0 10233.8 11880.7 11930.7 11942.4 11945.5 4074.8 4719.2 4795.1 4845.2 4921.5 10347.7 10367.5 10387.1 10387.9 10412.6 5325.9 5328.5 5329.1 5329.4 5335.9 4275.3 4421.3 4660.4 4730.9 4835.5 3965.3 4015.4 4084.2 4116.5 4121.0 1269.8 1295.7 1298.6 1304.2 1310.7 657.0 795.9 799.3 925.7 982.8 5909.2 5975.8 6020.6 6071.2 6233.9 488.1 489.6 490.7 627.5 830.7 3651.8 4063.0 4078.7 4153.8 4158.5 10420.7 10701.4 10827.2 10839.6 10862.6 10796.4 10821.1 10833.5 10844.3 10852.3 7850.3 8222.0 8274.4 8404.7 8425.6 5825.3 6029.7 6053.4 6136.7 6150.7 9069.7 10045.5 10140.5 10161.1 10170.2 9777.2 10136.5 10223.3 10226.6 10275.0 7594.3 7666.9 7791.4 7791.5 7818.8 8358.4 8405.0 8407.0 8478.9 8494.6 7640.0 7666.3 7729.2 7812.1 7829.0 7419.7 7518.7 7585.5 7633.1 7655.1 7104.9 7125.2 7183.4 7206.4 7211.9 4335.9 5057.0 5065.0 5079.6 5225.0 5119.1 5144.3 5161.4 5245.7 5309.4 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4246.34 Median:4655.82 stddev:1282.47 (27.5%) stddev-sans-first:1251.40 17:10:36 INFO - PROCESS | 1655 | Values: 300.3 302.9 315.1 319.8 321.7 4795.8 4897.8 5279.8 5340.3 5356.0 3920.9 4199.6 4953.7 5048.5 5251.8 3489.4 3676.6 3700.3 3974.4 4009.8 4019.4 4026.3 4032.0 4052.3 4067.9 3442.4 3755.7 3776.3 3969.2 3972.4 3702.2 3910.5 3973.5 3981.5 3997.7 3198.9 3378.5 3493.4 3510.8 3523.6 4444.5 4456.5 4879.6 5155.0 5229.2 4515.5 4565.8 4573.6 4580.3 4592.8 4785.9 5157.6 5478.0 5483.4 5556.7 3371.3 3823.8 3841.5 3852.9 3868.0 4627.0 4827.5 5782.4 5805.6 5813.1 3655.6 3824.8 3838.7 3884.3 3907.4 3489.7 3607.4 3927.9 3948.9 3965.7 3659.4 4237.6 4481.9 4515.0 4559.9 4683.7 5539.9 5568.9 5569.7 5600.8 1246.1 1282.7 1285.4 1313.9 1352.4 798.4 876.5 879.0 899.9 906.7 5138.7 5149.9 5153.9 5193.5 5206.7 5602.4 5621.7 5626.9 5659.9 5676.3 4349.5 4543.7 4968.7 5151.3 5196.0 2185.8 2244.0 2497.3 2521.4 2568.7 4450.2 4494.3 4728.4 4771.3 4962.0 4248.1 4574.7 4670.8 4761.7 4808.9 4542.6 4834.6 4928.2 4932.2 4973.0 4323.3 4667.8 4735.6 4750.5 4859.3 4445.8 4640.9 4693.6 4701.4 4715.6 4187.4 4870.9 4891.5 4895.9 4947.6 3304.3 3315.1 3335.6 3341.5 3374.6 4231.9 4450.4 4596.6 4741.7 5407.4 4988.3 5490.5 5494.6 5517.1 5632.3 4643.8 4992.8 5478.0 5539.7 5550.3 4863.5 4910.6 5468.6 5477.2 5514.0 4782.0 4869.9 5205.0 5613.0 5628.4 4360.4 4957.6 5290.5 5514.4 5580.9 17:10:36 INFO - PROCESS | 1655 | 17:10:36 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:21760.49 Median:15656.85 stddev:33503.32 (214.0%) stddev-sans-first:33559.94 17:10:36 INFO - PROCESS | 1655 | Values: 687.3 726.6 734.3 755.0 843.8 14852.4 16154.8 16171.9 16181.2 16203.7 14215.4 14562.5 14934.5 14964.6 14966.6 721.8 747.0 748.6 919.7 927.3 895.1 932.9 933.7 936.4 938.2 983.3 986.2 986.5 988.2 990.2 760.3 949.7 976.6 982.0 989.3 727.0 728.9 729.9 730.1 731.3 15202.5 15230.3 15233.8 15234.2 15248.2 14029.6 14157.4 14167.6 14203.5 14317.9 12789.8 12988.2 13195.6 13270.8 13437.9 4007.5 4567.7 4687.2 4695.5 4861.8 103442.5 103760.5 104255.4 104571.0 104700.5 11061.7 11258.9 11450.5 11711.9 11780.8 22453.9 22458.7 22471.9 22479.3 22489.0 7645.5 7706.1 7755.1 7874.8 7914.9 4450.5 4452.1 4527.3 4535.2 4652.9 3534.0 3659.5 3661.1 3666.6 3671.0 497.5 653.6 672.5 689.5 692.4 553.6 629.9 649.2 676.7 693.2 7424.0 9215.0 9330.3 9430.2 9541.1 541.5 565.5 613.9 647.6 680.5 4467.4 4551.5 4571.4 4593.4 4692.1 85318.6 89546.6 117175.8 118346.4 137333.1 119502.2 123633.0 123911.0 125303.4 125732.2 69137.3 101381.5 103410.5 107282.5 112727.0 8954.0 9239.7 9799.0 9821.5 9830.2 52560.2 56347.6 56862.4 60528.5 63816.0 27727.0 27727.0 27754.0 27779.7 85801.6 14086.2 14485.0 14627.4 14833.7 14950.5 12036.6 14879.4 15019.6 15457.2 15728.8 13679.5 13684.5 13692.7 13769.8 14063.8 12651.8 13283.9 13737.8 13962.0 13979.2 13301.3 13430.6 13782.8 13805.2 13812.9 10630.6 10945.7 11062.9 11195.2 11495.2 10809.9 10910.2 10944.3 11011.7 11102.9 17:10:36 INFO - PROCESS | 1655 | -------- Summary: end -------- 17:10:36 INFO - PROCESS | 1655 | 17:10:37 INFO - TEST-INFO | 1655: exit 0 17:10:37 INFO - TEST-OK | dromaeo_css | took 1117655ms 17:10:37 INFO - TEST-START | kraken 17:10:37 INFO - operating with platform_type : mac_ 17:10:37 INFO - Initialising browser for kraken test... 17:10:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpKT_mD0/profile http://localhost:49279/getInfo.html) 17:10:39 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 17:10:39 INFO - PROCESS | 1662 | colorDepth:24 17:10:39 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 17:10:39 INFO - PROCESS | 1662 | __metrics 17:10:39 INFO - PROCESS | 1662 | 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" 17:10:39 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:40 INFO - TEST-INFO | 1662: exit 0 17:10:40 INFO - Browser initialized. 17:10:40 INFO - Running cycle 1/1 for kraken test... 17:10:40 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpKT_mD0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:52 INFO - PROCESS | 1663 | RSS: Main: 244887552 17:10:52 INFO - PROCESS | 1663 | 17:10:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:55 INFO - PROCESS | 1663 | RSS: Main: 294002688 17:10:55 INFO - PROCESS | 1663 | 17:10:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 17:10:59 INFO - PROCESS | 1663 | RSS: Main: 304607232 17:10:59 INFO - PROCESS | 1663 | 17:11:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 17:11:03 INFO - PROCESS | 1663 | RSS: Main: 389840896 17:11:03 INFO - PROCESS | 1663 | 17:11:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 17:11:06 INFO - PROCESS | 1663 | RSS: Main: 290144256 17:11:06 INFO - PROCESS | 1663 | 17:11:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:08 INFO - PROCESS | 1663 | RSS: Main: 294379520 17:11:08 INFO - PROCESS | 1663 | 17:11:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:12 INFO - PROCESS | 1663 | RSS: Main: 332201984 17:11:12 INFO - PROCESS | 1663 | 17:11:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:15 INFO - PROCESS | 1663 | RSS: Main: 334065664 17:11:15 INFO - PROCESS | 1663 | 17:11:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 17:11:19 INFO - PROCESS | 1663 | RSS: Main: 334909440 17:11:19 INFO - PROCESS | 1663 | 17:11:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:21 INFO - PROCESS | 1663 | RSS: Main: 313212928 17:11:21 INFO - PROCESS | 1663 | 17:11:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:24 INFO - PROCESS | 1663 | RSS: Main: 319012864 17:11:24 INFO - PROCESS | 1663 | 17:11:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:27 INFO - PROCESS | 1663 | RSS: Main: 318058496 17:11:27 INFO - PROCESS | 1663 | 17:11:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:30 INFO - PROCESS | 1663 | RSS: Main: 327659520 17:11:30 INFO - PROCESS | 1663 | 17:11:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:33 INFO - PROCESS | 1663 | RSS: Main: 329809920 17:11:33 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 17:11:35 INFO - PROCESS | 1663 | RSS: Main: 372928512 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | __start_tp_report 17:11:35 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 17:11:35 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 17:11:35 INFO - PROCESS | 1663 | |i|pagename|runs| 17:11:35 INFO - PROCESS | 1663 | |0;ai-astar;102;116;112;112;111;112;90;153;164;164 17:11:35 INFO - PROCESS | 1663 | |1;audio-beat-detection;144;106;108;157;104;108;129;118;179;136 17:11:35 INFO - PROCESS | 1663 | |2;audio-dft;184;182;184;185;184;183;216;180;183;184 17:11:35 INFO - PROCESS | 1663 | |3;audio-fft;79;73;57;99;70;81;53;82;100;83 17:11:35 INFO - PROCESS | 1663 | |4;audio-oscillator;85;83;92;71;72;68;95;68;67;105 17:11:35 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;85;89;85;89;84;90;86;88;85 17:11:35 INFO - PROCESS | 1663 | |6;imaging-darkroom;92;94;94;94;94;93;94;93;113;146 17:11:35 INFO - PROCESS | 1663 | |7;imaging-desaturate;87;89;89;88;88;89;88;88;88;86 17:11:35 INFO - PROCESS | 1663 | |8;json-parse-financial;52;54;52;54;53;53;54;54;55;54 17:11:35 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;66;70;74;78;72;68;70;70;70;70 17:11:35 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;83;85;85;85;82;84;88;99;100;80 17:11:35 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;137;135;139;134;137;139;140;149;226;153 17:11:35 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;163;160;162;161;160;162;162;162;157;159 17:11:35 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;68;65;67;68;64;66;67;67;65;66 17:11:35 INFO - PROCESS | 1663 | __end_tp_report 17:11:35 INFO - PROCESS | 1663 | __start_cc_report 17:11:35 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2091 17:11:35 INFO - PROCESS | 1663 | __end_cc_report 17:11:35 INFO - PROCESS | 1663 | __startTimestamp1467677495901__endTimestamp 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | ------- Summary: start ------- 17:11:35 INFO - PROCESS | 1663 | Number of tests: 14 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:123.60 Median:134.50 stddev:26.55 (19.7%) stddev-sans-first:26.99 17:11:35 INFO - PROCESS | 1663 | Values: 102.0 116.0 112.0 112.0 111.0 112.0 90.0 153.0 164.0 164.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:132.50 stddev:25.20 (19.0%) stddev-sans-first:26.13 17:11:35 INFO - PROCESS | 1663 | Values: 144.0 106.0 108.0 157.0 104.0 108.0 129.0 118.0 179.0 136.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:186.50 Median:184.00 stddev:10.46 (5.7%) stddev-sans-first:11.05 17:11:35 INFO - PROCESS | 1663 | Values: 184.0 182.0 184.0 185.0 184.0 183.0 216.0 180.0 183.0 184.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:77.70 Median:80.00 stddev:15.38 (19.2%) stddev-sans-first:16.31 17:11:35 INFO - PROCESS | 1663 | Values: 79.0 73.0 57.0 99.0 70.0 81.0 53.0 82.0 100.0 83.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:77.50 stddev:13.44 (17.3%) stddev-sans-first:14.16 17:11:35 INFO - PROCESS | 1663 | Values: 85.0 83.0 92.0 71.0 72.0 68.0 95.0 68.0 67.0 105.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.50 stddev:2.21 (2.5%) stddev-sans-first:2.22 17:11:35 INFO - PROCESS | 1663 | Values: 89.0 85.0 89.0 85.0 89.0 84.0 90.0 86.0 88.0 85.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:94.00 stddev:17.07 (18.2%) stddev-sans-first:17.81 17:11:35 INFO - PROCESS | 1663 | Values: 92.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 113.0 146.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:88.00 Median:88.00 stddev:0.94 (1.1%) stddev-sans-first:0.93 17:11:35 INFO - PROCESS | 1663 | Values: 87.0 89.0 89.0 88.0 88.0 89.0 88.0 88.0 88.0 86.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:0.87 17:11:35 INFO - PROCESS | 1663 | Values: 52.0 54.0 52.0 54.0 53.0 53.0 54.0 54.0 55.0 54.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.00 stddev:3.29 (4.7%) stddev-sans-first:3.00 17:11:35 INFO - PROCESS | 1663 | Values: 66.0 70.0 74.0 78.0 72.0 68.0 70.0 70.0 70.0 70.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.00 stddev:6.87 (8.1%) stddev-sans-first:7.13 17:11:35 INFO - PROCESS | 1663 | Values: 83.0 85.0 85.0 85.0 82.0 84.0 88.0 99.0 100.0 80.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:139.50 stddev:27.76 (19.9%) stddev-sans-first:29.11 17:11:35 INFO - PROCESS | 1663 | Values: 137.0 135.0 139.0 134.0 137.0 139.0 140.0 149.0 226.0 153.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:162.00 stddev:1.81 (1.1%) stddev-sans-first:1.74 17:11:35 INFO - PROCESS | 1663 | Values: 163.0 160.0 162.0 161.0 160.0 162.0 162.0 162.0 157.0 159.0 17:11:35 INFO - PROCESS | 1663 | 17:11:35 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.27 17:11:35 INFO - PROCESS | 1663 | Values: 68.0 65.0 67.0 68.0 64.0 66.0 67.0 67.0 65.0 66.0 17:11:35 INFO - PROCESS | 1663 | -------- Summary: end -------- 17:11:35 INFO - PROCESS | 1663 | 17:11:36 INFO - TEST-INFO | 1663: exit 0 17:11:36 INFO - TEST-OK | kraken | took 59666ms 17:11:36 INFO - SUITE-END | took 1177s 17:11:37 INFO - Completed test suite (00:19:37) 17:11:37 INFO - javascript benchmark 17:11:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2767.2251769504533, 3338.0987133473964, 3385.6445073267323, 3388.3392738416005, 3388.593368795745, 5603.80386686466, 5672.120821272704, 5709.486146246837, 5723.313202415716, 5756.079027355619, 5730.398308177644, 5757.510611598019, 5763.884722305552, 5770.711464426772, 5791.594588378815, 4375.299952007664, 5115.923261151076, 5160.716160611165, 5182.507661772125, 5188.299579556769, 5228.111221092423, 5247.1866860636665, 5251.868703282429, 5253.57971362292, 5255.211718242256, 5126.512981266774, 5133.127368347371, 5134.0, 5151.201563757623, 5228.529432351088, 5220.086484865172, 5227.738613069331, 5244.711540865251, 5247.23915032322, 5295.973520132375, 5057.4689657585795, 5072.67027643202, 5081.212412076134, 5155.587552995788, 5180.300659410969, 5604.215409842625, 5630.071038278679, 5640.689762063085, 5663.178839068353, 5728.971355143198, 6177.320494745574, 6190.288116866573, 6199.349068347804, 6200.720967556471, 6214.5649804513705, 6124.871567228937, 6185.010398336244, 6240.750369985195, 6243.0, 6243.875122497525, 5831.825045248649, 5842.678652674102, 5856.0630299151935, 5859.7949071782705, 5864.912026319608, 6241.7191226394925, 6255.186825712628, 6273.9372606273355, 6274.717637706314, 6276.6547839869245, 6006.699665016732, 6051.703003022374, 6074.9392506075255, 6145.262568491809, 6162.044883043135, 6115.84710382244, 6142.232220972379, 6180.845478863064, 6181.783637572664, 6195.070739389038, 6166.599171053867, 6178.0, 6183.659898705524, 6188.628682279078, 6197.03945888388, 6161.291451483136, 6163.7842675506145, 6180.072989051589, 6215.595986260879, 6230.532710046765, 4838.854834354975, 4866.537678920497, 4894.021195760862, 4934.481879402683, 4956.5786908112495, 4363.2800587903275, 4425.867223983286, 4429.136318417942, 4479.776011199492, 4593.977030114895, 5824.0390335595, 5827.533797296206, 5831.562632802556, 5857.88284234313, 5878.412158784087, 6204.534659900525, 6232.004415911194, 6247.219097612799, 6252.437280644673, 6305.274893387227, 5549.667019978733, 5585.888282234332, 5602.243697100921, 5644.8306550803545, 5906.645601263938, 5307.708076055854, 5362.544183744348, 5423.18652202165, 5423.403425623178, 5463.0, 6283.277423096311, 6285.120083188357, 6286.52851036165, 6294.8426289342215, 6299.842503937438, 5475.671459712271, 6041.003234466264, 6285.811425657238, 6299.307076221704, 6353.555251132377, 6208.192934918432, 6256.5620406572925, 6264.812055638338, 6283.622982621057, 6297.275813281532, 6128.564234752123, 6144.3717414884195, 6184.0, 6191.84520386994, 6259.155014073224, 6278.058291256348, 6310.242770867341, 6319.6840157991, 6322.715477803418, 6338.619682819046, 6142.662153581596, 6161.72272247741, 6172.783952561639, 6176.444120029039, 6179.0422484514975, 5741.91387129185, 5948.821535353946, 5985.910211346746, 6055.969720151371, 6060.000099983454, 5907.32065812437, 5963.91054134197, 5969.462748352669, 6044.969775151096, 6047.244094488189, 6106.908396374147, 6107.870044041866, 6114.877702445837, 6120.693965301628, 6128.5597884498, 5359.383670877899, 5675.829725108253, 5962.761489540543, 5973.731182096729, 5997.16039754426], "value": 5681.165024491696, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.38609965343994, 494.67104375590213, 520.6927912531605, 529.9258103865462, 563.0681222576636, 30695.539566906486, 32687.1828204295, 42870.78564607177, 44136.77931610346, 44222.55777442225, 45819.77090114545, 45890.311645325266, 46027.079458410815, 46137.0, 46256.0, 9843.163331116846, 10030.097291243786, 10033.59865605375, 10042.74893127674, 10047.689031522754, 8806.823863522726, 9024.684136055239, 11983.041356691443, 12235.204711693756, 12264.0, 12118.697032574211, 12182.086343524226, 12199.573014944479, 12208.877911220863, 12224.388780560981, 8849.513276769776, 12029.218100823418, 12092.818607720892, 12101.93949030258, 12107.757844843141, 8773.912260877374, 8964.072724364292, 8964.744935709006, 11694.590689325918, 12027.699307517294, 42804.57195428037, 43246.0, 43301.700948971265, 43303.56696433027, 43357.0, 3083.444979903639, 3498.8950331490096, 3547.946780798264, 3702.5253529528627, 3885.0, 31700.682993170005, 33267.55821098345, 33675.831620841986, 33685.49471757901, 33690.0, 3257.397381484433, 3410.6077801052948, 3433.4334834752235, 3435.2270739083506, 3435.7423193260606, 497362.0, 503031.0, 503668.0, 506144.0, 514826.42586786824, 65099.34900650933, 65439.34560654428, 65551.34448655548, 65558.0, 65617.67191164014, 71007.64496177486, 71124.28875711176, 71148.0, 71178.28821711717, 71254.29965602739, 13443.932780336232, 14803.259837008321, 15134.697306053817, 15143.621409464851, 15165.24173791306, 10249.180065594735, 10483.266171368083, 10535.578576856993, 11124.443777811077, 11505.079593632488, 14653.302416037164, 16834.0, 19877.701834472493, 19893.701594476093, 19908.402747917586, 6659.467242620675, 7722.6910923563555, 7912.4065695073095, 8044.758657240292, 8048.758537243892, 876.250805561236, 958.2621381536178, 1001.5893483671659, 1045.4772613693153, 1174.4304012553905, 29510.852445738063, 31164.974276671943, 31238.53142202869, 31568.0, 31870.0, 1056.6460235820932, 1066.648006157966, 1076.8707755069443, 1086.1148164246115, 1093.557109370706, 16437.342506299854, 16463.506094817174, 16513.6697266054, 16555.337786488646, 16887.746683799753, 701850.0, 704730.0, 708090.0, 709640.0, 710733.0, 63591.6820415895, 64111.35888641147, 64151.0, 64276.678616606616, 64316.67841660762, 1279.6225113591513, 1394.6304229379425, 1411.8588141186005, 1438.4390087865531, 1441.819772528434, 32564.674353256163, 32641.347173055932, 32733.67266327306, 32781.50827737538, 33549.49675754817, 54205.0, 54229.45770542244, 54927.0, 55060.174097389376, 55243.447565525435, 585742.0, 588131.0, 588196.0, 590124.0, 590642.0, 24648.383790405383, 27527.449451011267, 27936.44127117487, 28146.155615331572, 28210.43579128447, 50515.747421262655, 51328.74335628298, 52183.0, 52351.69120772011, 52473.47526524686, 36507.634923650425, 36942.815285923396, 38315.2336953265, 38421.0, 41695.37456938209, 41339.24598671191, 42093.73718788319, 42317.0, 42393.709262691904, 43052.56947430486, 39375.60624393834, 39817.2036559273, 40156.79921600373, 40504.3924341141, 40941.56704515328, 35756.82121589375, 35980.0, 36042.557858944994, 36493.27013459769, 36835.815820920725, 22473.775262247167, 23670.52658946777, 24859.62710559307, 25852.612210817228, 26559.90421312641], "value": 20996.594963539963, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.0262681565918, 374.7919904453028, 385.99614003859955, 386.61338661338664, 404.10289158069077, 12921.741565168702, 15574.688506229868, 20562.97185140741, 21170.788292117057, 21201.257955971505, 16207.83792162078, 19646.410607681755, 21119.15523379063, 21497.57004859902, 21508.354749357506, 5563.082091454915, 5603.411641777616, 5746.425357464262, 5754.367019627837, 6293.118963345135, 4019.4573732546023, 4213.052063285767, 5924.674142922137, 6024.126501657257, 6214.720337584819, 6240.656763878008, 6244.56288059836, 6256.280527739323, 6259.561830671855, 6266.655333956631, 5008.824691135811, 6266.060090986343, 6269.96865015672, 6277.058441233806, 6282.717277722513, 3852.171783066654, 5742.97128514359, 6083.695815209222, 6097.268327800648, 6101.420365065312, 13829.585112446543, 13981.0, 13986.510472133528, 24970.5005899881, 26127.477450450886, 2201.8348623853276, 2232.9218477353215, 2251.538434620899, 2434.805215582749, 2842.4315136972687, 9690.176335011533, 9964.302498825013, 10106.782825140013, 10654.573817047309, 10793.352398856094, 1871.8502519798383, 1900.4963684623585, 1957.549763554376, 1961.0684924660814, 1961.1567026178736, 121648.0, 124117.0, 125392.22254442192, 128150.3592482041, 130659.0, 11436.885631143748, 11614.593489227836, 11684.006859416875, 11703.0, 11800.46897889597, 14873.925630371996, 14963.925180374028, 14985.175815330262, 15010.624734381729, 15013.924930375279, 7394.853797661371, 7468.589227592426, 8044.678212871537, 8046.316063134582, 8199.22107399796, 7760.728374506865, 7779.572123533147, 7818.14000459949, 7910.16943220965, 7951.642176102089, 3885.9805700971315, 4560.521145279764, 4662.347271382009, 4669.0, 4692.41344831896, 1617.9352825886833, 1757.4374198836483, 1787.4816303272166, 1824.6917649173806, 1934.35199208264, 922.2990527199377, 980.6273616025865, 989.248171389749, 1013.6654903881702, 1015.5836107196014, 16539.586510337336, 21402.0, 22061.33815985491, 22074.558508829734, 22139.667904981437, 923.1922068190333, 937.2642475656713, 959.8800149981253, 962.2782912815388, 1004.3271008424227, 11174.27367221128, 11264.211505194722, 11432.371219582836, 11530.01994830432, 11537.538498460135, 583155.0, 611139.0, 618673.0, 626536.8673156605, 628097.0, 130107.0, 130947.0, 132140.0, 133525.0, 136648.0, 714.8034290570134, 842.3429724814777, 955.3121752338305, 975.7560609847538, 979.5689896445541, 16296.755548666542, 17249.223784929458, 17411.651766964842, 17448.82551174472, 18696.7195492065, 42644.999999998756, 54110.18834717404, 54268.0, 54760.72619636876, 55631.443685562626, 64002.039969399564, 78088.60955695185, 78225.60887195528, 78582.0, 79100.0, 8213.753587392388, 8249.257566819015, 8335.374846886387, 8401.327893768606, 8726.563671816511, 11970.22193557416, 12232.654408014932, 12440.688982775502, 13383.0, 13574.79637805414, 5979.671118088373, 9463.722397476253, 9589.616415343307, 11105.722356940818, 11885.702857428634, 10577.62978295756, 10794.892051079389, 11101.945315195366, 11653.0, 12047.939760301142, 11382.14633902444, 12040.976516995803, 12082.154249202471, 12112.333821639895, 12175.45210465549, 8370.53962032094, 8454.0, 8559.914400855912, 8640.963084429908, 8748.69379571712, 10107.848382274418, 11080.667579972614, 11210.43947802623, 11766.352850592957, 11916.940415297868], "value": 9442.450135023077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.7888885000525, 1609.1230279497672, 1828.908554572271, 1952.7559055118102, 1956.8630195886276, 8767.824643507127, 9054.456732596049, 9225.031371705974, 9248.982611912692, 9252.629894804217, 7935.285824275814, 8173.468724532916, 8177.959110204455, 8552.35857310701, 9027.00702922678, 2324.662923876033, 2379.7739214774656, 2380.3811009137576, 2385.4632707640817, 2388.0328466970905, 2368.7157541095094, 2370.2059809963685, 2411.2645643078854, 2414.4326083370393, 2415.372003279151, 2079.7504299484085, 2307.2040146149634, 2370.9170179043736, 2373.335466069503, 2386.1409892438796, 2372.525494901027, 2386.4749755054036, 2388.4625959159225, 2389.952200955971, 2399.748026457214, 2340.508493216427, 2376.65538496917, 2377.322463098026, 2380.4286971126803, 2380.940476488084, 8738.606762695694, 8811.603477843513, 8812.515311657857, 8822.073682263399, 8839.734807955772, 5108.693478391308, 5235.057689615867, 5260.289860868772, 5292.285541451894, 5295.0, 3446.327966046622, 3527.9118022049397, 3638.381475149231, 3643.344198044351, 3653.598104208535, 1058.8570542976754, 1063.643679367413, 1066.5520481397832, 1074.9355038697704, 1081.9567217311298, 10233.795324093551, 11880.702982425422, 11930.701732456671, 11942.402879855972, 11945.462454189495, 4074.7758873262255, 4719.244920812722, 4795.112904112751, 4845.152098382769, 4921.483244259372, 10347.689569312932, 10367.533460994273, 10387.117095046855, 10387.94806025965, 10412.635557755593, 5325.920111198335, 5328.49379308965, 5329.067413202674, 5329.413764485981, 5335.86660333487, 4275.273203555403, 4421.336799480039, 4660.370849935283, 4730.88172795676, 4835.468098509161, 3965.345717956505, 4015.357542793139, 4084.1627466369323, 4116.547179810218, 4120.979395103005, 1269.796832506813, 1295.6890346316816, 1298.5974347952165, 1304.1588175626669, 1310.7444048410468, 656.9638669873108, 795.8845967334704, 799.2926260259596, 925.7037747920601, 982.7936133411921, 5909.172715819789, 5975.790847320323, 6020.608660437058, 6071.210742603434, 6233.937660623426, 488.14330849359146, 489.6254365410464, 490.70067258972, 627.4729227448873, 830.6552780596106, 3651.799151046665, 4062.959370406258, 4078.6940979426663, 4153.7507749535125, 4158.500979882373, 10420.68737937863, 10701.357918524913, 10827.242093053568, 10839.566417343376, 10862.565497380174, 10796.352218866894, 10821.134309255242, 10833.512491937881, 10844.29512081728, 10852.348859068481, 7850.2542258485355, 8222.013358397151, 8274.379421543408, 8404.663813447516, 8425.578721063923, 5825.300963884361, 6029.698515074317, 6053.424924632153, 6136.723847426966, 6150.723217455315, 9069.682561110329, 10045.547950342107, 10140.543675534765, 10161.136303413998, 10170.186385089322, 9777.168940640126, 10136.543855526372, 10223.335483193569, 10226.6420675276, 10275.02387273208, 7594.278543538355, 7666.884996725165, 7791.415643826623, 7791.4935529190425, 7818.843623127619, 8358.414910956175, 8404.957975210085, 8407.0, 8478.922663947373, 8494.617742201492, 7639.961800190964, 7666.310032096915, 7729.227077292226, 7812.062552493737, 7828.960855195915, 7419.740309089156, 7518.699252029857, 7585.544867307979, 7633.084029916446, 7655.0813902332075, 7104.857902841811, 7125.18060423058, 7183.389411900047, 7206.423486121203, 7211.891821622575, 4335.934960975651, 5057.039162559102, 5064.987002599421, 5079.568236699922, 5225.033368826779, 5119.129747942933, 5144.331236939174, 5161.380634323755, 5245.737713114406, 5309.442508536548], "value": 4580.95921674689, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.3392536419877, 302.895501052137, 315.08939165810796, 319.8129094479729, 321.7297470125096, 4795.7602119894, 4897.828575999841, 5279.762410691518, 5340.332458442695, 5355.98236335097, 3920.8825484736853, 4199.643030342425, 4953.653244272902, 5048.466073748373, 5251.842444726654, 3489.441689329708, 3676.6285745694013, 3700.278445703089, 3974.403839424095, 4009.7794621295816, 4019.356902895537, 4026.262141743613, 4031.9596804032026, 4052.3111071117983, 4067.9186416271655, 3442.3803715331233, 3755.6807671347833, 3776.2825063238033, 3969.24584328978, 3972.36442169253, 3702.2410405866867, 3910.452536644872, 3973.4834471518807, 3981.4824072870633, 3997.700747257124, 3198.896380748638, 3378.476336167898, 3493.449781659403, 3510.7717998330027, 3523.612402635708, 4444.466664000308, 4456.509783923766, 4879.585235255007, 5154.974225128888, 5229.241759944786, 4515.525869783658, 4565.794539245742, 4573.565511276423, 4580.290055041441, 4592.7933243004145, 4785.880352991168, 5157.58739300855, 5478.0, 5483.396826349099, 5556.722163891789, 3371.342588195303, 3823.808809559511, 3841.481400010991, 3852.8844134675724, 3868.0, 4626.953730462719, 4827.468978412372, 5782.380933338672, 5805.564582656276, 5813.09896965971, 3655.597884232732, 3824.808759562011, 3838.692904567628, 3884.3392276290265, 3907.355286377716, 3489.65103489649, 3607.3687104756564, 3927.9410808837893, 3948.9012774680864, 3965.72239943207, 3659.432787917877, 4237.576242375738, 4481.910361792746, 4515.029268707243, 4559.886002849889, 4683.672142949961, 5539.861503462365, 5568.860778480571, 5569.721513924287, 5600.831975040755, 1246.1028059796931, 1282.6724340307737, 1285.4087119924752, 1313.934303284832, 1352.384664977433, 798.3932211519171, 876.487254955858, 878.9780255493664, 899.9010108888017, 906.7143849687327, 5138.741008452878, 5149.914284714697, 5153.871153221199, 5193.545807173998, 5206.71363075027, 5602.386460732804, 5621.690807005654, 5626.887462250732, 5659.858503537363, 5676.347220069745, 4349.456317960255, 4543.66001509223, 4968.72672003036, 5151.304573882553, 5196.012292931579, 2185.7650427508406, 2244.0, 2497.325722055035, 2521.369657585604, 2568.7284794026705, 4450.198964186413, 4494.258447356215, 4728.361671174347, 4771.328056288489, 4961.975190124026, 4248.129133527619, 4574.679772415965, 4670.7664616769025, 4761.6904901181315, 4808.93215917152, 4542.591166795004, 4834.564889159992, 4928.211486162197, 4932.210846264652, 4973.0, 4323.287616498033, 4667.8330417395655, 4735.573798358164, 4750.460906624587, 4859.2788038698445, 4445.777711114496, 4640.930386044144, 4693.647976401715, 4701.412323459567, 4715.6463265255925, 4187.350960601112, 4870.90258194827, 4891.5353041461, 4895.926561101515, 4947.579455746158, 3304.256542277968, 3315.088350703576, 3335.5997280326515, 3341.4914339942475, 3374.645662205531, 4231.87304380869, 4450.420100864147, 4596.632269418372, 4741.67657847659, 5407.432219616883, 4988.27669987857, 5490.450954904637, 5494.587905906993, 5517.144842549411, 5632.3246457932155, 4643.814247430065, 4992.800287988585, 5478.01395748769, 5539.695316757617, 5550.278463799842, 4863.489333619919, 4910.558049775537, 5468.617196796186, 5477.1510415885605, 5513.972430137824, 4781.976090119527, 4869.878253043702, 5205.037068142255, 5613.0, 5628.409017053151, 4360.36774667665, 4957.554499622727, 5290.497402746733, 5514.448555144453, 5580.944190558205], "value": 3848.773956200588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2783577243893, 726.560430939282, 734.3170851108468, 755.0373274075553, 843.7899240390998, 14852.40590376385, 16154.757678634829, 16171.91914040431, 16181.190940452989, 16203.675926481463, 14215.360308786103, 14562.490312839052, 14934.477293294736, 14964.625884352896, 14966.625834354147, 721.754603434832, 746.981325466865, 748.5508694783141, 919.6965001549472, 927.2720914082413, 895.1048951048951, 932.8600709893502, 933.6592143867473, 936.442816524167, 938.2212763406357, 983.3362480325787, 986.2307400227834, 986.4919566423262, 988.199558357729, 990.2375171118234, 760.3081196111511, 949.6723630347519, 976.6484065736329, 982.003266684316, 989.3124278626358, 727.0366764037672, 728.9416846652255, 729.8832186850078, 730.0582248898914, 731.2650785960129, 15202.543923682308, 15230.314635841303, 15233.847661523354, 15234.162121083336, 15248.161351125684, 14029.64925876851, 14157.433702651882, 14167.574972750834, 14203.502877399242, 14317.898619349133, 12789.808152877715, 12988.220706757531, 13195.60413187606, 13270.800937985938, 13437.865621343759, 4007.519097708294, 4567.680262381635, 4687.156311863863, 4695.5069717679835, 4861.756912154414, 103442.48278758633, 103760.48119759353, 104255.43616845753, 104570.99999999924, 104700.47649761703, 11061.72345691348, 11258.943705281421, 11450.471930481435, 11711.941440292743, 11780.764384712258, 22453.887730561568, 22458.663120053214, 22471.887640561694, 22479.32562023142, 22488.98799554024, 7645.464817462725, 7706.07527096752, 7755.146933837386, 7874.803129921684, 7914.881276780853, 4450.525209563371, 4452.109578084396, 4527.253003254426, 4535.206338890747, 4652.930206046912, 3533.982330088333, 3659.524261845943, 3661.139632186434, 3666.5783434904793, 3671.045528162697, 497.48261807719564, 653.5621133840339, 672.542670983726, 689.5207830557714, 692.4079911675545, 553.5709824885665, 629.9086632438363, 649.1820306413953, 676.67857767561, 693.2166651683666, 7424.0, 9214.953925230331, 9330.253579713743, 9430.245580353556, 9541.093596108358, 541.5315751874679, 565.4797586220686, 613.8649497110629, 647.5726020826232, 680.4692339974828, 4467.441569803775, 4551.544845515422, 4571.405717256802, 4593.402857628487, 4692.1084993851055, 85318.57340713381, 89546.55226723825, 117175.82824171819, 118346.4082679581, 137333.13334333245, 119502.2113954249, 123633.0, 123911.0, 125303.373483132, 125732.1987460869, 69137.30862691309, 101381.49309253554, 103410.48294758628, 107282.46358768156, 112727.0, 8954.0, 9239.72280831576, 9798.971108033838, 9821.459819709984, 9830.213582913493, 52560.21159682531, 56347.59131021757, 56862.43137568737, 60528.486787830654, 63816.0, 27727.0, 27727.029553965513, 27754.02860899859, 27779.722202777713, 85801.57099214464, 14086.15483071019, 14484.989185864204, 14627.414903404171, 14833.703325933637, 14950.476733314283, 12036.578719744766, 14879.404823806926, 15019.624509386915, 15457.227138643248, 15728.842711572737, 13679.452821887411, 13684.45262189541, 13692.65768355799, 13769.793453098411, 14063.789043164155, 12651.810222846849, 13283.933580332037, 13737.789408498069, 13962.022658413813, 13979.161250325013, 13301.334933253105, 13430.597082087554, 13782.793258100935, 13805.24071176095, 13812.930935345259, 10630.574777009142, 10945.726356841144, 11062.944685276521, 11195.216334856808, 11495.195336326376, 10809.945950270197, 10910.181736369645, 10944.343339399662, 11011.724706882393, 11102.944485277521], "value": 7690.500082547373, "unit": "score"}], "name": "dromaeo_css", "value": 7311.265152277295, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 112.0, 112.0, 111.0, 112.0, 90.0, 153.0, 164.0, 164.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 108.0, 157.0, 104.0, 108.0, 129.0, 118.0, 179.0, 136.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 185.0, 184.0, 183.0, 216.0, 180.0, 183.0, 184.0], "value": 186.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 57.0, 99.0, 70.0, 81.0, 53.0, 82.0, 100.0, 83.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 92.0, 71.0, 72.0, 68.0, 95.0, 68.0, 67.0, 105.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 85.0, 89.0, 84.0, 90.0, 86.0, 88.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 113.0, 146.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 89.0, 88.0, 88.0, 89.0, 88.0, 88.0, 88.0, 86.0], "value": 88.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 52.0, 54.0, 53.0, 53.0, 54.0, 54.0, 55.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 74.0, 78.0, 72.0, 68.0, 70.0, 70.0, 70.0, 70.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 85.0, 82.0, 84.0, 88.0, 99.0, 100.0, 80.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 139.0, 134.0, 137.0, 139.0, 140.0, 149.0, 226.0, 153.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 157.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 68.0, 64.0, 66.0, 67.0, 67.0, 65.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1460.4, "alertThreshold": 2.0}]} 17:11:37 INFO - Return code: 0 17:11:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:11:37 INFO - # TBPL SUCCESS # 17:11:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:11:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:11:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:11:37 INFO - 2016-07-04 17:11:37.222 screenresolution[1667:10634] starting screenresolution argv=screenresolution get 17:11:37 INFO - 2016-07-04 17:11:37.225 screenresolution[1667:10634] Display 0: 1600x1200x32@60 17:11:37 INFO - 2016-07-04 17:11:37.231 screenresolution[1668:10637] starting screenresolution argv=screenresolution list 17:11:37 INFO - Available Modes on Display 0 17:11:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:11:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:11:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:11:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:11:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:11:37 INFO - Intel Iris: 17:11:37 INFO - Chipset Model: Intel Iris 17:11:37 INFO - Type: GPU 17:11:37 INFO - Bus: Built-In 17:11:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:11:37 INFO - Vendor: Intel (0x8086) 17:11:37 INFO - Device ID: 0x0a2e 17:11:37 INFO - Revision ID: 0x0009 17:11:37 INFO - Displays: 17:11:37 INFO - Display: 17:11:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:11:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:11:37 INFO - Display Serial Number: 1600x1200 60 17:11:37 INFO - Main Display: Yes 17:11:37 INFO - Mirror: Off 17:11:37 INFO - Online: Yes 17:11:37 INFO - Rotation: Supported 17:11:37 INFO - Return code: 0 17:11:37 INFO - Running post-action listener: _resource_record_post_action 17:11:37 INFO - ##### 17:11:37 INFO - ##### Finished run-tests step (success) 17:11:37 INFO - ##### 17:11:37 INFO - Running post-run listener: _resource_record_post_run 17:11:37 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31464960; Write bytes: 706227200; Read time: 195; Write time: 1953 17:11:37 INFO - TinderboxPrint: CPU usage
53.6% 17:11:37 INFO - TinderboxPrint: I/O read bytes / time
31,464,960 / 195 17:11:37 INFO - TinderboxPrint: I/O write bytes / time
706,227,200 / 1,953 17:11:37 INFO - TinderboxPrint: CPU idle
2,248.0 (46.4%) 17:11:37 INFO - TinderboxPrint: CPU system
972.1 (20.0%) 17:11:37 INFO - TinderboxPrint: CPU user
1,629.6 (33.6%) 17:11:37 INFO - TinderboxPrint: Swap in / out
434,982,912 / 0 17:11:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 400669184; Write bytes: 395110400; Read time: 29630; Write time: 837 17:11:37 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29437440; Write bytes: 295248896; Read time: 177; Write time: 1072 17:11:37 INFO - Running post-run listener: _upload_blobber_files 17:11:37 INFO - Blob upload gear active. 17:11:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:11:37 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 17:11:37 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'] 17:11:37 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 17:11:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:11:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:11:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:39 INFO - (blobuploader) - INFO - Done attempting. 17:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:11:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:40 INFO - (blobuploader) - INFO - Done attempting. 17:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:42 INFO - (blobuploader) - INFO - Done attempting. 17:11:42 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:42 INFO - Return code: 0 17:11:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:11:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a7cd06b8eaa7bd5a62c25d19e9d90ee6cab2c79e16dc3ddc4a9a6a413c6096ee787a6d9fa41c3cfbac51e5e299c9508d817c0b50c187e675df3c4842f9b29a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cde73d6dbd053070617c5c8a1a3e039bfb3fbfbcc63fd8b7b31c5da24a682e9119fc946f982d70ed47699279fadfe2526c9d358c12c6b1d56710d2a7bd23c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f83e670e80222d8883ac108ef398285b2c49e7ed072d98cec349f1622fafdaff011edc530f5850ace27b13d47f35083ecace2a8a1ee0ed8f14deb462a84703d"} 17:11:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:11:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:11:42 INFO - Contents: 17:11:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a7cd06b8eaa7bd5a62c25d19e9d90ee6cab2c79e16dc3ddc4a9a6a413c6096ee787a6d9fa41c3cfbac51e5e299c9508d817c0b50c187e675df3c4842f9b29a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cde73d6dbd053070617c5c8a1a3e039bfb3fbfbcc63fd8b7b31c5da24a682e9119fc946f982d70ed47699279fadfe2526c9d358c12c6b1d56710d2a7bd23c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f83e670e80222d8883ac108ef398285b2c49e7ed072d98cec349f1622fafdaff011edc530f5850ace27b13d47f35083ecace2a8a1ee0ed8f14deb462a84703d"} 17:11:42 INFO - Running post-run listener: copy_logs_to_upload_dir 17:11:42 INFO - Copying logs to upload dir... 17:11:42 INFO - mkdir: /builds/slave/test/build/upload/logs 17:11:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1345.729255 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-07-04 17:11:42.600668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:42.608202) ========= 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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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/1a7cd06b8eaa7bd5a62c25d19e9d90ee6cab2c79e16dc3ddc4a9a6a413c6096ee787a6d9fa41c3cfbac51e5e299c9508d817c0b50c187e675df3c4842f9b29a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cde73d6dbd053070617c5c8a1a3e039bfb3fbfbcc63fd8b7b31c5da24a682e9119fc946f982d70ed47699279fadfe2526c9d358c12c6b1d56710d2a7bd23c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f83e670e80222d8883ac108ef398285b2c49e7ed072d98cec349f1622fafdaff011edc530f5850ace27b13d47f35083ecace2a8a1ee0ed8f14deb462a84703d"} build_url:https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/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/1a7cd06b8eaa7bd5a62c25d19e9d90ee6cab2c79e16dc3ddc4a9a6a413c6096ee787a6d9fa41c3cfbac51e5e299c9508d817c0b50c187e675df3c4842f9b29a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cde73d6dbd053070617c5c8a1a3e039bfb3fbfbcc63fd8b7b31c5da24a682e9119fc946f982d70ed47699279fadfe2526c9d358c12c6b1d56710d2a7bd23c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f83e670e80222d8883ac108ef398285b2c49e7ed072d98cec349f1622fafdaff011edc530f5850ace27b13d47f35083ecace2a8a1ee0ed8f14deb462a84703d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:42.643151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:42.643526) ========= 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.4xZSyvMTzv/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.JPLg6F9mCX/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.005174 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:42.691478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 17:11:42.694840) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 17:11:42.695174) ========= ========= Total master_lag: 0.86 =========