builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0371 starttime: 1481470505.24 results: success (0) buildid: 20161211063750 builduid: de268f3660034ccb88708df13b52ee48 revision: 327307b7933666ef32b964865f2d853ece5744e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.240263) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.241086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.241353) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.279762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.280041) ========= 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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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-12-11 07:35:05-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 56.1M=0s 2016-12-11 07:35:05 (56.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.485321 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.791568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.792373) ========= 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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.019650 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:05.842535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 07:35:05.842881) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 327307b7933666ef32b964865f2d853ece5744e1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 327307b7933666ef32b964865f2d853ece5744e1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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-12-11 07:35:05,925 truncating revision to first 12 chars 2016-12-11 07:35:05,925 Setting DEBUG logging. 2016-12-11 07:35:05,925 attempt 1/10 2016-12-11 07:35:05,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/327307b79336?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-11 07:35:07,045 unpacking tar archive at: mozilla-aurora-327307b79336/testing/mozharness/ program finished with exit code 0 elapsedTime=1.379264 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 07:35:07.253121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:07.253502) ========= script_repo_revision: 327307b7933666ef32b964865f2d853ece5744e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:07.253930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:07.254228) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 07:35:07.286893) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-11 07:35:07.287230) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:07 INFO - MultiFileLogger online at 20161211 07:35:07 in /builds/slave/test 07:35:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:35:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:07 INFO - {'append_to_log': False, 07:35:07 INFO - 'base_work_dir': '/builds/slave/test', 07:35:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:35:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:07 INFO - 'branch': 'Mozilla-Aurora', 07:35:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:07 INFO - 'config_files': ('talos/mac_config.py',), 07:35:07 INFO - 'default_actions': ('clobber', 07:35:07 INFO - 'read-buildbot-config', 07:35:07 INFO - 'download-and-extract', 07:35:07 INFO - 'populate-webroot', 07:35:07 INFO - 'create-virtualenv', 07:35:07 INFO - 'install', 07:35:07 INFO - 'run-tests'), 07:35:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:07 INFO - 'download_minidump_stackwalk': True, 07:35:07 INFO - 'download_symbols': 'ondemand', 07:35:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:07 INFO - 'installer_path': 'installer.exe', 07:35:07 INFO - 'log_level': 'info', 07:35:07 INFO - 'log_name': 'talos', 07:35:07 INFO - 'log_to_console': True, 07:35:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:07 INFO - 'opt_config_files': (), 07:35:07 INFO - 'pip_index': False, 07:35:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:07 INFO - 'cmd': ('bash', 07:35:07 INFO - '-c', 07:35:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:07 INFO - 'enabled': True, 07:35:07 INFO - 'halt_on_failure': False, 07:35:07 INFO - 'name': 'check_screen_resolution'},), 07:35:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:07 INFO - 'cmd': ('bash', 07:35:07 INFO - '-c', 07:35:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:07 INFO - 'enabled': True, 07:35:07 INFO - 'halt_on_failure': False, 07:35:07 INFO - 'name': 'check_screen_resolution'},), 07:35:07 INFO - 'run_cmd_checks_enabled': True, 07:35:07 INFO - 'sps_profile': False, 07:35:07 INFO - 'sps_profile_interval': 0, 07:35:07 INFO - 'suite': 'dromaeojs-e10s', 07:35:07 INFO - 'system_bits': '32', 07:35:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:07 INFO - 'title': 't-yosemite-r7-0371', 07:35:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:07 INFO - 'use_talos_json': True, 07:35:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:07 INFO - 'work_dir': 'build'} 07:35:07 INFO - [mozharness: 2016-12-11 15:35:07.485883Z] Running clobber step. 07:35:07 INFO - Running pre-action listener: _resource_record_pre_action 07:35:07 INFO - Running main action method: clobber 07:35:07 INFO - rmtree: /builds/slave/test/build 07:35:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:07 INFO - Running post-action listener: _resource_record_post_action 07:35:07 INFO - [mozharness: 2016-12-11 15:35:07.700198Z] Finished clobber step (success) 07:35:07 INFO - [mozharness: 2016-12-11 15:35:07.700322Z] Running read-buildbot-config step. 07:35:07 INFO - Running pre-action listener: _resource_record_pre_action 07:35:07 INFO - Running main action method: read_buildbot_config 07:35:07 INFO - Using buildbot properties: 07:35:07 INFO - { 07:35:07 INFO - "project": "", 07:35:07 INFO - "product": "firefox", 07:35:07 INFO - "script_repo_revision": "production", 07:35:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:35:07 INFO - "repository": "", 07:35:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:35:07 INFO - "buildid": "20161211063750", 07:35:07 INFO - "pgo_build": "False", 07:35:07 INFO - "basedir": "/builds/slave/test", 07:35:07 INFO - "buildnumber": 54, 07:35:07 INFO - "slavename": "t-yosemite-r7-0371", 07:35:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:35:07 INFO - "platform": "yosemite_r7", 07:35:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:35:07 INFO - "branch": "mozilla-aurora", 07:35:07 INFO - "repo_path": "releases/mozilla-aurora", 07:35:07 INFO - "revision": "327307b7933666ef32b964865f2d853ece5744e1", 07:35:07 INFO - "stage_platform": "macosx64", 07:35:07 INFO - "builduid": "de268f3660034ccb88708df13b52ee48", 07:35:07 INFO - "slavebuilddir": "test" 07:35:07 INFO - } 07:35:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:35:07 INFO - Running post-action listener: _resource_record_post_action 07:35:07 INFO - [mozharness: 2016-12-11 15:35:07.703655Z] Finished read-buildbot-config step (success) 07:35:07 INFO - [mozharness: 2016-12-11 15:35:07.703754Z] Running download-and-extract step. 07:35:07 INFO - Running pre-action listener: _resource_record_pre_action 07:35:07 INFO - Running main action method: download_and_extract 07:35:07 INFO - mkdir: /builds/slave/test/build/tests 07:35:07 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:07 INFO - trying https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:35:07 INFO - Downloading https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 07:35:08 INFO - Downloaded 1199 bytes. 07:35:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:35:08 INFO - Using the following test package requirements: 07:35:08 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:35:08 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:35:08 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:35:08 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'jsshell-mac.zip'], 07:35:08 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:35:08 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:35:08 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:35:08 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:35:08 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:35:08 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:35:08 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:35:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:35:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:35:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:08 INFO - Fetch https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:35:09 INFO - Http code: 200 07:35:09 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 07:35:09 INFO - x-amz-cf-id: JmRjiOwer5FtkAeN31dzlp7yKTPiJWUcFK7XKyo21EVGLcFQwyal4Q== 07:35:09 INFO - x-amz-version-id: _CEcU6m2aTZG_7VriUCkOmrUwOzNst_f 07:35:09 INFO - Expected file size: 16280906 07:35:09 INFO - Obtained file size: 16280906 07:35:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:35:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:35:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:16 INFO - Fetch https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:35:16 INFO - Http code: 200 07:35:16 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 07:35:16 INFO - x-amz-cf-id: suB3vXN5tiV3q2nFY3dClq-spJBt30t2KbyL0rmZdKYEHiWa71UIXg== 07:35:16 INFO - x-amz-version-id: _CEcU6m2aTZG_7VriUCkOmrUwOzNst_f 07:35:17 INFO - Expected file size: 16280906 07:35:17 INFO - Obtained file size: 16280906 07:35:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:35:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:35:23 INFO - Fetch https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:35:24 INFO - Http code: 200 07:35:24 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 07:35:24 INFO - x-amz-cf-id: 792wCN7kkM1jzWou5ufxJN5onPRDJcf7DAJMQOYFxcSg15pOKs-_wg== 07:35:24 INFO - x-amz-version-id: ONhGC4xDSKOpOIH_SOJtKw4pZ9CRy1aa 07:35:25 INFO - Expected file size: 14409038 07:35:25 INFO - Obtained file size: 14409038 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:25 INFO - trying https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:35:25 INFO - Downloading https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 07:35:29 INFO - Downloaded 109780096 bytes. 07:35:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:35:29 INFO - mkdir: /builds/slave/test/properties 07:35:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:29 INFO - Contents: 07:35:29 INFO - build_url:https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:35:30 INFO - Running post-action listener: _resource_record_post_action 07:35:30 INFO - Running post-action listener: set_extra_try_arguments 07:35:30 INFO - [mozharness: 2016-12-11 15:35:30.082130Z] Finished download-and-extract step (success) 07:35:30 INFO - [mozharness: 2016-12-11 15:35:30.082297Z] Running populate-webroot step. 07:35:30 INFO - Running pre-action listener: _resource_record_pre_action 07:35:30 INFO - Running main action method: populate_webroot 07:35:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:30 INFO - '--tppagecycles', 07:35:30 INFO - '7'], 07:35:30 INFO - 'tests': ['tsvgm']}}, 07:35:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['damp', 'tps']}, 07:35:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'tests': ['damp', 'tps']}, 07:35:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['dromaeo_dom']}, 07:35:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['basic_compositor_video']}, 07:35:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['a11yr', 07:35:30 INFO - 'ts_paint', 07:35:30 INFO - 'tpaint', 07:35:30 INFO - 'sessionrestore', 07:35:30 INFO - 'sessionrestore_no_auto_restore', 07:35:30 INFO - 'tabpaint']}, 07:35:30 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:30 INFO - 'ts_paint', 07:35:30 INFO - 'tpaint', 07:35:30 INFO - 'sessionrestore', 07:35:30 INFO - 'sessionrestore_no_auto_restore', 07:35:30 INFO - 'tabpaint']}, 07:35:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:30 INFO - 'ts_paint', 07:35:30 INFO - 'tpaint', 07:35:30 INFO - 'sessionrestore', 07:35:30 INFO - 'sessionrestore_no_auto_restore', 07:35:30 INFO - 'tabpaint']}, 07:35:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:30 INFO - 'ts_paint', 07:35:30 INFO - 'tpaint', 07:35:30 INFO - 'sessionrestore', 07:35:30 INFO - 'sessionrestore_no_auto_restore', 07:35:30 INFO - 'tabpaint']}, 07:35:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['a11yr', 07:35:30 INFO - 'ts_paint', 07:35:30 INFO - 'tpaint', 07:35:30 INFO - 'sessionrestore', 07:35:30 INFO - 'sessionrestore_no_auto_restore', 07:35:30 INFO - 'tabpaint']}, 07:35:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['a11yr', 07:35:30 INFO - 'ts_paint', 07:35:30 INFO - 'tpaint', 07:35:30 INFO - 'sessionrestore', 07:35:30 INFO - 'sessionrestore_no_auto_restore', 07:35:30 INFO - 'tabpaint']}, 07:35:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['tsvgx', 07:35:30 INFO - 'tsvgr_opacity', 07:35:30 INFO - 'tart', 07:35:30 INFO - 'tscrollx', 07:35:30 INFO - 'cart']}, 07:35:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:30 INFO - 'tsvgr_opacity', 07:35:30 INFO - 'tart', 07:35:30 INFO - 'tscrollx', 07:35:30 INFO - 'cart']}, 07:35:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'talos_options': ['--disable-e10s'], 07:35:30 INFO - 'tests': ['tp5o']}, 07:35:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'tests': ['tp5o']}, 07:35:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'talos_options': ['--disable-e10s', 07:35:30 INFO - '--xperf_path', 07:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:30 INFO - 'tests': ['tp5n']}, 07:35:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:30 INFO - 'talos_options': ['--xperf_path', 07:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:30 INFO - 'tests': ['tp5n']}}, 07:35:30 INFO - 'talos.zip': {'path': '', 07:35:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:30 INFO - Running post-action listener: _resource_record_post_action 07:35:30 INFO - [mozharness: 2016-12-11 15:35:30.100968Z] Finished populate-webroot step (success) 07:35:30 INFO - [mozharness: 2016-12-11 15:35:30.101106Z] Running create-virtualenv step. 07:35:30 INFO - Running pre-action listener: _resource_record_pre_action 07:35:30 INFO - Running main action method: create_virtualenv 07:35:30 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:30 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 07:35:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:30 INFO - Using real prefix '/tools/python27' 07:35:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:33 INFO - Installing pip.................done. 07:35:33 INFO - Return code: 0 07:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:35:34 INFO - Reading from file tmpfile_stdout 07:35:34 INFO - Output received: 07:35:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:35:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:34 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:34 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 07:35:34 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 07:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:34 INFO - 'HOME': '/Users/cltbld', 07:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:34 INFO - 'LOGNAME': 'cltbld', 07:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:34 INFO - 'MOZ_NO_REMOTE': '1', 07:35:34 INFO - 'NO_EM_RESTART': '1', 07:35:34 INFO - 'PAGER': '/bin/cat', 07:35:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:34 INFO - 'PWD': '/builds/slave/test', 07:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:34 INFO - 'SHELL': '/bin/bash', 07:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:34 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:34 INFO - 'USER': 'cltbld', 07:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:34 INFO - 'XPC_FLAGS': '0x0', 07:35:34 INFO - 'XPC_SERVICE_NAME': '0', 07:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:34 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 07:35:34 INFO - Cleaning up... 07:35:34 INFO - Return code: 0 07:35:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:34 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:34 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 07:35:34 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 07:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:34 INFO - 'HOME': '/Users/cltbld', 07:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:34 INFO - 'LOGNAME': 'cltbld', 07:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:34 INFO - 'MOZ_NO_REMOTE': '1', 07:35:34 INFO - 'NO_EM_RESTART': '1', 07:35:34 INFO - 'PAGER': '/bin/cat', 07:35:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:34 INFO - 'PWD': '/builds/slave/test', 07:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:34 INFO - 'SHELL': '/bin/bash', 07:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:34 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:34 INFO - 'USER': 'cltbld', 07:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:34 INFO - 'XPC_FLAGS': '0x0', 07:35:34 INFO - 'XPC_SERVICE_NAME': '0', 07:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:34 INFO - Downloading/unpacking psutil>=3.1.1 07:35:34 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 07:35:34 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 07:35:34 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 07:35:34 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 07:35:34 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 07:35:34 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 07:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:38 INFO - Installing collected packages: psutil 07:35:38 INFO - Running setup.py install for psutil 07:35:38 INFO - building 'psutil._psutil_osx' extension 07:35:38 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 07:35:38 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 07:35:38 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 07:35:38 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 07:35:38 INFO - building 'psutil._psutil_posix' extension 07:35:38 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 07:35:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:39 INFO - ^ 07:35:39 INFO - 1 warning generated. 07:35:39 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 07:35:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:39 INFO - Successfully installed psutil 07:35:39 INFO - Cleaning up... 07:35:39 INFO - Return code: 0 07:35:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:39 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:39 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 07:35:39 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 07:35:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:39 INFO - 'HOME': '/Users/cltbld', 07:35:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:39 INFO - 'LOGNAME': 'cltbld', 07:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:39 INFO - 'MOZ_NO_REMOTE': '1', 07:35:39 INFO - 'NO_EM_RESTART': '1', 07:35:39 INFO - 'PAGER': '/bin/cat', 07:35:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:39 INFO - 'PWD': '/builds/slave/test', 07:35:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:39 INFO - 'SHELL': '/bin/bash', 07:35:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:39 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:39 INFO - 'USER': 'cltbld', 07:35:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:39 INFO - 'XPC_FLAGS': '0x0', 07:35:39 INFO - 'XPC_SERVICE_NAME': '0', 07:35:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:39 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 07:35:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:42 INFO - Installing collected packages: mozsystemmonitor 07:35:42 INFO - Running setup.py install for mozsystemmonitor 07:35:42 INFO - Successfully installed mozsystemmonitor 07:35:42 INFO - Cleaning up... 07:35:42 INFO - Return code: 0 07:35:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:42 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:42 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 07:35:42 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 07:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:42 INFO - 'HOME': '/Users/cltbld', 07:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:42 INFO - 'LOGNAME': 'cltbld', 07:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:42 INFO - 'MOZ_NO_REMOTE': '1', 07:35:42 INFO - 'NO_EM_RESTART': '1', 07:35:42 INFO - 'PAGER': '/bin/cat', 07:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:42 INFO - 'PWD': '/builds/slave/test', 07:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:42 INFO - 'SHELL': '/bin/bash', 07:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:42 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:42 INFO - 'USER': 'cltbld', 07:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:42 INFO - 'XPC_FLAGS': '0x0', 07:35:42 INFO - 'XPC_SERVICE_NAME': '0', 07:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:42 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:42 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 07:35:42 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 07:35:42 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 07:35:42 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 07:35:42 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 07:35:42 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 07:35:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35:45 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 07:35:45 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 07:35:45 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 07:35:45 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 07:35:45 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 07:35:45 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 07:35:45 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:45 INFO - warning: no files found matching '*.txt' 07:35:45 INFO - no previously-included directories found matching 'build' 07:35:45 INFO - no previously-included directories found matching 'dist' 07:35:45 INFO - no previously-included directories found matching '.git*' 07:35:45 INFO - Installing collected packages: jsonschema, functools32 07:35:45 INFO - Running setup.py install for functools32 07:35:46 INFO - warning: no files found matching '*.txt' 07:35:46 INFO - no previously-included directories found matching 'build' 07:35:46 INFO - no previously-included directories found matching 'dist' 07:35:46 INFO - no previously-included directories found matching '.git*' 07:35:46 INFO - Successfully installed jsonschema functools32 07:35:46 INFO - Cleaning up... 07:35:46 INFO - Return code: 0 07:35:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:35:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:46 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:35:46 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 functools32==3.2.3-2 07:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:46 INFO - 'HOME': '/Users/cltbld', 07:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:46 INFO - 'LOGNAME': 'cltbld', 07:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:46 INFO - 'MOZ_NO_REMOTE': '1', 07:35:46 INFO - 'NO_EM_RESTART': '1', 07:35:46 INFO - 'PAGER': '/bin/cat', 07:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:46 INFO - 'PWD': '/builds/slave/test', 07:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:46 INFO - 'SHELL': '/bin/bash', 07:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:46 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:46 INFO - 'USER': 'cltbld', 07:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:46 INFO - 'XPC_FLAGS': '0x0', 07:35:46 INFO - 'XPC_SERVICE_NAME': '0', 07:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:35:46 INFO - Cleaning up... 07:35:46 INFO - Return code: 0 07:35:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:46 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:46 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 07:35:46 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 07:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:46 INFO - 'HOME': '/Users/cltbld', 07:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:46 INFO - 'LOGNAME': 'cltbld', 07:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:46 INFO - 'MOZ_NO_REMOTE': '1', 07:35:46 INFO - 'NO_EM_RESTART': '1', 07:35:46 INFO - 'PAGER': '/bin/cat', 07:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:46 INFO - 'PWD': '/builds/slave/test', 07:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:46 INFO - 'SHELL': '/bin/bash', 07:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:46 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:46 INFO - 'USER': 'cltbld', 07:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:46 INFO - 'XPC_FLAGS': '0x0', 07:35:46 INFO - 'XPC_SERVICE_NAME': '0', 07:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:35:46 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 07:35:46 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 07:35:46 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 07:35:46 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 07:35:46 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 07:35:46 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 07:35:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35:50 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 07:35:50 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 07:35:50 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 07:35:50 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 07:35:50 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 07:35:50 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 07:35:50 INFO - Downloading docopt-0.6.1.tar.gz 07:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:50 INFO - Running setup.py install for blobuploader 07:35:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:50 INFO - Running setup.py install for requests 07:35:51 INFO - Running setup.py install for docopt 07:35:51 INFO - Successfully installed blobuploader requests docopt 07:35:51 INFO - Cleaning up... 07:35:51 INFO - Return code: 0 07:35:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:51 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 07:35:51 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 07:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:51 INFO - 'HOME': '/Users/cltbld', 07:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:51 INFO - 'LOGNAME': 'cltbld', 07:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:51 INFO - 'MOZ_NO_REMOTE': '1', 07:35:51 INFO - 'NO_EM_RESTART': '1', 07:35:51 INFO - 'PAGER': '/bin/cat', 07:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:51 INFO - 'PWD': '/builds/slave/test', 07:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:51 INFO - 'SHELL': '/bin/bash', 07:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:51 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:51 INFO - 'USER': 'cltbld', 07:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:51 INFO - 'XPC_FLAGS': '0x0', 07:35:51 INFO - 'XPC_SERVICE_NAME': '0', 07:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-NOteVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-rzQTP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-0__7oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-MM3Ao9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-3kuL1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-8zQE7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-bMxx6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-WclgfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-oUPR16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-U3xSFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-RNMOQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:52 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-PdbiMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-DKGlf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-WLlTMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-L5mbTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ERNdf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Mana3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:53 INFO - Running setup.py install for manifestparser 07:35:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:53 INFO - Running setup.py install for mozcrash 07:35:53 INFO - Running setup.py install for mozdebug 07:35:53 INFO - Running setup.py install for mozdevice 07:35:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Running setup.py install for mozfile 07:35:54 INFO - Running setup.py install for mozhttpd 07:35:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Running setup.py install for mozinfo 07:35:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Running setup.py install for mozInstall 07:35:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:54 INFO - Running setup.py install for mozleak 07:35:54 INFO - Running setup.py install for mozlog 07:35:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:55 INFO - Running setup.py install for moznetwork 07:35:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:55 INFO - Running setup.py install for mozprocess 07:35:55 INFO - Running setup.py install for mozprofile 07:35:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:55 INFO - Running setup.py install for mozrunner 07:35:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:55 INFO - Running setup.py install for mozscreenshot 07:35:55 INFO - Running setup.py install for moztest 07:35:55 INFO - Running setup.py install for mozversion 07:35:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:56 INFO - Cleaning up... 07:35:56 INFO - Return code: 0 07:35:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:56 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:35:56 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 07:35:56 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 07:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:56 INFO - 'HOME': '/Users/cltbld', 07:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:56 INFO - 'LOGNAME': 'cltbld', 07:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:56 INFO - 'MOZ_NO_REMOTE': '1', 07:35:56 INFO - 'NO_EM_RESTART': '1', 07:35:56 INFO - 'PAGER': '/bin/cat', 07:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:56 INFO - 'PWD': '/builds/slave/test', 07:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:56 INFO - 'SHELL': '/bin/bash', 07:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:35:56 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:56 INFO - 'USER': 'cltbld', 07:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:56 INFO - 'XPC_FLAGS': '0x0', 07:35:56 INFO - 'XPC_SERVICE_NAME': '0', 07:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-En5TyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:56 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)) 07:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-7P1eLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-6wCJcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:56 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)) 07:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ZIIIRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:56 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)) 07:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-18ecuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:56 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)) 07:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-uLdWfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:57 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-hojfVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:57 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Z3Mfep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:57 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Y3zdWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:57 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-kOhBXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-URg3Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:57 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-c_oAzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-eW1yNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:57 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-pccpRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-YalXcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:57 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)) 07:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:57 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-VS_a59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:58 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)) 07:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-uDK4hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:58 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)) 07:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:58 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)) 07:35:58 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)) 07:35:58 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)) 07:35:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:36:00 INFO - Downloading blessings-1.6.tar.gz 07:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:00 INFO - Installing collected packages: blessings 07:36:00 INFO - Running setup.py install for blessings 07:36:00 INFO - Successfully installed blessings 07:36:00 INFO - Cleaning up... 07:36:01 INFO - Return code: 0 07:36:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:01 INFO - Reading from file tmpfile_stdout 07:36:01 INFO - Current package versions: 07:36:01 INFO - blessings == 1.6 07:36:01 INFO - blobuploader == 1.2.4 07:36:01 INFO - docopt == 0.6.1 07:36:01 INFO - functools32 == 3.2.3-2 07:36:01 INFO - jsonschema == 2.5.1 07:36:01 INFO - manifestparser == 1.1 07:36:01 INFO - mozInstall == 1.12 07:36:01 INFO - mozcrash == 1.0 07:36:01 INFO - mozdebug == 0.1 07:36:01 INFO - mozdevice == 0.48 07:36:01 INFO - mozfile == 1.2 07:36:01 INFO - mozhttpd == 0.7 07:36:01 INFO - mozinfo == 0.9 07:36:01 INFO - mozleak == 0.1 07:36:01 INFO - mozlog == 3.4 07:36:01 INFO - moznetwork == 0.27 07:36:01 INFO - mozprocess == 0.23 07:36:01 INFO - mozprofile == 0.28 07:36:01 INFO - mozrunner == 6.13 07:36:01 INFO - mozscreenshot == 0.1 07:36:01 INFO - mozsystemmonitor == 0.3 07:36:01 INFO - moztest == 0.7 07:36:01 INFO - mozversion == 1.4 07:36:01 INFO - psutil == 3.1.1 07:36:01 INFO - requests == 1.2.3 07:36:01 INFO - wsgiref == 0.1.2 07:36:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:01 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:36:01 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 07:36:01 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 07:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:01 INFO - 'HOME': '/Users/cltbld', 07:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:01 INFO - 'LOGNAME': 'cltbld', 07:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:01 INFO - 'MOZ_NO_REMOTE': '1', 07:36:01 INFO - 'NO_EM_RESTART': '1', 07:36:01 INFO - 'PAGER': '/bin/cat', 07:36:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:01 INFO - 'PWD': '/builds/slave/test', 07:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:01 INFO - 'SHELL': '/bin/bash', 07:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:36:01 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:01 INFO - 'USER': 'cltbld', 07:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:01 INFO - 'XPC_FLAGS': '0x0', 07:36:01 INFO - 'XPC_SERVICE_NAME': '0', 07:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 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)) 07:36:01 INFO - Cleaning up... 07:36:01 INFO - Return code: 0 07:36:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:01 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 0x10a77d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe241c669e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, '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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 07:36:01 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 07:36:01 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 07:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:01 INFO - 'HOME': '/Users/cltbld', 07:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:01 INFO - 'LOGNAME': 'cltbld', 07:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:01 INFO - 'MOZ_NO_REMOTE': '1', 07:36:01 INFO - 'NO_EM_RESTART': '1', 07:36:01 INFO - 'PAGER': '/bin/cat', 07:36:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:01 INFO - 'PWD': '/builds/slave/test', 07:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:01 INFO - 'SHELL': '/bin/bash', 07:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:36:01 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:01 INFO - 'USER': 'cltbld', 07:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:01 INFO - 'XPC_FLAGS': '0x0', 07:36:01 INFO - 'XPC_SERVICE_NAME': '0', 07:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:01 INFO - Cleaning up... 07:36:01 INFO - Return code: 0 07:36:01 INFO - Running post-action listener: _resource_record_post_action 07:36:01 INFO - Running post-action listener: _start_resource_monitoring 07:36:01 INFO - Starting resource monitoring. 07:36:01 INFO - [mozharness: 2016-12-11 15:36:01.913609Z] Finished create-virtualenv step (success) 07:36:01 INFO - [mozharness: 2016-12-11 15:36:01.914603Z] Running install step. 07:36:01 INFO - Running pre-action listener: _resource_record_pre_action 07:36:01 INFO - Running main action method: install 07:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:02 INFO - Reading from file tmpfile_stdout 07:36:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:02 INFO - Reading from file tmpfile_stdout 07:36:02 INFO - Output received: 07:36:02 INFO - Usage: mozinstall [options] installer 07:36:02 INFO - Options: 07:36:02 INFO - -h, --help show this help message and exit 07:36:02 INFO - -d DEST, --destination=DEST 07:36:02 INFO - Directory to install application into. [default: 07:36:02 INFO - "/builds/slave/test"] 07:36:02 INFO - --app=APP Application being installed. [default: firefox] 07:36:02 INFO - mkdir: /builds/slave/test/build/application 07:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:36:33 INFO - Reading from file tmpfile_stdout 07:36:33 INFO - Output received: 07:36:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:36:33 INFO - Running post-action listener: _resource_record_post_action 07:36:33 INFO - [mozharness: 2016-12-11 15:36:33.145446Z] Finished install step (success) 07:36:33 INFO - [mozharness: 2016-12-11 15:36:33.145616Z] Running run-tests step. 07:36:33 INFO - Running pre-action listener: _resource_record_pre_action 07:36:33 INFO - Running main action method: run_tests 07:36:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:33 INFO - 2016-12-11 07:36:33.160 screenresolution[2188:21061] starting screenresolution argv=screenresolution get 07:36:33 INFO - 2016-12-11 07:36:33.163 screenresolution[2188:21061] Display 0: 1600x1200x32@60 07:36:33 INFO - 2016-12-11 07:36:33.169 screenresolution[2189:21063] starting screenresolution argv=screenresolution list 07:36:33 INFO - Available Modes on Display 0 07:36:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:33 INFO - Intel Iris: 07:36:33 INFO - Chipset Model: Intel Iris 07:36:33 INFO - Type: GPU 07:36:33 INFO - Bus: Built-In 07:36:33 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:33 INFO - Vendor: Intel (0x8086) 07:36:33 INFO - Device ID: 0x0a2e 07:36:33 INFO - Revision ID: 0x0009 07:36:33 INFO - Displays: 07:36:33 INFO - Display: 07:36:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:33 INFO - Display Serial Number: 1600x1200 60 07:36:33 INFO - Main Display: Yes 07:36:33 INFO - Mirror: Off 07:36:33 INFO - Online: Yes 07:36:33 INFO - Rotation: Supported 07:36:33 INFO - Return code: 0 07:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:33 INFO - Python 2.7.3 07:36:33 INFO - Return code: 0 07:36:33 INFO - grabbing minidump binary from tooltool 07:36:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:33 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 0x10a591d30>, '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 0x10a3f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a589b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:33 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 07:36:33 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 07:36:33 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 07:36:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:33 INFO - Return code: 0 07:36:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0371 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XwWVV2GsJ9/Render', 07:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:33 INFO - 'HOME': '/Users/cltbld', 07:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:33 INFO - 'LOGNAME': 'cltbld', 07:36:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:33 INFO - 'MOZ_NO_REMOTE': '1', 07:36:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:33 INFO - 'NO_EM_RESTART': '1', 07:36:33 INFO - 'PAGER': '/bin/cat', 07:36:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:33 INFO - 'PWD': '/builds/slave/test', 07:36:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:33 INFO - 'SHELL': '/bin/bash', 07:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JQNDBoBhtC/Listeners', 07:36:33 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 07:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:33 INFO - 'USER': 'cltbld', 07:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:33 INFO - 'XPC_FLAGS': '0x0', 07:36:33 INFO - 'XPC_SERVICE_NAME': '0', 07:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:36:33 INFO - mozversion application_buildid: 20161211063750 07:36:33 INFO - mozversion application_changeset: 327307b7933666ef32b964865f2d853ece5744e1 07:36:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:36:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:33 INFO - mozversion application_name: Firefox 07:36:33 INFO - mozversion application_remotingname: firefox-dev 07:36:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:33 INFO - mozversion application_vendor: Mozilla 07:36:33 INFO - mozversion application_version: 52.0a2 07:36:33 INFO - mozversion platform_buildid: 20161211063750 07:36:33 INFO - mozversion platform_changeset: 327307b7933666ef32b964865f2d853ece5744e1 07:36:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:33 INFO - mozversion platform_version: 52.0a2 07:36:33 INFO - using testdate: 1481470593 07:36:33 INFO - actual date: 1481470593 07:36:33 INFO - starting webserver on 'localhost:54705' 07:36:33 INFO - SUITE-START | Running 2 tests 07:36:33 INFO - TEST-START | dromaeo_css 07:36:33 INFO - operating with platform_type : mac_ 07:36:33 INFO - Initialising browser for dromaeo_css test... 07:36:33 INFO - TEST-INFO | started process 2199 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpYkTzqi/profile http://localhost:54705/getInfo.html) 07:36:36 INFO - PROCESS | 2199 | 2016-12-11 07:36:36.933 plugin-container[2201:21235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 07:36:36 INFO - PROCESS | 2199 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:36 INFO - PROCESS | 2199 | 2016-12-11 07:36:36.936 plugin-container[2201:21235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a2f, name = 'com.apple.CFPasteboardClient' 07:36:36 INFO - PROCESS | 2199 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:36 INFO - PROCESS | 2199 | 2016-12-11 07:36:36.936 plugin-container[2201:21235] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:36:37 INFO - PROCESS | 2199 | __metrics Screen width/height:1600/1200 07:36:37 INFO - PROCESS | 2199 | colorDepth:24 07:36:37 INFO - PROCESS | 2199 | Browser inner width/height: 1024/663 07:36:37 INFO - PROCESS | 2199 | __metrics 07:36:37 ERROR - PROCESS | 2199 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:36:37 INFO - TEST-INFO | 2199: exit 0 07:36:37 INFO - Browser initialized. 07:36:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:37 INFO - TEST-INFO | started process 2202 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpYkTzqi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:40 INFO - PROCESS | 2202 | 2016-12-11 07:36:40.677 plugin-container[2203:21355] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 07:36:40 INFO - PROCESS | 2202 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:40 INFO - PROCESS | 2202 | 2016-12-11 07:36:40.678 plugin-container[2203:21355] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1b, name = 'com.apple.CFPasteboardClient' 07:36:40 INFO - PROCESS | 2202 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:40 INFO - PROCESS | 2202 | 2016-12-11 07:36:40.678 plugin-container[2203:21355] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:36:50 INFO - PROCESS | 2202 | RSS: Main: 236847104 07:36:50 INFO - PROCESS | 2202 | 07:37:39 INFO - PROCESS | 2202 | 1481470659839 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] 07:39:52 INFO - PROCESS | 2202 | Cycle 1(1): loaded http://localhost:54705/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54705/tests/dromaeo/cssquery-ext.html) 07:39:55 INFO - PROCESS | 2202 | RSS: Main: 239431680 07:39:55 INFO - PROCESS | 2202 | 07:42:57 INFO - PROCESS | 2202 | Cycle 1(1): loaded http://localhost:54705/tests/dromaeo/cssquery-ext.html (next: http://localhost:54705/tests/dromaeo/cssquery-jquery.html) 07:42:58 INFO - PROCESS | 2202 | RSS: Main: 248565760 07:42:58 INFO - PROCESS | 2202 | 07:46:00 INFO - PROCESS | 2202 | Cycle 1(1): loaded http://localhost:54705/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54705/tests/dromaeo/cssquery-mootools.html) 07:46:00 INFO - PROCESS | 2202 | RSS: Main: 251363328 07:46:00 INFO - PROCESS | 2202 | 07:49:02 INFO - PROCESS | 2202 | Cycle 1(1): loaded http://localhost:54705/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54705/tests/dromaeo/cssquery-prototype.html) 07:49:03 INFO - PROCESS | 2202 | RSS: Main: 251445248 07:49:03 INFO - PROCESS | 2202 | 07:52:06 INFO - PROCESS | 2202 | Cycle 1(1): loaded http://localhost:54705/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54705/tests/dromaeo/cssquery-yui.html) 07:52:06 INFO - PROCESS | 2202 | RSS: Main: 254885888 07:52:06 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | Cycle 1(1): loaded http://localhost:54705/tests/dromaeo/cssquery-yui.html (next: http://localhost:54705/tests/dromaeo/cssquery-dojo.html) 07:55:09 INFO - PROCESS | 2202 | RSS: Main: 256249856 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | __start_tp_report 07:55:09 INFO - PROCESS | 2202 | _x_x_mozilla_page_load 07:55:09 INFO - PROCESS | 2202 | _x_x_mozilla_page_load_details 07:55:09 INFO - PROCESS | 2202 | |i|pagename|runs| 07:55:09 INFO - PROCESS | 2202 | |0;dojo.html;2835.914922552324;3328.151321413039;3344.9498257526143;3368.9663103368957;3389.9830050984697;5573.777048918048;5585.525230355424;5587.608867379285;5619.241402410673;5640.74616642251;5547.33431988161;5582.525485333752;5605.103183490643;5643.294588176478;5678.864227154565;5081.009203205376;5097.184450487923;5189.636725429222;5199.090159222121;5209.348831396075;5135.9743201283945;5176.792928282883;5184.092783762845;5202.687838729688;5240.292560504321;5019.372578427697;5078.898422031576;5111.335526381566;5162.535371816554;5162.993216322819;5097.770600322994;5102.311187989611;5127.154019586801;5135.87160320995;5141;4884.658073934826;4939.234418665113;5040.34475518184;5043.4956504349275;5091.567216786578;4225.830966761326;4302.548232435581;5470.9452905470835;5528.06022976095;5627.184058311563;6144.385561443864;6150.66171360575;6154.138420621117;6163.1679723237685;6178.9691051544905;5430.728463576845;6005.069214271794;6157.661328626924;6175.845603859894;6187.81436556904;5706.828795136153;5754.079347304411;5763.106718458645;5780.277465316835;5788.768449262025;6260.530460215502;6267.811965641038;6293.496520278458;6297.905531417033;6319.05214217871;4862.3922009748785;5844.532437405082;5904.5571582131515;5937.495312898452;5963.671998040063;6101.3104086445255;6116.19576210807;6145.354737752472;6153.292371377349;6159.137720719103;6055.757769689251;6106;6116.174316467309;6124.6325220486915;6149.046897730859;5955.791547295824;5959.67221802805;6058.57589968698;6100.816975490742;6102.298235702862;4787;4846.5153484651255;4855.95144048555;4863.051704917578;4870.561649451566;4331.740095594211;4338.457692788402;4353.085851971058;4356.978215108968;4371;4646.814127434933;5526.171074338881;5545.833624991256;5650.74571644277;5742.885142297131;6107.541934354941;6203.348648391944;6215.223097112861;6224.408681175281;6224.937750622526;5721.5708821838525;5727.31272247333;5732;5732.3121225453215;5781.479666830005;5220.9738951305;5221.660592061504;5262.71055091966;5309;5351.464853514695;6288;6292.748290068346;6294.055891616111;6294.811155665154;6302.716377763103;6178.567500274938;6188.257409110935;6188.288346840171;6190.0405437157315;6210.4100110489435;5418.214358918013;6161.661108639068;6235.625862448268;6264.655443950626;6274.968625156845;4745.383100196952;5652.63257888236;6018.759249630141;6024.608400453956;6043.063325184604;5493.7802487900035;6105.175801266772;6186.876262474815;6225.190725205694;6247.531435142291;6002.069679199731;6028.87942241144;6035.515960209396;6061.393860613904;6083.117947897442;5792.7103644818435;5863.17915491823;6035.849103772441;6049.3950604939155;6049.78825741097;5649.68926709035;5688.146777983336;5782.3639399666845;5785.710714464344;5794.101914203306;4567.040921406542;4908.484609115992;4953.331300274417;5659.717014149359;5902.1441890926435;5729.312482502127;5803.245578074823;5804.477597016289;5808.099744539603;5834.737436815269 07:55:09 INFO - PROCESS | 2202 | |1;ext.html;467.91109689159055;480.21724588920057;517.7851191755421;523.743365750782;554.7628787803199;29217.707822921766;31238.84380578097;31365.745370185195;39836.99999999993;40666.59333406665;40452.393214101736;40850.59149408505;40918;40944.59055409445;40955.79522102393;9327.44035357879;9466.24270058397;9471.763205919839;9517.428954262732;9528.666496672618;9395;9516.619335226582;9526.952365238165;9540.141387275144;9540.856887146698;9490.335676502647;9528.952355238214;9539.47532885691;9547.474888881108;9555.092266234697;9420.528973551329;9456.621735130586;9493.240540756791;9498.192653624381;9508.954015058373;9239.769005774842;9313.813723725556;9328.906710932939;9356;9361.970183279835;38560;38902.80548597267;38952.80523597364;38966;38979.68672662799;2703.783697304211;3450.447928331455;3560.5193298904833;3791.0711875590655;3874.670652994499;27898;27928.860355698296;28424.147275581767;29664.813407463676;29935.952241671435;3160.5101209312593;3180.984095079533;3241.092494101655;3298.109510432194;3301.8679252829857;472748.99999999657;484808;487262;487502;488112.5594372041;57018;57254;57337.713311433174;57403;57720;58656.41343586509;59474.70262648746;59647;59659.70170149121;59679.70160149172;15580.688386232212;15710.450134245246;15815.762763558556;15836.60408489797;15849.445269415515;12247.69380765488;12291.323977181162;12319.445624946899;12322.32227227511;12323.630291091282;15151.166685832164;15241.23793810305;15409;15508.302126404338;15722.68554628901;3150.6376766672124;3250.837458127084;3273.5908011498564;6237.937620623827;6320.462760665303;894.3471265975874;901.6032945503957;917.5045475443319;1012.2762225009154;1044.2742294105676;23864.036021933927;28510.287242818682;29054.06080966241;29450.852745736564;29875;848.3891598049395;852.4714676900361;880.2605811118691;997.4314640654757;1002.8646132771983;14484.565463036126;14914.328855201542;15024.399024038916;15173.468928587667;15493.767593486107;602821;684764;685357;693380.5330973414;694732;55312.17031744446;55599;55674.443255567734;56041.7197914016;56092;1321.2865052871534;1337;1354.133354653023;1360.9591712248648;1363.577291039781;26304;29035.7096429033;29055.56416653794;29244.853775731837;29542.261443464085;48720.756396217796;48892.26661600007;48943.5105648939;49029;49304.26043609277;610779;611547;611973;612398;614188;24716.629250560898;25562.744372556037;25565.84953677126;25582;25612.9754809813;44164.77917610391;44702.3294650574;44903.101937960404;44944.77527612341;45512.54487455083;36729.89810305695;36856.525738970144;37357.25285494329;38530;38610.227795443374;37035.25929481341;37396.13019349076;37899.62100378961;38357;38927.61072389353;29212.56181157327;35010.42453089566;35698.46452303269;36326.45510317294;36647.08382290464;31434;33366.83316583402;33522.66477335196;33542.16144596405;33564.496532551544;24346;24495;24644.630330544696;24973.87513062423;25008.499830002933 07:55:09 INFO - PROCESS | 2202 | |2;jquery.html;339.43484098975205;345.7113310385828;352.98692751802315;380.3458052150301;402.68389314388213;17876.195571199296;18900.810991890077;19597.314094006713;19789.604207915832;19986.800131998676;14859.405623775036;18839.905800470977;19017.904910475463;19424.611507769838;19769.703454448158;5752.568557358194;5978.306608513984;6015.969920150415;6029.758809647609;6049.848753781147;4597.241455159911;5982.670953097578;6038.818835434922;6042;6064.181335519715;5058.544730974211;5857.456238975423;5983.132445795379;6004.5196384289375;6009.5192384609345;5765.625234359753;5835.562332825034;5863.677497737623;5867.149263356832;5877.089051197093;4955.281484184773;5021.221710634857;5146.742662866842;5154.819581314636;5172.250023746573;24145.154919577904;24281.87859060711;24482.755172448225;24619.261422157364;24647.876760616084;2131.893405329743;2203.427108951684;2463.2610216935027;2664.9733502665113;2726.6046423268517;13294.601161965156;14409.78385324221;14646.340914658866;15188.316525756367;15568.37726490939;1782.5008997480597;1879.1543805287538;1892.3376818113688;1895.573495963411;1909.3889955214338;78730.21269787286;89627;91685.54157229238;103258;113353;10286.588536458608;10423.166146708245;10442.843357349646;10808.729781755519;11244.38155901417;13307.534236301683;13395.866041339463;13416.731665366638;13419.530316438877;13422.261775602241;8005;8263.173682631808;8268.875966860502;8340.457870238415;8398.874016889751;7872.960635196788;8278.503289802631;8294.958525207456;8434.030086540126;8460.450070745383;5561.749721262553;5905.43898329658;6306.085617585424;6470.708818103197;6491.058796474485;1589.9205039747967;1784.7150051962567;1787.7944036435977;1827.1321122466722;1830.1215416600107;890.4434728294816;895.3687650206718;921.4517362169498;948.1324588001901;952.7618095476131;19737.901310493642;20900.37298881036;20990.895045524674;21125.577488450144;21154.88451154872;839.8362319347791;864.5072308783933;934.5934518484481;998.5955687946393;1008.5007921079113;10872.67381978542;11243.7662078595;11256;11381.658550243506;11462.484188211383;581279;585363;590055;598557;603802;96646;115682.8431715672;117438;118242;120974.3951280238;944.990550094504;974.3715303629261;976.6776963601994;984.8965858584745;1006.2503434941016;17919.552011199303;18235.81764182394;18648.720269196245;18715.251389944795;18849.811501884804;50516.98966020586;50944;51672.741636291576;52758.472415275355;53030.73484632552;69396.65301673661;69629.30370696228;71306;72227.63886180536;73670;6313.589616674902;7529.1717911028645;7541.585212813348;7662.348700360531;7774.339181169664;11654.883451165719;11694.30432587287;11717.824232636347;11989.76020479603;12448.128630996105;9305.720828375159;9361.876574811065;10147.7463063424;10352.792944141225;10752.51613677402;9549.856752148862;10179.895131984817;10226.670532830685;10320.277580569287;10615.734606634587;8472.661093556435;10334.483275836328;10450.843237351597;10606.098481629147;10892.61875834342;7485.66314515859;7692.153863075169;7696.422768292512;7747.690092396241;7879.803004924923;10045.296829221885;10083.24375671813;10375.169986400919;10714.035736783728;10725.731856703645 07:55:09 INFO - PROCESS | 2202 | |3;mootools.html;1327.867213278672;1454.4691187716483;1481.681438490725;1511.5692027772086;1700.9574760630976;6083.574149809515;7677.6161191940455;7865.449418540705;8293.709720159795;8328.333733301337;7781.455298129134;8047.718329858456;8050.315723163538;8082.070561885385;8144.633491492882;2282.8287878409146;2307.526956973825;2309.9191528296515;2323.314622186459;2343.1915988983774;1826.5890174710717;1939.8739081959627;2285.6228722260807;2347.495288512969;2360.752121027293;1888.4523488188477;2137.2946927513963;2298.9425264368356;2326.592846251899;2329.8234391632286;2266.5466906618576;2274.442761523429;2299.4366380236784;2299.5515874404496;2307.0541078157958;2236.586231547169;2258.299927022612;2260.649599312093;2270.4777901082844;2271.7732424490755;8125.5530945797955;8236.217559331853;8267.379946503976;8304.377171712145;8320.70877519284;4678.321643361727;4937.234728617034;5142.6914385137015;5156.948430515685;5174.379074511083;3255.1699316674335;3257.6579459156683;3395.9320813583836;3458.56767904012;3464.5275757803083;1033.3902997231594;1062.8777690565607;1076.1874784537702;1095.5124969388626;1099.5656715597295;9079.45523268606;10568;10579.259451838374;10679.626213082505;10718.41048742311;4471.172833025836;4487.708298960557;4674.579287864109;4688.226442636995;4716.599089077398;9182.816343673223;9204.309676774268;9258.444493330288;9271.953640231755;9337.972822989466;5140.151874940593;5151.381834179922;5156.664816786897;5167.121589329823;5172.146595811724;4183.686223533247;4548.658850586153;4677.251639737626;4737.24204127338;4756.239001759702;3794.962050379461;3795.7663759277793;3805.6765174960437;3882.398228274622;3937.586553411908;1063.3832377221347;1228.4717571444364;1234.0806099455783;1243.639344590077;1249.900007999358;852.3862818770599;866.3459088388227;870.425519157353;884.5223579267252;887.0464250930276;5555.333359996826;5564.8330550083565;5646.632968857011;5663.093904975184;5699.316082070178;892.6295587331185;903.9322050846213;920.6382168691337;925.0019956893078;928.9702001127558;3675.9448608270895;3676.7977761223387;3715.368387374153;3727.086863718352;3753.9436908446396;9257;9599.136077753035;9794.216462682969;9875.555599997873;9886.901130988597;9861.457619830979;9875.506224688737;9892.25808064398;9895.703128906;9910.35582687123;7587.468877178655;7594.240575942362;7727.690892364242;7791.805204869924;7823.2567906048835;5302.787888484418;5342.572594192377;5395.554493307821;5539.362973257966;5541.8639178967405;9241.491717955309;9246;9254.537273136451;9275.814483710154;9350.205232555038;8984.550772461482;9307.76730581741;9452.669156579486;9461.668841590512;9527.952360238154;6201;6424.582402143846;6435.83910402225;6617.735290588323;6749.358810912955;7664.501807382502;7908.4068694846965;7922.0889597697005;7928.127905930459;7936.047674279123;6922.8615427692175;7070.434365250665;7080.645967701491;7093.432525398059;7169.892451613335;6784.660766961731;6939.340762627542;6990.545614535243;6994.825129371807;7009.088818453569;6386.648734319471;6508.121403610452;6578.309277525982;6611.504137189826;6692.631905245258;4689.155951928686;4696.272077827942;4755.144074066563;4759.6430267729365;4781.4262288524205;4627.074585083064;4702.835400760957;4707.599854012447;4849.151398505318;4934.9753251233515 07:55:09 INFO - PROCESS | 2202 | |4;prototype.html;252.9974700252997;280.8553594898626;305.52795930287704;309.4121169777424;311.7942158175604;4528.328286311076;4629.7777067007855;4931.605471562271;5354.965113256967;5434.266374039504;5182.896342073156;5306.124489459235;5376.91934620981;5387.811426600069;5446.645968012086;3376.8687489690983;3865.8260378283044;4122.835086596532;4143.19207754488;4150.667946564276;3912.9043867717087;4090.8568200113;4109.103082326952;4133.793310334471;4150.97924510377;3245.496947973068;3706.5366829146355;4067.1865626874596;4075.5924407559305;4092.7544347339253;4067.8576249831112;4068.816903239361;4080.0823612902186;4090.427340172378;4092.5907409258984;3335.466325387926;3537.398642230827;3559.661832125944;3589.4974703541266;3597.928041439183;4381.145676593065;4438.60052595268;5240.423553409122;5260.579153667697;5268.736563171826;4449.933251001237;4685.578297953167;4690.366800481959;4698.647601429906;4709.552592503741;5630.5495560355075;5639;5651.8587035324035;5674.943250567483;5696.77212911483;3726.65852259978;3901.5174233791263;3918.1967696622123;3919.7060220483577;3935.9729739184345;4801.927971080437;5424.945750542483;5437.782488700487;5687.7156142192725;5782.566307526952;3976.8011599419915;3982.78094704794;3991.620796024431;4003.3794761811964;4008.6592639625374;3233.8221397822876;3907.5115610548683;4041.535223449282;4044.7775372354213;4074.4499492568716;4318.589733975267;4541.000979784442;4596.747178905125;4607.539246075366;4638.907221855544;5194.246834209019;5336.67979921206;5374.973125134349;5775.653460792366;5780.277465316835;1099.9660319299833;1183.7573297473998;1211.9636410907688;1248.8126780982925;1274.133589159362;771.7844395077775;854.030675183671;867.6095756909416;874.776931882366;878.7539488943106;4642.0019695764895;4999.575036121898;5180.264611355163;5217.921731174036;5246.396664383568;4985.5762260208285;5248.897731476356;5398.838034858961;5511.208857121452;5613.7193140342815;4620.699654522446;5037.546620804072;5159.561437277874;5171.431712118626;5188.273641690166;2939.8093772022366;2940;2957.742959242313;2960.7779416543844;2984.8956485677545;4999.925001124986;5310.9734451327495;5634.408387119375;5979.431953964367;6093.415711914846;4888.780004899788;5328.014317351302;5527.756254842629;5759.308882933991;5763;5239.790408383698;5275.494140283411;5434.972825135849;5536.750846211849;5999.880002399927;5435.537285028521;5476.589255805751;5619.775208991595;5656.490915817596;5667.858303542444;5503.7798488061635;5868.977476599469;5905.435059709094;5929.733162007634;5976.970115149396;5031.698098114125;5409.972950135224;6100.725467354068;6266.561340706106;6268.424050443111;3033.8366669301536;3567.1795487038644;3665.3402387570495;3910.413437984211;3943.309920763912;4722.834700785456;4747.952520474751;5473.945260547343;5618.52242559387;6006.819795406145;5562.3047119110115;5595.5803314752375;5698.54411647059;5749.396313387034;5805.651660900359;5057.898842023065;5545.72271386421;5823.718781868151;5830.912536311874;5850.970745146417;5046.899062018812;5174.97412512935;5403.540699040625;5432.022235997559;5605.915911261416;5501.477359650827;5601.747921343631;5666.943330566642;5761.8559536011935;5796.710164491674;5574.9721251393485;5590.413006634408;5654.06707893193;5689.829305120853;5698.344690360662 07:55:09 INFO - PROCESS | 2202 | |5;yui.html;619.4394073363604;754.9169591344954;756.9129550101736;757.4773406349618;788.1921030943284;13937.372818223179;14709.852901470982;14765.335559899804;14790.482333118343;14803.963722539427;12961.416736246869;13079.673008174801;13159.14465559738;13289;13460.125091869046;641.804249703839;666.5234357434433;793.5516433215244;819.9959000205021;825.4593241426845;812.8658771302728;820.7004443378154;821.1214001018913;821.4824660463929;824.3116997307255;879.3888247667874;882.2677177942293;885.4156256870467;887.9334049946248;890.3100097424483;738.8928605352221;850.8425941200867;874.5321253129545;878.0780180810124;880.5377176982072;639.2361128451503;653.2389765922694;656.3174298729316;658.9505787065989;661.576590981772;13311.134776239513;13551.45794168242;13568.59294221175;13578.25319607431;14191.219482928434;13417.66455838602;13583.932080339633;13624.863751362558;13696.315184240848;14027.158370497802;11109.111271098292;11312.434378281136;11393.829092563536;11410.600628978029;11498.540058397653;3580.104973756561;3601.1897323102353;3604.3692353838237;3630.146915474861;3687.967369136646;88362;89077;91344.17311653796;93050.06949930482;95641.52179239129;8718.17177368149;9078.636854525877;10219.489025548693;10516.842247366296;10632.989865962722;20476.590468190552;20512.487187820425;20542.486437838874;20578.176872925214;20595.58808823815;7181.784546463615;7355.5586664800285;7486.475946683789;7502.699892004368;7645.808854778675;4090.4886889138857;4128.979355103265;4161.791910404468;4255.042615411569;4306.354046892991;3284.211789170582;3310.4372256715933;3329.3174899145615;3371.190914180628;3378.476336167898;605.5065121925617;608.4979891589456;617.0682269772676;624.3163735709481;626.5927147354165;616.5653214483779;627.1533429869639;628.8144997225829;636.1602684456473;682.8941514065327;6813.897791533131;8574.528400937883;8740.912590874137;8807;9086;556.4213218253052;577.0737965565291;627.3381582430488;628.7013668507423;657.9013148027834;4171.186618609403;4367.75977321244;4390.604845563915;4391.209582275221;4462;69803;71410.9288360675;87242;88160.5591972036;111700;60172;63277.36722632807;63403.68298158572;72279.91580126302;94598;58647.706761466776;74037.25962740411;80147;82251;83811.16188838155;7261.963690181516;8309.709160179365;8431.241188293083;8555.081826441992;8681.877994885519;55623.443765561824;57139.428605715075;58110.7094464525;58450.4154958445;58848;82036.58981705054;82049;83072.58463707643;84155.31689366057;85447.14552854392;11210.66368008961;11395.544178232778;11403.828942565702;11420.257683250562;11602.6519204424;11597.18819682614;11738.94130529342;12047.096467764777;12243.081768867192;12335.69160770952;11600.593979210687;12491.562795302485;12660.366981651065;12717.80923286133;13260.204387736767;12601.306928119042;12635.305058221518;12902.032347573782;12970.416331265304;13630.386632601754;12093;12445.751084978068;12605.24368537854;13436.664083397602;13472.393742281425;10872.402017889091;11047.447627618427;11082.889171108185;11223.270487418291;11442.970132688099;10317.380957142595;10779.838302425313;10853.186011049045;11207.327560346404;11211.327320360804 07:55:09 INFO - PROCESS | 2202 | __end_tp_report 07:55:09 INFO - PROCESS | 2202 | __start_cc_report 07:55:09 INFO - PROCESS | 2202 | _x_x_mozilla_cycle_collect,379 07:55:09 INFO - PROCESS | 2202 | __end_cc_report 07:55:09 INFO - PROCESS | 2202 | __startTimestamp1481471709724__endTimestamp 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | ------- Summary: start ------- 07:55:09 INFO - PROCESS | 2202 | Number of tests: 6 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | [#0] dojo.html Cycles:165 Average:5579.15 Median:5742.89 stddev:671.03 (11.7%) stddev-sans-first:637.65 07:55:09 INFO - PROCESS | 2202 | Values: 2835.9 3328.2 3344.9 3369.0 3390.0 5573.8 5585.5 5587.6 5619.2 5640.7 5547.3 5582.5 5605.1 5643.3 5678.9 5081.0 5097.2 5189.6 5199.1 5209.3 5136.0 5176.8 5184.1 5202.7 5240.3 5019.4 5078.9 5111.3 5162.5 5163.0 5097.8 5102.3 5127.2 5135.9 5141.0 4884.7 4939.2 5040.3 5043.5 5091.6 4225.8 4302.5 5470.9 5528.1 5627.2 6144.4 6150.7 6154.1 6163.2 6179.0 5430.7 6005.1 6157.7 6175.8 6187.8 5706.8 5754.1 5763.1 5780.3 5788.8 6260.5 6267.8 6293.5 6297.9 6319.1 4862.4 5844.5 5904.6 5937.5 5963.7 6101.3 6116.2 6145.4 6153.3 6159.1 6055.8 6106.0 6116.2 6124.6 6149.0 5955.8 5959.7 6058.6 6100.8 6102.3 4787.0 4846.5 4856.0 4863.1 4870.6 4331.7 4338.5 4353.1 4357.0 4371.0 4646.8 5526.2 5545.8 5650.7 5742.9 6107.5 6203.3 6215.2 6224.4 6224.9 5721.6 5727.3 5732.0 5732.3 5781.5 5221.0 5221.7 5262.7 5309.0 5351.5 6288.0 6292.7 6294.1 6294.8 6302.7 6178.6 6188.3 6188.3 6190.0 6210.4 5418.2 6161.7 6235.6 6264.7 6275.0 4745.4 5652.6 6018.8 6024.6 6043.1 5493.8 6105.2 6186.9 6225.2 6247.5 6002.1 6028.9 6035.5 6061.4 6083.1 5792.7 5863.2 6035.8 6049.4 6049.8 5649.7 5688.1 5782.4 5785.7 5794.1 4567.0 4908.5 4953.3 5659.7 5902.1 5729.3 5803.2 5804.5 5808.1 5834.7 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | [#1] ext.html Cycles:180 Average:70791.72 Median:38940.21 stddev:159499.09 (409.6%) stddev-sans-first:159859.14 07:55:09 INFO - PROCESS | 2202 | Values: 467.9 480.2 517.8 523.7 554.8 29217.7 31238.8 31365.7 39837.0 40666.6 40452.4 40850.6 40918.0 40944.6 40955.8 9327.4 9466.2 9471.8 9517.4 9528.7 9395.0 9516.6 9527.0 9540.1 9540.9 9490.3 9529.0 9539.5 9547.5 9555.1 9420.5 9456.6 9493.2 9498.2 9509.0 9239.8 9313.8 9328.9 9356.0 9362.0 38560.0 38902.8 38952.8 38966.0 38979.7 2703.8 3450.4 3560.5 3791.1 3874.7 27898.0 27928.9 28424.1 29664.8 29936.0 3160.5 3181.0 3241.1 3298.1 3301.9 472749.0 484808.0 487262.0 487502.0 488112.6 57018.0 57254.0 57337.7 57403.0 57720.0 58656.4 59474.7 59647.0 59659.7 59679.7 15580.7 15710.5 15815.8 15836.6 15849.4 12247.7 12291.3 12319.4 12322.3 12323.6 15151.2 15241.2 15409.0 15508.3 15722.7 3150.6 3250.8 3273.6 6237.9 6320.5 894.3 901.6 917.5 1012.3 1044.3 23864.0 28510.3 29054.1 29450.9 29875.0 848.4 852.5 880.3 997.4 1002.9 14484.6 14914.3 15024.4 15173.5 15493.8 602821.0 684764.0 685357.0 693380.5 694732.0 55312.2 55599.0 55674.4 56041.7 56092.0 1321.3 1337.0 1354.1 1361.0 1363.6 26304.0 29035.7 29055.6 29244.9 29542.3 48720.8 48892.3 48943.5 49029.0 49304.3 610779.0 611547.0 611973.0 612398.0 614188.0 24716.6 25562.7 25565.8 25582.0 25613.0 44164.8 44702.3 44903.1 44944.8 45512.5 36729.9 36856.5 37357.3 38530.0 38610.2 37035.3 37396.1 37899.6 38357.0 38927.6 29212.6 35010.4 35698.5 36326.5 36647.1 31434.0 33366.8 33522.7 33542.2 33564.5 24346.0 24495.0 24644.6 24973.9 25008.5 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | [#2] jquery.html Cycles:180 Average:33422.24 Median:349.35 stddev:98004.13 (28053.3%) stddev-sans-first:98247.57 07:55:09 INFO - PROCESS | 2202 | Values: 339.4 345.7 353.0 380.3 402.7 17876.2 18900.8 19597.3 19789.6 19986.8 14859.4 18839.9 19017.9 19424.6 19769.7 5752.6 5978.3 6016.0 6029.8 6049.8 4597.2 5982.7 6038.8 6042.0 6064.2 5058.5 5857.5 5983.1 6004.5 6009.5 5765.6 5835.6 5863.7 5867.1 5877.1 4955.3 5021.2 5146.7 5154.8 5172.3 24145.2 24281.9 24482.8 24619.3 24647.9 2131.9 2203.4 2463.3 2665.0 2726.6 13294.6 14409.8 14646.3 15188.3 15568.4 1782.5 1879.2 1892.3 1895.6 1909.4 78730.2 89627.0 91685.5 103258.0 113353.0 10286.6 10423.2 10442.8 10808.7 11244.4 13307.5 13395.9 13416.7 13419.5 13422.3 8005.0 8263.2 8268.9 8340.5 8398.9 7873.0 8278.5 8295.0 8434.0 8460.5 5561.7 5905.4 6306.1 6470.7 6491.1 1589.9 1784.7 1787.8 1827.1 1830.1 890.4 895.4 921.5 948.1 952.8 19737.9 20900.4 20990.9 21125.6 21154.9 839.8 864.5 934.6 998.6 1008.5 10872.7 11243.8 11256.0 11381.7 11462.5 581279.0 585363.0 590055.0 598557.0 603802.0 96646.0 115682.8 117438.0 118242.0 120974.4 945.0 974.4 976.7 984.9 1006.3 17919.6 18235.8 18648.7 18715.3 18849.8 50517.0 50944.0 51672.7 52758.5 53030.7 69396.7 69629.3 71306.0 72227.6 73670.0 6313.6 7529.2 7541.6 7662.3 7774.3 11654.9 11694.3 11717.8 11989.8 12448.1 9305.7 9361.9 10147.7 10352.8 10752.5 9549.9 10179.9 10226.7 10320.3 10615.7 8472.7 10334.5 10450.8 10606.1 10892.6 7485.7 7692.2 7696.4 7747.7 7879.8 10045.3 10083.2 10375.2 10714.0 10725.7 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | [#3] mootools.html Cycles:180 Average:5331.13 Median:5369.06 stddev:2906.93 (54.1%) stddev-sans-first:2899.51 07:55:09 INFO - PROCESS | 2202 | Values: 1327.9 1454.5 1481.7 1511.6 1701.0 6083.6 7677.6 7865.4 8293.7 8328.3 7781.5 8047.7 8050.3 8082.1 8144.6 2282.8 2307.5 2309.9 2323.3 2343.2 1826.6 1939.9 2285.6 2347.5 2360.8 1888.5 2137.3 2298.9 2326.6 2329.8 2266.5 2274.4 2299.4 2299.6 2307.1 2236.6 2258.3 2260.6 2270.5 2271.8 8125.6 8236.2 8267.4 8304.4 8320.7 4678.3 4937.2 5142.7 5156.9 5174.4 3255.2 3257.7 3395.9 3458.6 3464.5 1033.4 1062.9 1076.2 1095.5 1099.6 9079.5 10568.0 10579.3 10679.6 10718.4 4471.2 4487.7 4674.6 4688.2 4716.6 9182.8 9204.3 9258.4 9272.0 9338.0 5140.2 5151.4 5156.7 5167.1 5172.1 4183.7 4548.7 4677.3 4737.2 4756.2 3795.0 3795.8 3805.7 3882.4 3937.6 1063.4 1228.5 1234.1 1243.6 1249.9 852.4 866.3 870.4 884.5 887.0 5555.3 5564.8 5646.6 5663.1 5699.3 892.6 903.9 920.6 925.0 929.0 3675.9 3676.8 3715.4 3727.1 3753.9 9257.0 9599.1 9794.2 9875.6 9886.9 9861.5 9875.5 9892.3 9895.7 9910.4 7587.5 7594.2 7727.7 7791.8 7823.3 5302.8 5342.6 5395.6 5539.4 5541.9 9241.5 9246.0 9254.5 9275.8 9350.2 8984.6 9307.8 9452.7 9461.7 9528.0 6201.0 6424.6 6435.8 6617.7 6749.4 7664.5 7908.4 7922.1 7928.1 7936.0 6922.9 7070.4 7080.6 7093.4 7169.9 6784.7 6939.3 6990.5 6994.8 7009.1 6386.6 6508.1 6578.3 6611.5 6692.6 4689.2 4696.3 4755.1 4759.6 4781.4 4627.1 4702.8 4707.6 4849.2 4935.0 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | [#4] prototype.html Cycles:180 Average:4544.22 Median:5177.62 stddev:1401.68 (27.1%) stddev-sans-first:1368.10 07:55:09 INFO - PROCESS | 2202 | Values: 253.0 280.9 305.5 309.4 311.8 4528.3 4629.8 4931.6 5355.0 5434.3 5182.9 5306.1 5376.9 5387.8 5446.6 3376.9 3865.8 4122.8 4143.2 4150.7 3912.9 4090.9 4109.1 4133.8 4151.0 3245.5 3706.5 4067.2 4075.6 4092.8 4067.9 4068.8 4080.1 4090.4 4092.6 3335.5 3537.4 3559.7 3589.5 3597.9 4381.1 4438.6 5240.4 5260.6 5268.7 4449.9 4685.6 4690.4 4698.6 4709.6 5630.5 5639.0 5651.9 5674.9 5696.8 3726.7 3901.5 3918.2 3919.7 3936.0 4801.9 5424.9 5437.8 5687.7 5782.6 3976.8 3982.8 3991.6 4003.4 4008.7 3233.8 3907.5 4041.5 4044.8 4074.4 4318.6 4541.0 4596.7 4607.5 4638.9 5194.2 5336.7 5375.0 5775.7 5780.3 1100.0 1183.8 1212.0 1248.8 1274.1 771.8 854.0 867.6 874.8 878.8 4642.0 4999.6 5180.3 5217.9 5246.4 4985.6 5248.9 5398.8 5511.2 5613.7 4620.7 5037.5 5159.6 5171.4 5188.3 2939.8 2940.0 2957.7 2960.8 2984.9 4999.9 5311.0 5634.4 5979.4 6093.4 4888.8 5328.0 5527.8 5759.3 5763.0 5239.8 5275.5 5435.0 5536.8 5999.9 5435.5 5476.6 5619.8 5656.5 5667.9 5503.8 5869.0 5905.4 5929.7 5977.0 5031.7 5410.0 6100.7 6266.6 6268.4 3033.8 3567.2 3665.3 3910.4 3943.3 4722.8 4748.0 5473.9 5618.5 6006.8 5562.3 5595.6 5698.5 5749.4 5805.7 5057.9 5545.7 5823.7 5830.9 5851.0 5046.9 5175.0 5403.5 5432.0 5605.9 5501.5 5601.7 5666.9 5761.9 5796.7 5575.0 5590.4 5654.1 5689.8 5698.3 07:55:09 INFO - PROCESS | 2202 | 07:55:09 INFO - PROCESS | 2202 | [#5] yui.html Cycles:180 Average:19203.94 Median:56381.44 stddev:27261.53 (48.4%) stddev-sans-first:27302.29 07:55:09 INFO - PROCESS | 2202 | Values: 619.4 754.9 756.9 757.5 788.2 13937.4 14709.9 14765.3 14790.5 14804.0 12961.4 13079.7 13159.1 13289.0 13460.1 641.8 666.5 793.6 820.0 825.5 812.9 820.7 821.1 821.5 824.3 879.4 882.3 885.4 887.9 890.3 738.9 850.8 874.5 878.1 880.5 639.2 653.2 656.3 659.0 661.6 13311.1 13551.5 13568.6 13578.3 14191.2 13417.7 13583.9 13624.9 13696.3 14027.2 11109.1 11312.4 11393.8 11410.6 11498.5 3580.1 3601.2 3604.4 3630.1 3688.0 88362.0 89077.0 91344.2 93050.1 95641.5 8718.2 9078.6 10219.5 10516.8 10633.0 20476.6 20512.5 20542.5 20578.2 20595.6 7181.8 7355.6 7486.5 7502.7 7645.8 4090.5 4129.0 4161.8 4255.0 4306.4 3284.2 3310.4 3329.3 3371.2 3378.5 605.5 608.5 617.1 624.3 626.6 616.6 627.2 628.8 636.2 682.9 6813.9 8574.5 8740.9 8807.0 9086.0 556.4 577.1 627.3 628.7 657.9 4171.2 4367.8 4390.6 4391.2 4462.0 69803.0 71410.9 87242.0 88160.6 111700.0 60172.0 63277.4 63403.7 72279.9 94598.0 58647.7 74037.3 80147.0 82251.0 83811.2 7262.0 8309.7 8431.2 8555.1 8681.9 55623.4 57139.4 58110.7 58450.4 58848.0 82036.6 82049.0 83072.6 84155.3 85447.1 11210.7 11395.5 11403.8 11420.3 11602.7 11597.2 11738.9 12047.1 12243.1 12335.7 11600.6 12491.6 12660.4 12717.8 13260.2 12601.3 12635.3 12902.0 12970.4 13630.4 12093.0 12445.8 12605.2 13436.7 13472.4 10872.4 11047.4 11082.9 11223.3 11443.0 10317.4 10779.8 10853.2 11207.3 11211.3 07:55:09 INFO - PROCESS | 2202 | -------- Summary: end -------- 07:55:09 INFO - PROCESS | 2202 | 07:55:10 INFO - TEST-INFO | 2202: exit 0 07:55:10 INFO - TEST-OK | dromaeo_css | took 1116682ms 07:55:10 INFO - TEST-START | kraken 07:55:10 INFO - operating with platform_type : mac_ 07:55:10 INFO - Initialising browser for kraken test... 07:55:10 INFO - TEST-INFO | started process 2208 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpAUvfJe/profile http://localhost:54705/getInfo.html) 07:55:13 INFO - PROCESS | 2208 | 2016-12-11 07:55:13.251 plugin-container[2209:23660] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 07:55:13 INFO - PROCESS | 2208 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:13 INFO - PROCESS | 2208 | 2016-12-11 07:55:13.254 plugin-container[2209:23660] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:55:13 INFO - PROCESS | 2208 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:13 INFO - PROCESS | 2208 | 2016-12-11 07:55:13.254 plugin-container[2209:23660] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:13 INFO - PROCESS | 2208 | __metrics Screen width/height:1600/1200 07:55:13 INFO - PROCESS | 2208 | colorDepth:24 07:55:13 INFO - PROCESS | 2208 | Browser inner width/height: 1024/663 07:55:13 INFO - PROCESS | 2208 | __metrics 07:55:13 ERROR - PROCESS | 2208 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:55:14 INFO - TEST-INFO | 2208: exit 0 07:55:14 INFO - Browser initialized. 07:55:14 INFO - Running cycle 1/1 for kraken test... 07:55:14 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpAUvfJe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:16 INFO - PROCESS | 2210 | 2016-12-11 07:55:16.840 plugin-container[2211:23787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 07:55:16 INFO - PROCESS | 2210 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:16 INFO - PROCESS | 2210 | 2016-12-11 07:55:16.841 plugin-container[2211:23787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 07:55:16 INFO - PROCESS | 2210 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:16 INFO - PROCESS | 2210 | 2016-12-11 07:55:16.841 plugin-container[2211:23787] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:26 INFO - PROCESS | 2210 | RSS: Main: 236830720 07:55:26 INFO - PROCESS | 2210 | 07:55:29 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54705/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:30 INFO - PROCESS | 2210 | RSS: Main: 246493184 07:55:30 INFO - PROCESS | 2210 | 07:55:32 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54705/tests/kraken/driver.html?testName=audio-dft) 07:55:33 INFO - PROCESS | 2210 | RSS: Main: 254078976 07:55:33 INFO - PROCESS | 2210 | 07:55:36 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54705/tests/kraken/driver.html?testName=audio-fft) 07:55:37 INFO - PROCESS | 2210 | RSS: Main: 254963712 07:55:37 INFO - PROCESS | 2210 | 07:55:39 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54705/tests/kraken/driver.html?testName=audio-oscillator) 07:55:39 INFO - PROCESS | 2210 | RSS: Main: 254787584 07:55:39 INFO - PROCESS | 2210 | 07:55:41 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54705/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:42 INFO - PROCESS | 2210 | RSS: Main: 254853120 07:55:42 INFO - PROCESS | 2210 | 07:55:45 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54705/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:46 INFO - PROCESS | 2210 | RSS: Main: 258928640 07:55:46 INFO - PROCESS | 2210 | 07:55:49 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54705/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:49 INFO - PROCESS | 2210 | RSS: Main: 259448832 07:55:49 INFO - PROCESS | 2210 | 07:55:52 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54705/tests/kraken/driver.html?testName=json-parse-financial) 07:55:53 INFO - PROCESS | 2210 | RSS: Main: 258850816 07:55:53 INFO - PROCESS | 2210 | 07:55:55 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54705/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:55 INFO - PROCESS | 2210 | RSS: Main: 257323008 07:55:55 INFO - PROCESS | 2210 | 07:55:57 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:58 INFO - PROCESS | 2210 | RSS: Main: 257519616 07:55:58 INFO - PROCESS | 2210 | 07:56:00 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:01 INFO - PROCESS | 2210 | RSS: Main: 257429504 07:56:01 INFO - PROCESS | 2210 | 07:56:04 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:05 INFO - PROCESS | 2210 | RSS: Main: 257871872 07:56:05 INFO - PROCESS | 2210 | 07:56:08 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:08 INFO - PROCESS | 2210 | RSS: Main: 258056192 07:56:08 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:54705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54705/tests/kraken/driver.html?testName=ai-astar) 07:56:10 INFO - PROCESS | 2210 | RSS: Main: 259641344 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | __start_tp_report 07:56:10 INFO - PROCESS | 2210 | _x_x_mozilla_page_load 07:56:10 INFO - PROCESS | 2210 | _x_x_mozilla_page_load_details 07:56:10 INFO - PROCESS | 2210 | |i|pagename|runs| 07:56:10 INFO - PROCESS | 2210 | |0;ai-astar;114;117;118;126;120;119;117;118;127;176 07:56:10 INFO - PROCESS | 2210 | |1;audio-beat-detection;154;115;117;168;150;127;119;116;145;115 07:56:10 INFO - PROCESS | 2210 | |2;audio-dft;196;205;198;210;196;196;195;200;197;196 07:56:10 INFO - PROCESS | 2210 | |3;audio-fft;78;59;58;85;61;60;60;57;79;58 07:56:10 INFO - PROCESS | 2210 | |4;audio-oscillator;84;71;89;73;70;66;113;100;96;87 07:56:10 INFO - PROCESS | 2210 | |5;imaging-gaussian-blur;89;86;89;87;109;86;136;131;88;93 07:56:10 INFO - PROCESS | 2210 | |6;imaging-darkroom;98;99;98;103;144;173;145;99;161;98 07:56:10 INFO - PROCESS | 2210 | |7;imaging-desaturate;90;89;125;73;140;141;136;92;95;126 07:56:10 INFO - PROCESS | 2210 | |8;json-parse-financial;57;55;56;62;83;90;90;91;62;59 07:56:10 INFO - PROCESS | 2210 | |9;json-stringify-tinderbox;71;75;83;86;79;72;71;71;73;64 07:56:10 INFO - PROCESS | 2210 | |10;stanford-crypto-aes;99;105;85;80;90;94;82;87;107;98 07:56:10 INFO - PROCESS | 2210 | |11;stanford-crypto-ccm;140;153;149;148;155;175;152;147;209;174 07:56:10 INFO - PROCESS | 2210 | |12;stanford-crypto-pbkdf2;171;171;169;172;188;234;178;172;169;178 07:56:10 INFO - PROCESS | 2210 | |13;stanford-crypto-sha256-iterative;68;72;64;85;89;87;88;76;67;71 07:56:10 INFO - PROCESS | 2210 | __end_tp_report 07:56:10 INFO - PROCESS | 2210 | __start_cc_report 07:56:10 INFO - PROCESS | 2210 | _x_x_mozilla_cycle_collect,969 07:56:10 INFO - PROCESS | 2210 | __end_cc_report 07:56:10 INFO - PROCESS | 2210 | __startTimestamp1481471770945__endTimestamp 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | ------- Summary: start ------- 07:56:10 INFO - PROCESS | 2210 | Number of tests: 14 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#0] ai-astar Cycles:10 Average:125.20 Median:119.50 stddev:18.30 (15.3%) stddev-sans-first:18.95 07:56:10 INFO - PROCESS | 2210 | Values: 114.0 117.0 118.0 126.0 120.0 119.0 117.0 118.0 127.0 176.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:136.00 stddev:19.78 (14.5%) stddev-sans-first:19.41 07:56:10 INFO - PROCESS | 2210 | Values: 154.0 115.0 117.0 168.0 150.0 127.0 119.0 116.0 145.0 115.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#2] audio-dft Cycles:10 Average:198.90 Median:197.50 stddev:4.89 (2.5%) stddev-sans-first:5.07 07:56:10 INFO - PROCESS | 2210 | Values: 196.0 205.0 198.0 210.0 196.0 196.0 195.0 200.0 197.0 196.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#3] audio-fft Cycles:10 Average:65.50 Median:60.50 stddev:10.68 (17.7%) stddev-sans-first:10.33 07:56:10 INFO - PROCESS | 2210 | Values: 78.0 59.0 58.0 85.0 61.0 60.0 60.0 57.0 79.0 58.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:78.50 stddev:15.19 (19.4%) stddev-sans-first:16.11 07:56:10 INFO - PROCESS | 2210 | Values: 84.0 71.0 89.0 73.0 70.0 66.0 113.0 100.0 96.0 87.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:87.50 stddev:19.24 (22.0%) stddev-sans-first:20.03 07:56:10 INFO - PROCESS | 2210 | Values: 89.0 86.0 89.0 87.0 109.0 86.0 136.0 131.0 88.0 93.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#6] imaging-darkroom Cycles:10 Average:121.80 Median:98.00 stddev:30.33 (31.0%) stddev-sans-first:30.93 07:56:10 INFO - PROCESS | 2210 | Values: 98.0 99.0 98.0 103.0 144.0 173.0 145.0 99.0 161.0 98.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#7] imaging-desaturate Cycles:10 Average:110.70 Median:81.00 stddev:25.32 (31.3%) stddev-sans-first:25.73 07:56:10 INFO - PROCESS | 2210 | Values: 90.0 89.0 125.0 73.0 140.0 141.0 136.0 92.0 95.0 126.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#8] json-parse-financial Cycles:10 Average:70.50 Median:72.50 stddev:15.80 (21.8%) stddev-sans-first:15.98 07:56:10 INFO - PROCESS | 2210 | Values: 57.0 55.0 56.0 62.0 83.0 90.0 90.0 91.0 62.0 59.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#9] json-stringify-tinderbox Cycles:10 Average:74.50 Median:74.00 stddev:6.50 (8.8%) stddev-sans-first:6.77 07:56:10 INFO - PROCESS | 2210 | Values: 71.0 75.0 83.0 86.0 79.0 72.0 71.0 71.0 73.0 64.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:88.50 stddev:9.43 (10.7%) stddev-sans-first:9.72 07:56:10 INFO - PROCESS | 2210 | Values: 99.0 105.0 85.0 80.0 90.0 94.0 82.0 87.0 107.0 98.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:154.00 stddev:20.53 (13.3%) stddev-sans-first:20.43 07:56:10 INFO - PROCESS | 2210 | Values: 140.0 153.0 149.0 148.0 155.0 175.0 152.0 147.0 209.0 174.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:175.00 stddev:19.78 (11.3%) stddev-sans-first:20.69 07:56:10 INFO - PROCESS | 2210 | Values: 171.0 171.0 169.0 172.0 188.0 234.0 178.0 172.0 169.0 178.0 07:56:10 INFO - PROCESS | 2210 | 07:56:10 INFO - PROCESS | 2210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:80.50 stddev:9.66 (12.0%) stddev-sans-first:9.72 07:56:10 INFO - PROCESS | 2210 | Values: 68.0 72.0 64.0 85.0 89.0 87.0 88.0 76.0 67.0 71.0 07:56:10 INFO - PROCESS | 2210 | -------- Summary: end -------- 07:56:10 INFO - PROCESS | 2210 | 07:56:11 INFO - TEST-INFO | 2210: exit 0 07:56:12 INFO - TEST-OK | kraken | took 61572ms 07:56:12 INFO - SUITE-END | took 1178s 07:56:12 INFO - Completed test suite (00:19:38) 07:56:12 INFO - javascript benchmark 07:56:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7045.873204650484, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2835.914922552324, 3328.151321413039, 3344.9498257526143, 3368.9663103368957, 3389.9830050984697, 5573.777048918048, 5585.525230355424, 5587.608867379285, 5619.241402410673, 5640.74616642251, 5547.33431988161, 5582.525485333752, 5605.103183490643, 5643.294588176478, 5678.864227154565, 5081.009203205376, 5097.184450487923, 5189.636725429222, 5199.090159222121, 5209.348831396075, 5135.9743201283945, 5176.792928282883, 5184.092783762845, 5202.687838729688, 5240.292560504321, 5019.372578427697, 5078.898422031576, 5111.335526381566, 5162.535371816554, 5162.993216322819, 5097.770600322994, 5102.311187989611, 5127.154019586801, 5135.87160320995, 5141.0, 4884.658073934826, 4939.234418665113, 5040.34475518184, 5043.4956504349275, 5091.567216786578, 4225.830966761326, 4302.548232435581, 5470.9452905470835, 5528.06022976095, 5627.184058311563, 6144.385561443864, 6150.66171360575, 6154.138420621117, 6163.1679723237685, 6178.9691051544905, 5430.728463576845, 6005.069214271794, 6157.661328626924, 6175.845603859894, 6187.81436556904, 5706.828795136153, 5754.079347304411, 5763.106718458645, 5780.277465316835, 5788.768449262025, 6260.530460215502, 6267.811965641038, 6293.496520278458, 6297.905531417033, 6319.05214217871, 4862.3922009748785, 5844.532437405082, 5904.5571582131515, 5937.495312898452, 5963.671998040063, 6101.3104086445255, 6116.19576210807, 6145.354737752472, 6153.292371377349, 6159.137720719103, 6055.757769689251, 6106.0, 6116.174316467309, 6124.6325220486915, 6149.046897730859, 5955.791547295824, 5959.67221802805, 6058.57589968698, 6100.816975490742, 6102.298235702862, 4787.0, 4846.5153484651255, 4855.95144048555, 4863.051704917578, 4870.561649451566, 4331.740095594211, 4338.457692788402, 4353.085851971058, 4356.978215108968, 4371.0, 4646.814127434933, 5526.171074338881, 5545.833624991256, 5650.74571644277, 5742.885142297131, 6107.541934354941, 6203.348648391944, 6215.223097112861, 6224.408681175281, 6224.937750622526, 5721.5708821838525, 5727.31272247333, 5732.0, 5732.3121225453215, 5781.479666830005, 5220.9738951305, 5221.660592061504, 5262.71055091966, 5309.0, 5351.464853514695, 6288.0, 6292.748290068346, 6294.055891616111, 6294.811155665154, 6302.716377763103, 6178.567500274938, 6188.257409110935, 6188.288346840171, 6190.0405437157315, 6210.4100110489435, 5418.214358918013, 6161.661108639068, 6235.625862448268, 6264.655443950626, 6274.968625156845, 4745.383100196952, 5652.63257888236, 6018.759249630141, 6024.608400453956, 6043.063325184604, 5493.7802487900035, 6105.175801266772, 6186.876262474815, 6225.190725205694, 6247.531435142291, 6002.069679199731, 6028.87942241144, 6035.515960209396, 6061.393860613904, 6083.117947897442, 5792.7103644818435, 5863.17915491823, 6035.849103772441, 6049.3950604939155, 6049.78825741097, 5649.68926709035, 5688.146777983336, 5782.3639399666845, 5785.710714464344, 5794.101914203306, 4567.040921406542, 4908.484609115992, 4953.331300274417, 5659.717014149359, 5902.1441890926435, 5729.312482502127, 5803.245578074823, 5804.477597016289, 5808.099744539603, 5834.737436815269], "value": 5537.0542644022225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.91109689159055, 480.21724588920057, 517.7851191755421, 523.743365750782, 554.7628787803199, 29217.707822921766, 31238.84380578097, 31365.745370185195, 39836.99999999993, 40666.59333406665, 40452.393214101736, 40850.59149408505, 40918.0, 40944.59055409445, 40955.79522102393, 9327.44035357879, 9466.24270058397, 9471.763205919839, 9517.428954262732, 9528.666496672618, 9395.0, 9516.619335226582, 9526.952365238165, 9540.141387275144, 9540.856887146698, 9490.335676502647, 9528.952355238214, 9539.47532885691, 9547.474888881108, 9555.092266234697, 9420.528973551329, 9456.621735130586, 9493.240540756791, 9498.192653624381, 9508.954015058373, 9239.769005774842, 9313.813723725556, 9328.906710932939, 9356.0, 9361.970183279835, 38560.0, 38902.80548597267, 38952.80523597364, 38966.0, 38979.68672662799, 2703.783697304211, 3450.447928331455, 3560.5193298904833, 3791.0711875590655, 3874.670652994499, 27898.0, 27928.860355698296, 28424.147275581767, 29664.813407463676, 29935.952241671435, 3160.5101209312593, 3180.984095079533, 3241.092494101655, 3298.109510432194, 3301.8679252829857, 472748.99999999657, 484808.0, 487262.0, 487502.0, 488112.5594372041, 57018.0, 57254.0, 57337.713311433174, 57403.0, 57720.0, 58656.41343586509, 59474.70262648746, 59647.0, 59659.70170149121, 59679.70160149172, 15580.688386232212, 15710.450134245246, 15815.762763558556, 15836.60408489797, 15849.445269415515, 12247.69380765488, 12291.323977181162, 12319.445624946899, 12322.32227227511, 12323.630291091282, 15151.166685832164, 15241.23793810305, 15409.0, 15508.302126404338, 15722.68554628901, 3150.6376766672124, 3250.837458127084, 3273.5908011498564, 6237.937620623827, 6320.462760665303, 894.3471265975874, 901.6032945503957, 917.5045475443319, 1012.2762225009154, 1044.2742294105676, 23864.036021933927, 28510.287242818682, 29054.06080966241, 29450.852745736564, 29875.0, 848.3891598049395, 852.4714676900361, 880.2605811118691, 997.4314640654757, 1002.8646132771983, 14484.565463036126, 14914.328855201542, 15024.399024038916, 15173.468928587667, 15493.767593486107, 602821.0, 684764.0, 685357.0, 693380.5330973414, 694732.0, 55312.17031744446, 55599.0, 55674.443255567734, 56041.7197914016, 56092.0, 1321.2865052871534, 1337.0, 1354.133354653023, 1360.9591712248648, 1363.577291039781, 26304.0, 29035.7096429033, 29055.56416653794, 29244.853775731837, 29542.261443464085, 48720.756396217796, 48892.26661600007, 48943.5105648939, 49029.0, 49304.26043609277, 610779.0, 611547.0, 611973.0, 612398.0, 614188.0, 24716.629250560898, 25562.744372556037, 25565.84953677126, 25582.0, 25612.9754809813, 44164.77917610391, 44702.3294650574, 44903.101937960404, 44944.77527612341, 45512.54487455083, 36729.89810305695, 36856.525738970144, 37357.25285494329, 38530.0, 38610.227795443374, 37035.25929481341, 37396.13019349076, 37899.62100378961, 38357.0, 38927.61072389353, 29212.56181157327, 35010.42453089566, 35698.46452303269, 36326.45510317294, 36647.08382290464, 31434.0, 33366.83316583402, 33522.66477335196, 33542.16144596405, 33564.496532551544, 24346.0, 24495.0, 24644.630330544696, 24973.87513062423, 25008.499830002933], "value": 19009.888005420766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.43484098975205, 345.7113310385828, 352.98692751802315, 380.3458052150301, 402.68389314388213, 17876.195571199296, 18900.810991890077, 19597.314094006713, 19789.604207915832, 19986.800131998676, 14859.405623775036, 18839.905800470977, 19017.904910475463, 19424.611507769838, 19769.703454448158, 5752.568557358194, 5978.306608513984, 6015.969920150415, 6029.758809647609, 6049.848753781147, 4597.241455159911, 5982.670953097578, 6038.818835434922, 6042.0, 6064.181335519715, 5058.544730974211, 5857.456238975423, 5983.132445795379, 6004.5196384289375, 6009.5192384609345, 5765.625234359753, 5835.562332825034, 5863.677497737623, 5867.149263356832, 5877.089051197093, 4955.281484184773, 5021.221710634857, 5146.742662866842, 5154.819581314636, 5172.250023746573, 24145.154919577904, 24281.87859060711, 24482.755172448225, 24619.261422157364, 24647.876760616084, 2131.893405329743, 2203.427108951684, 2463.2610216935027, 2664.9733502665113, 2726.6046423268517, 13294.601161965156, 14409.78385324221, 14646.340914658866, 15188.316525756367, 15568.37726490939, 1782.5008997480597, 1879.1543805287538, 1892.3376818113688, 1895.573495963411, 1909.3889955214338, 78730.21269787286, 89627.0, 91685.54157229238, 103258.0, 113353.0, 10286.588536458608, 10423.166146708245, 10442.843357349646, 10808.729781755519, 11244.38155901417, 13307.534236301683, 13395.866041339463, 13416.731665366638, 13419.530316438877, 13422.261775602241, 8005.0, 8263.173682631808, 8268.875966860502, 8340.457870238415, 8398.874016889751, 7872.960635196788, 8278.503289802631, 8294.958525207456, 8434.030086540126, 8460.450070745383, 5561.749721262553, 5905.43898329658, 6306.085617585424, 6470.708818103197, 6491.058796474485, 1589.9205039747967, 1784.7150051962567, 1787.7944036435977, 1827.1321122466722, 1830.1215416600107, 890.4434728294816, 895.3687650206718, 921.4517362169498, 948.1324588001901, 952.7618095476131, 19737.901310493642, 20900.37298881036, 20990.895045524674, 21125.577488450144, 21154.88451154872, 839.8362319347791, 864.5072308783933, 934.5934518484481, 998.5955687946393, 1008.5007921079113, 10872.67381978542, 11243.7662078595, 11256.0, 11381.658550243506, 11462.484188211383, 581279.0, 585363.0, 590055.0, 598557.0, 603802.0, 96646.0, 115682.8431715672, 117438.0, 118242.0, 120974.3951280238, 944.990550094504, 974.3715303629261, 976.6776963601994, 984.8965858584745, 1006.2503434941016, 17919.552011199303, 18235.81764182394, 18648.720269196245, 18715.251389944795, 18849.811501884804, 50516.98966020586, 50944.0, 51672.741636291576, 52758.472415275355, 53030.73484632552, 69396.65301673661, 69629.30370696228, 71306.0, 72227.63886180536, 73670.0, 6313.589616674902, 7529.1717911028645, 7541.585212813348, 7662.348700360531, 7774.339181169664, 11654.883451165719, 11694.30432587287, 11717.824232636347, 11989.76020479603, 12448.128630996105, 9305.720828375159, 9361.876574811065, 10147.7463063424, 10352.792944141225, 10752.51613677402, 9549.856752148862, 10179.895131984817, 10226.670532830685, 10320.277580569287, 10615.734606634587, 8472.661093556435, 10334.483275836328, 10450.843237351597, 10606.098481629147, 10892.61875834342, 7485.66314515859, 7692.153863075169, 7696.422768292512, 7747.690092396241, 7879.803004924923, 10045.296829221885, 10083.24375671813, 10375.169986400919, 10714.035736783728, 10725.731856703645], "value": 9326.532484236255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.867213278672, 1454.4691187716483, 1481.681438490725, 1511.5692027772086, 1700.9574760630976, 6083.574149809515, 7677.6161191940455, 7865.449418540705, 8293.709720159795, 8328.333733301337, 7781.455298129134, 8047.718329858456, 8050.315723163538, 8082.070561885385, 8144.633491492882, 2282.8287878409146, 2307.526956973825, 2309.9191528296515, 2323.314622186459, 2343.1915988983774, 1826.5890174710717, 1939.8739081959627, 2285.6228722260807, 2347.495288512969, 2360.752121027293, 1888.4523488188477, 2137.2946927513963, 2298.9425264368356, 2326.592846251899, 2329.8234391632286, 2266.5466906618576, 2274.442761523429, 2299.4366380236784, 2299.5515874404496, 2307.0541078157958, 2236.586231547169, 2258.299927022612, 2260.649599312093, 2270.4777901082844, 2271.7732424490755, 8125.5530945797955, 8236.217559331853, 8267.379946503976, 8304.377171712145, 8320.70877519284, 4678.321643361727, 4937.234728617034, 5142.6914385137015, 5156.948430515685, 5174.379074511083, 3255.1699316674335, 3257.6579459156683, 3395.9320813583836, 3458.56767904012, 3464.5275757803083, 1033.3902997231594, 1062.8777690565607, 1076.1874784537702, 1095.5124969388626, 1099.5656715597295, 9079.45523268606, 10568.0, 10579.259451838374, 10679.626213082505, 10718.41048742311, 4471.172833025836, 4487.708298960557, 4674.579287864109, 4688.226442636995, 4716.599089077398, 9182.816343673223, 9204.309676774268, 9258.444493330288, 9271.953640231755, 9337.972822989466, 5140.151874940593, 5151.381834179922, 5156.664816786897, 5167.121589329823, 5172.146595811724, 4183.686223533247, 4548.658850586153, 4677.251639737626, 4737.24204127338, 4756.239001759702, 3794.962050379461, 3795.7663759277793, 3805.6765174960437, 3882.398228274622, 3937.586553411908, 1063.3832377221347, 1228.4717571444364, 1234.0806099455783, 1243.639344590077, 1249.900007999358, 852.3862818770599, 866.3459088388227, 870.425519157353, 884.5223579267252, 887.0464250930276, 5555.333359996826, 5564.8330550083565, 5646.632968857011, 5663.093904975184, 5699.316082070178, 892.6295587331185, 903.9322050846213, 920.6382168691337, 925.0019956893078, 928.9702001127558, 3675.9448608270895, 3676.7977761223387, 3715.368387374153, 3727.086863718352, 3753.9436908446396, 9257.0, 9599.136077753035, 9794.216462682969, 9875.555599997873, 9886.901130988597, 9861.457619830979, 9875.506224688737, 9892.25808064398, 9895.703128906, 9910.35582687123, 7587.468877178655, 7594.240575942362, 7727.690892364242, 7791.805204869924, 7823.2567906048835, 5302.787888484418, 5342.572594192377, 5395.554493307821, 5539.362973257966, 5541.8639178967405, 9241.491717955309, 9246.0, 9254.537273136451, 9275.814483710154, 9350.205232555038, 8984.550772461482, 9307.76730581741, 9452.669156579486, 9461.668841590512, 9527.952360238154, 6201.0, 6424.582402143846, 6435.83910402225, 6617.735290588323, 6749.358810912955, 7664.501807382502, 7908.4068694846965, 7922.0889597697005, 7928.127905930459, 7936.047674279123, 6922.8615427692175, 7070.434365250665, 7080.645967701491, 7093.432525398059, 7169.892451613335, 6784.660766961731, 6939.340762627542, 6990.545614535243, 6994.825129371807, 7009.088818453569, 6386.648734319471, 6508.121403610452, 6578.309277525982, 6611.504137189826, 6692.631905245258, 4689.155951928686, 4696.272077827942, 4755.144074066563, 4759.6430267729365, 4781.4262288524205, 4627.074585083064, 4702.835400760957, 4707.599854012447, 4849.151398505318, 4934.9753251233515], "value": 4327.29763772962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.9974700252997, 280.8553594898626, 305.52795930287704, 309.4121169777424, 311.7942158175604, 4528.328286311076, 4629.7777067007855, 4931.605471562271, 5354.965113256967, 5434.266374039504, 5182.896342073156, 5306.124489459235, 5376.91934620981, 5387.811426600069, 5446.645968012086, 3376.8687489690983, 3865.8260378283044, 4122.835086596532, 4143.19207754488, 4150.667946564276, 3912.9043867717087, 4090.8568200113, 4109.103082326952, 4133.793310334471, 4150.97924510377, 3245.496947973068, 3706.5366829146355, 4067.1865626874596, 4075.5924407559305, 4092.7544347339253, 4067.8576249831112, 4068.816903239361, 4080.0823612902186, 4090.427340172378, 4092.5907409258984, 3335.466325387926, 3537.398642230827, 3559.661832125944, 3589.4974703541266, 3597.928041439183, 4381.145676593065, 4438.60052595268, 5240.423553409122, 5260.579153667697, 5268.736563171826, 4449.933251001237, 4685.578297953167, 4690.366800481959, 4698.647601429906, 4709.552592503741, 5630.5495560355075, 5639.0, 5651.8587035324035, 5674.943250567483, 5696.77212911483, 3726.65852259978, 3901.5174233791263, 3918.1967696622123, 3919.7060220483577, 3935.9729739184345, 4801.927971080437, 5424.945750542483, 5437.782488700487, 5687.7156142192725, 5782.566307526952, 3976.8011599419915, 3982.78094704794, 3991.620796024431, 4003.3794761811964, 4008.6592639625374, 3233.8221397822876, 3907.5115610548683, 4041.535223449282, 4044.7775372354213, 4074.4499492568716, 4318.589733975267, 4541.000979784442, 4596.747178905125, 4607.539246075366, 4638.907221855544, 5194.246834209019, 5336.67979921206, 5374.973125134349, 5775.653460792366, 5780.277465316835, 1099.9660319299833, 1183.7573297473998, 1211.9636410907688, 1248.8126780982925, 1274.133589159362, 771.7844395077775, 854.030675183671, 867.6095756909416, 874.776931882366, 878.7539488943106, 4642.0019695764895, 4999.575036121898, 5180.264611355163, 5217.921731174036, 5246.396664383568, 4985.5762260208285, 5248.897731476356, 5398.838034858961, 5511.208857121452, 5613.7193140342815, 4620.699654522446, 5037.546620804072, 5159.561437277874, 5171.431712118626, 5188.273641690166, 2939.8093772022366, 2940.0, 2957.742959242313, 2960.7779416543844, 2984.8956485677545, 4999.925001124986, 5310.9734451327495, 5634.408387119375, 5979.431953964367, 6093.415711914846, 4888.780004899788, 5328.014317351302, 5527.756254842629, 5759.308882933991, 5763.0, 5239.790408383698, 5275.494140283411, 5434.972825135849, 5536.750846211849, 5999.880002399927, 5435.537285028521, 5476.589255805751, 5619.775208991595, 5656.490915817596, 5667.858303542444, 5503.7798488061635, 5868.977476599469, 5905.435059709094, 5929.733162007634, 5976.970115149396, 5031.698098114125, 5409.972950135224, 6100.725467354068, 6266.561340706106, 6268.424050443111, 3033.8366669301536, 3567.1795487038644, 3665.3402387570495, 3910.413437984211, 3943.309920763912, 4722.834700785456, 4747.952520474751, 5473.945260547343, 5618.52242559387, 6006.819795406145, 5562.3047119110115, 5595.5803314752375, 5698.54411647059, 5749.396313387034, 5805.651660900359, 5057.898842023065, 5545.72271386421, 5823.718781868151, 5830.912536311874, 5850.970745146417, 5046.899062018812, 5174.97412512935, 5403.540699040625, 5432.022235997559, 5605.915911261416, 5501.477359650827, 5601.747921343631, 5666.943330566642, 5761.8559536011935, 5796.710164491674, 5574.9721251393485, 5590.413006634408, 5654.06707893193, 5689.829305120853, 5698.344690360662], "value": 4083.1487120073543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4394073363604, 754.9169591344954, 756.9129550101736, 757.4773406349618, 788.1921030943284, 13937.372818223179, 14709.852901470982, 14765.335559899804, 14790.482333118343, 14803.963722539427, 12961.416736246869, 13079.673008174801, 13159.14465559738, 13289.0, 13460.125091869046, 641.804249703839, 666.5234357434433, 793.5516433215244, 819.9959000205021, 825.4593241426845, 812.8658771302728, 820.7004443378154, 821.1214001018913, 821.4824660463929, 824.3116997307255, 879.3888247667874, 882.2677177942293, 885.4156256870467, 887.9334049946248, 890.3100097424483, 738.8928605352221, 850.8425941200867, 874.5321253129545, 878.0780180810124, 880.5377176982072, 639.2361128451503, 653.2389765922694, 656.3174298729316, 658.9505787065989, 661.576590981772, 13311.134776239513, 13551.45794168242, 13568.59294221175, 13578.25319607431, 14191.219482928434, 13417.66455838602, 13583.932080339633, 13624.863751362558, 13696.315184240848, 14027.158370497802, 11109.111271098292, 11312.434378281136, 11393.829092563536, 11410.600628978029, 11498.540058397653, 3580.104973756561, 3601.1897323102353, 3604.3692353838237, 3630.146915474861, 3687.967369136646, 88362.0, 89077.0, 91344.17311653796, 93050.06949930482, 95641.52179239129, 8718.17177368149, 9078.636854525877, 10219.489025548693, 10516.842247366296, 10632.989865962722, 20476.590468190552, 20512.487187820425, 20542.486437838874, 20578.176872925214, 20595.58808823815, 7181.784546463615, 7355.5586664800285, 7486.475946683789, 7502.699892004368, 7645.808854778675, 4090.4886889138857, 4128.979355103265, 4161.791910404468, 4255.042615411569, 4306.354046892991, 3284.211789170582, 3310.4372256715933, 3329.3174899145615, 3371.190914180628, 3378.476336167898, 605.5065121925617, 608.4979891589456, 617.0682269772676, 624.3163735709481, 626.5927147354165, 616.5653214483779, 627.1533429869639, 628.8144997225829, 636.1602684456473, 682.8941514065327, 6813.897791533131, 8574.528400937883, 8740.912590874137, 8807.0, 9086.0, 556.4213218253052, 577.0737965565291, 627.3381582430488, 628.7013668507423, 657.9013148027834, 4171.186618609403, 4367.75977321244, 4390.604845563915, 4391.209582275221, 4462.0, 69803.0, 71410.9288360675, 87242.0, 88160.5591972036, 111700.0, 60172.0, 63277.36722632807, 63403.68298158572, 72279.91580126302, 94598.0, 58647.706761466776, 74037.25962740411, 80147.0, 82251.0, 83811.16188838155, 7261.963690181516, 8309.709160179365, 8431.241188293083, 8555.081826441992, 8681.877994885519, 55623.443765561824, 57139.428605715075, 58110.7094464525, 58450.4154958445, 58848.0, 82036.58981705054, 82049.0, 83072.58463707643, 84155.31689366057, 85447.14552854392, 11210.66368008961, 11395.544178232778, 11403.828942565702, 11420.257683250562, 11602.6519204424, 11597.18819682614, 11738.94130529342, 12047.096467764777, 12243.081768867192, 12335.69160770952, 11600.593979210687, 12491.562795302485, 12660.366981651065, 12717.80923286133, 13260.204387736767, 12601.306928119042, 12635.305058221518, 12902.032347573782, 12970.416331265304, 13630.386632601754, 12093.0, 12445.751084978068, 12605.24368537854, 13436.664083397602, 13472.393742281425, 10872.402017889091, 11047.447627618427, 11082.889171108185, 11223.270487418291, 11442.970132688099, 10317.380957142595, 10779.838302425313, 10853.186011049045, 11207.327560346404, 11211.327320360804], "value": 7052.9714599441095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 118.0, 126.0, 120.0, 119.0, 117.0, 118.0, 127.0, 176.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 115.0, 117.0, 168.0, 150.0, 127.0, 119.0, 116.0, 145.0, 115.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 205.0, 198.0, 210.0, 196.0, 196.0, 195.0, 200.0, 197.0, 196.0], "value": 198.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 85.0, 61.0, 60.0, 60.0, 57.0, 79.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 89.0, 73.0, 70.0, 66.0, 113.0, 100.0, 96.0, 87.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 109.0, 86.0, 136.0, 131.0, 88.0, 93.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 98.0, 103.0, 144.0, 173.0, 145.0, 99.0, 161.0, 98.0], "value": 121.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 125.0, 73.0, 140.0, 141.0, 136.0, 92.0, 95.0, 126.0], "value": 110.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 62.0, 83.0, 90.0, 90.0, 91.0, 62.0, 59.0], "value": 70.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 83.0, 86.0, 79.0, 72.0, 71.0, 71.0, 73.0, 64.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 105.0, 85.0, 80.0, 90.0, 94.0, 82.0, 87.0, 107.0, 98.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 153.0, 149.0, 148.0, 155.0, 175.0, 152.0, 147.0, 209.0, 174.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 172.0, 188.0, 234.0, 178.0, 172.0, 169.0, 178.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 64.0, 85.0, 89.0, 87.0, 88.0, 76.0, 67.0, 71.0], "value": 76.7, "unit": "score"}]}]} 07:56:12 INFO - Return code: 0 07:56:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:12 ERROR - # TBPL SUCCESS # 07:56:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:12 INFO - 2016-12-11 07:56:12.272 screenresolution[2215:24174] starting screenresolution argv=screenresolution get 07:56:12 INFO - 2016-12-11 07:56:12.275 screenresolution[2215:24174] Display 0: 1600x1200x32@60 07:56:12 INFO - 2016-12-11 07:56:12.281 screenresolution[2216:24177] starting screenresolution argv=screenresolution list 07:56:12 INFO - Available Modes on Display 0 07:56:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:12 INFO - Intel Iris: 07:56:12 INFO - Chipset Model: Intel Iris 07:56:12 INFO - Type: GPU 07:56:12 INFO - Bus: Built-In 07:56:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:12 INFO - Vendor: Intel (0x8086) 07:56:12 INFO - Device ID: 0x0a2e 07:56:12 INFO - Revision ID: 0x0009 07:56:12 INFO - Displays: 07:56:12 INFO - Display: 07:56:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:12 INFO - Display Serial Number: 1600x1200 60 07:56:12 INFO - Main Display: Yes 07:56:12 INFO - Mirror: Off 07:56:12 INFO - Online: Yes 07:56:12 INFO - Rotation: Supported 07:56:12 INFO - Return code: 0 07:56:12 INFO - Running post-action listener: _resource_record_post_action 07:56:12 INFO - [mozharness: 2016-12-11 15:56:12.523257Z] Finished run-tests step (success) 07:56:12 INFO - Running post-run listener: _resource_record_post_run 07:56:12 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 299008; Write bytes: 662036480; Read time: 4; Write time: 1977 07:56:12 INFO - TinderboxPrint: CPU usage
54.4% 07:56:12 INFO - TinderboxPrint: I/O read bytes / time
299,008 / 4 07:56:12 INFO - TinderboxPrint: I/O write bytes / time
662,036,480 / 1,977 07:56:12 INFO - TinderboxPrint: CPU idle
2,208.4 (45.6%) 07:56:12 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 07:56:12 INFO - TinderboxPrint: CPU user
1,652.8 (34.1%) 07:56:12 INFO - TinderboxPrint: Swap in / out
348,438,528 / 0 07:56:12 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 347726336; Write bytes: 345880576; Read time: 26809; Write time: 748 07:56:12 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 258048; Write bytes: 308893696; Read time: 3; Write time: 1195 07:56:13 INFO - Running post-run listener: _upload_blobber_files 07:56:13 INFO - Blob upload gear active. 07:56:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:13 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 07:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:56:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:56:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:14 INFO - (blobuploader) - INFO - Done attempting. 07:56:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:56:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:15 INFO - (blobuploader) - INFO - Done attempting. 07:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:17 INFO - (blobuploader) - INFO - Done attempting. 07:56:17 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:17 INFO - Return code: 0 07:56:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85cd8cd9966cf844e58aea25f7226328108ec133b567f6bf49d101ba5c633ad391338d3b9b0388fcd78fc094d1452d5b77cc72daa33efc5c1d621581f9e29e85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fe8661cf442ac7d5fd431de47c9bf3ee145c4871bde9f113c80ff808338d2abe643729689c551d8130acb93a34d3fd1d8ceec641bd92543c70df369be7e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350bb763b9e5842f41a3ac7645b49aa55c36dbb7cd299ad3452d5bc48ac0b05f50d26be017c93a79d1705feb6ad1049617eabe57b0f1e68f9ceb64da003500b0"} 07:56:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:17 INFO - Contents: 07:56:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85cd8cd9966cf844e58aea25f7226328108ec133b567f6bf49d101ba5c633ad391338d3b9b0388fcd78fc094d1452d5b77cc72daa33efc5c1d621581f9e29e85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fe8661cf442ac7d5fd431de47c9bf3ee145c4871bde9f113c80ff808338d2abe643729689c551d8130acb93a34d3fd1d8ceec641bd92543c70df369be7e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350bb763b9e5842f41a3ac7645b49aa55c36dbb7cd299ad3452d5bc48ac0b05f50d26be017c93a79d1705feb6ad1049617eabe57b0f1e68f9ceb64da003500b0"} 07:56:17 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:17 INFO - Copying logs to upload dir... 07:56:17 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.957316 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-11 07:56:17.297508) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 07:56:17.301783) ========= 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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85cd8cd9966cf844e58aea25f7226328108ec133b567f6bf49d101ba5c633ad391338d3b9b0388fcd78fc094d1452d5b77cc72daa33efc5c1d621581f9e29e85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fe8661cf442ac7d5fd431de47c9bf3ee145c4871bde9f113c80ff808338d2abe643729689c551d8130acb93a34d3fd1d8ceec641bd92543c70df369be7e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350bb763b9e5842f41a3ac7645b49aa55c36dbb7cd299ad3452d5bc48ac0b05f50d26be017c93a79d1705feb6ad1049617eabe57b0f1e68f9ceb64da003500b0"} build_url:https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011000 build_url: 'https://queue.taskcluster.net/v1/task/bUglAxXDRlGyZMJBQNyRDA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85cd8cd9966cf844e58aea25f7226328108ec133b567f6bf49d101ba5c633ad391338d3b9b0388fcd78fc094d1452d5b77cc72daa33efc5c1d621581f9e29e85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42fe8661cf442ac7d5fd431de47c9bf3ee145c4871bde9f113c80ff808338d2abe643729689c551d8130acb93a34d3fd1d8ceec641bd92543c70df369be7e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350bb763b9e5842f41a3ac7645b49aa55c36dbb7cd299ad3452d5bc48ac0b05f50d26be017c93a79d1705feb6ad1049617eabe57b0f1e68f9ceb64da003500b0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 07:56:17.338528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 07:56:17.338810) ========= 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.XwWVV2GsJ9/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.JQNDBoBhtC/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 07:56:17.386882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 07:56:17.387176) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 07:56:17.390476) ========= ========= Total master_lag: 0.21 =========