builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0149 starttime: 1485232817.91 results: success (0) buildid: 20170123180844 builduid: f90ba4415511428290bded78e98d4bd8 revision: 748ca6ea965cd7287affab431369809c751b462e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:17.909461) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:17.909956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:17.910278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:18.104077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-23 20:40:18.104440) ========= 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.htfqSs7Giw/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.zSefVCs0ff/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 --2017-01-23 20:40:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2017-01-23 20:40:18 (15.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.372901 ========= master_lag: 2.91 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-23 20:40:21.389498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:21.389855) ========= 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.htfqSs7Giw/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.zSefVCs0ff/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.027154 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:21.440821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-23 20:40:21.441159) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 748ca6ea965cd7287affab431369809c751b462e --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-beta --rev 748ca6ea965cd7287affab431369809c751b462e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.htfqSs7Giw/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.zSefVCs0ff/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 2017-01-23 20:40:21,542 truncating revision to first 12 chars 2017-01-23 20:40:21,542 Setting DEBUG logging. 2017-01-23 20:40:21,542 attempt 1/10 2017-01-23 20:40:21,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/748ca6ea965c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 20:40:23,481 unpacking tar archive at: mozilla-beta-748ca6ea965c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.213591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-23 20:40:23.678377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:23.678694) ========= script_repo_revision: 748ca6ea965cd7287affab431369809c751b462e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:23.679113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:23.679392) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:40:23.699770) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-23 20:40:23.700668) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.htfqSs7Giw/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.zSefVCs0ff/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:40:23 INFO - MultiFileLogger online at 20170123 20:40:23 in /builds/slave/test 20:40:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:40:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:40:23 INFO - {'append_to_log': False, 20:40:23 INFO - 'base_work_dir': '/builds/slave/test', 20:40:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:40:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:40:23 INFO - 'branch': 'Mozilla-Beta', 20:40:23 INFO - 'buildbot_json_path': 'buildprops.json', 20:40:23 INFO - 'config_files': ('talos/mac_config.py',), 20:40:23 INFO - 'default_actions': ('clobber', 20:40:23 INFO - 'read-buildbot-config', 20:40:23 INFO - 'download-and-extract', 20:40:23 INFO - 'populate-webroot', 20:40:23 INFO - 'create-virtualenv', 20:40:23 INFO - 'install', 20:40:23 INFO - 'run-tests'), 20:40:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:40:23 INFO - 'download_minidump_stackwalk': True, 20:40:23 INFO - 'download_symbols': 'ondemand', 20:40:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:40:23 INFO - 'tooltool.py': '/tools/tooltool.py', 20:40:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:40:23 INFO - '/tools/misc-python/virtualenv.py')}, 20:40:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:40:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:40:23 INFO - 'installer_path': 'installer.exe', 20:40:23 INFO - 'log_level': 'info', 20:40:23 INFO - 'log_name': 'talos', 20:40:23 INFO - 'log_to_console': True, 20:40:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:40:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:40:23 INFO - 'opt_config_files': (), 20:40:23 INFO - 'pip_index': False, 20:40:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:40:23 INFO - 'cmd': ('bash', 20:40:23 INFO - '-c', 20:40:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:40:23 INFO - 'enabled': True, 20:40:23 INFO - 'halt_on_failure': False, 20:40:23 INFO - 'name': 'check_screen_resolution'},), 20:40:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:40:23 INFO - 'cmd': ('bash', 20:40:23 INFO - '-c', 20:40:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:40:23 INFO - 'enabled': True, 20:40:23 INFO - 'halt_on_failure': False, 20:40:23 INFO - 'name': 'check_screen_resolution'},), 20:40:23 INFO - 'run_cmd_checks_enabled': True, 20:40:23 INFO - 'sps_profile': False, 20:40:23 INFO - 'sps_profile_interval': 0, 20:40:23 INFO - 'suite': 'dromaeojs-e10s', 20:40:23 INFO - 'system_bits': '32', 20:40:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:40:23 INFO - 'title': 't-yosemite-r7-0149', 20:40:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:40:23 INFO - 'use_talos_json': True, 20:40:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:40:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:40:23 INFO - 'work_dir': 'build'} 20:40:23 INFO - [mozharness: 2017-01-24 04:40:23.916882Z] Running clobber step. 20:40:23 INFO - Running pre-action listener: _resource_record_pre_action 20:40:23 INFO - Running main action method: clobber 20:40:23 INFO - rmtree: /builds/slave/test/build 20:40:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:40:26 INFO - Running post-action listener: _resource_record_post_action 20:40:26 INFO - [mozharness: 2017-01-24 04:40:26.493813Z] Finished clobber step (success) 20:40:26 INFO - [mozharness: 2017-01-24 04:40:26.493940Z] Running read-buildbot-config step. 20:40:26 INFO - Running pre-action listener: _resource_record_pre_action 20:40:26 INFO - Running main action method: read_buildbot_config 20:40:26 INFO - Using buildbot properties: 20:40:26 INFO - { 20:40:26 INFO - "project": "", 20:40:26 INFO - "product": "firefox", 20:40:26 INFO - "script_repo_revision": "production", 20:40:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 20:40:26 INFO - "repository": "", 20:40:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 20:40:26 INFO - "buildid": "20170123180844", 20:40:26 INFO - "pgo_build": "False", 20:40:26 INFO - "basedir": "/builds/slave/test", 20:40:26 INFO - "buildnumber": 49, 20:40:26 INFO - "slavename": "t-yosemite-r7-0149", 20:40:26 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:40:26 INFO - "platform": "yosemite_r7", 20:40:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:40:26 INFO - "branch": "mozilla-beta", 20:40:26 INFO - "repo_path": "releases/mozilla-beta", 20:40:26 INFO - "revision": "748ca6ea965cd7287affab431369809c751b462e", 20:40:26 INFO - "stage_platform": "macosx64", 20:40:26 INFO - "builduid": "f90ba4415511428290bded78e98d4bd8", 20:40:26 INFO - "slavebuilddir": "test" 20:40:26 INFO - } 20:40:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 20:40:26 INFO - Running post-action listener: _resource_record_post_action 20:40:26 INFO - [mozharness: 2017-01-24 04:40:26.496971Z] Finished read-buildbot-config step (success) 20:40:26 INFO - [mozharness: 2017-01-24 04:40:26.497091Z] Running download-and-extract step. 20:40:26 INFO - Running pre-action listener: _resource_record_pre_action 20:40:26 INFO - Running main action method: download_and_extract 20:40:26 INFO - mkdir: /builds/slave/test/build/tests 20:40:26 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')]} 20:40:26 INFO - trying https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 20:40:26 INFO - Downloading https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 20:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 20:40:27 INFO - Downloaded 1165 bytes. 20:40:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 20:40:27 INFO - Using the following test package requirements: 20:40:27 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:40:27 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:40:27 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 20:40:27 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:40:27 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 20:40:27 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:40:27 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:40:27 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 20:40:27 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:40:27 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:40:27 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 20:40:27 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:40:27 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 20:40:27 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:40:27 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 20:40:27 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:40:27 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 20:40:27 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 20:40:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:40:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:40:27 INFO - Fetch https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:40:28 INFO - Http code: 200 20:40:28 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 20:40:28 INFO - x-amz-cf-id: _Hx4dCIaBfdsfYJ1F86-5hZ-9to0NKXJcWhmQVVgGLrxvbJWELyDiw== 20:40:28 INFO - x-amz-version-id: 8mq3o9VoVPd1TOvhMRRtcEiIpk4BY0Zi 20:40:28 INFO - Expected file size: 16086053 20:40:28 INFO - Obtained file size: 16086053 20:40:34 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:40:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:40:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:40:34 INFO - Fetch https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:40:35 INFO - Http code: 200 20:40:35 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 20:40:35 INFO - x-amz-cf-id: lCD9GkLt_L1gkrp3NB-wMBBQUd2ugXSv41qvOL0d8gIqZ16a8wWVIg== 20:40:35 INFO - x-amz-version-id: 8mq3o9VoVPd1TOvhMRRtcEiIpk4BY0Zi 20:40:35 INFO - Expected file size: 16086053 20:40:35 INFO - Obtained file size: 16086053 20:40:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 20:40:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 20:40:42 INFO - Fetch https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 20:40:42 INFO - Http code: 200 20:40:42 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 20:40:42 INFO - x-amz-cf-id: 5vwa3SWGRuhVb66pmgzqlr_PZKrmX6yySnv2jq93KT7aej3TO2JBzA== 20:40:42 INFO - x-amz-version-id: SsL14qFte.JDwGF5PnHsMSWyllqcV0tT 20:40:42 INFO - Expected file size: 14402992 20:40:42 INFO - Obtained file size: 14402992 20:40:43 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')]} 20:40:43 INFO - trying https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:40:43 INFO - Downloading https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 20:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 20:40:45 INFO - Downloaded 82107058 bytes. 20:40:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:40:45 INFO - mkdir: /builds/slave/test/properties 20:40:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:40:45 INFO - Writing to file /builds/slave/test/properties/build_url 20:40:45 INFO - Contents: 20:40:45 INFO - build_url:https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:40:46 INFO - Running post-action listener: _resource_record_post_action 20:40:46 INFO - Running post-action listener: set_extra_try_arguments 20:40:46 INFO - [mozharness: 2017-01-24 04:40:46.209249Z] Finished download-and-extract step (success) 20:40:46 INFO - [mozharness: 2017-01-24 04:40:46.209390Z] Running populate-webroot step. 20:40:46 INFO - Running pre-action listener: _resource_record_pre_action 20:40:46 INFO - Running main action method: populate_webroot 20:40:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:40:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:40:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:40:46 INFO - '--tppagecycles', 20:40:46 INFO - '7'], 20:40:46 INFO - 'tests': ['tsvgm']}}, 20:40:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:40:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:40:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:40:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:40:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:40:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['damp', 'tps']}, 20:40:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'tests': ['damp', 'tps']}, 20:40:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['dromaeo_dom']}, 20:40:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:40:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['basic_compositor_video']}, 20:40:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:40:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['a11yr', 20:40:46 INFO - 'ts_paint', 20:40:46 INFO - 'tpaint', 20:40:46 INFO - 'sessionrestore', 20:40:46 INFO - 'sessionrestore_no_auto_restore', 20:40:46 INFO - 'tabpaint']}, 20:40:46 INFO - 'other-e10s': {'tests': ['a11yr', 20:40:46 INFO - 'ts_paint', 20:40:46 INFO - 'tpaint', 20:40:46 INFO - 'sessionrestore', 20:40:46 INFO - 'sessionrestore_no_auto_restore', 20:40:46 INFO - 'tabpaint']}, 20:40:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:40:46 INFO - 'ts_paint', 20:40:46 INFO - 'tpaint', 20:40:46 INFO - 'sessionrestore', 20:40:46 INFO - 'sessionrestore_no_auto_restore', 20:40:46 INFO - 'tabpaint']}, 20:40:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:40:46 INFO - 'ts_paint', 20:40:46 INFO - 'tpaint', 20:40:46 INFO - 'sessionrestore', 20:40:46 INFO - 'sessionrestore_no_auto_restore', 20:40:46 INFO - 'tabpaint']}, 20:40:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['a11yr', 20:40:46 INFO - 'ts_paint', 20:40:46 INFO - 'tpaint', 20:40:46 INFO - 'sessionrestore', 20:40:46 INFO - 'sessionrestore_no_auto_restore', 20:40:46 INFO - 'tabpaint']}, 20:40:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['a11yr', 20:40:46 INFO - 'ts_paint', 20:40:46 INFO - 'tpaint', 20:40:46 INFO - 'sessionrestore', 20:40:46 INFO - 'sessionrestore_no_auto_restore', 20:40:46 INFO - 'tabpaint']}, 20:40:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['tsvgx', 20:40:46 INFO - 'tsvgr_opacity', 20:40:46 INFO - 'tart', 20:40:46 INFO - 'tscrollx', 20:40:46 INFO - 'cart']}, 20:40:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:40:46 INFO - 'tsvgr_opacity', 20:40:46 INFO - 'tart', 20:40:46 INFO - 'tscrollx', 20:40:46 INFO - 'cart']}, 20:40:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'talos_options': ['--disable-e10s'], 20:40:46 INFO - 'tests': ['tp5o']}, 20:40:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'tests': ['tp5o']}, 20:40:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'talos_options': ['--disable-e10s', 20:40:46 INFO - '--xperf_path', 20:40:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:46 INFO - 'tests': ['tp5n']}, 20:40:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:40:46 INFO - 'talos_options': ['--xperf_path', 20:40:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:40:46 INFO - 'tests': ['tp5n']}}, 20:40:46 INFO - 'talos.zip': {'path': '', 20:40:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:40:46 INFO - Running post-action listener: _resource_record_post_action 20:40:46 INFO - [mozharness: 2017-01-24 04:40:46.228279Z] Finished populate-webroot step (success) 20:40:46 INFO - [mozharness: 2017-01-24 04:40:46.228382Z] Running create-virtualenv step. 20:40:46 INFO - Running pre-action listener: _resource_record_pre_action 20:40:46 INFO - Running main action method: create_virtualenv 20:40:46 INFO - Creating virtualenv /builds/slave/test/build/venv 20:40:46 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 20:40:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:40:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:40:46 INFO - Using real prefix '/tools/python27' 20:40:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:40:47 INFO - Installing distribute.............................................................................................................................................................................................done. 20:40:49 INFO - Installing pip.................done. 20:40:49 INFO - Return code: 0 20:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:40:50 INFO - Reading from file tmpfile_stdout 20:40:50 INFO - Output received: 20:40:50 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) 20:40:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:40:50 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 20:40:50 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 20:40:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:40:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:40:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:40:50 INFO - 'HOME': '/Users/cltbld', 20:40:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:40:50 INFO - 'LOGNAME': 'cltbld', 20:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:50 INFO - 'MOZ_NO_REMOTE': '1', 20:40:50 INFO - 'NO_EM_RESTART': '1', 20:40:50 INFO - 'PAGER': '/bin/cat', 20:40:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:50 INFO - 'PWD': '/builds/slave/test', 20:40:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:40:50 INFO - 'SHELL': '/bin/bash', 20:40:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:40:50 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:40:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:40:50 INFO - 'USER': 'cltbld', 20:40:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:40:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:50 INFO - 'XPC_FLAGS': '0x0', 20:40:50 INFO - 'XPC_SERVICE_NAME': '0', 20:40:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:50 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 20:40:50 INFO - Cleaning up... 20:40:50 INFO - Return code: 0 20:40:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:50 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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:40:50 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 20:40:50 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 20:40:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:40:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:40:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:40:50 INFO - 'HOME': '/Users/cltbld', 20:40:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:40:50 INFO - 'LOGNAME': 'cltbld', 20:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:50 INFO - 'MOZ_NO_REMOTE': '1', 20:40:50 INFO - 'NO_EM_RESTART': '1', 20:40:50 INFO - 'PAGER': '/bin/cat', 20:40:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:50 INFO - 'PWD': '/builds/slave/test', 20:40:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:40:50 INFO - 'SHELL': '/bin/bash', 20:40:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:40:50 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:40:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:40:50 INFO - 'USER': 'cltbld', 20:40:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:40:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:50 INFO - 'XPC_FLAGS': '0x0', 20:40:50 INFO - 'XPC_SERVICE_NAME': '0', 20:40:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:50 INFO - Downloading/unpacking psutil>=3.1.1 20:40: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 20:40: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 20:40: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 20:40: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 20:40: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 20:40: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 20:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:40:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:54 INFO - Installing collected packages: psutil 20:40:54 INFO - Running setup.py install for psutil 20:40:54 INFO - building 'psutil._psutil_osx' extension 20:40:54 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 20:40:55 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 20:40:55 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 20:40:55 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 20:40:55 INFO - building 'psutil._psutil_posix' extension 20:40:55 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 20:40:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:40:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:40:55 INFO - ^ 20:40:55 INFO - 1 warning generated. 20:40:55 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 20:40:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:40:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:40:55 INFO - Successfully installed psutil 20:40:55 INFO - Cleaning up... 20:40:55 INFO - Return code: 0 20:40:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:55 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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:40:55 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 20:40:55 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 20:40:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:40:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:40:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:40:55 INFO - 'HOME': '/Users/cltbld', 20:40:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:40:55 INFO - 'LOGNAME': 'cltbld', 20:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:55 INFO - 'MOZ_NO_REMOTE': '1', 20:40:55 INFO - 'NO_EM_RESTART': '1', 20:40:55 INFO - 'PAGER': '/bin/cat', 20:40:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:55 INFO - 'PWD': '/builds/slave/test', 20:40:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:40:55 INFO - 'SHELL': '/bin/bash', 20:40:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:40:55 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:40:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:40:55 INFO - 'USER': 'cltbld', 20:40:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:40:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:55 INFO - 'XPC_FLAGS': '0x0', 20:40:55 INFO - 'XPC_SERVICE_NAME': '0', 20:40:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:40:55 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 20:40:55 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 20:40:55 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 20:40:55 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 20:40:55 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 20:40:55 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 20:40:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:40:58 INFO - Installing collected packages: mozsystemmonitor 20:40:58 INFO - Running setup.py install for mozsystemmonitor 20:40:58 INFO - Successfully installed mozsystemmonitor 20:40:58 INFO - Cleaning up... 20:40:58 INFO - Return code: 0 20:40:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:40:58 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')]} 20:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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')]} 20:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:58 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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:40:58 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 20:40:58 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 20:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:40:58 INFO - 'HOME': '/Users/cltbld', 20:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:40:58 INFO - 'LOGNAME': 'cltbld', 20:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:58 INFO - 'MOZ_NO_REMOTE': '1', 20:40:58 INFO - 'NO_EM_RESTART': '1', 20:40:58 INFO - 'PAGER': '/bin/cat', 20:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:58 INFO - 'PWD': '/builds/slave/test', 20:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:40:58 INFO - 'SHELL': '/bin/bash', 20:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:40:58 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:40:58 INFO - 'USER': 'cltbld', 20:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:58 INFO - 'XPC_FLAGS': '0x0', 20:40:58 INFO - 'XPC_SERVICE_NAME': '0', 20:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:59 INFO - Downloading/unpacking jsonschema==2.5.1 20:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:41:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:01 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 20:41:02 INFO - Downloading functools32-3.2.3-2.tar.gz 20:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:41:02 INFO - warning: no files found matching '*.txt' 20:41:02 INFO - no previously-included directories found matching 'build' 20:41:02 INFO - no previously-included directories found matching 'dist' 20:41:02 INFO - no previously-included directories found matching '.git*' 20:41:02 INFO - Installing collected packages: jsonschema, functools32 20:41:02 INFO - Running setup.py install for functools32 20:41:02 INFO - warning: no files found matching '*.txt' 20:41:02 INFO - no previously-included directories found matching 'build' 20:41:02 INFO - no previously-included directories found matching 'dist' 20:41:02 INFO - no previously-included directories found matching '.git*' 20:41:02 INFO - Successfully installed jsonschema functools32 20:41:02 INFO - Cleaning up... 20:41:02 INFO - Return code: 0 20:41:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:41:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:41:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:41:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:41:02 INFO - 'HOME': '/Users/cltbld', 20:41:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:41:02 INFO - 'LOGNAME': 'cltbld', 20:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:02 INFO - 'MOZ_NO_REMOTE': '1', 20:41:02 INFO - 'NO_EM_RESTART': '1', 20:41:02 INFO - 'PAGER': '/bin/cat', 20:41:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:02 INFO - 'PWD': '/builds/slave/test', 20:41:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:41:02 INFO - 'SHELL': '/bin/bash', 20:41:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:41:02 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:41:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:41:02 INFO - 'USER': 'cltbld', 20:41:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:41:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:02 INFO - 'XPC_FLAGS': '0x0', 20:41:02 INFO - 'XPC_SERVICE_NAME': '0', 20:41:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:41:02 INFO - Cleaning up... 20:41:02 INFO - Return code: 0 20:41:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:41:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:41:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:41:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:41:02 INFO - 'HOME': '/Users/cltbld', 20:41:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:41:02 INFO - 'LOGNAME': 'cltbld', 20:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:02 INFO - 'MOZ_NO_REMOTE': '1', 20:41:02 INFO - 'NO_EM_RESTART': '1', 20:41:02 INFO - 'PAGER': '/bin/cat', 20:41:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:02 INFO - 'PWD': '/builds/slave/test', 20:41:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:41:02 INFO - 'SHELL': '/bin/bash', 20:41:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:41:02 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:41:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:41:02 INFO - 'USER': 'cltbld', 20:41:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:41:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:02 INFO - 'XPC_FLAGS': '0x0', 20:41:02 INFO - 'XPC_SERVICE_NAME': '0', 20:41:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:03 INFO - Downloading/unpacking blobuploader==1.2.4 20:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:05 INFO - Downloading blobuploader-1.2.4.tar.gz 20:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:41:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:41:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:41:06 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 20:41:06 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 20:41:06 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 20:41:06 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 20:41:06 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 20:41:06 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 20:41:06 INFO - Downloading docopt-0.6.1.tar.gz 20:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:41:07 INFO - Installing collected packages: blobuploader, requests, docopt 20:41:07 INFO - Running setup.py install for blobuploader 20:41:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:41:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:41:07 INFO - Running setup.py install for requests 20:41:07 INFO - Running setup.py install for docopt 20:41:07 INFO - Successfully installed blobuploader requests docopt 20:41:07 INFO - Cleaning up... 20:41:07 INFO - Return code: 0 20:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41: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')]} 20:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41: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')]} 20:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:07 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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:41:07 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 20:41:07 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 20:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:41:07 INFO - 'HOME': '/Users/cltbld', 20:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:41:07 INFO - 'LOGNAME': 'cltbld', 20:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:07 INFO - 'MOZ_NO_REMOTE': '1', 20:41:07 INFO - 'NO_EM_RESTART': '1', 20:41:07 INFO - 'PAGER': '/bin/cat', 20:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:07 INFO - 'PWD': '/builds/slave/test', 20:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:41:07 INFO - 'SHELL': '/bin/bash', 20:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:41:07 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:41:07 INFO - 'USER': 'cltbld', 20:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:07 INFO - 'XPC_FLAGS': '0x0', 20:41:07 INFO - 'XPC_SERVICE_NAME': '0', 20:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-K5XtH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-lpq2fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-CGT1_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-gWvlXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-P7Er__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-_5gBtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-gE9JPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:41:08 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Oy412Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-YN5daZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-PHDlaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-sOSliY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-LMUnI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-COVej_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-q2C289-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-x0c49t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-A8Ofx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:41:09 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-J1BWpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:41:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:41:09 INFO - Running setup.py install for manifestparser 20:41:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:41:10 INFO - Running setup.py install for mozcrash 20:41:10 INFO - Running setup.py install for mozdebug 20:41:10 INFO - Running setup.py install for mozdevice 20:41:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:41:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:41:10 INFO - Running setup.py install for mozfile 20:41:10 INFO - Running setup.py install for mozhttpd 20:41:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:41:10 INFO - Running setup.py install for mozinfo 20:41:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:41:10 INFO - Running setup.py install for mozInstall 20:41:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Running setup.py install for mozleak 20:41:11 INFO - Running setup.py install for mozlog 20:41:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Running setup.py install for moznetwork 20:41:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Running setup.py install for mozprocess 20:41:11 INFO - Running setup.py install for mozprofile 20:41:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:41:11 INFO - Running setup.py install for mozrunner 20:41:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:41:12 INFO - Running setup.py install for mozscreenshot 20:41:12 INFO - Running setup.py install for moztest 20:41:12 INFO - Running setup.py install for mozversion 20:41:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:41:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:41:12 INFO - Cleaning up... 20:41:12 INFO - Return code: 0 20:41:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:12 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')]} 20:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:12 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')]} 20:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:12 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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:41:12 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 20:41:12 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 20:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:41:12 INFO - 'HOME': '/Users/cltbld', 20:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:41:12 INFO - 'LOGNAME': 'cltbld', 20:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:12 INFO - 'MOZ_NO_REMOTE': '1', 20:41:12 INFO - 'NO_EM_RESTART': '1', 20:41:12 INFO - 'PAGER': '/bin/cat', 20:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:12 INFO - 'PWD': '/builds/slave/test', 20:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:41:12 INFO - 'SHELL': '/bin/bash', 20:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:41:12 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:41:12 INFO - 'USER': 'cltbld', 20:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:12 INFO - 'XPC_FLAGS': '0x0', 20:41:12 INFO - 'XPC_SERVICE_NAME': '0', 20:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:41:12 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-DrYjFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:41:12 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)) 20:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:41:12 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-C1XuGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-kBvOWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-LnNWYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-McGGbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-6e8F8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-kU2nK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-TatuCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-46ko2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-yPoodl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:41:13 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)) 20:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:41:13 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-VvSMxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:41:14 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)) 20:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:41:14 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-KjNI3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:41:14 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)) 20:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:41:14 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-VrBwS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:41:14 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)) 20:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:41:14 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-CjvAPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:41:14 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)) 20:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:14 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-bzevsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:41:14 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)) 20:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:41:14 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-OFjZyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 20:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:41:14 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-njIvr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:41:14 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)) 20:41:14 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)) 20:41:14 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)) 20:41:14 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)) 20:41:14 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)) 20:41:14 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)) 20:41:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:41:14 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 20:41:14 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 20:41:14 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 20:41:14 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 20:41:14 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 20:41:14 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 20:41:17 INFO - Downloading blessings-1.6.tar.gz 20:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:41:17 INFO - Installing collected packages: blessings 20:41:17 INFO - Running setup.py install for blessings 20:41:17 INFO - Successfully installed blessings 20:41:17 INFO - Cleaning up... 20:41:17 INFO - Return code: 0 20:41:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:41:17 INFO - Reading from file tmpfile_stdout 20:41:17 INFO - Current package versions: 20:41:17 INFO - blessings == 1.6 20:41:17 INFO - blobuploader == 1.2.4 20:41:17 INFO - docopt == 0.6.1 20:41:17 INFO - functools32 == 3.2.3-2 20:41:17 INFO - jsonschema == 2.5.1 20:41:17 INFO - manifestparser == 1.1 20:41:17 INFO - mozInstall == 1.12 20:41:17 INFO - mozcrash == 1.0 20:41:17 INFO - mozdebug == 0.1 20:41:17 INFO - mozdevice == 0.48 20:41:17 INFO - mozfile == 1.2 20:41:17 INFO - mozhttpd == 0.7 20:41:17 INFO - mozinfo == 0.9 20:41:17 INFO - mozleak == 0.1 20:41:17 INFO - mozlog == 3.4 20:41:17 INFO - moznetwork == 0.27 20:41:17 INFO - mozprocess == 0.23 20:41:17 INFO - mozprofile == 0.28 20:41:17 INFO - mozrunner == 6.13 20:41:17 INFO - mozscreenshot == 0.1 20:41:17 INFO - mozsystemmonitor == 0.3 20:41:17 INFO - moztest == 0.8 20:41:17 INFO - mozversion == 1.4 20:41:17 INFO - psutil == 3.1.1 20:41:17 INFO - requests == 1.2.3 20:41:17 INFO - wsgiref == 0.1.2 20:41:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:41:17 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')]} 20:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:18 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 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:41:18 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 20:41:18 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 20:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:41:18 INFO - 'HOME': '/Users/cltbld', 20:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:41:18 INFO - 'LOGNAME': 'cltbld', 20:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:18 INFO - 'MOZ_NO_REMOTE': '1', 20:41:18 INFO - 'NO_EM_RESTART': '1', 20:41:18 INFO - 'PAGER': '/bin/cat', 20:41:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:18 INFO - 'PWD': '/builds/slave/test', 20:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:41:18 INFO - 'SHELL': '/bin/bash', 20:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:41:18 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:41:18 INFO - 'USER': 'cltbld', 20:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:18 INFO - 'XPC_FLAGS': '0x0', 20:41:18 INFO - 'XPC_SERVICE_NAME': '0', 20:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 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)) 20:41:18 INFO - Cleaning up... 20:41:18 INFO - Return code: 0 20:41:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984a471de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, '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.htfqSs7Giw/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.zSefVCs0ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 20:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:41:18 INFO - 'HOME': '/Users/cltbld', 20:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:41:18 INFO - 'LOGNAME': 'cltbld', 20:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:18 INFO - 'MOZ_NO_REMOTE': '1', 20:41:18 INFO - 'NO_EM_RESTART': '1', 20:41:18 INFO - 'PAGER': '/bin/cat', 20:41:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:18 INFO - 'PWD': '/builds/slave/test', 20:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:41:18 INFO - 'SHELL': '/bin/bash', 20:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:41:18 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:41:18 INFO - 'USER': 'cltbld', 20:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:18 INFO - 'XPC_FLAGS': '0x0', 20:41:18 INFO - 'XPC_SERVICE_NAME': '0', 20:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:41:18 INFO - Cleaning up... 20:41:18 INFO - Return code: 0 20:41:18 INFO - Running post-action listener: _resource_record_post_action 20:41:18 INFO - Running post-action listener: _start_resource_monitoring 20:41:18 INFO - Starting resource monitoring. 20:41:18 INFO - [mozharness: 2017-01-24 04:41:18.813304Z] Finished create-virtualenv step (success) 20:41:18 INFO - [mozharness: 2017-01-24 04:41:18.814303Z] Running install step. 20:41:18 INFO - Running pre-action listener: _resource_record_pre_action 20:41:18 INFO - Running main action method: install 20:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:41:19 INFO - Reading from file tmpfile_stdout 20:41:19 INFO - Detecting whether we're running mozinstall >=1.0... 20:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:41:19 INFO - Reading from file tmpfile_stdout 20:41:19 INFO - Output received: 20:41:19 INFO - Usage: mozinstall [options] installer 20:41:19 INFO - Options: 20:41:19 INFO - -h, --help show this help message and exit 20:41:19 INFO - -d DEST, --destination=DEST 20:41:19 INFO - Directory to install application into. [default: 20:41:19 INFO - "/builds/slave/test"] 20:41:19 INFO - --app=APP Application being installed. [default: firefox] 20:41:19 INFO - mkdir: /builds/slave/test/build/application 20:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 20:41:40 INFO - Reading from file tmpfile_stdout 20:41:40 INFO - Output received: 20:41:40 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:41:40 INFO - Running post-action listener: _resource_record_post_action 20:41:40 INFO - [mozharness: 2017-01-24 04:41:40.227226Z] Finished install step (success) 20:41:40 INFO - [mozharness: 2017-01-24 04:41:40.227346Z] Running run-tests step. 20:41:40 INFO - Running pre-action listener: _resource_record_pre_action 20:41:40 INFO - Running main action method: run_tests 20:41:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:41:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:41:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:41:40 INFO - 2017-01-23 20:41:40.240 screenresolution[1624:7369] starting screenresolution argv=screenresolution get 20:41:40 INFO - 2017-01-23 20:41:40.242 screenresolution[1624:7369] Display 0: 1600x1200x32@60 20:41:40 INFO - 2017-01-23 20:41:40.247 screenresolution[1625:7371] starting screenresolution argv=screenresolution list 20:41:40 INFO - Available Modes on Display 0 20:41:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:41:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:41:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:41:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:41:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:41:40 INFO - Intel Iris: 20:41:40 INFO - Chipset Model: Intel Iris 20:41:40 INFO - Type: GPU 20:41:40 INFO - Bus: Built-In 20:41:40 INFO - VRAM (Dynamic, Max): 1536 MB 20:41:40 INFO - Vendor: Intel (0x8086) 20:41:40 INFO - Device ID: 0x0a2e 20:41:40 INFO - Revision ID: 0x0009 20:41:40 INFO - Displays: 20:41:40 INFO - Display: 20:41:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:41:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:41:40 INFO - Display Serial Number: 1600x1200 60 20:41:40 INFO - Main Display: Yes 20:41:40 INFO - Mirror: Off 20:41:40 INFO - Online: Yes 20:41:40 INFO - Rotation: Supported 20:41:40 INFO - Return code: 0 20:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:41:40 INFO - Python 2.7.3 20:41:40 INFO - Return code: 0 20:41:40 INFO - grabbing minidump binary from tooltool 20:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:40 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 0x105aa0d30>, '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 0x105906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a98b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:41:40 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 20:41:40 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 20:41:40 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 20:41:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:41:40 INFO - Return code: 0 20:41:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:41:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:41:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:41:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:41:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 20:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0149 --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 20:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.htfqSs7Giw/Render', 20:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:41:40 INFO - 'HOME': '/Users/cltbld', 20:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:41:40 INFO - 'LOGNAME': 'cltbld', 20:41:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:41:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:40 INFO - 'MOZ_NO_REMOTE': '1', 20:41:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:41:40 INFO - 'NO_EM_RESTART': '1', 20:41:40 INFO - 'PAGER': '/bin/cat', 20:41:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:41:40 INFO - 'PWD': '/builds/slave/test', 20:41:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:41:40 INFO - 'SHELL': '/bin/bash', 20:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zSefVCs0ff/Listeners', 20:41:40 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 20:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:41:40 INFO - 'USER': 'cltbld', 20:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:40 INFO - 'XPC_FLAGS': '0x0', 20:41:40 INFO - 'XPC_SERVICE_NAME': '0', 20:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:41:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 20:41:40 INFO - mozversion application_buildid: 20170123180844 20:41:40 INFO - mozversion application_changeset: 748ca6ea965cd7287affab431369809c751b462e 20:41:40 INFO - mozversion application_display_name: Firefox 20:41:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:41:40 INFO - mozversion application_name: Firefox 20:41:40 INFO - mozversion application_remotingname: firefox 20:41:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:41:40 INFO - mozversion application_vendor: Mozilla 20:41:40 INFO - mozversion application_version: 52.0 20:41:40 INFO - mozversion platform_buildid: 20170123180844 20:41:40 INFO - mozversion platform_changeset: 748ca6ea965cd7287affab431369809c751b462e 20:41:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:41:40 INFO - mozversion platform_version: 52.0 20:41:40 INFO - using testdate: 1485232900 20:41:40 INFO - actual date: 1485232900 20:41:40 INFO - starting webserver on 'localhost:49236' 20:41:40 INFO - SUITE-START | Running 2 tests 20:41:40 INFO - TEST-START | dromaeo_css 20:41:40 INFO - operating with platform_type : mac_ 20:41:40 INFO - Initialising browser for dromaeo_css test... 20:41:40 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpqA8EkX/profile http://localhost:49236/getInfo.html) 20:41:43 INFO - PROCESS | 1635 | 2017-01-23 20:41:43.837 plugin-container[1638:7549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 20:41:43 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:41:43 INFO - PROCESS | 1635 | 2017-01-23 20:41:43.838 plugin-container[1638:7549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 20:41:43 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:41:43 INFO - PROCESS | 1635 | 2017-01-23 20:41:43.838 plugin-container[1638:7549] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:41:43 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 20:41:43 INFO - PROCESS | 1635 | colorDepth:24 20:41:43 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 20:41:43 INFO - PROCESS | 1635 | __metrics 20:41:44 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 20:41:44 INFO - TEST-INFO | 1635: exit 0 20:41:44 INFO - Browser initialized. 20:41:44 INFO - Running cycle 1/1 for dromaeo_css test... 20:41:44 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpqA8EkX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:47 INFO - PROCESS | 1639 | 2017-01-23 20:41:47.195 plugin-container[1640:7807] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x832b, name = 'com.apple.tsm.portname' 20:41:47 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:41:47 INFO - PROCESS | 1639 | 2017-01-23 20:41:47.195 plugin-container[1640:7807] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 20:41:47 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:41:47 INFO - PROCESS | 1639 | 2017-01-23 20:41:47.195 plugin-container[1640:7807] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:41:56 INFO - PROCESS | 1639 | RSS: Main: 178458624 20:41:56 INFO - PROCESS | 1639 | 20:44:59 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 20:45:01 INFO - PROCESS | 1639 | RSS: Main: 183345152 20:45:01 INFO - PROCESS | 1639 | 20:48:03 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 20:48:03 INFO - PROCESS | 1639 | RSS: Main: 192405504 20:48:03 INFO - PROCESS | 1639 | 20:51:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 20:51:06 INFO - PROCESS | 1639 | RSS: Main: 196210688 20:51:06 INFO - PROCESS | 1639 | 20:54:08 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 20:54:08 INFO - PROCESS | 1639 | RSS: Main: 199225344 20:54:08 INFO - PROCESS | 1639 | 20:57:11 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 20:57:12 INFO - PROCESS | 1639 | RSS: Main: 200638464 20:57:12 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 21:00:14 INFO - PROCESS | 1639 | RSS: Main: 201187328 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | __start_tp_report 21:00:14 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 21:00:14 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 21:00:14 INFO - PROCESS | 1639 | |i|pagename|runs| 21:00:14 INFO - PROCESS | 1639 | |0;dojo.html;3373.98313008435;3586.6592673696005;3630.546181727283;3631.8002509861963;3641.2717456508703;6034.788782392618;6043.274807023158;6055.940210463174;6087.573869829113;6114.1745864308305;6059.545534084939;6118.235220597426;6129.724162412691;6137.6624285664275;6156.076588511725;4569.337446070318;5387.0303345397815;5446.183072539111;5447.782088716446;5455.5908306876945;5483.561315094783;5507.03626865299;5509.504144626982;5528.861778455531;5569.10894256919;5345.518903298722;5372.140457526796;5503.9174412383845;5516.282883225175;5522.806701765439;4713.622910167179;5180.974095129519;5423;5503.587230957654;5558.6942718150485;5340.599455040888;5458.426865179139;5459.808906688287;5471.50756431919;5513.724313784295;5747.252857128588;6071;6108.725107370179;6144.754209831646;6153.384661533811;6192.87614247717;6196.504279657616;6225.439710426038;6238.064290356438;6246.469050130744;6257.092721555395;6263.530235232376;6281.528885333618;6353;6374.139491168679;6169.629822210682;6185.381461853869;6199.969000154971;6211;6215.409536094064;6416.35836416364;6435.935640643534;6438.54930154894;6539.50953678476;6561.507886908501;6278.372162783685;6285.182926219653;6295.055741638791;6306.842328941813;6316.4315211630255;5123.205903085028;6261.405166509175;6393.776217832354;6420.550561460746;6438.163038804925;4959.454460009396;6269.059641053878;6271.7804876830005;6311.747530098836;6351.364863513611;6241.96879015602;6302.65335406557;6314.873702525923;6354.91966365719;6383.521235907326;4995.450500444948;5063.594912406998;5220.634555581073;5237.528622424;5254.343207099113;3815.2178803345246;3883.8446462141196;4604.447466304065;4618.584327410549;4719.961608446137;5339.919901201485;5724.656520608777;6160.414760597736;6205.751769929152;6216.627002379872;6415.133956915756;6419.422251997249;6421.550491465552;6428.067930150102;6431.517636177306;6037.215162028908;6117.929362361569;6124.319907527392;6126.2123341605975;6140.381550880983;5722.141678748221;5723.8855222896145;5735.0250457422335;5742.684152371576;5744.425557444306;6601.669916504252;6681.599104053772;6686.13080299558;6695.497837662195;6713.429358504582;6247.750089996531;6265.15420418256;6306.810795676137;6340.65126418033;6437.710303036468;6607.075009498578;6631.602103873783;6643.069970204272;6645.335466453316;6651.068850360856;6347.809565713036;6355.650439225887;6371.490280777434;6374.776882809079;6378.2346118466085;5125.2568377585785;6248.250209974832;6272.184616000073;6356.872862542816;6396.872062558629;4912.48418916023;5774.48029677331;5857.677827719516;6269;6278.340774218641;6179.671739184614;6252.812415627538;6253.5622506424115;6267.561270711007;6277.497800176066;5888.970555147197;6085.056816193497;6242;6274;6294.748210071546;5722.769604535045;6119.015143218386;6148.354422785543;6158.983767678283;6286.905696414649;6251.437370636664;6288.245410550763;6295.213098362705;6300.464460520907;6324.17785687876 21:00:14 INFO - PROCESS | 1639 | |1;ext.html;447.8454933048099;493.5311454118588;520.6303524497606;524.6956765076255;581.4853854338909;39521.60478395215;41579.79210103949;41707.791461042725;43681;43698.34452483207;42887.57112428883;43191.78404107983;43316.56683433172;43325;43401.78299108508;9549.23606111511;9721.708348749513;9721.902780972207;9725.610975560969;9751.902480975206;9644.710658680251;9717.61129554817;9721.465319407429;9727.562259698296;9758.024197580256;9696.951515242414;9728.929817720045;9758.707238782848;9765.462899540522;9768.609255629803;9658.323917325755;9715.222782177445;9726.17327527161;9733.805323893554;9751.414915105117;9659.90340096597;9707.174890134347;9722.611095556169;9732.95133524335;9750.219982401391;34509.65490345089;40957.180856383005;41260.79369603163;41331.7933410331;41334.793326033476;3286.5398844161837;3409.2840503494294;3429.5884493860895;3440.8623655053766;4040.1313717550865;30089.69910300891;30116;30785.692143078508;30976.225594360098;32433.83783081093;3208.358328334319;3293.8847140350213;3318.983405082983;3379.222778760874;3388.3053973935284;463609;467438;469282;471405;475947;62889.37110628927;63404.36595634077;63568;63650;63843.76546820839;65965;66157.66921165363;66464.33535664678;66599;66649.33350666528;17161.227744751268;17209.65580688379;17349.045802480734;17421.564460888578;17439.302427902996;12749;13159.934200328937;13194.472221111047;13236.933815330862;13300.600981970556;18313.572442584744;19475.8052419474;19721.901390492956;19760.40718778439;19792.50518737014;3275.852586633607;3392.4232880409895;8061.596920154087;8120.305261106182;8277.714268598933;901.5492253873064;973.1047436358567;996.3125443444001;1079.4386918802336;1109.3676604335612;30269.94055208057;30364.54453183204;30524.350179243895;30699.693003069682;31044.53433198504;1069.550788668761;1097.9011888930036;1103.939283339424;1110.74452875839;1157.3171828621155;14989.400423983137;15820.446284379992;15932.761008584881;15959;16239.431619893247;686515;689546;689930;695702;696207;60303;60355;60395.69802151049;60442;60768.08847867286;1399.0556374447208;1413.8374086979923;1439.6688761584685;1445.2268036600158;1445.8265008198873;28816.785357538916;29941.70058299389;30303.545446818756;31051;31072;49643.50356496389;58208.708956454946;58796.82406351934;59012.52468688146;59056.409435905094;618877.905610469;623405;625102;635213;635766;43674;43855.78072109619;44713.65859024235;44753;44757.55242447664;45436.54563454323;46457;46847.76576117097;47612.761936190094;48390;38305.85082447531;39402.88746420387;40235.59764402318;41095.589044109176;41693.58306417018;34251.65748342584;39792.403113952736;39975.80012100037;40304.59695403009;41172;38463.615363846;39433.80283098566;40031.79984100061;40037.79981100076;40201.79899100603;28901;32492.212928289173;35651;35873.103172420895;36191.81904090463;26651.33371665724;26665.60001599939;26690.065847695238;26775.598366024915;27090.458190836467 21:00:14 INFO - PROCESS | 1639 | |2;jquery.html;316.68964414873426;384.1337783298663;387.49431991251424;391.6162161082138;406.8840380491559;19657.709532949444;20750.688739668916;21252.787472125274;21550.676739848914;21799.891000545016;20214.797852021475;20342.69485957708;20401.897990510028;20533;20618.381448556567;5807.738651760681;5925.88148237035;6070.5447091468095;6106;6162.537809664271;3521.366154092262;4070.9389359159636;5965.582409231356;6107.5113990880845;6113.847153821145;5812.680302583356;6078.17944577483;6135.110408990694;6136.140940268366;6154.138420621117;6128.4178003089855;6149.446549810516;6290.685465726719;6592.80221593353;6635.004749287597;5901.911471327933;5904.1734157218025;5920.496757775594;5940.405959404068;5949.643021418686;13266.00504962122;13486.460541578324;13539.187648741106;13557.38991745364;13746.793798093036;2317.9685040157137;2406.049610403898;2735.753782159615;3029.9545506817417;3033.196203006205;10248.180145588334;10316.277860549764;10577.524011419504;10776.78446431067;10799.622013229578;1940.1075505267595;1957.4616980330381;1962.097435179819;1982.682770756672;2024.4129202531249;123169.76830231672;123757;126647;132694;132898;9645;10847.403392813314;11449.912258335446;11496.942515287537;11569.537218511334;14029.78955315671;14609.78085328721;14874.553763387115;14922.179280139479;14930.925345373204;8498.235158835734;8736.951565812016;8769.342299327449;8800.16398442147;8943.597538110671;8630.26642735362;8635.438696484709;8654.35092368075;8689.956550217335;8806.075362086889;3964.663003644665;4498.460184777848;4601.861944141681;4620.237660785932;4690.671652984327;1679.7648329233916;1986.3941497843007;1990.5819777846814;2016.5462770876436;3800.315943130208;855.8972923249125;913.5021413329752;966.6520052780993;967.7677357434166;1007.8437842134481;19170.61658766817;20126.798732012787;20636.896815516127;20741.79258207429;20860;912.8585069314134;946.4794363100267;952.4095061062186;1010.7068950004416;1016.2276669731058;10652.360858348524;10994.395308257963;11073.169512286611;11074.778504429867;11095.38975356347;590854;598374;600554.9972250111;606573;606666;114792.70414591662;132368;133430;137745;139007;858.6050416808338;998.9051040151174;999.3753903810118;1010.7624708193715;1015.8374660054355;17734.91132544329;18431.788185417834;18795.81204187995;18818.24727010904;18855.811441885955;53190.73404632952;53806;54733;54834.72582637061;55343;62109.689451552455;72470.63764681354;74168;75231;77635.61182194053;7489.962550187214;8326.25063744266;8326.83346333082;8509.10654381281;8527.658893644184;10177.49112544355;12932.806007910078;13161.276129812952;13382.397792099184;13525.661858453224;9364.859527107235;11458;11556.479958401724;12050.638480845588;12094.576689815814;11262.7747445049;11284.887151128383;11672.416379181177;11684.474198660911;11849.05207583374;10629;10886.183536234656;11635.011024062711;11695.649130526097;11824.940875295568;8427.831443370975;8563.785905352415;8610.65557377698;8655.56722163902;8656.826863462822;11544.94227528857;11996.40017999114;12039.819402709141;12107.091968102251;12124.818127727915 21:00:14 INFO - PROCESS | 1639 | |3;mootools.html;1358.1579420759128;1503.0680977793766;1674.983250167498;1832.9725054124183;1866.3747644539071;6519.967400163005;7937.5237485750895;8245.422820402575;8582.828343433128;8626.870596941044;8096.878546821802;8375.036870759865;8395.538245396501;8498.447600905953;8503.914960850405;2360.3862995621134;2409.855408675476;2410.6504556839336;2412.0954642009247;2417.407735104902;2403.759624037591;2418.9516209675794;2446.217210492643;2446.902123915041;2452.16626347042;2379.3694670912223;2391.7608239176116;2407.458321877581;2407.7953373963232;2417.903283868652;2019.1519561784087;2371.95256094878;2375.798057165143;2399.172285561487;2409.2410890569504;2398.784109430142;2399.7641214774403;2407.7953373963232;2415.7221919479307;2417.9758202417925;8433.789155271106;8459.95770021146;8522.914770852274;8550.52972086535;8560.785980350478;4574.565416285481;5210.322658054467;5339.733013349356;5345.198220266952;5359.303290572239;3244.621036059665;3258.152880251128;3414.8804791832417;3441.913952151191;3530.1880567469625;894.5259012723267;915.199200699388;1053.1943063556384;1060.8037513060108;1094.5402930769096;10726.731831704192;10860.402677852715;10904.509297081571;10919.290246134055;10968.122550195965;4618.676692631483;4707.129181101507;4767.547083027107;4772.7136371817805;4775.976120119377;9464.858027129598;9627.229821614254;9672.903270967341;9687;9693.176080033276;5251.317328747315;5317.8404647860625;5351.170568561879;5352.946470535323;5354.678719276856;4415.646748260131;4442.133783912106;4859.052484765437;4899.240617704261;4919.975400123048;3904.472896159039;3905.5899130591447;4010.438538604598;4034.374671925856;4052.797360131982;1155.8612966443911;1259;1284.2487145020268;1301.4533895763802;1324.4503531034704;789.1083076123944;807.9394045446616;894.9731508054768;940.8682784410188;962.119660510625;4843.2250839865455;5816.185733997244;5850.619709718854;5905.173275741399;5946.613470124428;810.5866008335792;942.2179590939504;966.6954909203579;984.1978787288338;1019.1235537437798;3745.6628903398823;3835.5589107252463;3912.4522566840665;3949.585293544194;3971.702122340836;8385.874211886827;9754.170895473822;10087.646932357333;10210.540525676362;10238.12975897057;10145.9492702536;10161.08550230468;10187.694369168938;10232.693019209435;10254.28220024606;7511.399088072941;7826.4130190235965;7852.960735196288;7985.2014798519685;8002.159773223728;5732.140178973187;5743.483086522233;5884.323302820059;5966.522678185822;5971.193888824953;8994.640214391351;9228.877358207785;9413.811723765622;9447.385919915183;9552.044795520393;9518.857217141609;9528.52357382142;9532.95233523828;9615;9708.223342132753;6730.663466826737;6758.459323254227;7153.606551639502;7228.27717228294;7376.926230737624;7891.881621775793;8034.598270086355;8067.193280671886;8071.757847264592;8079.151689072798;7148.428125749823;7315.853682926205;7320.816979575553;7371.520851144658;7376.557406555624;7074.434045276468;7161.4270858330165;7168.569885806868;7187.281271872771;7193.892091618734;6728.764493242713;6807.115075040411;6834.760783372558;6838.487113466609;6852;4897.608191344612;4913.484084171254;4915.778789954389;4990.126727822544;5007.273945277987;4969.130402179532;4986.576141028053;5044.4451110377095;5078.136716758234;5094.388673359221 21:00:14 INFO - PROCESS | 1639 | |4;prototype.html;309.33801664438107;312.6248501797843;318.34103405949685;324.1232466178986;324.1539581691783;4984.959174903311;5346.946530534694;5445.346558412986;5505.697186654737;5556.805511807088;5290.523852853243;5412.242286079952;5431.972840135803;5452.6455780374245;5501.394846566875;4161.417401563776;4184.51878034027;4200.285951388271;4200.4539409876825;4200.642945349634;3692.4092145256764;3719.82825409995;3756.211195648917;4138.213739389522;4239.236937351276;4141.9585804142025;4154.9820294028;4161.271777438951;4167.499900012002;4183.665306775466;4154.5222299435645;4184.602462766047;4192.937105943382;4201.495820501544;4202.508109621071;3237.5629290045777;3499.6001599360206;3683.2633473305445;3690.1697118148472;3692.818298144595;4807.951920480786;5033.84898453047;5150.7895644523505;5274.393444753864;5315.73421328932;4133.937990930139;4210.989362552996;4823.855284341475;4833.516648335173;4840.298156767249;5424.7758419048005;5580.190872323531;5759.5968282220265;5759.971200144015;5796.2464879565805;3780.9621903781162;3966.702497312684;4023.295923213426;4056.7565946043333;4061.959380406188;5158.638895277332;6067.787627433018;6090.96954515229;6139.416755408229;6156.87686246277;4113.691473139466;4139.627433530996;4147.087640719037;4155.293600087993;4164.8542301019315;4051.918961620751;4158.688098392633;4191.91616167675;4192.958070419318;4200.916890562393;4306.935395969063;4600.125976064537;4828.444728856227;4835.87221622485;4844;4844.467108618049;5017.9247311290355;5635.7175343985755;5803.361630220672;5813.302403711582;1142.5087212498706;1198.688341031338;1340.8468716903456;1350.4260689207047;1359.7756370199004;803.2329125684956;906.2976193450129;930.5114814722325;941.37612618233;945.7351941456403;5124.5131712487255;5126.7180305083575;5167.715775632376;5172.793088276502;5179.663321884065;5093.439721630618;5183.481651834786;5205.401378841406;5547.805826796123;5575.637583557137;4103.240241320054;4350.542568239612;5105.923411148836;5155.587552995827;5194.948050519446;2508.4105235270063;2725.523033469135;2899.6520417550028;2918.176139912555;2921.5617657351568;5041.621878359138;5480.260164877691;5516.668999860021;5745.88508229833;5768.711564421762;5088.542031217208;5292.92060619091;5325.390558626245;5653.462921022497;5723.313202415737;4724.456687480915;5019.034962379752;5347.385050719217;5645.640843697993;5723.112917497794;4818.807247710052;4934.827281045146;5489.423610520837;5542.473465020817;5598.944010559842;5273.709945953009;5371.838844834661;5505.476979686923;5505.752241149078;5899.852503687443;5551.9722401387735;5579.916301255404;6205.751769929152;6237.781677641261;6263.342349053284;3415.846286917045;4008.997750562359;4025.315696331572;4033.294173519681;4038.2529232092156;5641.605087643826;5835.620684655484;5947.877364383733;5981.7607295707685;6030.30651475086;5559.721264109358;5576.804811831566;5886.646801191942;5900.279776179125;5915.794101190924;4962.851114466572;5381.73091345439;5572.832815015556;5870.706464676835;5910.7340169693325;5258.0798360286035;5374.667706022291;5645.943540564542;5746.569007324384;5765.279340082489;5716.456556729577;5846.298444186725;5866.5893387462465;5889.734961926809;5894.930359890576;5488.7530061148145;5491.270249871438;5659.943400566106;5741.282339707536;5802.143314139435 21:00:14 INFO - PROCESS | 1639 | |5;yui.html;669.4142625202948;679.9732404069853;728.2935552514061;749.8387846612977;828.643683216217;13952.372143253566;14975.925120374397;15326.080435173897;15447.536573902773;15965.361385544593;14459.638509037279;14467.710645787078;14565.927170364133;14566.854331456681;14594.562163135097;880.0891077734562;896.8251191017754;896.9953651909871;900.5272232078179;908.591133989704;654.4077609763148;722.8409749855024;864.8702694595798;896.5158814240302;910.0580898769774;895.8700988356717;938.713692323841;939.5302348825587;942.5428667096487;944.9385789923667;899.1458114790942;925.7037747920668;934.2946075712828;936.4194199596294;938.7512309238092;664.7772996046331;684.4661164291861;692.3076923076923;695.778908016433;702.0592406175749;14555;14594.635134121625;14738.55784326472;14829.851701482956;15210.847891521054;14498.855011449856;14839.406423743038;14893.374047317573;14900.105993640416;15110.622234444118;11324.94337528307;11537.134714896416;11769.941150294193;11802.586909458129;11998.400079996052;4553.043860789238;4594.411238926213;4606.930896036529;4610.492845786961;4678.157931572316;97314;98566.5071674637;100948.49525752325;102578.99999999926;102928;10417.739556511147;10777.62278320255;10830.241883068109;10836.891631083747;10842.457877106113;19776.505587360145;19842.404727858186;19872.60254794896;19901.104450299772;21471.67792483114;8087.838243235103;8163.7142700005215;8211.17888211174;8222.917770822216;8504.362172837062;4300.483941926988;4326.740395576276;4365.388845561624;4498.8425405110665;4530.84142055033;3288.1450822786246;3397.5073614325784;3406.2506248625264;3423.3666771647327;3427.7429192810637;586.2320360327984;603.0772917436329;603.2218438214742;616.3220457496718;618.3939739055751;592.4016743089425;605.8247000818486;639.0605809460086;694.9409300209538;701.7543859649184;8835.453795585747;9546.711193988862;9835.45904975219;9848.556814943344;9948.552315145836;604.7127614383221;630.19020558582;684.0759026827649;687.9759208427681;696.6621188723465;4061;4295.978520107379;4508.909821803545;4574.382458368144;4590.42619672541;76740.84888726674;97558;121179.39410303069;122493.38753306176;125618.7438125607;97798.51100744451;105062;106437.46781266044;108826;109918;65414;91580.08419915849;92178;95332;96472.03527964771;6672.966635166793;8632.956835215784;8982.775430614287;9049.909500904907;9083.091690830865;46273.53726462827;55069;55135;55833.720831395585;57862.7106864463;57850.84298313926;59028;59534.10698839607;60220.69889650524;76970;11857.11071669611;11931;11938.28370297785;12287.078469114673;12355.505779768708;14462;14579.343929522985;14724.26378681083;14774.261286935396;15037.849621503645;13416.993725470433;13510.729785404434;13744.450221991008;13751.099208569814;13800.654983625489;13070;13230.801537977131;13380;13664.658383540092;13769.03616746818;13185.40665670028;13337.133086349357;13485;13540;13746.725065498435;10556.577736890438;10914.290571112851;11048.668539943814;11054.447277636247;11322.94338528302;11334;11589.7102572433;11621.240252506499;11693;11712.238704484522 21:00:14 INFO - PROCESS | 1639 | __end_tp_report 21:00:14 INFO - PROCESS | 1639 | __start_cc_report 21:00:14 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,358 21:00:14 INFO - PROCESS | 1639 | __end_cc_report 21:00:14 INFO - PROCESS | 1639 | __startTimestamp1485234014842__endTimestamp 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | ------- Summary: start ------- 21:00:14 INFO - PROCESS | 1639 | Number of tests: 6 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5911.96 Median:6185.38 stddev:674.38 (10.9%) stddev-sans-first:646.39 21:00:14 INFO - PROCESS | 1639 | Values: 3374.0 3586.7 3630.5 3631.8 3641.3 6034.8 6043.3 6055.9 6087.6 6114.2 6059.5 6118.2 6129.7 6137.7 6156.1 4569.3 5387.0 5446.2 5447.8 5455.6 5483.6 5507.0 5509.5 5528.9 5569.1 5345.5 5372.1 5503.9 5516.3 5522.8 4713.6 5181.0 5423.0 5503.6 5558.7 5340.6 5458.4 5459.8 5471.5 5513.7 5747.3 6071.0 6108.7 6144.8 6153.4 6192.9 6196.5 6225.4 6238.1 6246.5 6257.1 6263.5 6281.5 6353.0 6374.1 6169.6 6185.4 6200.0 6211.0 6215.4 6416.4 6435.9 6438.5 6539.5 6561.5 6278.4 6285.2 6295.1 6306.8 6316.4 5123.2 6261.4 6393.8 6420.6 6438.2 4959.5 6269.1 6271.8 6311.7 6351.4 6242.0 6302.7 6314.9 6354.9 6383.5 4995.5 5063.6 5220.6 5237.5 5254.3 3815.2 3883.8 4604.4 4618.6 4720.0 5339.9 5724.7 6160.4 6205.8 6216.6 6415.1 6419.4 6421.6 6428.1 6431.5 6037.2 6117.9 6124.3 6126.2 6140.4 5722.1 5723.9 5735.0 5742.7 5744.4 6601.7 6681.6 6686.1 6695.5 6713.4 6247.8 6265.2 6306.8 6340.7 6437.7 6607.1 6631.6 6643.1 6645.3 6651.1 6347.8 6355.7 6371.5 6374.8 6378.2 5125.3 6248.3 6272.2 6356.9 6396.9 4912.5 5774.5 5857.7 6269.0 6278.3 6179.7 6252.8 6253.6 6267.6 6277.5 5889.0 6085.1 6242.0 6274.0 6294.7 5722.8 6119.0 6148.4 6159.0 6286.9 6251.4 6288.2 6295.2 6300.5 6324.2 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:73749.83 Median:41700.69 stddev:161416.44 (387.1%) stddev-sans-first:161775.43 21:00:14 INFO - PROCESS | 1639 | Values: 447.8 493.5 520.6 524.7 581.5 39521.6 41579.8 41707.8 43681.0 43698.3 42887.6 43191.8 43316.6 43325.0 43401.8 9549.2 9721.7 9721.9 9725.6 9751.9 9644.7 9717.6 9721.5 9727.6 9758.0 9697.0 9728.9 9758.7 9765.5 9768.6 9658.3 9715.2 9726.2 9733.8 9751.4 9659.9 9707.2 9722.6 9733.0 9750.2 34509.7 40957.2 41260.8 41331.8 41334.8 3286.5 3409.3 3429.6 3440.9 4040.1 30089.7 30116.0 30785.7 30976.2 32433.8 3208.4 3293.9 3319.0 3379.2 3388.3 463609.0 467438.0 469282.0 471405.0 475947.0 62889.4 63404.4 63568.0 63650.0 63843.8 65965.0 66157.7 66464.3 66599.0 66649.3 17161.2 17209.7 17349.0 17421.6 17439.3 12749.0 13159.9 13194.5 13236.9 13300.6 18313.6 19475.8 19721.9 19760.4 19792.5 3275.9 3392.4 8061.6 8120.3 8277.7 901.5 973.1 996.3 1079.4 1109.4 30269.9 30364.5 30524.4 30699.7 31044.5 1069.6 1097.9 1103.9 1110.7 1157.3 14989.4 15820.4 15932.8 15959.0 16239.4 686515.0 689546.0 689930.0 695702.0 696207.0 60303.0 60355.0 60395.7 60442.0 60768.1 1399.1 1413.8 1439.7 1445.2 1445.8 28816.8 29941.7 30303.5 31051.0 31072.0 49643.5 58208.7 58796.8 59012.5 59056.4 618877.9 623405.0 625102.0 635213.0 635766.0 43674.0 43855.8 44713.7 44753.0 44757.6 45436.5 46457.0 46847.8 47612.8 48390.0 38305.9 39402.9 40235.6 41095.6 41693.6 34251.7 39792.4 39975.8 40304.6 41172.0 38463.6 39433.8 40031.8 40037.8 40201.8 28901.0 32492.2 35651.0 35873.1 36191.8 26651.3 26665.6 26690.1 26775.6 27090.5 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35134.83 Median:21675.28 stddev:100533.23 (463.8%) stddev-sans-first:100781.26 21:00:14 INFO - PROCESS | 1639 | Values: 316.7 384.1 387.5 391.6 406.9 19657.7 20750.7 21252.8 21550.7 21799.9 20214.8 20342.7 20401.9 20533.0 20618.4 5807.7 5925.9 6070.5 6106.0 6162.5 3521.4 4070.9 5965.6 6107.5 6113.8 5812.7 6078.2 6135.1 6136.1 6154.1 6128.4 6149.4 6290.7 6592.8 6635.0 5901.9 5904.2 5920.5 5940.4 5949.6 13266.0 13486.5 13539.2 13557.4 13746.8 2318.0 2406.0 2735.8 3030.0 3033.2 10248.2 10316.3 10577.5 10776.8 10799.6 1940.1 1957.5 1962.1 1982.7 2024.4 123169.8 123757.0 126647.0 132694.0 132898.0 9645.0 10847.4 11449.9 11496.9 11569.5 14029.8 14609.8 14874.6 14922.2 14930.9 8498.2 8737.0 8769.3 8800.2 8943.6 8630.3 8635.4 8654.4 8690.0 8806.1 3964.7 4498.5 4601.9 4620.2 4690.7 1679.8 1986.4 1990.6 2016.5 3800.3 855.9 913.5 966.7 967.8 1007.8 19170.6 20126.8 20636.9 20741.8 20860.0 912.9 946.5 952.4 1010.7 1016.2 10652.4 10994.4 11073.2 11074.8 11095.4 590854.0 598374.0 600555.0 606573.0 606666.0 114792.7 132368.0 133430.0 137745.0 139007.0 858.6 998.9 999.4 1010.8 1015.8 17734.9 18431.8 18795.8 18818.2 18855.8 53190.7 53806.0 54733.0 54834.7 55343.0 62109.7 72470.6 74168.0 75231.0 77635.6 7490.0 8326.3 8326.8 8509.1 8527.7 10177.5 12932.8 13161.3 13382.4 13525.7 9364.9 11458.0 11556.5 12050.6 12094.6 11262.8 11284.9 11672.4 11684.5 11849.1 10629.0 10886.2 11635.0 11695.6 11824.9 8427.8 8563.8 8610.7 8655.6 8656.8 11544.9 11996.4 12039.8 12107.1 12124.8 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5521.57 Median:5284.58 stddev:2986.33 (56.5%) stddev-sans-first:2978.31 21:00:14 INFO - PROCESS | 1639 | Values: 1358.2 1503.1 1675.0 1833.0 1866.4 6520.0 7937.5 8245.4 8582.8 8626.9 8096.9 8375.0 8395.5 8498.4 8503.9 2360.4 2409.9 2410.7 2412.1 2417.4 2403.8 2419.0 2446.2 2446.9 2452.2 2379.4 2391.8 2407.5 2407.8 2417.9 2019.2 2372.0 2375.8 2399.2 2409.2 2398.8 2399.8 2407.8 2415.7 2418.0 8433.8 8460.0 8522.9 8550.5 8560.8 4574.6 5210.3 5339.7 5345.2 5359.3 3244.6 3258.2 3414.9 3441.9 3530.2 894.5 915.2 1053.2 1060.8 1094.5 10726.7 10860.4 10904.5 10919.3 10968.1 4618.7 4707.1 4767.5 4772.7 4776.0 9464.9 9627.2 9672.9 9687.0 9693.2 5251.3 5317.8 5351.2 5352.9 5354.7 4415.6 4442.1 4859.1 4899.2 4920.0 3904.5 3905.6 4010.4 4034.4 4052.8 1155.9 1259.0 1284.2 1301.5 1324.5 789.1 807.9 895.0 940.9 962.1 4843.2 5816.2 5850.6 5905.2 5946.6 810.6 942.2 966.7 984.2 1019.1 3745.7 3835.6 3912.5 3949.6 3971.7 8385.9 9754.2 10087.6 10210.5 10238.1 10145.9 10161.1 10187.7 10232.7 10254.3 7511.4 7826.4 7853.0 7985.2 8002.2 5732.1 5743.5 5884.3 5966.5 5971.2 8994.6 9228.9 9413.8 9447.4 9552.0 9518.9 9528.5 9533.0 9615.0 9708.2 6730.7 6758.5 7153.6 7228.3 7376.9 7891.9 8034.6 8067.2 8071.8 8079.2 7148.4 7315.9 7320.8 7371.5 7376.6 7074.4 7161.4 7168.6 7187.3 7193.9 6728.8 6807.1 6834.8 6838.5 6852.0 4897.6 4913.5 4915.8 4990.1 5007.3 4969.1 4986.6 5044.4 5078.1 5094.4 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4614.43 Median:5163.18 stddev:1397.68 (27.1%) stddev-sans-first:1363.74 21:00:14 INFO - PROCESS | 1639 | Values: 309.3 312.6 318.3 324.1 324.2 4985.0 5346.9 5445.3 5505.7 5556.8 5290.5 5412.2 5432.0 5452.6 5501.4 4161.4 4184.5 4200.3 4200.5 4200.6 3692.4 3719.8 3756.2 4138.2 4239.2 4142.0 4155.0 4161.3 4167.5 4183.7 4154.5 4184.6 4192.9 4201.5 4202.5 3237.6 3499.6 3683.3 3690.2 3692.8 4808.0 5033.8 5150.8 5274.4 5315.7 4133.9 4211.0 4823.9 4833.5 4840.3 5424.8 5580.2 5759.6 5760.0 5796.2 3781.0 3966.7 4023.3 4056.8 4062.0 5158.6 6067.8 6091.0 6139.4 6156.9 4113.7 4139.6 4147.1 4155.3 4164.9 4051.9 4158.7 4191.9 4193.0 4200.9 4306.9 4600.1 4828.4 4835.9 4844.0 4844.5 5017.9 5635.7 5803.4 5813.3 1142.5 1198.7 1340.8 1350.4 1359.8 803.2 906.3 930.5 941.4 945.7 5124.5 5126.7 5167.7 5172.8 5179.7 5093.4 5183.5 5205.4 5547.8 5575.6 4103.2 4350.5 5105.9 5155.6 5194.9 2508.4 2725.5 2899.7 2918.2 2921.6 5041.6 5480.3 5516.7 5745.9 5768.7 5088.5 5292.9 5325.4 5653.5 5723.3 4724.5 5019.0 5347.4 5645.6 5723.1 4818.8 4934.8 5489.4 5542.5 5598.9 5273.7 5371.8 5505.5 5505.8 5899.9 5552.0 5579.9 6205.8 6237.8 6263.3 3415.8 4009.0 4025.3 4033.3 4038.3 5641.6 5835.6 5947.9 5981.8 6030.3 5559.7 5576.8 5886.6 5900.3 5915.8 4962.9 5381.7 5572.8 5870.7 5910.7 5258.1 5374.7 5645.9 5746.6 5765.3 5716.5 5846.3 5866.6 5889.7 5894.9 5488.8 5491.3 5659.9 5741.3 5802.1 21:00:14 INFO - PROCESS | 1639 | 21:00:14 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21154.43 Median:4503.88 stddev:31348.46 (696.0%) stddev-sans-first:31398.67 21:00:14 INFO - PROCESS | 1639 | Values: 669.4 680.0 728.3 749.8 828.6 13952.4 14975.9 15326.1 15447.5 15965.4 14459.6 14467.7 14565.9 14566.9 14594.6 880.1 896.8 897.0 900.5 908.6 654.4 722.8 864.9 896.5 910.1 895.9 938.7 939.5 942.5 944.9 899.1 925.7 934.3 936.4 938.8 664.8 684.5 692.3 695.8 702.1 14555.0 14594.6 14738.6 14829.9 15210.8 14498.9 14839.4 14893.4 14900.1 15110.6 11324.9 11537.1 11769.9 11802.6 11998.4 4553.0 4594.4 4606.9 4610.5 4678.2 97314.0 98566.5 100948.5 102579.0 102928.0 10417.7 10777.6 10830.2 10836.9 10842.5 19776.5 19842.4 19872.6 19901.1 21471.7 8087.8 8163.7 8211.2 8222.9 8504.4 4300.5 4326.7 4365.4 4498.8 4530.8 3288.1 3397.5 3406.3 3423.4 3427.7 586.2 603.1 603.2 616.3 618.4 592.4 605.8 639.1 694.9 701.8 8835.5 9546.7 9835.5 9848.6 9948.6 604.7 630.2 684.1 688.0 696.7 4061.0 4296.0 4508.9 4574.4 4590.4 76740.8 97558.0 121179.4 122493.4 125618.7 97798.5 105062.0 106437.5 108826.0 109918.0 65414.0 91580.1 92178.0 95332.0 96472.0 6673.0 8633.0 8982.8 9049.9 9083.1 46273.5 55069.0 55135.0 55833.7 57862.7 57850.8 59028.0 59534.1 60220.7 76970.0 11857.1 11931.0 11938.3 12287.1 12355.5 14462.0 14579.3 14724.3 14774.3 15037.8 13417.0 13510.7 13744.5 13751.1 13800.7 13070.0 13230.8 13380.0 13664.7 13769.0 13185.4 13337.1 13485.0 13540.0 13746.7 10556.6 10914.3 11048.7 11054.4 11322.9 11334.0 11589.7 11621.2 11693.0 11712.2 21:00:14 INFO - PROCESS | 1639 | -------- Summary: end -------- 21:00:14 INFO - PROCESS | 1639 | 21:00:15 INFO - TEST-INFO | 1639: exit 0 21:00:15 INFO - TEST-OK | dromaeo_css | took 1114605ms 21:00:15 INFO - TEST-START | kraken 21:00:15 INFO - operating with platform_type : mac_ 21:00:15 INFO - Initialising browser for kraken test... 21:00:15 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpYwgLz6/profile http://localhost:49236/getInfo.html) 21:00:18 INFO - PROCESS | 1650 | 2017-01-23 21:00:18.174 plugin-container[1652:10197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 21:00:18 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:00:18 INFO - PROCESS | 1650 | 2017-01-23 21:00:18.174 plugin-container[1652:10197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.CFPasteboardClient' 21:00:18 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:00:18 INFO - PROCESS | 1650 | 2017-01-23 21:00:18.174 plugin-container[1652:10197] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:00:18 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 21:00:18 INFO - PROCESS | 1650 | colorDepth:24 21:00:18 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 21:00:18 INFO - PROCESS | 1650 | __metrics 21:00:18 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 21:00:19 INFO - TEST-INFO | 1650: exit 0 21:00:19 INFO - Browser initialized. 21:00:19 INFO - Running cycle 1/1 for kraken test... 21:00:19 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpYwgLz6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:21 INFO - PROCESS | 1653 | 2017-01-23 21:00:21.492 plugin-container[1654:10319] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x884f, name = 'com.apple.tsm.portname' 21:00:21 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:00:21 INFO - PROCESS | 1653 | 2017-01-23 21:00:21.492 plugin-container[1654:10319] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 21:00:21 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:00:21 INFO - PROCESS | 1653 | 2017-01-23 21:00:21.492 plugin-container[1654:10319] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:00:31 INFO - PROCESS | 1653 | RSS: Main: 178528256 21:00:31 INFO - PROCESS | 1653 | 21:00:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 21:00:34 INFO - PROCESS | 1653 | RSS: Main: 190550016 21:00:34 INFO - PROCESS | 1653 | 21:00:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 21:00:38 INFO - PROCESS | 1653 | RSS: Main: 199725056 21:00:38 INFO - PROCESS | 1653 | 21:00:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 21:00:41 INFO - PROCESS | 1653 | RSS: Main: 202752000 21:00:41 INFO - PROCESS | 1653 | 21:00:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 21:00:44 INFO - PROCESS | 1653 | RSS: Main: 202825728 21:00:44 INFO - PROCESS | 1653 | 21:00:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:00:46 INFO - PROCESS | 1653 | RSS: Main: 202887168 21:00:46 INFO - PROCESS | 1653 | 21:00:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 21:00:50 INFO - PROCESS | 1653 | RSS: Main: 206438400 21:00:50 INFO - PROCESS | 1653 | 21:00:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 21:00:54 INFO - PROCESS | 1653 | RSS: Main: 206987264 21:00:54 INFO - PROCESS | 1653 | 21:00:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 21:00:57 INFO - PROCESS | 1653 | RSS: Main: 207622144 21:00:57 INFO - PROCESS | 1653 | 21:00:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:00:59 INFO - PROCESS | 1653 | RSS: Main: 206622720 21:00:59 INFO - PROCESS | 1653 | 21:01:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:01:02 INFO - PROCESS | 1653 | RSS: Main: 206761984 21:01:02 INFO - PROCESS | 1653 | 21:01:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:01:05 INFO - PROCESS | 1653 | RSS: Main: 206704640 21:01:05 INFO - PROCESS | 1653 | 21:01:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:01:08 INFO - PROCESS | 1653 | RSS: Main: 206757888 21:01:08 INFO - PROCESS | 1653 | 21:01:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:01:12 INFO - PROCESS | 1653 | RSS: Main: 207044608 21:01:12 INFO - PROCESS | 1653 | 21:01:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 21:01:14 INFO - PROCESS | 1653 | RSS: Main: 209014784 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | __start_tp_report 21:01:14 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 21:01:14 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 21:01:14 INFO - PROCESS | 1653 | |i|pagename|runs| 21:01:14 INFO - PROCESS | 1653 | |0;ai-astar;104;117;117;119;116;116;117;116;114;122 21:01:14 INFO - PROCESS | 1653 | |1;audio-beat-detection;138;113;110;140;108;109;109;112;132;112 21:01:14 INFO - PROCESS | 1653 | |2;audio-dft;197;199;199;197;197;195;194;191;198;192 21:01:14 INFO - PROCESS | 1653 | |3;audio-fft;86;61;63;108;87;80;57;57;76;59 21:01:14 INFO - PROCESS | 1653 | |4;audio-oscillator;83;72;89;73;73;72;85;69;71;87 21:01:14 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;134;124;89;86;87;86;89;85;89;97 21:01:14 INFO - PROCESS | 1653 | |6;imaging-darkroom;149;144;94;98;95;147;124;152;152;95 21:01:14 INFO - PROCESS | 1653 | |7;imaging-desaturate;89;91;126;117;96;89;92;109;88;90 21:01:14 INFO - PROCESS | 1653 | |8;json-parse-financial;53;54;53;56;59;59;59;59;58;59 21:01:14 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;66;67;97;70;69;61;80;103;105;103 21:01:14 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;83;79;105;82;83;82;84;84;82;84 21:01:14 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;137;135;140;138;151;138;141;140;178;140 21:01:14 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;162;164;166;163;165;165;163;163;143;205 21:01:14 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;66;68;70;69;66;69;67;70;66 21:01:14 INFO - PROCESS | 1653 | __end_tp_report 21:01:14 INFO - PROCESS | 1653 | __start_cc_report 21:01:14 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,906 21:01:14 INFO - PROCESS | 1653 | __end_cc_report 21:01:14 INFO - PROCESS | 1653 | __startTimestamp1485234074174__endTimestamp 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | ------- Summary: start ------- 21:01:14 INFO - PROCESS | 1653 | Number of tests: 14 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:4.66 (4.0%) stddev-sans-first:2.26 21:01:14 INFO - PROCESS | 1653 | Values: 104.0 117.0 117.0 119.0 116.0 116.0 117.0 116.0 114.0 122.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:112.50 stddev:12.92 (11.5%) stddev-sans-first:11.57 21:01:14 INFO - PROCESS | 1653 | Values: 138.0 113.0 110.0 140.0 108.0 109.0 109.0 112.0 132.0 112.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:195.90 Median:197.00 stddev:2.81 (1.4%) stddev-sans-first:2.95 21:01:14 INFO - PROCESS | 1653 | Values: 197.0 199.0 199.0 197.0 197.0 195.0 194.0 191.0 198.0 192.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:73.40 Median:69.50 stddev:16.99 (24.4%) stddev-sans-first:17.40 21:01:14 INFO - PROCESS | 1653 | Values: 86.0 61.0 63.0 108.0 87.0 80.0 57.0 57.0 76.0 59.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:7.63 (9.8%) stddev-sans-first:7.82 21:01:14 INFO - PROCESS | 1653 | Values: 83.0 72.0 89.0 73.0 73.0 72.0 85.0 69.0 71.0 87.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:88.00 stddev:17.56 (20.0%) stddev-sans-first:12.35 21:01:14 INFO - PROCESS | 1653 | Values: 134.0 124.0 89.0 86.0 87.0 86.0 89.0 85.0 89.0 97.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:125.00 Median:123.00 stddev:26.60 (21.6%) stddev-sans-first:26.76 21:01:14 INFO - PROCESS | 1653 | Values: 149.0 144.0 94.0 98.0 95.0 147.0 124.0 152.0 152.0 95.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:98.70 Median:89.50 stddev:13.65 (15.2%) stddev-sans-first:14.02 21:01:14 INFO - PROCESS | 1653 | Values: 89.0 91.0 126.0 117.0 96.0 89.0 92.0 109.0 88.0 90.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:59.00 stddev:2.64 (4.5%) stddev-sans-first:2.40 21:01:14 INFO - PROCESS | 1653 | Values: 53.0 54.0 53.0 56.0 59.0 59.0 59.0 59.0 58.0 59.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:82.10 Median:68.00 stddev:17.87 (26.3%) stddev-sans-first:17.98 21:01:14 INFO - PROCESS | 1653 | Values: 66.0 67.0 97.0 70.0 69.0 61.0 80.0 103.0 105.0 103.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.00 stddev:7.25 (8.7%) stddev-sans-first:7.66 21:01:14 INFO - PROCESS | 1653 | Values: 83.0 79.0 105.0 82.0 83.0 82.0 84.0 84.0 82.0 84.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:140.00 stddev:12.75 (9.1%) stddev-sans-first:13.29 21:01:14 INFO - PROCESS | 1653 | Values: 137.0 135.0 140.0 138.0 151.0 138.0 141.0 140.0 178.0 140.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:164.50 stddev:15.27 (9.3%) stddev-sans-first:16.13 21:01:14 INFO - PROCESS | 1653 | Values: 162.0 164.0 166.0 163.0 165.0 165.0 163.0 163.0 143.0 205.0 21:01:14 INFO - PROCESS | 1653 | 21:01:14 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.62 (2.4%) stddev-sans-first:1.69 21:01:14 INFO - PROCESS | 1653 | Values: 67.0 66.0 68.0 70.0 69.0 66.0 69.0 67.0 70.0 66.0 21:01:14 INFO - PROCESS | 1653 | -------- Summary: end -------- 21:01:14 INFO - PROCESS | 1653 | 21:01:15 INFO - TEST-INFO | 1653: exit 0 21:01:15 INFO - TEST-OK | kraken | took 59690ms 21:01:15 INFO - SUITE-END | took 1174s 21:01:15 INFO - Completed test suite (00:19:34) 21:01:15 INFO - javascript benchmark 21:01:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7409.630592368544, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.98313008435, 3586.6592673696005, 3630.546181727283, 3631.8002509861963, 3641.2717456508703, 6034.788782392618, 6043.274807023158, 6055.940210463174, 6087.573869829113, 6114.1745864308305, 6059.545534084939, 6118.235220597426, 6129.724162412691, 6137.6624285664275, 6156.076588511725, 4569.337446070318, 5387.0303345397815, 5446.183072539111, 5447.782088716446, 5455.5908306876945, 5483.561315094783, 5507.03626865299, 5509.504144626982, 5528.861778455531, 5569.10894256919, 5345.518903298722, 5372.140457526796, 5503.9174412383845, 5516.282883225175, 5522.806701765439, 4713.622910167179, 5180.974095129519, 5423.0, 5503.587230957654, 5558.6942718150485, 5340.599455040888, 5458.426865179139, 5459.808906688287, 5471.50756431919, 5513.724313784295, 5747.252857128588, 6071.0, 6108.725107370179, 6144.754209831646, 6153.384661533811, 6192.87614247717, 6196.504279657616, 6225.439710426038, 6238.064290356438, 6246.469050130744, 6257.092721555395, 6263.530235232376, 6281.528885333618, 6353.0, 6374.139491168679, 6169.629822210682, 6185.381461853869, 6199.969000154971, 6211.0, 6215.409536094064, 6416.35836416364, 6435.935640643534, 6438.54930154894, 6539.50953678476, 6561.507886908501, 6278.372162783685, 6285.182926219653, 6295.055741638791, 6306.842328941813, 6316.4315211630255, 5123.205903085028, 6261.405166509175, 6393.776217832354, 6420.550561460746, 6438.163038804925, 4959.454460009396, 6269.059641053878, 6271.7804876830005, 6311.747530098836, 6351.364863513611, 6241.96879015602, 6302.65335406557, 6314.873702525923, 6354.91966365719, 6383.521235907326, 4995.450500444948, 5063.594912406998, 5220.634555581073, 5237.528622424, 5254.343207099113, 3815.2178803345246, 3883.8446462141196, 4604.447466304065, 4618.584327410549, 4719.961608446137, 5339.919901201485, 5724.656520608777, 6160.414760597736, 6205.751769929152, 6216.627002379872, 6415.133956915756, 6419.422251997249, 6421.550491465552, 6428.067930150102, 6431.517636177306, 6037.215162028908, 6117.929362361569, 6124.319907527392, 6126.2123341605975, 6140.381550880983, 5722.141678748221, 5723.8855222896145, 5735.0250457422335, 5742.684152371576, 5744.425557444306, 6601.669916504252, 6681.599104053772, 6686.13080299558, 6695.497837662195, 6713.429358504582, 6247.750089996531, 6265.15420418256, 6306.810795676137, 6340.65126418033, 6437.710303036468, 6607.075009498578, 6631.602103873783, 6643.069970204272, 6645.335466453316, 6651.068850360856, 6347.809565713036, 6355.650439225887, 6371.490280777434, 6374.776882809079, 6378.2346118466085, 5125.2568377585785, 6248.250209974832, 6272.184616000073, 6356.872862542816, 6396.872062558629, 4912.48418916023, 5774.48029677331, 5857.677827719516, 6269.0, 6278.340774218641, 6179.671739184614, 6252.812415627538, 6253.5622506424115, 6267.561270711007, 6277.497800176066, 5888.970555147197, 6085.056816193497, 6242.0, 6274.0, 6294.748210071546, 5722.769604535045, 6119.015143218386, 6148.354422785543, 6158.983767678283, 6286.905696414649, 6251.437370636664, 6288.245410550763, 6295.213098362705, 6300.464460520907, 6324.17785687876], "value": 5871.413082027304, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.8454933048099, 493.5311454118588, 520.6303524497606, 524.6956765076255, 581.4853854338909, 39521.60478395215, 41579.79210103949, 41707.791461042725, 43681.0, 43698.34452483207, 42887.57112428883, 43191.78404107983, 43316.56683433172, 43325.0, 43401.78299108508, 9549.23606111511, 9721.708348749513, 9721.902780972207, 9725.610975560969, 9751.902480975206, 9644.710658680251, 9717.61129554817, 9721.465319407429, 9727.562259698296, 9758.024197580256, 9696.951515242414, 9728.929817720045, 9758.707238782848, 9765.462899540522, 9768.609255629803, 9658.323917325755, 9715.222782177445, 9726.17327527161, 9733.805323893554, 9751.414915105117, 9659.90340096597, 9707.174890134347, 9722.611095556169, 9732.95133524335, 9750.219982401391, 34509.65490345089, 40957.180856383005, 41260.79369603163, 41331.7933410331, 41334.793326033476, 3286.5398844161837, 3409.2840503494294, 3429.5884493860895, 3440.8623655053766, 4040.1313717550865, 30089.69910300891, 30116.0, 30785.692143078508, 30976.225594360098, 32433.83783081093, 3208.358328334319, 3293.8847140350213, 3318.983405082983, 3379.222778760874, 3388.3053973935284, 463609.0, 467438.0, 469282.0, 471405.0, 475947.0, 62889.37110628927, 63404.36595634077, 63568.0, 63650.0, 63843.76546820839, 65965.0, 66157.66921165363, 66464.33535664678, 66599.0, 66649.33350666528, 17161.227744751268, 17209.65580688379, 17349.045802480734, 17421.564460888578, 17439.302427902996, 12749.0, 13159.934200328937, 13194.472221111047, 13236.933815330862, 13300.600981970556, 18313.572442584744, 19475.8052419474, 19721.901390492956, 19760.40718778439, 19792.50518737014, 3275.852586633607, 3392.4232880409895, 8061.596920154087, 8120.305261106182, 8277.714268598933, 901.5492253873064, 973.1047436358567, 996.3125443444001, 1079.4386918802336, 1109.3676604335612, 30269.94055208057, 30364.54453183204, 30524.350179243895, 30699.693003069682, 31044.53433198504, 1069.550788668761, 1097.9011888930036, 1103.939283339424, 1110.74452875839, 1157.3171828621155, 14989.400423983137, 15820.446284379992, 15932.761008584881, 15959.0, 16239.431619893247, 686515.0, 689546.0, 689930.0, 695702.0, 696207.0, 60303.0, 60355.0, 60395.69802151049, 60442.0, 60768.08847867286, 1399.0556374447208, 1413.8374086979923, 1439.6688761584685, 1445.2268036600158, 1445.8265008198873, 28816.785357538916, 29941.70058299389, 30303.545446818756, 31051.0, 31072.0, 49643.50356496389, 58208.708956454946, 58796.82406351934, 59012.52468688146, 59056.409435905094, 618877.905610469, 623405.0, 625102.0, 635213.0, 635766.0, 43674.0, 43855.78072109619, 44713.65859024235, 44753.0, 44757.55242447664, 45436.54563454323, 46457.0, 46847.76576117097, 47612.761936190094, 48390.0, 38305.85082447531, 39402.88746420387, 40235.59764402318, 41095.589044109176, 41693.58306417018, 34251.65748342584, 39792.403113952736, 39975.80012100037, 40304.59695403009, 41172.0, 38463.615363846, 39433.80283098566, 40031.79984100061, 40037.79981100076, 40201.79899100603, 28901.0, 32492.212928289173, 35651.0, 35873.103172420895, 36191.81904090463, 26651.33371665724, 26665.60001599939, 26690.065847695238, 26775.598366024915, 27090.458190836467], "value": 20753.70707697165, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.68964414873426, 384.1337783298663, 387.49431991251424, 391.6162161082138, 406.8840380491559, 19657.709532949444, 20750.688739668916, 21252.787472125274, 21550.676739848914, 21799.891000545016, 20214.797852021475, 20342.69485957708, 20401.897990510028, 20533.0, 20618.381448556567, 5807.738651760681, 5925.88148237035, 6070.5447091468095, 6106.0, 6162.537809664271, 3521.366154092262, 4070.9389359159636, 5965.582409231356, 6107.5113990880845, 6113.847153821145, 5812.680302583356, 6078.17944577483, 6135.110408990694, 6136.140940268366, 6154.138420621117, 6128.4178003089855, 6149.446549810516, 6290.685465726719, 6592.80221593353, 6635.004749287597, 5901.911471327933, 5904.1734157218025, 5920.496757775594, 5940.405959404068, 5949.643021418686, 13266.00504962122, 13486.460541578324, 13539.187648741106, 13557.38991745364, 13746.793798093036, 2317.9685040157137, 2406.049610403898, 2735.753782159615, 3029.9545506817417, 3033.196203006205, 10248.180145588334, 10316.277860549764, 10577.524011419504, 10776.78446431067, 10799.622013229578, 1940.1075505267595, 1957.4616980330381, 1962.097435179819, 1982.682770756672, 2024.4129202531249, 123169.76830231672, 123757.0, 126647.0, 132694.0, 132898.0, 9645.0, 10847.403392813314, 11449.912258335446, 11496.942515287537, 11569.537218511334, 14029.78955315671, 14609.78085328721, 14874.553763387115, 14922.179280139479, 14930.925345373204, 8498.235158835734, 8736.951565812016, 8769.342299327449, 8800.16398442147, 8943.597538110671, 8630.26642735362, 8635.438696484709, 8654.35092368075, 8689.956550217335, 8806.075362086889, 3964.663003644665, 4498.460184777848, 4601.861944141681, 4620.237660785932, 4690.671652984327, 1679.7648329233916, 1986.3941497843007, 1990.5819777846814, 2016.5462770876436, 3800.315943130208, 855.8972923249125, 913.5021413329752, 966.6520052780993, 967.7677357434166, 1007.8437842134481, 19170.61658766817, 20126.798732012787, 20636.896815516127, 20741.79258207429, 20860.0, 912.8585069314134, 946.4794363100267, 952.4095061062186, 1010.7068950004416, 1016.2276669731058, 10652.360858348524, 10994.395308257963, 11073.169512286611, 11074.778504429867, 11095.38975356347, 590854.0, 598374.0, 600554.9972250111, 606573.0, 606666.0, 114792.70414591662, 132368.0, 133430.0, 137745.0, 139007.0, 858.6050416808338, 998.9051040151174, 999.3753903810118, 1010.7624708193715, 1015.8374660054355, 17734.91132544329, 18431.788185417834, 18795.81204187995, 18818.24727010904, 18855.811441885955, 53190.73404632952, 53806.0, 54733.0, 54834.72582637061, 55343.0, 62109.689451552455, 72470.63764681354, 74168.0, 75231.0, 77635.61182194053, 7489.962550187214, 8326.25063744266, 8326.83346333082, 8509.10654381281, 8527.658893644184, 10177.49112544355, 12932.806007910078, 13161.276129812952, 13382.397792099184, 13525.661858453224, 9364.859527107235, 11458.0, 11556.479958401724, 12050.638480845588, 12094.576689815814, 11262.7747445049, 11284.887151128383, 11672.416379181177, 11684.474198660911, 11849.05207583374, 10629.0, 10886.183536234656, 11635.011024062711, 11695.649130526097, 11824.940875295568, 8427.831443370975, 8563.785905352415, 8610.65557377698, 8655.56722163902, 8656.826863462822, 11544.94227528857, 11996.40017999114, 12039.819402709141, 12107.091968102251, 12124.818127727915], "value": 9627.751868479929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.1579420759128, 1503.0680977793766, 1674.983250167498, 1832.9725054124183, 1866.3747644539071, 6519.967400163005, 7937.5237485750895, 8245.422820402575, 8582.828343433128, 8626.870596941044, 8096.878546821802, 8375.036870759865, 8395.538245396501, 8498.447600905953, 8503.914960850405, 2360.3862995621134, 2409.855408675476, 2410.6504556839336, 2412.0954642009247, 2417.407735104902, 2403.759624037591, 2418.9516209675794, 2446.217210492643, 2446.902123915041, 2452.16626347042, 2379.3694670912223, 2391.7608239176116, 2407.458321877581, 2407.7953373963232, 2417.903283868652, 2019.1519561784087, 2371.95256094878, 2375.798057165143, 2399.172285561487, 2409.2410890569504, 2398.784109430142, 2399.7641214774403, 2407.7953373963232, 2415.7221919479307, 2417.9758202417925, 8433.789155271106, 8459.95770021146, 8522.914770852274, 8550.52972086535, 8560.785980350478, 4574.565416285481, 5210.322658054467, 5339.733013349356, 5345.198220266952, 5359.303290572239, 3244.621036059665, 3258.152880251128, 3414.8804791832417, 3441.913952151191, 3530.1880567469625, 894.5259012723267, 915.199200699388, 1053.1943063556384, 1060.8037513060108, 1094.5402930769096, 10726.731831704192, 10860.402677852715, 10904.509297081571, 10919.290246134055, 10968.122550195965, 4618.676692631483, 4707.129181101507, 4767.547083027107, 4772.7136371817805, 4775.976120119377, 9464.858027129598, 9627.229821614254, 9672.903270967341, 9687.0, 9693.176080033276, 5251.317328747315, 5317.8404647860625, 5351.170568561879, 5352.946470535323, 5354.678719276856, 4415.646748260131, 4442.133783912106, 4859.052484765437, 4899.240617704261, 4919.975400123048, 3904.472896159039, 3905.5899130591447, 4010.438538604598, 4034.374671925856, 4052.797360131982, 1155.8612966443911, 1259.0, 1284.2487145020268, 1301.4533895763802, 1324.4503531034704, 789.1083076123944, 807.9394045446616, 894.9731508054768, 940.8682784410188, 962.119660510625, 4843.2250839865455, 5816.185733997244, 5850.619709718854, 5905.173275741399, 5946.613470124428, 810.5866008335792, 942.2179590939504, 966.6954909203579, 984.1978787288338, 1019.1235537437798, 3745.6628903398823, 3835.5589107252463, 3912.4522566840665, 3949.585293544194, 3971.702122340836, 8385.874211886827, 9754.170895473822, 10087.646932357333, 10210.540525676362, 10238.12975897057, 10145.9492702536, 10161.08550230468, 10187.694369168938, 10232.693019209435, 10254.28220024606, 7511.399088072941, 7826.4130190235965, 7852.960735196288, 7985.2014798519685, 8002.159773223728, 5732.140178973187, 5743.483086522233, 5884.323302820059, 5966.522678185822, 5971.193888824953, 8994.640214391351, 9228.877358207785, 9413.811723765622, 9447.385919915183, 9552.044795520393, 9518.857217141609, 9528.52357382142, 9532.95233523828, 9615.0, 9708.223342132753, 6730.663466826737, 6758.459323254227, 7153.606551639502, 7228.27717228294, 7376.926230737624, 7891.881621775793, 8034.598270086355, 8067.193280671886, 8071.757847264592, 8079.151689072798, 7148.428125749823, 7315.853682926205, 7320.816979575553, 7371.520851144658, 7376.557406555624, 7074.434045276468, 7161.4270858330165, 7168.569885806868, 7187.281271872771, 7193.892091618734, 6728.764493242713, 6807.115075040411, 6834.760783372558, 6838.487113466609, 6852.0, 4897.608191344612, 4913.484084171254, 4915.778789954389, 4990.126727822544, 5007.273945277987, 4969.130402179532, 4986.576141028053, 5044.4451110377095, 5078.136716758234, 5094.388673359221], "value": 4489.252608928684, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.33801664438107, 312.6248501797843, 318.34103405949685, 324.1232466178986, 324.1539581691783, 4984.959174903311, 5346.946530534694, 5445.346558412986, 5505.697186654737, 5556.805511807088, 5290.523852853243, 5412.242286079952, 5431.972840135803, 5452.6455780374245, 5501.394846566875, 4161.417401563776, 4184.51878034027, 4200.285951388271, 4200.4539409876825, 4200.642945349634, 3692.4092145256764, 3719.82825409995, 3756.211195648917, 4138.213739389522, 4239.236937351276, 4141.9585804142025, 4154.9820294028, 4161.271777438951, 4167.499900012002, 4183.665306775466, 4154.5222299435645, 4184.602462766047, 4192.937105943382, 4201.495820501544, 4202.508109621071, 3237.5629290045777, 3499.6001599360206, 3683.2633473305445, 3690.1697118148472, 3692.818298144595, 4807.951920480786, 5033.84898453047, 5150.7895644523505, 5274.393444753864, 5315.73421328932, 4133.937990930139, 4210.989362552996, 4823.855284341475, 4833.516648335173, 4840.298156767249, 5424.7758419048005, 5580.190872323531, 5759.5968282220265, 5759.971200144015, 5796.2464879565805, 3780.9621903781162, 3966.702497312684, 4023.295923213426, 4056.7565946043333, 4061.959380406188, 5158.638895277332, 6067.787627433018, 6090.96954515229, 6139.416755408229, 6156.87686246277, 4113.691473139466, 4139.627433530996, 4147.087640719037, 4155.293600087993, 4164.8542301019315, 4051.918961620751, 4158.688098392633, 4191.91616167675, 4192.958070419318, 4200.916890562393, 4306.935395969063, 4600.125976064537, 4828.444728856227, 4835.87221622485, 4844.0, 4844.467108618049, 5017.9247311290355, 5635.7175343985755, 5803.361630220672, 5813.302403711582, 1142.5087212498706, 1198.688341031338, 1340.8468716903456, 1350.4260689207047, 1359.7756370199004, 803.2329125684956, 906.2976193450129, 930.5114814722325, 941.37612618233, 945.7351941456403, 5124.5131712487255, 5126.7180305083575, 5167.715775632376, 5172.793088276502, 5179.663321884065, 5093.439721630618, 5183.481651834786, 5205.401378841406, 5547.805826796123, 5575.637583557137, 4103.240241320054, 4350.542568239612, 5105.923411148836, 5155.587552995827, 5194.948050519446, 2508.4105235270063, 2725.523033469135, 2899.6520417550028, 2918.176139912555, 2921.5617657351568, 5041.621878359138, 5480.260164877691, 5516.668999860021, 5745.88508229833, 5768.711564421762, 5088.542031217208, 5292.92060619091, 5325.390558626245, 5653.462921022497, 5723.313202415737, 4724.456687480915, 5019.034962379752, 5347.385050719217, 5645.640843697993, 5723.112917497794, 4818.807247710052, 4934.827281045146, 5489.423610520837, 5542.473465020817, 5598.944010559842, 5273.709945953009, 5371.838844834661, 5505.476979686923, 5505.752241149078, 5899.852503687443, 5551.9722401387735, 5579.916301255404, 6205.751769929152, 6237.781677641261, 6263.342349053284, 3415.846286917045, 4008.997750562359, 4025.315696331572, 4033.294173519681, 4038.2529232092156, 5641.605087643826, 5835.620684655484, 5947.877364383733, 5981.7607295707685, 6030.30651475086, 5559.721264109358, 5576.804811831566, 5886.646801191942, 5900.279776179125, 5915.794101190924, 4962.851114466572, 5381.73091345439, 5572.832815015556, 5870.706464676835, 5910.7340169693325, 5258.0798360286035, 5374.667706022291, 5645.943540564542, 5746.569007324384, 5765.279340082489, 5716.456556729577, 5846.298444186725, 5866.5893387462465, 5889.734961926809, 5894.930359890576, 5488.7530061148145, 5491.270249871438, 5659.943400566106, 5741.282339707536, 5802.143314139435], "value": 4164.312493303142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.4142625202948, 679.9732404069853, 728.2935552514061, 749.8387846612977, 828.643683216217, 13952.372143253566, 14975.925120374397, 15326.080435173897, 15447.536573902773, 15965.361385544593, 14459.638509037279, 14467.710645787078, 14565.927170364133, 14566.854331456681, 14594.562163135097, 880.0891077734562, 896.8251191017754, 896.9953651909871, 900.5272232078179, 908.591133989704, 654.4077609763148, 722.8409749855024, 864.8702694595798, 896.5158814240302, 910.0580898769774, 895.8700988356717, 938.713692323841, 939.5302348825587, 942.5428667096487, 944.9385789923667, 899.1458114790942, 925.7037747920668, 934.2946075712828, 936.4194199596294, 938.7512309238092, 664.7772996046331, 684.4661164291861, 692.3076923076923, 695.778908016433, 702.0592406175749, 14555.0, 14594.635134121625, 14738.55784326472, 14829.851701482956, 15210.847891521054, 14498.855011449856, 14839.406423743038, 14893.374047317573, 14900.105993640416, 15110.622234444118, 11324.94337528307, 11537.134714896416, 11769.941150294193, 11802.586909458129, 11998.400079996052, 4553.043860789238, 4594.411238926213, 4606.930896036529, 4610.492845786961, 4678.157931572316, 97314.0, 98566.5071674637, 100948.49525752325, 102578.99999999926, 102928.0, 10417.739556511147, 10777.62278320255, 10830.241883068109, 10836.891631083747, 10842.457877106113, 19776.505587360145, 19842.404727858186, 19872.60254794896, 19901.104450299772, 21471.67792483114, 8087.838243235103, 8163.7142700005215, 8211.17888211174, 8222.917770822216, 8504.362172837062, 4300.483941926988, 4326.740395576276, 4365.388845561624, 4498.8425405110665, 4530.84142055033, 3288.1450822786246, 3397.5073614325784, 3406.2506248625264, 3423.3666771647327, 3427.7429192810637, 586.2320360327984, 603.0772917436329, 603.2218438214742, 616.3220457496718, 618.3939739055751, 592.4016743089425, 605.8247000818486, 639.0605809460086, 694.9409300209538, 701.7543859649184, 8835.453795585747, 9546.711193988862, 9835.45904975219, 9848.556814943344, 9948.552315145836, 604.7127614383221, 630.19020558582, 684.0759026827649, 687.9759208427681, 696.6621188723465, 4061.0, 4295.978520107379, 4508.909821803545, 4574.382458368144, 4590.42619672541, 76740.84888726674, 97558.0, 121179.39410303069, 122493.38753306176, 125618.7438125607, 97798.51100744451, 105062.0, 106437.46781266044, 108826.0, 109918.0, 65414.0, 91580.08419915849, 92178.0, 95332.0, 96472.03527964771, 6672.966635166793, 8632.956835215784, 8982.775430614287, 9049.909500904907, 9083.091690830865, 46273.53726462827, 55069.0, 55135.0, 55833.720831395585, 57862.7106864463, 57850.84298313926, 59028.0, 59534.10698839607, 60220.69889650524, 76970.0, 11857.11071669611, 11931.0, 11938.28370297785, 12287.078469114673, 12355.505779768708, 14462.0, 14579.343929522985, 14724.26378681083, 14774.261286935396, 15037.849621503645, 13416.993725470433, 13510.729785404434, 13744.450221991008, 13751.099208569814, 13800.654983625489, 13070.0, 13230.801537977131, 13380.0, 13664.658383540092, 13769.03616746818, 13185.40665670028, 13337.133086349357, 13485.0, 13540.0, 13746.725065498435, 10556.577736890438, 10914.290571112851, 11048.668539943814, 11054.447277636247, 11322.94338528302, 11334.0, 11589.7102572433, 11621.240252506499, 11693.0, 11712.238704484522], "value": 7544.8718594662105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 117.0, 119.0, 116.0, 116.0, 117.0, 116.0, 114.0, 122.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 113.0, 110.0, 140.0, 108.0, 109.0, 109.0, 112.0, 132.0, 112.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 199.0, 197.0, 197.0, 195.0, 194.0, 191.0, 198.0, 192.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 61.0, 63.0, 108.0, 87.0, 80.0, 57.0, 57.0, 76.0, 59.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 72.0, 89.0, 73.0, 73.0, 72.0, 85.0, 69.0, 71.0, 87.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 89.0, 86.0, 87.0, 86.0, 89.0, 85.0, 89.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 144.0, 94.0, 98.0, 95.0, 147.0, 124.0, 152.0, 152.0, 95.0], "value": 125.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 126.0, 117.0, 96.0, 89.0, 92.0, 109.0, 88.0, 90.0], "value": 98.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 56.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 97.0, 70.0, 69.0, 61.0, 80.0, 103.0, 105.0, 103.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 105.0, 82.0, 83.0, 82.0, 84.0, 84.0, 82.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 140.0, 138.0, 151.0, 138.0, 141.0, 140.0, 178.0, 140.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 166.0, 163.0, 165.0, 165.0, 163.0, 163.0, 143.0, 205.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 70.0, 69.0, 66.0, 69.0, 67.0, 70.0, 66.0], "value": 67.8, "unit": "score"}]}]} 21:01:15 INFO - Return code: 0 21:01:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:01:15 ERROR - # TBPL SUCCESS # 21:01:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:01:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:01:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:01:15 INFO - 2017-01-23 21:01:15.517 screenresolution[1658:10704] starting screenresolution argv=screenresolution get 21:01:15 INFO - 2017-01-23 21:01:15.520 screenresolution[1658:10704] Display 0: 1600x1200x32@60 21:01:15 INFO - 2017-01-23 21:01:15.526 screenresolution[1659:10707] starting screenresolution argv=screenresolution list 21:01:15 INFO - Available Modes on Display 0 21:01:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:01:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:01:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:01:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:01:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:01:15 INFO - Intel Iris: 21:01:15 INFO - Chipset Model: Intel Iris 21:01:15 INFO - Type: GPU 21:01:15 INFO - Bus: Built-In 21:01:15 INFO - VRAM (Dynamic, Max): 1536 MB 21:01:15 INFO - Vendor: Intel (0x8086) 21:01:15 INFO - Device ID: 0x0a2e 21:01:15 INFO - Revision ID: 0x0009 21:01:15 INFO - Displays: 21:01:15 INFO - Display: 21:01:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:01:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:01:15 INFO - Display Serial Number: 1600x1200 60 21:01:15 INFO - Main Display: Yes 21:01:15 INFO - Mirror: Off 21:01:15 INFO - Online: Yes 21:01:15 INFO - Rotation: Supported 21:01:15 INFO - Return code: 0 21:01:15 INFO - Running post-action listener: _resource_record_post_action 21:01:15 INFO - [mozharness: 2017-01-24 05:01:15.764369Z] Finished run-tests step (success) 21:01:15 INFO - Running post-run listener: _resource_record_post_run 21:01:15 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 40204288; Write bytes: 503078400; Read time: 387; Write time: 1588 21:01:15 INFO - TinderboxPrint: CPU usage
54.2% 21:01:15 INFO - TinderboxPrint: I/O read bytes / time
40,204,288 / 387 21:01:15 INFO - TinderboxPrint: I/O write bytes / time
503,078,400 / 1,588 21:01:15 INFO - TinderboxPrint: CPU idle
2,190.6 (45.8%) 21:01:15 INFO - TinderboxPrint: CPU system
964.7 (20.2%) 21:01:15 INFO - TinderboxPrint: CPU user
1,630.3 (34.1%) 21:01:15 INFO - TinderboxPrint: Swap in / out
231,473,152 / 0 21:01:15 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 188461568; Write bytes: 186060800; Read time: 16825; Write time: 333 21:01:15 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 38168576; Write bytes: 309931520; Read time: 364; Write time: 1226 21:01:16 INFO - Running post-run listener: _upload_blobber_files 21:01:16 INFO - Blob upload gear active. 21:01:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:01:16 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 21:01:16 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:01:16 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:01:16 INFO - (blobuploader) - INFO - Open directory for files ... 21:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:01:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:17 INFO - (blobuploader) - INFO - Done attempting. 21:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:18 INFO - (blobuploader) - INFO - Done attempting. 21:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:01:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:01:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:01:21 INFO - (blobuploader) - INFO - Done attempting. 21:01:21 INFO - (blobuploader) - INFO - Iteration through files over. 21:01:21 INFO - Return code: 0 21:01:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:01:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:01:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f001bf50a9ca5874ac5beca44beebdfce6345c53f00ed3fe4c243f87243f1f6cb44b820e27eb5e63ab569ec0e8c83872ea8c94b0aa6d47053a881c9bc446d5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d6a43f157467e17abef5c4d5632d35b0f80a8dae3e7f6740b2bb1a143fa8091cb1e2a8246ece2e44454a87159d0b010e80aac357436e3151533dd229a6a508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adece94dc485417f1191e317c6c1cb8e5f8cc35f44caccc6c26dad9195eab4d6e4fc6827babbbe2f93e812b1a9e7a1f9679b651513b54866294bec9ad3b8ff64"} 21:01:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:01:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:01:21 INFO - Contents: 21:01:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f001bf50a9ca5874ac5beca44beebdfce6345c53f00ed3fe4c243f87243f1f6cb44b820e27eb5e63ab569ec0e8c83872ea8c94b0aa6d47053a881c9bc446d5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d6a43f157467e17abef5c4d5632d35b0f80a8dae3e7f6740b2bb1a143fa8091cb1e2a8246ece2e44454a87159d0b010e80aac357436e3151533dd229a6a508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adece94dc485417f1191e317c6c1cb8e5f8cc35f44caccc6c26dad9195eab4d6e4fc6827babbbe2f93e812b1a9e7a1f9679b651513b54866294bec9ad3b8ff64"} 21:01:21 INFO - Running post-run listener: copy_logs_to_upload_dir 21:01:21 INFO - Copying logs to upload dir... 21:01:21 INFO - mkdir: /builds/slave/test/build/upload/logs 21:01:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.388373 ========= master_lag: 2.88 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-23 21:01:23.967119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 21:01:23.972706) ========= 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.htfqSs7Giw/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.zSefVCs0ff/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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-Beta/sha512/f001bf50a9ca5874ac5beca44beebdfce6345c53f00ed3fe4c243f87243f1f6cb44b820e27eb5e63ab569ec0e8c83872ea8c94b0aa6d47053a881c9bc446d5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d6a43f157467e17abef5c4d5632d35b0f80a8dae3e7f6740b2bb1a143fa8091cb1e2a8246ece2e44454a87159d0b010e80aac357436e3151533dd229a6a508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adece94dc485417f1191e317c6c1cb8e5f8cc35f44caccc6c26dad9195eab4d6e4fc6827babbbe2f93e812b1a9e7a1f9679b651513b54866294bec9ad3b8ff64"} build_url:https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010994 build_url: 'https://queue.taskcluster.net/v1/task/K3QyimyrRx284vYmQnDbjA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f001bf50a9ca5874ac5beca44beebdfce6345c53f00ed3fe4c243f87243f1f6cb44b820e27eb5e63ab569ec0e8c83872ea8c94b0aa6d47053a881c9bc446d5ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87d6a43f157467e17abef5c4d5632d35b0f80a8dae3e7f6740b2bb1a143fa8091cb1e2a8246ece2e44454a87159d0b010e80aac357436e3151533dd229a6a508", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adece94dc485417f1191e317c6c1cb8e5f8cc35f44caccc6c26dad9195eab4d6e4fc6827babbbe2f93e812b1a9e7a1f9679b651513b54866294bec9ad3b8ff64"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 21:01:24.011022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 21:01:24.011328) ========= 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.htfqSs7Giw/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.zSefVCs0ff/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.004936 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 21:01:24.059868) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 21:01:24.060164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 21:01:24.060469) ========= ========= Total master_lag: 5.91 =========