builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0031 starttime: 1487220286.6 results: success (0) buildid: 20170215181318 builduid: bf4a503ff18c4722a153f23d8627e1ea revision: 24c5c108f6d63bf2872fda200fc1e643333bfbc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.601342) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.601829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.602115) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.628526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.628820) ========= 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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-02-15 20:44:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.70M=0.001s 2017-02-15 20:44:46 (9.70 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159966 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.816188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.816912) ========= 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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.027724 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:46.867177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 20:44:46.867506) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 24c5c108f6d63bf2872fda200fc1e643333bfbc7 --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 24c5c108f6d63bf2872fda200fc1e643333bfbc7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DFHR4yeW7S/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.FkM7lmMLa8/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-02-15 20:44:46,970 truncating revision to first 12 chars 2017-02-15 20:44:46,970 Setting DEBUG logging. 2017-02-15 20:44:46,970 attempt 1/10 2017-02-15 20:44:46,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/24c5c108f6d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 20:44:48,333 unpacking tar archive at: mozilla-beta-24c5c108f6d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.625144 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 20:44:48.518083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:48.518917) ========= script_repo_revision: 24c5c108f6d63bf2872fda200fc1e643333bfbc7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:48.519560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:48.520266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 20:44:48.541894) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-15 20:44:48.542220) ========= /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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:44:48 INFO - MultiFileLogger online at 20170215 20:44:48 in /builds/slave/test 20:44:48 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:44:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:44:48 INFO - {'append_to_log': False, 20:44:48 INFO - 'base_work_dir': '/builds/slave/test', 20:44:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:44:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:44:48 INFO - 'branch': 'Mozilla-Beta', 20:44:48 INFO - 'buildbot_json_path': 'buildprops.json', 20:44:48 INFO - 'config_files': ('talos/mac_config.py',), 20:44:48 INFO - 'default_actions': ('clobber', 20:44:48 INFO - 'read-buildbot-config', 20:44:48 INFO - 'download-and-extract', 20:44:48 INFO - 'populate-webroot', 20:44:48 INFO - 'create-virtualenv', 20:44:48 INFO - 'install', 20:44:48 INFO - 'run-tests'), 20:44:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:44:48 INFO - 'download_minidump_stackwalk': True, 20:44:48 INFO - 'download_symbols': 'ondemand', 20:44:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:44:48 INFO - 'tooltool.py': '/tools/tooltool.py', 20:44:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:44:48 INFO - '/tools/misc-python/virtualenv.py')}, 20:44:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:44:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:44:48 INFO - 'installer_path': 'installer.exe', 20:44:48 INFO - 'log_level': 'info', 20:44:48 INFO - 'log_name': 'talos', 20:44:48 INFO - 'log_to_console': True, 20:44:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:44:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:44:48 INFO - 'opt_config_files': (), 20:44:48 INFO - 'pip_index': False, 20:44:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:44:48 INFO - 'cmd': ('bash', 20:44:48 INFO - '-c', 20:44:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:44:48 INFO - 'enabled': True, 20:44:48 INFO - 'halt_on_failure': False, 20:44:48 INFO - 'name': 'check_screen_resolution'},), 20:44:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:44:48 INFO - 'cmd': ('bash', 20:44:48 INFO - '-c', 20:44:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:44:48 INFO - 'enabled': True, 20:44:48 INFO - 'halt_on_failure': False, 20:44:48 INFO - 'name': 'check_screen_resolution'},), 20:44:48 INFO - 'run_cmd_checks_enabled': True, 20:44:48 INFO - 'sps_profile': False, 20:44:48 INFO - 'sps_profile_interval': 0, 20:44:48 INFO - 'suite': 'dromaeojs-e10s', 20:44:48 INFO - 'system_bits': '32', 20:44:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:44:48 INFO - 'title': 't-yosemite-r7-0031', 20:44:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:44:48 INFO - 'use_talos_json': True, 20:44:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:44:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:44:48 INFO - 'work_dir': 'build'} 20:44:48 INFO - [mozharness: 2017-02-16 04:44:48.756597Z] Running clobber step. 20:44:48 INFO - Running pre-action listener: _resource_record_pre_action 20:44:48 INFO - Running main action method: clobber 20:44:48 INFO - rmtree: /builds/slave/test/build 20:44:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:44:51 INFO - Running post-action listener: _resource_record_post_action 20:44:51 INFO - [mozharness: 2017-02-16 04:44:51.426918Z] Finished clobber step (success) 20:44:51 INFO - [mozharness: 2017-02-16 04:44:51.427072Z] Running read-buildbot-config step. 20:44:51 INFO - Running pre-action listener: _resource_record_pre_action 20:44:51 INFO - Running main action method: read_buildbot_config 20:44:51 INFO - Using buildbot properties: 20:44:51 INFO - { 20:44:51 INFO - "project": "", 20:44:51 INFO - "product": "firefox", 20:44:51 INFO - "script_repo_revision": "production", 20:44:51 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 20:44:51 INFO - "repository": "", 20:44:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 20:44:51 INFO - "buildid": "20170215181318", 20:44:51 INFO - "pgo_build": "False", 20:44:51 INFO - "basedir": "/builds/slave/test", 20:44:51 INFO - "buildnumber": 11, 20:44:51 INFO - "slavename": "t-yosemite-r7-0031", 20:44:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:44:51 INFO - "platform": "yosemite_r7", 20:44:51 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:44:51 INFO - "branch": "mozilla-beta", 20:44:51 INFO - "repo_path": "releases/mozilla-beta", 20:44:51 INFO - "revision": "24c5c108f6d63bf2872fda200fc1e643333bfbc7", 20:44:51 INFO - "stage_platform": "macosx64", 20:44:51 INFO - "builduid": "bf4a503ff18c4722a153f23d8627e1ea", 20:44:51 INFO - "slavebuilddir": "test" 20:44:51 INFO - } 20:44:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 20:44:51 INFO - Running post-action listener: _resource_record_post_action 20:44:51 INFO - [mozharness: 2017-02-16 04:44:51.430368Z] Finished read-buildbot-config step (success) 20:44:51 INFO - [mozharness: 2017-02-16 04:44:51.430501Z] Running download-and-extract step. 20:44:51 INFO - Running pre-action listener: _resource_record_pre_action 20:44:51 INFO - Running main action method: download_and_extract 20:44:51 INFO - mkdir: /builds/slave/test/build/tests 20:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:44:51 INFO - trying https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 20:44:51 INFO - Downloading https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/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:44:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/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:44:52 INFO - Downloaded 1165 bytes. 20:44:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 20:44:52 INFO - Using the following test package requirements: 20:44:52 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:44:52 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:44:52 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 20:44:52 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:44:52 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 20:44:52 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:44:52 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:44:52 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 20:44:52 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 20:44:52 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:44:52 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 20:44:52 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:44:52 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 20:44:52 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:44:52 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 20:44:52 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 20:44:52 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 20:44:52 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 20:44:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:44:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:44:52 INFO - Fetch https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:44:52 INFO - Http code: 200 20:44:52 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 20:44:52 INFO - x-amz-cf-id: GnOAmyss_EzUBhSISbVvkog_jpmyYbGjSQoRzjL6CrtPqWMwh5gpjA== 20:44:52 INFO - x-amz-version-id: ylLQzRNnUwJH.AOXzyPxKKH49ZGnFS.L 20:44:53 INFO - Expected file size: 16094136 20:44:53 INFO - Obtained file size: 16094136 20:45:00 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:45:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 20:45:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 20:45:00 INFO - Fetch https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 20:45:00 INFO - Http code: 200 20:45:00 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 20:45:00 INFO - x-amz-cf-id: L77xajyvGoYUKqJUhjCRtiTNBVFZKlgQnj_-yqjw5Zk3LbSv6owm7g== 20:45:00 INFO - x-amz-version-id: ylLQzRNnUwJH.AOXzyPxKKH49ZGnFS.L 20:45:00 INFO - Expected file size: 16094136 20:45:00 INFO - Obtained file size: 16094136 20:45:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 20:45:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 20:45:07 INFO - Fetch https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 20:45:08 INFO - Http code: 200 20:45:08 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 20:45:08 INFO - x-amz-cf-id: xYHF_lviv0fBXir_ZZUDYebKPQCWi7pmMI0tVvgyd1qski5YGwmMBA== 20:45:08 INFO - x-amz-version-id: va7E_XMj4v2HSCGJg_nk.YvVBl5mkcF7 20:45:08 INFO - Expected file size: 14403005 20:45:08 INFO - Obtained file size: 14403005 20:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:08 INFO - trying https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:45:08 INFO - Downloading https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 20:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/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:45:11 INFO - Downloaded 82111266 bytes. 20:45:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:45:11 INFO - mkdir: /builds/slave/test/properties 20:45:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:45:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:45:11 INFO - Contents: 20:45:11 INFO - build_url:https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 20:45:11 INFO - Running post-action listener: _resource_record_post_action 20:45:11 INFO - Running post-action listener: set_extra_try_arguments 20:45:11 INFO - [mozharness: 2017-02-16 04:45:11.767762Z] Finished download-and-extract step (success) 20:45:11 INFO - [mozharness: 2017-02-16 04:45:11.767853Z] Running populate-webroot step. 20:45:11 INFO - Running pre-action listener: _resource_record_pre_action 20:45:11 INFO - Running main action method: populate_webroot 20:45:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:45:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:45:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:45:11 INFO - '--tppagecycles', 20:45:11 INFO - '7'], 20:45:11 INFO - 'tests': ['tsvgm']}}, 20:45:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:45:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:45:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:45:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:45:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['damp', 'tps']}, 20:45:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'tests': ['damp', 'tps']}, 20:45:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['dromaeo_dom']}, 20:45:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:45:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['basic_compositor_video']}, 20:45:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:45:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['a11yr', 20:45:11 INFO - 'ts_paint', 20:45:11 INFO - 'tpaint', 20:45:11 INFO - 'sessionrestore', 20:45:11 INFO - 'sessionrestore_no_auto_restore', 20:45:11 INFO - 'tabpaint']}, 20:45:11 INFO - 'other-e10s': {'tests': ['a11yr', 20:45:11 INFO - 'ts_paint', 20:45:11 INFO - 'tpaint', 20:45:11 INFO - 'sessionrestore', 20:45:11 INFO - 'sessionrestore_no_auto_restore', 20:45:11 INFO - 'tabpaint']}, 20:45:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:45:11 INFO - 'ts_paint', 20:45:11 INFO - 'tpaint', 20:45:11 INFO - 'sessionrestore', 20:45:11 INFO - 'sessionrestore_no_auto_restore', 20:45:11 INFO - 'tabpaint']}, 20:45:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:45:11 INFO - 'ts_paint', 20:45:11 INFO - 'tpaint', 20:45:11 INFO - 'sessionrestore', 20:45:11 INFO - 'sessionrestore_no_auto_restore', 20:45:11 INFO - 'tabpaint']}, 20:45:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['a11yr', 20:45:11 INFO - 'ts_paint', 20:45:11 INFO - 'tpaint', 20:45:11 INFO - 'sessionrestore', 20:45:11 INFO - 'sessionrestore_no_auto_restore', 20:45:11 INFO - 'tabpaint']}, 20:45:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['a11yr', 20:45:11 INFO - 'ts_paint', 20:45:11 INFO - 'tpaint', 20:45:11 INFO - 'sessionrestore', 20:45:11 INFO - 'sessionrestore_no_auto_restore', 20:45:11 INFO - 'tabpaint']}, 20:45:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['tsvgx', 20:45:11 INFO - 'tsvgr_opacity', 20:45:11 INFO - 'tart', 20:45:11 INFO - 'tscrollx', 20:45:11 INFO - 'cart']}, 20:45:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:45:11 INFO - 'tsvgr_opacity', 20:45:11 INFO - 'tart', 20:45:11 INFO - 'tscrollx', 20:45:11 INFO - 'cart']}, 20:45:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'talos_options': ['--disable-e10s'], 20:45:11 INFO - 'tests': ['tp5o']}, 20:45:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'tests': ['tp5o']}, 20:45:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'talos_options': ['--disable-e10s', 20:45:11 INFO - '--xperf_path', 20:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:11 INFO - 'tests': ['tp5n']}, 20:45:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:11 INFO - 'talos_options': ['--xperf_path', 20:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:11 INFO - 'tests': ['tp5n']}}, 20:45:11 INFO - 'talos.zip': {'path': '', 20:45:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:45:11 INFO - Running post-action listener: _resource_record_post_action 20:45:11 INFO - [mozharness: 2017-02-16 04:45:11.786486Z] Finished populate-webroot step (success) 20:45:11 INFO - [mozharness: 2017-02-16 04:45:11.786630Z] Running create-virtualenv step. 20:45:11 INFO - Running pre-action listener: _resource_record_pre_action 20:45:11 INFO - Running main action method: create_virtualenv 20:45:11 INFO - Creating virtualenv /builds/slave/test/build/venv 20:45:11 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:45:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:45:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:45:11 INFO - Using real prefix '/tools/python27' 20:45:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:45:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:45:15 INFO - Installing pip.................done. 20:45:15 INFO - Return code: 0 20:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:45:15 INFO - Reading from file tmpfile_stdout 20:45:15 INFO - Output received: 20:45:15 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:45:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:45:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:15 INFO - 'HOME': '/Users/cltbld', 20:45:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:15 INFO - 'LOGNAME': 'cltbld', 20:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:15 INFO - 'MOZ_NO_REMOTE': '1', 20:45:15 INFO - 'NO_EM_RESTART': '1', 20:45:15 INFO - 'PAGER': '/bin/cat', 20:45:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:15 INFO - 'PWD': '/builds/slave/test', 20:45:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:15 INFO - 'SHELL': '/bin/bash', 20:45:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:15 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:15 INFO - 'USER': 'cltbld', 20:45:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:15 INFO - 'XPC_FLAGS': '0x0', 20:45:15 INFO - 'XPC_SERVICE_NAME': '0', 20:45:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:16 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:45:16 INFO - Cleaning up... 20:45:16 INFO - Return code: 0 20:45:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:45:16 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:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:16 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:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:16 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:16 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:45:16 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:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:16 INFO - 'HOME': '/Users/cltbld', 20:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:16 INFO - 'LOGNAME': 'cltbld', 20:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:16 INFO - 'MOZ_NO_REMOTE': '1', 20:45:16 INFO - 'NO_EM_RESTART': '1', 20:45:16 INFO - 'PAGER': '/bin/cat', 20:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:16 INFO - 'PWD': '/builds/slave/test', 20:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:16 INFO - 'SHELL': '/bin/bash', 20:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:16 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:16 INFO - 'USER': 'cltbld', 20:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:16 INFO - 'XPC_FLAGS': '0x0', 20:45:16 INFO - 'XPC_SERVICE_NAME': '0', 20:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:16 INFO - Downloading/unpacking psutil>=3.1.1 20:45:16 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:45:16 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:45:16 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:45:16 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:45:16 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:45:16 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:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:45:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:19 INFO - Installing collected packages: psutil 20:45:19 INFO - Running setup.py install for psutil 20:45:20 INFO - building 'psutil._psutil_osx' extension 20:45:20 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:45:20 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:45:20 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:45:20 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:45:20 INFO - building 'psutil._psutil_posix' extension 20:45:20 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:45:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:45:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:45:20 INFO - ^ 20:45:20 INFO - 1 warning generated. 20:45:20 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:45:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:21 INFO - Successfully installed psutil 20:45:21 INFO - Cleaning up... 20:45:21 INFO - Return code: 0 20:45:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:21 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:21 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:45:21 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:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:21 INFO - 'HOME': '/Users/cltbld', 20:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:21 INFO - 'LOGNAME': 'cltbld', 20:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:21 INFO - 'MOZ_NO_REMOTE': '1', 20:45:21 INFO - 'NO_EM_RESTART': '1', 20:45:21 INFO - 'PAGER': '/bin/cat', 20:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:21 INFO - 'PWD': '/builds/slave/test', 20:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:21 INFO - 'SHELL': '/bin/bash', 20:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:21 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:21 INFO - 'USER': 'cltbld', 20:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:21 INFO - 'XPC_FLAGS': '0x0', 20:45:21 INFO - 'XPC_SERVICE_NAME': '0', 20:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:45:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:45:24 INFO - Installing collected packages: mozsystemmonitor 20:45:24 INFO - Running setup.py install for mozsystemmonitor 20:45:24 INFO - Successfully installed mozsystemmonitor 20:45:24 INFO - Cleaning up... 20:45:24 INFO - Return code: 0 20:45:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:45:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:24 INFO - 'HOME': '/Users/cltbld', 20:45:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:24 INFO - 'LOGNAME': 'cltbld', 20:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:24 INFO - 'MOZ_NO_REMOTE': '1', 20:45:24 INFO - 'NO_EM_RESTART': '1', 20:45:24 INFO - 'PAGER': '/bin/cat', 20:45:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:24 INFO - 'PWD': '/builds/slave/test', 20:45:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:24 INFO - 'SHELL': '/bin/bash', 20:45:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:24 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:24 INFO - 'USER': 'cltbld', 20:45:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:24 INFO - 'XPC_FLAGS': '0x0', 20:45:24 INFO - 'XPC_SERVICE_NAME': '0', 20:45:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:45:24 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:45:24 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:45:24 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:45:24 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:45:24 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:45:24 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:45:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:45:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:45:27 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:45:27 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:45:27 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:45:27 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:45:27 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:45:27 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:45:27 INFO - Downloading functools32-3.2.3-2.tar.gz 20:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:45:27 INFO - warning: no files found matching '*.txt' 20:45:27 INFO - no previously-included directories found matching 'build' 20:45:27 INFO - no previously-included directories found matching 'dist' 20:45:27 INFO - no previously-included directories found matching '.git*' 20:45:27 INFO - Installing collected packages: jsonschema, functools32 20:45:27 INFO - Running setup.py install for functools32 20:45:27 INFO - warning: no files found matching '*.txt' 20:45:27 INFO - no previously-included directories found matching 'build' 20:45:27 INFO - no previously-included directories found matching 'dist' 20:45:27 INFO - no previously-included directories found matching '.git*' 20:45:28 INFO - Successfully installed jsonschema functools32 20:45:28 INFO - Cleaning up... 20:45:28 INFO - Return code: 0 20:45:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:45:28 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:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:28 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:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:28 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:28 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:45:28 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:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:28 INFO - 'HOME': '/Users/cltbld', 20:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:28 INFO - 'LOGNAME': 'cltbld', 20:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:28 INFO - 'MOZ_NO_REMOTE': '1', 20:45:28 INFO - 'NO_EM_RESTART': '1', 20:45:28 INFO - 'PAGER': '/bin/cat', 20:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:28 INFO - 'PWD': '/builds/slave/test', 20:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:28 INFO - 'SHELL': '/bin/bash', 20:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:28 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:28 INFO - 'USER': 'cltbld', 20:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:28 INFO - 'XPC_FLAGS': '0x0', 20:45:28 INFO - 'XPC_SERVICE_NAME': '0', 20:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:45:28 INFO - Cleaning up... 20:45:28 INFO - Return code: 0 20:45:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:45:28 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:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:28 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:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:28 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:28 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:45:28 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:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:28 INFO - 'HOME': '/Users/cltbld', 20:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:28 INFO - 'LOGNAME': 'cltbld', 20:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:28 INFO - 'MOZ_NO_REMOTE': '1', 20:45:28 INFO - 'NO_EM_RESTART': '1', 20:45:28 INFO - 'PAGER': '/bin/cat', 20:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:28 INFO - 'PWD': '/builds/slave/test', 20:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:28 INFO - 'SHELL': '/bin/bash', 20:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:28 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:28 INFO - 'USER': 'cltbld', 20:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:28 INFO - 'XPC_FLAGS': '0x0', 20:45:28 INFO - 'XPC_SERVICE_NAME': '0', 20:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:28 INFO - Downloading/unpacking blobuploader==1.2.4 20:45:28 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:45:28 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:45:28 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:45:28 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:45:28 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:45:28 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:45:32 INFO - Downloading blobuploader-1.2.4.tar.gz 20:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:45:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 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:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:45:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:45:33 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:45:33 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:45:33 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:45:33 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:45:33 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:45:33 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:45:33 INFO - Downloading docopt-0.6.1.tar.gz 20:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:45:33 INFO - Installing collected packages: blobuploader, requests, docopt 20:45:33 INFO - Running setup.py install for blobuploader 20:45:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:45:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:45:33 INFO - Running setup.py install for requests 20:45:34 INFO - Running setup.py install for docopt 20:45:34 INFO - Successfully installed blobuploader requests docopt 20:45:34 INFO - Cleaning up... 20:45:34 INFO - Return code: 0 20:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:34 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:34 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:45:34 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:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:34 INFO - 'HOME': '/Users/cltbld', 20:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:34 INFO - 'LOGNAME': 'cltbld', 20:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:34 INFO - 'MOZ_NO_REMOTE': '1', 20:45:34 INFO - 'NO_EM_RESTART': '1', 20:45:34 INFO - 'PAGER': '/bin/cat', 20:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:34 INFO - 'PWD': '/builds/slave/test', 20:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:34 INFO - 'SHELL': '/bin/bash', 20:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:34 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:34 INFO - 'USER': 'cltbld', 20:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:34 INFO - 'XPC_FLAGS': '0x0', 20:45:34 INFO - 'XPC_SERVICE_NAME': '0', 20:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:34 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-GD_GL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:34 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-5X67mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:34 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-_B56pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-qdOwth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-u6zrJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-q9XktO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-yN7lsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-znUP9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-DK4qdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-cdwUel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-MVnFWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-VARbgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:35 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-mYpyUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-a1lzIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-njsXcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:45:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-4I4eUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:45:36 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AIJXMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:45:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:45:36 INFO - Running setup.py install for manifestparser 20:45:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:45:36 INFO - Running setup.py install for mozcrash 20:45:36 INFO - Running setup.py install for mozdebug 20:45:36 INFO - Running setup.py install for mozdevice 20:45:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Running setup.py install for mozfile 20:45:37 INFO - Running setup.py install for mozhttpd 20:45:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Running setup.py install for mozinfo 20:45:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Running setup.py install for mozInstall 20:45:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:45:37 INFO - Running setup.py install for mozleak 20:45:37 INFO - Running setup.py install for mozlog 20:45:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:45:38 INFO - Running setup.py install for moznetwork 20:45:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:45:38 INFO - Running setup.py install for mozprocess 20:45:38 INFO - Running setup.py install for mozprofile 20:45:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:45:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:45:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:45:38 INFO - Running setup.py install for mozrunner 20:45:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:45:38 INFO - Running setup.py install for mozscreenshot 20:45:38 INFO - Running setup.py install for moztest 20:45:38 INFO - Running setup.py install for mozversion 20:45:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:45:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:45:39 INFO - Cleaning up... 20:45:39 INFO - Return code: 0 20:45:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:39 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:45:39 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:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:39 INFO - 'HOME': '/Users/cltbld', 20:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:39 INFO - 'LOGNAME': 'cltbld', 20:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:39 INFO - 'MOZ_NO_REMOTE': '1', 20:45:39 INFO - 'NO_EM_RESTART': '1', 20:45:39 INFO - 'PAGER': '/bin/cat', 20:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:39 INFO - 'PWD': '/builds/slave/test', 20:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:39 INFO - 'SHELL': '/bin/bash', 20:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:39 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:39 INFO - 'USER': 'cltbld', 20:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:39 INFO - 'XPC_FLAGS': '0x0', 20:45:39 INFO - 'XPC_SERVICE_NAME': '0', 20:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:39 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-XjdEJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:39 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:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:39 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-7M5WWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:39 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:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:39 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-47z6hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:39 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:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:39 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-GIRrLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:39 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:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:39 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-uZfiov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:39 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:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:39 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-nUhzzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-LdVu9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-HKNskr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Qu3CVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-7JcHJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-IsBBNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-YPFQt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-No4DMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-b4Iuf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-FYcliB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:40 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:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:45:40 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-lJz6O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:45:41 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:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:45:41 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-tBujK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:45:41 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:45:41 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:45:41 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:45:41 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:45:41 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:45:41 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:45:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:45:41 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:45:41 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:45:41 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:45:41 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:45:41 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:45:41 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:45:43 INFO - Downloading blessings-1.6.tar.gz 20:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:45:43 INFO - Installing collected packages: blessings 20:45:43 INFO - Running setup.py install for blessings 20:45:44 INFO - Successfully installed blessings 20:45:44 INFO - Cleaning up... 20:45:44 INFO - Return code: 0 20:45:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:45:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:45:44 INFO - Reading from file tmpfile_stdout 20:45:44 INFO - Current package versions: 20:45:44 INFO - blessings == 1.6 20:45:44 INFO - blobuploader == 1.2.4 20:45:44 INFO - docopt == 0.6.1 20:45:44 INFO - functools32 == 3.2.3-2 20:45:44 INFO - jsonschema == 2.5.1 20:45:44 INFO - manifestparser == 1.1 20:45:44 INFO - mozInstall == 1.12 20:45:44 INFO - mozcrash == 1.0 20:45:44 INFO - mozdebug == 0.1 20:45:44 INFO - mozdevice == 0.48 20:45:44 INFO - mozfile == 1.2 20:45:44 INFO - mozhttpd == 0.7 20:45:44 INFO - mozinfo == 0.9 20:45:44 INFO - mozleak == 0.1 20:45:44 INFO - mozlog == 3.4 20:45:44 INFO - moznetwork == 0.27 20:45:44 INFO - mozprocess == 0.23 20:45:44 INFO - mozprofile == 0.28 20:45:44 INFO - mozrunner == 6.13 20:45:44 INFO - mozscreenshot == 0.1 20:45:44 INFO - mozsystemmonitor == 0.3 20:45:44 INFO - moztest == 0.8 20:45:44 INFO - mozversion == 1.4 20:45:44 INFO - psutil == 3.1.1 20:45:44 INFO - requests == 1.2.3 20:45:44 INFO - wsgiref == 0.1.2 20:45:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:44 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:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:44 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:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:45 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:45 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:45:45 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:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:45 INFO - 'HOME': '/Users/cltbld', 20:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:45 INFO - 'LOGNAME': 'cltbld', 20:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:45 INFO - 'MOZ_NO_REMOTE': '1', 20:45:45 INFO - 'NO_EM_RESTART': '1', 20:45:45 INFO - 'PAGER': '/bin/cat', 20:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:45 INFO - 'PWD': '/builds/slave/test', 20:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:45 INFO - 'SHELL': '/bin/bash', 20:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:45 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:45 INFO - 'USER': 'cltbld', 20:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:45 INFO - 'XPC_FLAGS': '0x0', 20:45:45 INFO - 'XPC_SERVICE_NAME': '0', 20:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:45 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:45:45 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:45:45 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:45:45 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:45:45 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:45:45 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:45:45 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:45:45 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:45:45 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:45:45 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:45:45 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:45:45 INFO - Cleaning up... 20:45:45 INFO - Return code: 0 20:45:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:45:45 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:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:45 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:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:45 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 0x103346490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3cc7f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, '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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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:45:45 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:45:45 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:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:45 INFO - 'HOME': '/Users/cltbld', 20:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:45 INFO - 'LOGNAME': 'cltbld', 20:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:45 INFO - 'MOZ_NO_REMOTE': '1', 20:45:45 INFO - 'NO_EM_RESTART': '1', 20:45:45 INFO - 'PAGER': '/bin/cat', 20:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:45 INFO - 'PWD': '/builds/slave/test', 20:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:45 INFO - 'SHELL': '/bin/bash', 20:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:45:45 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:45 INFO - 'USER': 'cltbld', 20:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:45 INFO - 'XPC_FLAGS': '0x0', 20:45:45 INFO - 'XPC_SERVICE_NAME': '0', 20:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:45:46 INFO - Cleaning up... 20:45:46 INFO - Return code: 0 20:45:46 INFO - Running post-action listener: _resource_record_post_action 20:45:46 INFO - Running post-action listener: _start_resource_monitoring 20:45:46 INFO - Starting resource monitoring. 20:45:46 INFO - [mozharness: 2017-02-16 04:45:46.127289Z] Finished create-virtualenv step (success) 20:45:46 INFO - [mozharness: 2017-02-16 04:45:46.128105Z] Running install step. 20:45:46 INFO - Running pre-action listener: _resource_record_pre_action 20:45:46 INFO - Running main action method: install 20:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:45:46 INFO - Reading from file tmpfile_stdout 20:45:46 INFO - Detecting whether we're running mozinstall >=1.0... 20:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:45:46 INFO - Reading from file tmpfile_stdout 20:45:46 INFO - Output received: 20:45:46 INFO - Usage: mozinstall [options] installer 20:45:46 INFO - Options: 20:45:46 INFO - -h, --help show this help message and exit 20:45:46 INFO - -d DEST, --destination=DEST 20:45:46 INFO - Directory to install application into. [default: 20:45:46 INFO - "/builds/slave/test"] 20:45:46 INFO - --app=APP Application being installed. [default: firefox] 20:45:46 INFO - mkdir: /builds/slave/test/build/application 20:45:46 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:45:46 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:46:07 INFO - Reading from file tmpfile_stdout 20:46:07 INFO - Output received: 20:46:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:46:07 INFO - Running post-action listener: _resource_record_post_action 20:46:07 INFO - [mozharness: 2017-02-16 04:46:07.846085Z] Finished install step (success) 20:46:07 INFO - [mozharness: 2017-02-16 04:46:07.846249Z] Running run-tests step. 20:46:07 INFO - Running pre-action listener: _resource_record_pre_action 20:46:07 INFO - Running main action method: run_tests 20:46:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:46:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:46:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:46:07 INFO - 2017-02-15 20:46:07.860 screenresolution[1624:7339] starting screenresolution argv=screenresolution get 20:46:07 INFO - 2017-02-15 20:46:07.863 screenresolution[1624:7339] Display 0: 1600x1200x32@60 20:46:07 INFO - 2017-02-15 20:46:07.869 screenresolution[1625:7341] starting screenresolution argv=screenresolution list 20:46:07 INFO - Available Modes on Display 0 20:46:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:46:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:46:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:46:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:46:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:46:08 INFO - Intel Iris: 20:46:08 INFO - Chipset Model: Intel Iris 20:46:08 INFO - Type: GPU 20:46:08 INFO - Bus: Built-In 20:46:08 INFO - VRAM (Dynamic, Max): 1536 MB 20:46:08 INFO - Vendor: Intel (0x8086) 20:46:08 INFO - Device ID: 0x0a2e 20:46:08 INFO - Revision ID: 0x0009 20:46:08 INFO - Displays: 20:46:08 INFO - Display: 20:46:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:46:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:46:08 INFO - Display Serial Number: 1600x1200 60 20:46:08 INFO - Main Display: Yes 20:46:08 INFO - Mirror: Off 20:46:08 INFO - Online: Yes 20:46:08 INFO - Rotation: Supported 20:46:08 INFO - Return code: 0 20:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:08 INFO - Python 2.7.3 20:46:08 INFO - Return code: 0 20:46:08 INFO - grabbing minidump binary from tooltool 20:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:08 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 0x10315ad30>, '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 0x102fc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103152b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:08 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:46:08 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:46:08 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:46:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:08 INFO - Return code: 0 20:46:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:46:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:46:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:08 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/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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:46:08 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/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --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:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFHR4yeW7S/Render', 20:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:08 INFO - 'HOME': '/Users/cltbld', 20:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:08 INFO - 'LOGNAME': 'cltbld', 20:46:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:08 INFO - 'MOZ_NO_REMOTE': '1', 20:46:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:08 INFO - 'NO_EM_RESTART': '1', 20:46:08 INFO - 'PAGER': '/bin/cat', 20:46:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:08 INFO - 'PWD': '/builds/slave/test', 20:46:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:08 INFO - 'SHELL': '/bin/bash', 20:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FkM7lmMLa8/Listeners', 20:46:08 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 20:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:08 INFO - 'USER': 'cltbld', 20:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:08 INFO - 'XPC_FLAGS': '0x0', 20:46:08 INFO - 'XPC_SERVICE_NAME': '0', 20:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:08 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/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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:46:08 INFO - mozversion application_buildid: 20170215181318 20:46:08 INFO - mozversion application_changeset: 24c5c108f6d63bf2872fda200fc1e643333bfbc7 20:46:08 INFO - mozversion application_display_name: Firefox 20:46:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:08 INFO - mozversion application_name: Firefox 20:46:08 INFO - mozversion application_remotingname: firefox 20:46:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:46:08 INFO - mozversion application_vendor: Mozilla 20:46:08 INFO - mozversion application_version: 52.0 20:46:08 INFO - mozversion platform_buildid: 20170215181318 20:46:08 INFO - mozversion platform_changeset: 24c5c108f6d63bf2872fda200fc1e643333bfbc7 20:46:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:46:08 INFO - mozversion platform_version: 52.0 20:46:08 INFO - using testdate: 1487220368 20:46:08 INFO - actual date: 1487220368 20:46:08 INFO - starting webserver on 'localhost:49236' 20:46:08 INFO - SUITE-START | Running 2 tests 20:46:08 INFO - TEST-START | dromaeo_css 20:46:08 INFO - operating with platform_type : mac_ 20:46:08 INFO - Initialising browser for dromaeo_css test... 20:46:08 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp7l85PB/profile http://localhost:49236/getInfo.html) 20:46:11 INFO - PROCESS | 1635 | 2017-02-15 20:46:11.414 plugin-container[1638:7520] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 20:46:11 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:46:11 INFO - PROCESS | 1635 | 2017-02-15 20:46:11.415 plugin-container[1638:7520] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 20:46:11 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:46:11 INFO - PROCESS | 1635 | 2017-02-15 20:46:11.415 plugin-container[1638:7520] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:46:11 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 20:46:11 INFO - PROCESS | 1635 | colorDepth:24 20:46:11 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 20:46:11 INFO - PROCESS | 1635 | __metrics 20:46:11 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 20:46:12 INFO - TEST-INFO | 1635: exit 0 20:46:12 INFO - Browser initialized. 20:46:12 INFO - Running cycle 1/1 for dromaeo_css test... 20:46:12 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp7l85PB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:46:14 INFO - PROCESS | 1639 | 2017-02-15 20:46:14.889 plugin-container[1640:7775] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 20:46:14 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:46:14 INFO - PROCESS | 1639 | 2017-02-15 20:46:14.889 plugin-container[1640:7775] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x421f, name = 'com.apple.CFPasteboardClient' 20:46:14 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:46:14 INFO - PROCESS | 1639 | 2017-02-15 20:46:14.889 plugin-container[1640:7775] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:46:24 INFO - PROCESS | 1639 | RSS: Main: 177508352 20:46:24 INFO - PROCESS | 1639 | 20:49:26 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:49:27 INFO - PROCESS | 1639 | RSS: Main: 183386112 20:49:27 INFO - PROCESS | 1639 | 20:52:30 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:52:30 INFO - PROCESS | 1639 | RSS: Main: 191934464 20:52:30 INFO - PROCESS | 1639 | 20:55:32 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:55:33 INFO - PROCESS | 1639 | RSS: Main: 198709248 20:55:33 INFO - PROCESS | 1639 | 20:58:35 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:58:35 INFO - PROCESS | 1639 | RSS: Main: 201781248 20:58:35 INFO - PROCESS | 1639 | 21:01:38 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 21:01:39 INFO - PROCESS | 1639 | RSS: Main: 203087872 21:01:39 INFO - PROCESS | 1639 | 21:04:42 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:04:42 INFO - PROCESS | 1639 | RSS: Main: 203780096 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | __start_tp_report 21:04:42 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 21:04:42 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 21:04:42 INFO - PROCESS | 1639 | |i|pagename|runs| 21:04:42 INFO - PROCESS | 1639 | |0;dojo.html;2906.2443764621194;3516.929661406772;3585.2650206707617;3606.296772129436;3624.909377265568;5849.122631605256;5939.88120237595;5945;5969.7015149242525;5981.282246130465;5775.768969241236;5894.88210235795;5895.410458954102;5903.704814759266;5913.172155898178;4712.434507859061;4927.211646136619;5261.763220655061;5302.151655735083;5338.839834804962;5346.625736198468;5355.143177091666;5365.946340536603;5372.865678358034;5373.274607927939;5242.685438873661;5253.763580638862;5339.172428273624;5341.786328546854;5352.2239275305055;5312.867178320554;5368.785248590052;5384.380796208447;5399.865003374908;5410.3507579090365;5206.7917283308625;5314.99015187117;5316.73416329182;5345.198220266952;5369.731513424353;5967.791127310524;6030.306514750816;6049.576529642927;6087.665178415185;6104.816855494298;5125.384953805567;6134.77336474251;6191.783287584958;6193.6903154842075;6306.306306306303;6304.401081897213;6305.653189074599;6315.210598675166;6315.74737010519;6318.210223722035;4991.975040124812;5618.438156184349;5982.282126144847;6005.939940600581;6028.336882942873;6185.505159587222;6290.842728931813;6294.496440284858;6316.178896743486;6380.680965951684;6176.6911654418;6180.381961803783;6191.5665903387235;6217.533684973645;6269.529785266123;6347.460465860361;6351.904721429182;6367.681615919186;6368.172137622079;6379.170707807955;5055.3428054353435;6237.4698150657705;6238;6254.405831446005;6283.371662833772;5196.376434827845;6255.280642726145;6259.499240060784;6274.780382686584;6286.811395658137;5087.669301495391;5100.311457953203;5103.97448012765;5113;5127.051495473349;4434.979954610458;4455.732656040648;4540.069285796404;4564.246899261651;4571.314302854598;4827.889585395379;6110.285381942539;6113.358097399709;6118.479929205978;6161.44546990773;6283;6294.087357333253;6330.987042073246;6341.8097457076365;6476.805695829133;6076.0278355462915;6088.086786981989;6134.294556126013;6143.232095988002;6152.753889844356;4704.270838020112;5505.587080968943;5577.888442231133;5583.218349431083;5614.129809879393;6546.770863019867;6567.770128045496;6570.704318305592;6583.210014798255;6583.979483180115;5436.238926550207;6200.56596038273;6288.213973253343;6331.176946996861;6333.588316759396;6407.903881441689;6526.216853977553;6530.542861999615;6562.704678289584;6570.441512471493;6264.123022776724;6302.117703521602;6309.747610095545;6332.651704156316;6339.873202536016;6223.688815559294;6286.151369565233;6309.022101574264;6318.368163183645;6363.3636636336;6177.444030037318;6213.1922850029205;6271.717772700148;6293.559450838397;6315.400036996478;6225.750969961151;6280.309165991646;6290.46531044848;6314.810555683337;6332.493400528039;5967.283925928743;6075.908861366995;6147.631142131487;6152.138700581832;6233.781817636361;5488.69812160335;6135.07955838608;6183.258009038944;6201.844953876189;6222.782202622887;6180.845478863064;6203.2245969253845;6211.161493198541;6217.813465596039;6237.438630523275 21:04:42 INFO - PROCESS | 1639 | |1;ext.html;461.24816549025087;493.2699604585214;515.8555604430761;524.310531650879;548.3693752184988;38162.427563586534;39874.20251594966;39935.40096898545;42059.3691094633;42139;41666.58333416665;41900.37149442761;42206.7889660552;42214.78892605533;42281.36577951325;9477.90522094777;9625.903740962605;9641.325107242496;9646.93883672799;9657.95171024144;9533;9602.711918642417;9668.274879384038;9672.468014259213;9728.951355243214;9635.903640963606;9674.226061915066;9683.418994860296;9690.37012594179;9692.854607180898;8265.297449716782;9600;9637.18083962864;9671.854922176139;9685.225181985425;9572.377795443273;9612.759681007961;9620.230381569458;9634.518274086338;9645.758856028586;39531;39783.80108099441;39804.004899877735;39926.60073399258;40119;3550.8224588770718;3576.946345804815;3579.1231148368556;3912.960870391288;4029.476168098158;28733.56899646507;29100.563491547644;30410.54384184239;30822;31136.844315778275;3142.3665236518914;3215.694509021639;3304.438245498271;3429.725621950238;3450.27544215715;503486;509690;511537;511651;512045;59048;59499.810003799685;59512.40487595155;59566;59580.70209648924;61700.69149654313;61928.38071619316;62192.37807621956;62410.37589624136;62569;16527.421540246032;16632.66734665324;16741.414050508174;16752.58118547022;16809.57976050584;11577.421128943519;12908.612741617766;13072.673183170496;13144.802827957588;13150.079494435298;13200.801987969997;14007.579772606838;16568.75146872798;16572.419965301156;16702.99782013083;2894.0738963531467;3110.6733792951413;6320.62076275425;6489.870202595922;6530.249021362604;863.6156910175038;933.1974501928336;1005.6882366466273;1056.8309070548828;1106.0653747583278;29568;29696.851515742284;29721;30575.2356191097;30645.387092258476;1067.0343339277965;1077.886821883691;1083.6369816111692;1090.3566895531674;1126.2960649594004;15281.087481078694;15438.15090170029;15491.84508154904;15551.922240388725;15856.127912964897;644208;659594;660313;661829;662655;53346.933061338554;53572;58210;58233;58745.531361715446;1324.2716505921896;1336.9933150334186;1369.1511263016994;1404.297851074483;1410.1750475971671;29119.417611647226;29716.405671886874;29981;30257.394852103276;30283;49609.25586116139;49933.50066499434;49948.75025624849;50096.99806003787;50124.498755011984;595811;596875;598080.0095999492;599005;599453;26375.73624263733;26618.733812661627;26900.192994210203;26966.73033269642;27067.864660676572;45340.967466820315;45850.31224531568;45972.770136149105;46337.53662463467;46345;28483.718232679166;31885.883994060096;35019.64980350164;37301.62698372982;38292;31422.52866206963;32249.51625725663;36980.63019369772;37107.628923710414;38285.808570956964;34337;34973.60105595748;37983;38139.80930095332;38210.42684359681;33011.504827427125;33832.66167338295;34376.48435273523;34459;34641;23417.41456463602;25063.122790702237;25221.873890630428;25316;25836.224913252634 21:04:42 INFO - PROCESS | 1639 | |2;jquery.html;329.836730818245;381.6736690129941;394.42020230261505;399.06618512680325;413.4707574304889;13096.41066152023;16210.918945405256;16211.894747818847;18355.174017169225;20987.370378888638;16350.672986540261;17251.482455526355;17819.376321828706;20056.197752089898;20671.86304753238;4887.266909963499;5820.330661973874;6154.938450615504;6161;6167.444929956303;5691.231683722686;6010;6076.3316035236085;6079.118527813464;6081.543884208702;5795.275590551181;5994.730237139339;5997.130416089664;6152.354002829706;6161.199044124258;6088.995315772892;6123.846903827395;6139.201903752528;6175.0737389391725;6193.845153871144;5900.409959004108;6034.909476357858;6045.365236650133;6089.847753806191;6110.083487476914;13224.338783060808;13438.865611343957;19406.514837129183;24453;24553.77231138436;2148.967765483519;2220.8001279884725;2226.343228747507;2262.8868556572106;2626.776723978464;9699;10131.949340253324;10402.739931501697;10683.572657093708;10716.196285278635;1868.560888191274;1884.218049509452;1893;1904.23830467814;1974.104221530598;114048;130498;131063.68936310706;136223;136879.6312036877;8750.34372422071;8992.775180620536;10148.441835698959;10318.845217321747;10344.637937672145;12553.246805191719;12644.683882903;12670.873291267153;12696.6825829355;12763.234205947672;8182.4681395709085;8279.668813247523;8348.958255208685;8424.03123640789;8475.321974242046;8673.436226645248;8678.435901666498;8713.170234250878;8859.734207973772;8869.512176830336;3318.3363327334146;3954.4463775071513;4004.7569496061114;4037.7779222142476;4057.797110144481;1689.2736123467027;1997.4107638246462;2009.3168322770327;2026.7365242518674;2041.7549894012814;833.0420016980521;847.6694089305176;868.9565521723888;882.4616983639975;987.9654212102541;17556.122193890253;19523.609527809363;20082.297119600746;20156.798432015494;20203.898980505004;961.6153538584622;968.1577027985697;1031.8555402243692;1055.1242468750918;1058.6347710040025;9768.60687022899;10238.488075596191;10830.098848506766;10831.47340845933;10894.330888932262;502333;573770;580741;587889;589180;124741;125577;131442;133019;137369;988.851672249154;1007.2495990487281;1034.3897100710617;1036.0934182590233;1040.9323393979366;18774.6245075095;18960.525986849887;19378.03109844474;19454.805451945864;19468.123934423267;58365.416345836;58580.12129818142;58603;58858.41141588529;60322;84888;86416;87266;88270;88649.55675221582;5443.237946687546;5825.0679891217205;7706.730264440717;8163.306118979715;8369.874451883104;9262.490563019099;10015.449150296803;12887.677808054874;13260.469581216643;13357.332133393485;11271.211015229183;11279.943600281946;11576.24754390962;11652.242604230698;11652.30086194831;5989.580729349078;7191.7842464726145;11354.829677554679;11372.60195893173;11654.53381864716;9220.262379009797;11573;11690.006349460391;11953.282803031845;11983.28100313984;8358.66565337404;8422.83154336922;8477.321814254721;8588.613512391832;8620.353473489387;9472.905270947202;9591.664291749756;9771.85342219853;10975.341479511255;11703.882961170279 21:04:42 INFO - PROCESS | 1639 | |3;mootools.html;1493.230986042188;1550.6976139652766;1729.792424909011;1766.7367832000118;1869.4298239037096;7717.768466946;7720.5753683547455;7948.324392426651;8587.78530536736;8626.698065567707;8078.272955434009;8354.665813367474;8390.790230244247;8503.829923401529;8550.52972086535;2185.825133989285;2218.511927375983;2220.955580888381;2227.3986023773573;2228.353777404551;2370.6799582056374;2414.2757172848164;2417.6857008588945;2432.720237172721;2446.4740080882607;2376.8811559422047;2380.5952987991996;2388.152205966883;2399.892004859777;2406.95186096278;2363.61000434928;2367.7040369953756;2391.1511413448325;2391.6771235883193;2398.292503711409;1945.7158275538218;2009.2264478175862;2321.0947730385165;2385.1413491143176;2414.6860908081835;7086.291370862924;7255.746048888316;8466;8524.57377131141;8573.785655358604;5015.724135172564;5250.05499010178;5259.710715910624;5266.34170728659;5301.867453313659;3247.9188020299443;3436.1924947637285;3537.5401197844117;3586.659267369596;3604;930.8277968575835;1039.3959954382042;1040.47976011994;1086.223350304536;1090.3239991205503;10929.672109836718;10935.234533582652;10984.505697243643;10984.725381865517;10992.065674417685;4554.203014472454;4640.675152739276;4721.9055618888115;4731.384919960383;4816.975915120472;9593.040695930351;9605.615775369046;9619.711408657751;9630.374025688448;9717.076877696749;4988.052270068748;5285.867853303698;5300.390455097636;5313.149896016619;5357.11607584752;4237.0466645005245;4501.257292546758;4778.689385189951;4835.758212089381;4875.561199492063;3873.9031524211555;3895.4935858338235;3955.3078211312904;3981.462502562117;4017.4375587417785;1302.3683513495946;1303.4069498378215;1311.4688551136805;1313.4155300891011;1325.105553751214;882.7175303902818;884.920357167845;900.9504477253682;905.5879574793453;924.6624981881699;4606.815727370935;5433.375161856358;5728.112142617901;5772.307323121252;5791.247137872134;368.32412523020025;437.269759501633;449.76612161675746;457.9542045795394;461.05023651278475;3214.5017522284083;3352.832358382071;3810.2760475509563;3935.4687117239378;3963.58382369847;9833.852492212622;10054.798904022025;10149.238807089498;10174.491275436347;10204.183665306758;9578.377405468622;9961.302708810459;10041.196704263788;10057.69826905194;10064.245181611263;6725.159355080713;7631.3131818136635;7978.242067003625;7986.960065199637;7994.2805147537;5685.914711279417;5705.37240903492;5727.341355744143;5868.23712917318;5974;9494.477803720862;9620.807583848144;9627.326087173831;9642.084002019797;9648.421094734338;8127.187281271826;9617.326787125114;9712.223022158352;9790.51047447639;9866.210703143875;6726.125603671491;6729.158855143107;6954;7110.182329032227;7303.890441643273;7995.440319177602;8162.7143049992965;8163.673453061811;8166.224208700164;8190.672373105009;7164.498485105993;7271.945567892732;7344.742933997284;7410.073740782403;7434.814129646802;6030.396960303934;6241.968790156202;6958.095447591781;7104;7130.857382852418;6771.62756048422;6787.5588086774205;6847.93152068473;6851.143607049119;6883.174019117738;4792.95207047939;4844.612431005582;4865.9270110947655;4868.221084626584;4887;4777.211760059551;4801.255805350176;4946.480619534897;4946.703197808143;4980 21:04:42 INFO - PROCESS | 1639 | |4;prototype.html;286.38998932274257;309.9101260634416;321.6831421050266;324.54725657707485;326.06582142162694;4491.573300536444;5236.005159019784;5495.6702597844105;5518.19986102015;5655.971720141399;5200.699825043739;5375.731213439332;5418.448503257273;5429.864253393667;5468.855408140315;3359.496075588669;4144;4164.437800896878;4176.728512646683;4184.560621134783;3848.26882892251;4073.5315438724483;4181.540030596632;4192.098698779761;4201.117765269297;3915.1973845361777;4048.453458783071;4056.411820286057;4058.5389259866574;4074.5314288856716;4051.493563304587;4092.2786347079154;4097.610726980932;4107.712460127792;4145.79271036447;2776.875365476965;3134.5298205269164;3464.9480257796154;3591.730620203495;3615.783053016801;4600.654950878664;4890.948446084109;5259.368875734936;5349.3045904032615;5360.2227676987;4679.485256621769;4702.4592171899985;4723.905521889577;4728.69263497875;4736.342280201936;5739.540836733051;5758.48173664368;5799.768009279624;5807.332156801937;5816.651000939957;2936.2219011961847;3264.183954011497;3588.8743893963588;3876.6511014008875;3937.8424863005444;5728.570357223183;6037.30570984338;6046.606970546901;6061.393860613947;6063.090536419529;3672.981635091807;3944.033711740642;3963.9891827583783;3964.0684439156776;3988.4216788566077;3196.360727854438;3685.4840322354894;3977.5226972763453;3980.805758272507;4028.436018957348;3778;3875.5736868944396;4314.331278651814;4449.265871131227;4720.796196969751;4936.975315123474;5168.3797944246935;5273.257905888916;5696.202531645573;5720.656760594377;1115.369816053927;1187.1333926233724;1199.9520019199135;1280.4110109349804;1289.8968082553374;782.710397153057;864.7794812322818;897.9910200897907;899.8155378147464;902.6118768929423;4648.883777905579;4728.858134255978;4759.095771803415;4864.440589332201;5172.793088276502;5004.724740139254;5461.262729531462;5555.916661250085;5558.360788509292;5591.440855914376;4128.545859955402;4625.537446255415;5181.1969144782615;5223.555997740159;5243.973780131075;2520.911768088108;2745.546984747534;2903.8983635572654;2911.490489164388;2959;5334.493223143795;5649.4633009864;5663.405342438985;5913.940860591339;5922.170896074553;5413.858398325285;5731.226284451629;5759.568032397587;6112.816615501542;6161.322254551996;5471.12462006093;5708.629928817137;5740.282464691913;6194.163787888668;6316.210473690789;5509.5041446270025;5979.312379076462;6007.468095635585;6030.065339872327;6031.276246850406;4668.393108895822;5216.113260745607;5919.378465261258;5929.762809487572;5970.910436343545;5007.716858714091;5766.365699772938;6226.62640241587;6299.96850015747;6321;3216.887408940676;3934.4295077214215;3970.404439334123;4000.579939106352;4041.0705537727076;5730.742116604846;5801.419858014165;5844.211031510692;5856.443637854397;5866.6186697864505;5720.3707592164;5857.26784151981;5860.472557469848;5870.765169393177;5892.469677729025;5618.522425593706;5710.086386178357;5787.2187254720075;5838.912416313674;5840.977828879844;5195.337492002523;5501.587380946525;5678.943210568007;5688.720037991418;5752.391418367059;4691.695039822401;4872.756362181947;5167.6641018333685;5789.392113828156;5822.097574875901;5481.588880833874;5699.487046165865;5739.110437882135;5739.547429941489;5785.681787501728 21:04:42 INFO - PROCESS | 1639 | |5;yui.html;675.8682056998886;703.6270776488462;720.2365492577865;765.062798072361;809.2352726673295;14796.260186990648;15146.16696081715;15538.689226215469;15565.844341556609;15592.766108508367;13942.024058315921;14118;14227.430902763877;14236.501722439716;14246.074005189656;783.6434422337851;791.9506653683864;834.9666013359458;848.4697064334791;859.6303589456531;816.7917181118806;839.8866153069349;847.1232274595794;851.948883067018;856.2379482260793;908.2461556907783;909.727081875438;911.589784596934;912.4981260306838;913.9223166030862;902.3548163063375;907.7095329494564;909.663424532927;909.7862002429424;912.3567884641345;669.4945316286221;675.1897722732691;676.8274090107041;676.8612434450926;678.9626570538618;14724.33740481681;14732.631684207874;14995.700085998218;15043.548693539211;15049;11213.439328033648;13529.661758456019;13652.453901843914;13972;13982.370793314325;11464.25482343645;11633.825492617618;11651.300921944625;11659.06727461801;11726.648200553997;3583.2475180212186;3674.3386190485703;3699.2971335446177;3736.346139425617;3870.554886188096;94908.52545737228;95579.0442095584;95774;96755.54866677006;97925;10236.744081398025;10355.94822025885;10443.32118412316;10513.421761803174;10717;20681.379558612964;20723.481912951996;20731.689024664644;20751;20755;7172.852343624995;7483.476156668981;7751.621151478568;7808.6095695216145;7987.16134805837;3839.7120215983914;4261.978690106592;4308.913821723548;4464.598186163261;4466.218411777926;3452.2577645806273;3511.7892926424497;3553.200529880756;3562.839672214757;3582.1044738815294;555.6666000399728;637.9393957574023;643.797203880776;647.9125318082093;659.5548005096541;598.8173607049805;656.8522082531392;657.4871600151889;667.4593579200863;698.7833771530842;8083.312918401884;8935;9170.541472926461;9335.159835614828;9429.3399462037;596.1415561591294;603.604638961481;627.8461776864698;654.8395643067479;655.7868692674899;4179.080602267557;4586.518415566317;4599.67802253839;4628.467726211461;4663.463701674351;115923.42038289754;116372;117130;119304;123235.76764232422;70056.29943700497;75754.62122689352;104322;106115;108147;53584;57668.134977975365;73954.63022684852;74479;92281;9477.763055923657;9646.324757267204;9802.411855288705;9871.506424678593;9923;39860;51251.48748512616;52031.617944833466;52540.73729631327;53959.460405395446;54672;64371;64624.35375646183;71952.64023679848;76633.61683191548;10304.484775761332;11080.335179889233;11991.22057066288;12377.072420945715;12477.75044499123;14061.156330620195;14166.220857852504;14214.431422742975;14520.636984075483;14592.978491505493;13444.798328024892;13589.252591107188;13603.455861765418;13646.385912633757;13936.860631393556;13000.479980800663;13171;13288.40202190923;13421.145782958476;13435.395407206504;11552.018078463425;12594.370281485706;13175;13496.05527613097;13725.588232353046;9556.856647150438;10396.165528661422;10829.67510974672;10943.45282735844;11680.824787628362;9681.564329605044;10654.786904261717;11143.72140696489;11541.249818761753;11544.59593914209 21:04:42 INFO - PROCESS | 1639 | __end_tp_report 21:04:42 INFO - PROCESS | 1639 | __start_cc_report 21:04:42 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,374 21:04:42 INFO - PROCESS | 1639 | __end_cc_report 21:04:42 INFO - PROCESS | 1639 | __startTimestamp1487221482249__endTimestamp 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | ------- Summary: start ------- 21:04:42 INFO - PROCESS | 1639 | Number of tests: 6 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5842.79 Median:6147.63 stddev:670.87 (10.9%) stddev-sans-first:632.14 21:04:42 INFO - PROCESS | 1639 | Values: 2906.2 3516.9 3585.3 3606.3 3624.9 5849.1 5939.9 5945.0 5969.7 5981.3 5775.8 5894.9 5895.4 5903.7 5913.2 4712.4 4927.2 5261.8 5302.2 5338.8 5346.6 5355.1 5365.9 5372.9 5373.3 5242.7 5253.8 5339.2 5341.8 5352.2 5312.9 5368.8 5384.4 5399.9 5410.4 5206.8 5315.0 5316.7 5345.2 5369.7 5967.8 6030.3 6049.6 6087.7 6104.8 5125.4 6134.8 6191.8 6193.7 6306.3 6304.4 6305.7 6315.2 6315.7 6318.2 4992.0 5618.4 5982.3 6005.9 6028.3 6185.5 6290.8 6294.5 6316.2 6380.7 6176.7 6180.4 6191.6 6217.5 6269.5 6347.5 6351.9 6367.7 6368.2 6379.2 5055.3 6237.5 6238.0 6254.4 6283.4 5196.4 6255.3 6259.5 6274.8 6286.8 5087.7 5100.3 5104.0 5113.0 5127.1 4435.0 4455.7 4540.1 4564.2 4571.3 4827.9 6110.3 6113.4 6118.5 6161.4 6283.0 6294.1 6331.0 6341.8 6476.8 6076.0 6088.1 6134.3 6143.2 6152.8 4704.3 5505.6 5577.9 5583.2 5614.1 6546.8 6567.8 6570.7 6583.2 6584.0 5436.2 6200.6 6288.2 6331.2 6333.6 6407.9 6526.2 6530.5 6562.7 6570.4 6264.1 6302.1 6309.7 6332.7 6339.9 6223.7 6286.2 6309.0 6318.4 6363.4 6177.4 6213.2 6271.7 6293.6 6315.4 6225.8 6280.3 6290.5 6314.8 6332.5 5967.3 6075.9 6147.6 6152.1 6233.8 5488.7 6135.1 6183.3 6201.8 6222.8 6180.8 6203.2 6211.2 6217.8 6237.4 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:71327.55 Median:39657.40 stddev:158317.24 (399.2%) stddev-sans-first:158671.95 21:04:42 INFO - PROCESS | 1639 | Values: 461.2 493.3 515.9 524.3 548.4 38162.4 39874.2 39935.4 42059.4 42139.0 41666.6 41900.4 42206.8 42214.8 42281.4 9477.9 9625.9 9641.3 9646.9 9658.0 9533.0 9602.7 9668.3 9672.5 9729.0 9635.9 9674.2 9683.4 9690.4 9692.9 8265.3 9600.0 9637.2 9671.9 9685.2 9572.4 9612.8 9620.2 9634.5 9645.8 39531.0 39783.8 39804.0 39926.6 40119.0 3550.8 3576.9 3579.1 3913.0 4029.5 28733.6 29100.6 30410.5 30822.0 31136.8 3142.4 3215.7 3304.4 3429.7 3450.3 503486.0 509690.0 511537.0 511651.0 512045.0 59048.0 59499.8 59512.4 59566.0 59580.7 61700.7 61928.4 62192.4 62410.4 62569.0 16527.4 16632.7 16741.4 16752.6 16809.6 11577.4 12908.6 13072.7 13144.8 13150.1 13200.8 14007.6 16568.8 16572.4 16703.0 2894.1 3110.7 6320.6 6489.9 6530.2 863.6 933.2 1005.7 1056.8 1106.1 29568.0 29696.9 29721.0 30575.2 30645.4 1067.0 1077.9 1083.6 1090.4 1126.3 15281.1 15438.2 15491.8 15551.9 15856.1 644208.0 659594.0 660313.0 661829.0 662655.0 53346.9 53572.0 58210.0 58233.0 58745.5 1324.3 1337.0 1369.2 1404.3 1410.2 29119.4 29716.4 29981.0 30257.4 30283.0 49609.3 49933.5 49948.8 50097.0 50124.5 595811.0 596875.0 598080.0 599005.0 599453.0 26375.7 26618.7 26900.2 26966.7 27067.9 45341.0 45850.3 45972.8 46337.5 46345.0 28483.7 31885.9 35019.6 37301.6 38292.0 31422.5 32249.5 36980.6 37107.6 38285.8 34337.0 34973.6 37983.0 38139.8 38210.4 33011.5 33832.7 34376.5 34459.0 34641.0 23417.4 25063.1 25221.9 25316.0 25836.2 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:34437.30 Median:1478.31 stddev:95711.18 (6474.4%) stddev-sans-first:95945.42 21:04:42 INFO - PROCESS | 1639 | Values: 329.8 381.7 394.4 399.1 413.5 13096.4 16210.9 16211.9 18355.2 20987.4 16350.7 17251.5 17819.4 20056.2 20671.9 4887.3 5820.3 6154.9 6161.0 6167.4 5691.2 6010.0 6076.3 6079.1 6081.5 5795.3 5994.7 5997.1 6152.4 6161.2 6089.0 6123.8 6139.2 6175.1 6193.8 5900.4 6034.9 6045.4 6089.8 6110.1 13224.3 13438.9 19406.5 24453.0 24553.8 2149.0 2220.8 2226.3 2262.9 2626.8 9699.0 10131.9 10402.7 10683.6 10716.2 1868.6 1884.2 1893.0 1904.2 1974.1 114048.0 130498.0 131063.7 136223.0 136879.6 8750.3 8992.8 10148.4 10318.8 10344.6 12553.2 12644.7 12670.9 12696.7 12763.2 8182.5 8279.7 8349.0 8424.0 8475.3 8673.4 8678.4 8713.2 8859.7 8869.5 3318.3 3954.4 4004.8 4037.8 4057.8 1689.3 1997.4 2009.3 2026.7 2041.8 833.0 847.7 869.0 882.5 988.0 17556.1 19523.6 20082.3 20156.8 20203.9 961.6 968.2 1031.9 1055.1 1058.6 9768.6 10238.5 10830.1 10831.5 10894.3 502333.0 573770.0 580741.0 587889.0 589180.0 124741.0 125577.0 131442.0 133019.0 137369.0 988.9 1007.2 1034.4 1036.1 1040.9 18774.6 18960.5 19378.0 19454.8 19468.1 58365.4 58580.1 58603.0 58858.4 60322.0 84888.0 86416.0 87266.0 88270.0 88649.6 5443.2 5825.1 7706.7 8163.3 8369.9 9262.5 10015.4 12887.7 13260.5 13357.3 11271.2 11279.9 11576.2 11652.2 11652.3 5989.6 7191.8 11354.8 11372.6 11654.5 9220.3 11573.0 11690.0 11953.3 11983.3 8358.7 8422.8 8477.3 8588.6 8620.4 9472.9 9591.7 9771.9 10975.3 11703.9 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5461.51 Median:4963.35 stddev:3014.00 (60.7%) stddev-sans-first:3007.70 21:04:42 INFO - PROCESS | 1639 | Values: 1493.2 1550.7 1729.8 1766.7 1869.4 7717.8 7720.6 7948.3 8587.8 8626.7 8078.3 8354.7 8390.8 8503.8 8550.5 2185.8 2218.5 2221.0 2227.4 2228.4 2370.7 2414.3 2417.7 2432.7 2446.5 2376.9 2380.6 2388.2 2399.9 2407.0 2363.6 2367.7 2391.2 2391.7 2398.3 1945.7 2009.2 2321.1 2385.1 2414.7 7086.3 7255.7 8466.0 8524.6 8573.8 5015.7 5250.1 5259.7 5266.3 5301.9 3247.9 3436.2 3537.5 3586.7 3604.0 930.8 1039.4 1040.5 1086.2 1090.3 10929.7 10935.2 10984.5 10984.7 10992.1 4554.2 4640.7 4721.9 4731.4 4817.0 9593.0 9605.6 9619.7 9630.4 9717.1 4988.1 5285.9 5300.4 5313.1 5357.1 4237.0 4501.3 4778.7 4835.8 4875.6 3873.9 3895.5 3955.3 3981.5 4017.4 1302.4 1303.4 1311.5 1313.4 1325.1 882.7 884.9 901.0 905.6 924.7 4606.8 5433.4 5728.1 5772.3 5791.2 368.3 437.3 449.8 458.0 461.1 3214.5 3352.8 3810.3 3935.5 3963.6 9833.9 10054.8 10149.2 10174.5 10204.2 9578.4 9961.3 10041.2 10057.7 10064.2 6725.2 7631.3 7978.2 7987.0 7994.3 5685.9 5705.4 5727.3 5868.2 5974.0 9494.5 9620.8 9627.3 9642.1 9648.4 8127.2 9617.3 9712.2 9790.5 9866.2 6726.1 6729.2 6954.0 7110.2 7303.9 7995.4 8162.7 8163.7 8166.2 8190.7 7164.5 7271.9 7344.7 7410.1 7434.8 6030.4 6242.0 6958.1 7104.0 7130.9 6771.6 6787.6 6847.9 6851.1 6883.2 4793.0 4844.6 4865.9 4868.2 4887.0 4777.2 4801.3 4946.5 4946.7 4980.0 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4597.22 Median:5208.41 stddev:1466.90 (28.2%) stddev-sans-first:1434.88 21:04:42 INFO - PROCESS | 1639 | Values: 286.4 309.9 321.7 324.5 326.1 4491.6 5236.0 5495.7 5518.2 5656.0 5200.7 5375.7 5418.4 5429.9 5468.9 3359.5 4144.0 4164.4 4176.7 4184.6 3848.3 4073.5 4181.5 4192.1 4201.1 3915.2 4048.5 4056.4 4058.5 4074.5 4051.5 4092.3 4097.6 4107.7 4145.8 2776.9 3134.5 3464.9 3591.7 3615.8 4600.7 4890.9 5259.4 5349.3 5360.2 4679.5 4702.5 4723.9 4728.7 4736.3 5739.5 5758.5 5799.8 5807.3 5816.7 2936.2 3264.2 3588.9 3876.7 3937.8 5728.6 6037.3 6046.6 6061.4 6063.1 3673.0 3944.0 3964.0 3964.1 3988.4 3196.4 3685.5 3977.5 3980.8 4028.4 3778.0 3875.6 4314.3 4449.3 4720.8 4937.0 5168.4 5273.3 5696.2 5720.7 1115.4 1187.1 1200.0 1280.4 1289.9 782.7 864.8 898.0 899.8 902.6 4648.9 4728.9 4759.1 4864.4 5172.8 5004.7 5461.3 5555.9 5558.4 5591.4 4128.5 4625.5 5181.2 5223.6 5244.0 2520.9 2745.5 2903.9 2911.5 2959.0 5334.5 5649.5 5663.4 5913.9 5922.2 5413.9 5731.2 5759.6 6112.8 6161.3 5471.1 5708.6 5740.3 6194.2 6316.2 5509.5 5979.3 6007.5 6030.1 6031.3 4668.4 5216.1 5919.4 5929.8 5970.9 5007.7 5766.4 6226.6 6300.0 6321.0 3216.9 3934.4 3970.4 4000.6 4041.1 5730.7 5801.4 5844.2 5856.4 5866.6 5720.4 5857.3 5860.5 5870.8 5892.5 5618.5 5710.1 5787.2 5838.9 5841.0 5195.3 5501.6 5678.9 5688.7 5752.4 4691.7 4872.8 5167.7 5789.4 5822.1 5481.6 5699.5 5739.1 5739.5 5785.7 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20313.89 Median:4386.76 stddev:30071.74 (685.5%) stddev-sans-first:30119.95 21:04:42 INFO - PROCESS | 1639 | Values: 675.9 703.6 720.2 765.1 809.2 14796.3 15146.2 15538.7 15565.8 15592.8 13942.0 14118.0 14227.4 14236.5 14246.1 783.6 792.0 835.0 848.5 859.6 816.8 839.9 847.1 851.9 856.2 908.2 909.7 911.6 912.5 913.9 902.4 907.7 909.7 909.8 912.4 669.5 675.2 676.8 676.9 679.0 14724.3 14732.6 14995.7 15043.5 15049.0 11213.4 13529.7 13652.5 13972.0 13982.4 11464.3 11633.8 11651.3 11659.1 11726.6 3583.2 3674.3 3699.3 3736.3 3870.6 94908.5 95579.0 95774.0 96755.5 97925.0 10236.7 10355.9 10443.3 10513.4 10717.0 20681.4 20723.5 20731.7 20751.0 20755.0 7172.9 7483.5 7751.6 7808.6 7987.2 3839.7 4262.0 4308.9 4464.6 4466.2 3452.3 3511.8 3553.2 3562.8 3582.1 555.7 637.9 643.8 647.9 659.6 598.8 656.9 657.5 667.5 698.8 8083.3 8935.0 9170.5 9335.2 9429.3 596.1 603.6 627.8 654.8 655.8 4179.1 4586.5 4599.7 4628.5 4663.5 115923.4 116372.0 117130.0 119304.0 123235.8 70056.3 75754.6 104322.0 106115.0 108147.0 53584.0 57668.1 73954.6 74479.0 92281.0 9477.8 9646.3 9802.4 9871.5 9923.0 39860.0 51251.5 52031.6 52540.7 53959.5 54672.0 64371.0 64624.4 71952.6 76633.6 10304.5 11080.3 11991.2 12377.1 12477.8 14061.2 14166.2 14214.4 14520.6 14593.0 13444.8 13589.3 13603.5 13646.4 13936.9 13000.5 13171.0 13288.4 13421.1 13435.4 11552.0 12594.4 13175.0 13496.1 13725.6 9556.9 10396.2 10829.7 10943.5 11680.8 9681.6 10654.8 11143.7 11541.2 11544.6 21:04:42 INFO - PROCESS | 1639 | -------- Summary: end -------- 21:04:42 INFO - PROCESS | 1639 | 21:04:42 INFO - TEST-INFO | 1639: exit 0 21:04:42 INFO - TEST-OK | dromaeo_css | took 1114357ms 21:04:42 INFO - TEST-START | kraken 21:04:42 INFO - operating with platform_type : mac_ 21:04:42 INFO - Initialising browser for kraken test... 21:04:42 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpnHFdUR/profile http://localhost:49236/getInfo.html) 21:04:45 INFO - PROCESS | 1650 | 2017-02-15 21:04:45.801 plugin-container[1652:10480] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 21:04:45 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:04:45 INFO - PROCESS | 1650 | 2017-02-15 21:04:45.802 plugin-container[1652:10480] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4427, name = 'com.apple.CFPasteboardClient' 21:04:45 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:04:45 INFO - PROCESS | 1650 | 2017-02-15 21:04:45.802 plugin-container[1652:10480] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:04:45 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 21:04:45 INFO - PROCESS | 1650 | colorDepth:24 21:04:45 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 21:04:45 INFO - PROCESS | 1650 | __metrics 21:04:46 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 21:04:46 INFO - TEST-INFO | 1650: exit 0 21:04:46 INFO - Browser initialized. 21:04:46 INFO - Running cycle 1/1 for kraken test... 21:04:46 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpnHFdUR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:04:49 INFO - PROCESS | 1653 | 2017-02-15 21:04:49.234 plugin-container[1654:10611] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x424b, name = 'com.apple.tsm.portname' 21:04:49 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:04:49 INFO - PROCESS | 1653 | 2017-02-15 21:04:49.235 plugin-container[1654:10611] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 21:04:49 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:04:49 INFO - PROCESS | 1653 | 2017-02-15 21:04:49.235 plugin-container[1654:10611] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:04:59 INFO - PROCESS | 1653 | RSS: Main: 177643520 21:04:59 INFO - PROCESS | 1653 | 21:05:02 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:05:03 INFO - PROCESS | 1653 | RSS: Main: 190394368 21:05:03 INFO - PROCESS | 1653 | 21:05:05 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:05:06 INFO - PROCESS | 1653 | RSS: Main: 198324224 21:05:06 INFO - PROCESS | 1653 | 21:05:09 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:05:10 INFO - PROCESS | 1653 | RSS: Main: 201945088 21:05:10 INFO - PROCESS | 1653 | 21:05:11 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:05:12 INFO - PROCESS | 1653 | RSS: Main: 202317824 21:05:12 INFO - PROCESS | 1653 | 21:05:14 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:05:15 INFO - PROCESS | 1653 | RSS: Main: 202358784 21:05:15 INFO - PROCESS | 1653 | 21:05:17 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:05:18 INFO - PROCESS | 1653 | RSS: Main: 207560704 21:05:18 INFO - PROCESS | 1653 | 21:05:21 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:05:22 INFO - PROCESS | 1653 | RSS: Main: 207953920 21:05:22 INFO - PROCESS | 1653 | 21:05:25 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:05:26 INFO - PROCESS | 1653 | RSS: Main: 207347712 21:05:26 INFO - PROCESS | 1653 | 21:05:27 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:05:28 INFO - PROCESS | 1653 | RSS: Main: 206127104 21:05:28 INFO - PROCESS | 1653 | 21:05:30 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:05:30 INFO - PROCESS | 1653 | RSS: Main: 206176256 21:05:30 INFO - PROCESS | 1653 | 21:05:33 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:05:33 INFO - PROCESS | 1653 | RSS: Main: 206188544 21:05:33 INFO - PROCESS | 1653 | 21:05:36 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:05:37 INFO - PROCESS | 1653 | RSS: Main: 206524416 21:05:37 INFO - PROCESS | 1653 | 21:05:40 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:05:41 INFO - PROCESS | 1653 | RSS: Main: 206450688 21:05:41 INFO - PROCESS | 1653 | 21:05:42 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:05:42 INFO - PROCESS | 1653 | RSS: Main: 208109568 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | __start_tp_report 21:05:42 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 21:05:42 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 21:05:42 INFO - PROCESS | 1653 | |i|pagename|runs| 21:05:42 INFO - PROCESS | 1653 | |0;ai-astar;109;118;131;175;158;118;118;118;116;117 21:05:42 INFO - PROCESS | 1653 | |1;audio-beat-detection;142;111;111;150;118;119;116;137;174;110 21:05:42 INFO - PROCESS | 1653 | |2;audio-dft;198;199;196;201;199;193;201;194;197;191 21:05:42 INFO - PROCESS | 1653 | |3;audio-fft;81;59;59;85;60;63;63;59;76;59 21:05:42 INFO - PROCESS | 1653 | |4;audio-oscillator;88;70;90;79;92;57;109;87;57;73 21:05:42 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;92;88;89;87;91;93;91;88;91;79 21:05:42 INFO - PROCESS | 1653 | |6;imaging-darkroom;107;143;133;107;113;106;141;150;153;95 21:05:42 INFO - PROCESS | 1653 | |7;imaging-desaturate;88;91;88;131;127;127;147;134;87;91 21:05:42 INFO - PROCESS | 1653 | |8;json-parse-financial;55;55;56;57;59;60;60;69;82;80 21:05:42 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;68;71;83;109;101;75;69;68;69;68 21:05:42 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;83;87;86;89;97;96;102;70;100;103 21:05:42 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;154;155;159;154;148;152;145;143;200;145 21:05:42 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;170;170;166;172;169;201;172;170;166;165 21:05:42 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;67;72;67;71;67;66;65;68;60 21:05:42 INFO - PROCESS | 1653 | __end_tp_report 21:05:42 INFO - PROCESS | 1653 | __start_cc_report 21:05:42 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,957 21:05:42 INFO - PROCESS | 1653 | __end_cc_report 21:05:42 INFO - PROCESS | 1653 | __startTimestamp1487221542959__endTimestamp 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | ------- Summary: start ------- 21:05:42 INFO - PROCESS | 1653 | Number of tests: 14 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:127.80 Median:118.00 stddev:21.46 (18.2%) stddev-sans-first:21.65 21:05:42 INFO - PROCESS | 1653 | Values: 109.0 118.0 131.0 175.0 158.0 118.0 118.0 118.0 116.0 117.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:128.00 stddev:21.34 (16.7%) stddev-sans-first:22.09 21:05:42 INFO - PROCESS | 1653 | Values: 142.0 111.0 111.0 150.0 118.0 119.0 116.0 137.0 174.0 110.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:196.90 Median:198.50 stddev:3.38 (1.7%) stddev-sans-first:3.56 21:05:42 INFO - PROCESS | 1653 | Values: 198.0 199.0 196.0 201.0 199.0 193.0 201.0 194.0 197.0 191.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:66.40 Median:63.00 stddev:10.19 (16.2%) stddev-sans-first:9.34 21:05:42 INFO - PROCESS | 1653 | Values: 81.0 59.0 59.0 85.0 60.0 63.0 63.0 59.0 76.0 59.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:83.00 stddev:16.35 (19.7%) stddev-sans-first:17.10 21:05:42 INFO - PROCESS | 1653 | Values: 88.0 70.0 90.0 79.0 92.0 57.0 109.0 87.0 57.0 73.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:91.00 stddev:3.98 (4.4%) stddev-sans-first:4.07 21:05:42 INFO - PROCESS | 1653 | Values: 92.0 88.0 89.0 87.0 91.0 93.0 91.0 88.0 91.0 79.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:124.80 Median:142.00 stddev:21.36 (15.0%) stddev-sans-first:21.66 21:05:42 INFO - PROCESS | 1653 | Values: 107.0 143.0 133.0 107.0 113.0 106.0 141.0 150.0 153.0 95.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:111.10 Median:87.50 stddev:23.97 (27.4%) stddev-sans-first:23.92 21:05:42 INFO - PROCESS | 1653 | Values: 88.0 91.0 88.0 131.0 127.0 127.0 147.0 134.0 87.0 91.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:60.00 stddev:10.18 (17.0%) stddev-sans-first:10.34 21:05:42 INFO - PROCESS | 1653 | Values: 55.0 55.0 56.0 57.0 59.0 60.0 60.0 69.0 82.0 80.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:69.00 stddev:15.04 (21.8%) stddev-sans-first:15.50 21:05:42 INFO - PROCESS | 1653 | Values: 68.0 71.0 83.0 109.0 101.0 75.0 69.0 68.0 69.0 68.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:86.50 stddev:10.31 (11.9%) stddev-sans-first:10.49 21:05:42 INFO - PROCESS | 1653 | Values: 83.0 87.0 86.0 89.0 97.0 96.0 102.0 70.0 100.0 103.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:155.50 Median:154.00 stddev:16.47 (10.7%) stddev-sans-first:17.46 21:05:42 INFO - PROCESS | 1653 | Values: 154.0 155.0 159.0 154.0 148.0 152.0 145.0 143.0 200.0 145.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:170.00 stddev:10.45 (6.1%) stddev-sans-first:11.06 21:05:42 INFO - PROCESS | 1653 | Values: 170.0 170.0 166.0 172.0 169.0 201.0 172.0 170.0 166.0 165.0 21:05:42 INFO - PROCESS | 1653 | 21:05:42 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:3.28 (4.9%) stddev-sans-first:3.46 21:05:42 INFO - PROCESS | 1653 | Values: 66.0 67.0 72.0 67.0 71.0 67.0 66.0 65.0 68.0 60.0 21:05:42 INFO - PROCESS | 1653 | -------- Summary: end -------- 21:05:42 INFO - PROCESS | 1653 | 21:05:43 INFO - TEST-INFO | 1653: exit 0 21:05:44 INFO - TEST-OK | kraken | took 61211ms 21:05:44 INFO - SUITE-END | took 1175s 21:05:44 INFO - Completed test suite (00:19:35) 21:05:44 INFO - javascript benchmark 21:05:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7210.878052045004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2906.2443764621194, 3516.929661406772, 3585.2650206707617, 3606.296772129436, 3624.909377265568, 5849.122631605256, 5939.88120237595, 5945.0, 5969.7015149242525, 5981.282246130465, 5775.768969241236, 5894.88210235795, 5895.410458954102, 5903.704814759266, 5913.172155898178, 4712.434507859061, 4927.211646136619, 5261.763220655061, 5302.151655735083, 5338.839834804962, 5346.625736198468, 5355.143177091666, 5365.946340536603, 5372.865678358034, 5373.274607927939, 5242.685438873661, 5253.763580638862, 5339.172428273624, 5341.786328546854, 5352.2239275305055, 5312.867178320554, 5368.785248590052, 5384.380796208447, 5399.865003374908, 5410.3507579090365, 5206.7917283308625, 5314.99015187117, 5316.73416329182, 5345.198220266952, 5369.731513424353, 5967.791127310524, 6030.306514750816, 6049.576529642927, 6087.665178415185, 6104.816855494298, 5125.384953805567, 6134.77336474251, 6191.783287584958, 6193.6903154842075, 6306.306306306303, 6304.401081897213, 6305.653189074599, 6315.210598675166, 6315.74737010519, 6318.210223722035, 4991.975040124812, 5618.438156184349, 5982.282126144847, 6005.939940600581, 6028.336882942873, 6185.505159587222, 6290.842728931813, 6294.496440284858, 6316.178896743486, 6380.680965951684, 6176.6911654418, 6180.381961803783, 6191.5665903387235, 6217.533684973645, 6269.529785266123, 6347.460465860361, 6351.904721429182, 6367.681615919186, 6368.172137622079, 6379.170707807955, 5055.3428054353435, 6237.4698150657705, 6238.0, 6254.405831446005, 6283.371662833772, 5196.376434827845, 6255.280642726145, 6259.499240060784, 6274.780382686584, 6286.811395658137, 5087.669301495391, 5100.311457953203, 5103.97448012765, 5113.0, 5127.051495473349, 4434.979954610458, 4455.732656040648, 4540.069285796404, 4564.246899261651, 4571.314302854598, 4827.889585395379, 6110.285381942539, 6113.358097399709, 6118.479929205978, 6161.44546990773, 6283.0, 6294.087357333253, 6330.987042073246, 6341.8097457076365, 6476.805695829133, 6076.0278355462915, 6088.086786981989, 6134.294556126013, 6143.232095988002, 6152.753889844356, 4704.270838020112, 5505.587080968943, 5577.888442231133, 5583.218349431083, 5614.129809879393, 6546.770863019867, 6567.770128045496, 6570.704318305592, 6583.210014798255, 6583.979483180115, 5436.238926550207, 6200.56596038273, 6288.213973253343, 6331.176946996861, 6333.588316759396, 6407.903881441689, 6526.216853977553, 6530.542861999615, 6562.704678289584, 6570.441512471493, 6264.123022776724, 6302.117703521602, 6309.747610095545, 6332.651704156316, 6339.873202536016, 6223.688815559294, 6286.151369565233, 6309.022101574264, 6318.368163183645, 6363.3636636336, 6177.444030037318, 6213.1922850029205, 6271.717772700148, 6293.559450838397, 6315.400036996478, 6225.750969961151, 6280.309165991646, 6290.46531044848, 6314.810555683337, 6332.493400528039, 5967.283925928743, 6075.908861366995, 6147.631142131487, 6152.138700581832, 6233.781817636361, 5488.69812160335, 6135.07955838608, 6183.258009038944, 6201.844953876189, 6222.782202622887, 6180.845478863064, 6203.2245969253845, 6211.161493198541, 6217.813465596039, 6237.438630523275], "value": 5801.869592446399, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.24816549025087, 493.2699604585214, 515.8555604430761, 524.310531650879, 548.3693752184988, 38162.427563586534, 39874.20251594966, 39935.40096898545, 42059.3691094633, 42139.0, 41666.58333416665, 41900.37149442761, 42206.7889660552, 42214.78892605533, 42281.36577951325, 9477.90522094777, 9625.903740962605, 9641.325107242496, 9646.93883672799, 9657.95171024144, 9533.0, 9602.711918642417, 9668.274879384038, 9672.468014259213, 9728.951355243214, 9635.903640963606, 9674.226061915066, 9683.418994860296, 9690.37012594179, 9692.854607180898, 8265.297449716782, 9600.0, 9637.18083962864, 9671.854922176139, 9685.225181985425, 9572.377795443273, 9612.759681007961, 9620.230381569458, 9634.518274086338, 9645.758856028586, 39531.0, 39783.80108099441, 39804.004899877735, 39926.60073399258, 40119.0, 3550.8224588770718, 3576.946345804815, 3579.1231148368556, 3912.960870391288, 4029.476168098158, 28733.56899646507, 29100.563491547644, 30410.54384184239, 30822.0, 31136.844315778275, 3142.3665236518914, 3215.694509021639, 3304.438245498271, 3429.725621950238, 3450.27544215715, 503486.0, 509690.0, 511537.0, 511651.0, 512045.0, 59048.0, 59499.810003799685, 59512.40487595155, 59566.0, 59580.70209648924, 61700.69149654313, 61928.38071619316, 62192.37807621956, 62410.37589624136, 62569.0, 16527.421540246032, 16632.66734665324, 16741.414050508174, 16752.58118547022, 16809.57976050584, 11577.421128943519, 12908.612741617766, 13072.673183170496, 13144.802827957588, 13150.079494435298, 13200.801987969997, 14007.579772606838, 16568.75146872798, 16572.419965301156, 16702.99782013083, 2894.0738963531467, 3110.6733792951413, 6320.62076275425, 6489.870202595922, 6530.249021362604, 863.6156910175038, 933.1974501928336, 1005.6882366466273, 1056.8309070548828, 1106.0653747583278, 29568.0, 29696.851515742284, 29721.0, 30575.2356191097, 30645.387092258476, 1067.0343339277965, 1077.886821883691, 1083.6369816111692, 1090.3566895531674, 1126.2960649594004, 15281.087481078694, 15438.15090170029, 15491.84508154904, 15551.922240388725, 15856.127912964897, 644208.0, 659594.0, 660313.0, 661829.0, 662655.0, 53346.933061338554, 53572.0, 58210.0, 58233.0, 58745.531361715446, 1324.2716505921896, 1336.9933150334186, 1369.1511263016994, 1404.297851074483, 1410.1750475971671, 29119.417611647226, 29716.405671886874, 29981.0, 30257.394852103276, 30283.0, 49609.25586116139, 49933.50066499434, 49948.75025624849, 50096.99806003787, 50124.498755011984, 595811.0, 596875.0, 598080.0095999492, 599005.0, 599453.0, 26375.73624263733, 26618.733812661627, 26900.192994210203, 26966.73033269642, 27067.864660676572, 45340.967466820315, 45850.31224531568, 45972.770136149105, 46337.53662463467, 46345.0, 28483.718232679166, 31885.883994060096, 35019.64980350164, 37301.62698372982, 38292.0, 31422.52866206963, 32249.51625725663, 36980.63019369772, 37107.628923710414, 38285.808570956964, 34337.0, 34973.60105595748, 37983.0, 38139.80930095332, 38210.42684359681, 33011.504827427125, 33832.66167338295, 34376.48435273523, 34459.0, 34641.0, 23417.41456463602, 25063.122790702237, 25221.873890630428, 25316.0, 25836.224913252634], "value": 19619.515161474243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.836730818245, 381.6736690129941, 394.42020230261505, 399.06618512680325, 413.4707574304889, 13096.41066152023, 16210.918945405256, 16211.894747818847, 18355.174017169225, 20987.370378888638, 16350.672986540261, 17251.482455526355, 17819.376321828706, 20056.197752089898, 20671.86304753238, 4887.266909963499, 5820.330661973874, 6154.938450615504, 6161.0, 6167.444929956303, 5691.231683722686, 6010.0, 6076.3316035236085, 6079.118527813464, 6081.543884208702, 5795.275590551181, 5994.730237139339, 5997.130416089664, 6152.354002829706, 6161.199044124258, 6088.995315772892, 6123.846903827395, 6139.201903752528, 6175.0737389391725, 6193.845153871144, 5900.409959004108, 6034.909476357858, 6045.365236650133, 6089.847753806191, 6110.083487476914, 13224.338783060808, 13438.865611343957, 19406.514837129183, 24453.0, 24553.77231138436, 2148.967765483519, 2220.8001279884725, 2226.343228747507, 2262.8868556572106, 2626.776723978464, 9699.0, 10131.949340253324, 10402.739931501697, 10683.572657093708, 10716.196285278635, 1868.560888191274, 1884.218049509452, 1893.0, 1904.23830467814, 1974.104221530598, 114048.0, 130498.0, 131063.68936310706, 136223.0, 136879.6312036877, 8750.34372422071, 8992.775180620536, 10148.441835698959, 10318.845217321747, 10344.637937672145, 12553.246805191719, 12644.683882903, 12670.873291267153, 12696.6825829355, 12763.234205947672, 8182.4681395709085, 8279.668813247523, 8348.958255208685, 8424.03123640789, 8475.321974242046, 8673.436226645248, 8678.435901666498, 8713.170234250878, 8859.734207973772, 8869.512176830336, 3318.3363327334146, 3954.4463775071513, 4004.7569496061114, 4037.7779222142476, 4057.797110144481, 1689.2736123467027, 1997.4107638246462, 2009.3168322770327, 2026.7365242518674, 2041.7549894012814, 833.0420016980521, 847.6694089305176, 868.9565521723888, 882.4616983639975, 987.9654212102541, 17556.122193890253, 19523.609527809363, 20082.297119600746, 20156.798432015494, 20203.898980505004, 961.6153538584622, 968.1577027985697, 1031.8555402243692, 1055.1242468750918, 1058.6347710040025, 9768.60687022899, 10238.488075596191, 10830.098848506766, 10831.47340845933, 10894.330888932262, 502333.0, 573770.0, 580741.0, 587889.0, 589180.0, 124741.0, 125577.0, 131442.0, 133019.0, 137369.0, 988.851672249154, 1007.2495990487281, 1034.3897100710617, 1036.0934182590233, 1040.9323393979366, 18774.6245075095, 18960.525986849887, 19378.03109844474, 19454.805451945864, 19468.123934423267, 58365.416345836, 58580.12129818142, 58603.0, 58858.41141588529, 60322.0, 84888.0, 86416.0, 87266.0, 88270.0, 88649.55675221582, 5443.237946687546, 5825.0679891217205, 7706.730264440717, 8163.306118979715, 8369.874451883104, 9262.490563019099, 10015.449150296803, 12887.677808054874, 13260.469581216643, 13357.332133393485, 11271.211015229183, 11279.943600281946, 11576.24754390962, 11652.242604230698, 11652.30086194831, 5989.580729349078, 7191.7842464726145, 11354.829677554679, 11372.60195893173, 11654.53381864716, 9220.262379009797, 11573.0, 11690.006349460391, 11953.282803031845, 11983.28100313984, 8358.66565337404, 8422.83154336922, 8477.321814254721, 8588.613512391832, 8620.353473489387, 9472.905270947202, 9591.664291749756, 9771.85342219853, 10975.341479511255, 11703.882961170279], "value": 9347.702124048594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.230986042188, 1550.6976139652766, 1729.792424909011, 1766.7367832000118, 1869.4298239037096, 7717.768466946, 7720.5753683547455, 7948.324392426651, 8587.78530536736, 8626.698065567707, 8078.272955434009, 8354.665813367474, 8390.790230244247, 8503.829923401529, 8550.52972086535, 2185.825133989285, 2218.511927375983, 2220.955580888381, 2227.3986023773573, 2228.353777404551, 2370.6799582056374, 2414.2757172848164, 2417.6857008588945, 2432.720237172721, 2446.4740080882607, 2376.8811559422047, 2380.5952987991996, 2388.152205966883, 2399.892004859777, 2406.95186096278, 2363.61000434928, 2367.7040369953756, 2391.1511413448325, 2391.6771235883193, 2398.292503711409, 1945.7158275538218, 2009.2264478175862, 2321.0947730385165, 2385.1413491143176, 2414.6860908081835, 7086.291370862924, 7255.746048888316, 8466.0, 8524.57377131141, 8573.785655358604, 5015.724135172564, 5250.05499010178, 5259.710715910624, 5266.34170728659, 5301.867453313659, 3247.9188020299443, 3436.1924947637285, 3537.5401197844117, 3586.659267369596, 3604.0, 930.8277968575835, 1039.3959954382042, 1040.47976011994, 1086.223350304536, 1090.3239991205503, 10929.672109836718, 10935.234533582652, 10984.505697243643, 10984.725381865517, 10992.065674417685, 4554.203014472454, 4640.675152739276, 4721.9055618888115, 4731.384919960383, 4816.975915120472, 9593.040695930351, 9605.615775369046, 9619.711408657751, 9630.374025688448, 9717.076877696749, 4988.052270068748, 5285.867853303698, 5300.390455097636, 5313.149896016619, 5357.11607584752, 4237.0466645005245, 4501.257292546758, 4778.689385189951, 4835.758212089381, 4875.561199492063, 3873.9031524211555, 3895.4935858338235, 3955.3078211312904, 3981.462502562117, 4017.4375587417785, 1302.3683513495946, 1303.4069498378215, 1311.4688551136805, 1313.4155300891011, 1325.105553751214, 882.7175303902818, 884.920357167845, 900.9504477253682, 905.5879574793453, 924.6624981881699, 4606.815727370935, 5433.375161856358, 5728.112142617901, 5772.307323121252, 5791.247137872134, 368.32412523020025, 437.269759501633, 449.76612161675746, 457.9542045795394, 461.05023651278475, 3214.5017522284083, 3352.832358382071, 3810.2760475509563, 3935.4687117239378, 3963.58382369847, 9833.852492212622, 10054.798904022025, 10149.238807089498, 10174.491275436347, 10204.183665306758, 9578.377405468622, 9961.302708810459, 10041.196704263788, 10057.69826905194, 10064.245181611263, 6725.159355080713, 7631.3131818136635, 7978.242067003625, 7986.960065199637, 7994.2805147537, 5685.914711279417, 5705.37240903492, 5727.341355744143, 5868.23712917318, 5974.0, 9494.477803720862, 9620.807583848144, 9627.326087173831, 9642.084002019797, 9648.421094734338, 8127.187281271826, 9617.326787125114, 9712.223022158352, 9790.51047447639, 9866.210703143875, 6726.125603671491, 6729.158855143107, 6954.0, 7110.182329032227, 7303.890441643273, 7995.440319177602, 8162.7143049992965, 8163.673453061811, 8166.224208700164, 8190.672373105009, 7164.498485105993, 7271.945567892732, 7344.742933997284, 7410.073740782403, 7434.814129646802, 6030.396960303934, 6241.968790156202, 6958.095447591781, 7104.0, 7130.857382852418, 6771.62756048422, 6787.5588086774205, 6847.93152068473, 6851.143607049119, 6883.174019117738, 4792.95207047939, 4844.612431005582, 4865.9270110947655, 4868.221084626584, 4887.0, 4777.211760059551, 4801.255805350176, 4946.480619534897, 4946.703197808143, 4980.0], "value": 4358.100830693416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.38998932274257, 309.9101260634416, 321.6831421050266, 324.54725657707485, 326.06582142162694, 4491.573300536444, 5236.005159019784, 5495.6702597844105, 5518.19986102015, 5655.971720141399, 5200.699825043739, 5375.731213439332, 5418.448503257273, 5429.864253393667, 5468.855408140315, 3359.496075588669, 4144.0, 4164.437800896878, 4176.728512646683, 4184.560621134783, 3848.26882892251, 4073.5315438724483, 4181.540030596632, 4192.098698779761, 4201.117765269297, 3915.1973845361777, 4048.453458783071, 4056.411820286057, 4058.5389259866574, 4074.5314288856716, 4051.493563304587, 4092.2786347079154, 4097.610726980932, 4107.712460127792, 4145.79271036447, 2776.875365476965, 3134.5298205269164, 3464.9480257796154, 3591.730620203495, 3615.783053016801, 4600.654950878664, 4890.948446084109, 5259.368875734936, 5349.3045904032615, 5360.2227676987, 4679.485256621769, 4702.4592171899985, 4723.905521889577, 4728.69263497875, 4736.342280201936, 5739.540836733051, 5758.48173664368, 5799.768009279624, 5807.332156801937, 5816.651000939957, 2936.2219011961847, 3264.183954011497, 3588.8743893963588, 3876.6511014008875, 3937.8424863005444, 5728.570357223183, 6037.30570984338, 6046.606970546901, 6061.393860613947, 6063.090536419529, 3672.981635091807, 3944.033711740642, 3963.9891827583783, 3964.0684439156776, 3988.4216788566077, 3196.360727854438, 3685.4840322354894, 3977.5226972763453, 3980.805758272507, 4028.436018957348, 3778.0, 3875.5736868944396, 4314.331278651814, 4449.265871131227, 4720.796196969751, 4936.975315123474, 5168.3797944246935, 5273.257905888916, 5696.202531645573, 5720.656760594377, 1115.369816053927, 1187.1333926233724, 1199.9520019199135, 1280.4110109349804, 1289.8968082553374, 782.710397153057, 864.7794812322818, 897.9910200897907, 899.8155378147464, 902.6118768929423, 4648.883777905579, 4728.858134255978, 4759.095771803415, 4864.440589332201, 5172.793088276502, 5004.724740139254, 5461.262729531462, 5555.916661250085, 5558.360788509292, 5591.440855914376, 4128.545859955402, 4625.537446255415, 5181.1969144782615, 5223.555997740159, 5243.973780131075, 2520.911768088108, 2745.546984747534, 2903.8983635572654, 2911.490489164388, 2959.0, 5334.493223143795, 5649.4633009864, 5663.405342438985, 5913.940860591339, 5922.170896074553, 5413.858398325285, 5731.226284451629, 5759.568032397587, 6112.816615501542, 6161.322254551996, 5471.12462006093, 5708.629928817137, 5740.282464691913, 6194.163787888668, 6316.210473690789, 5509.5041446270025, 5979.312379076462, 6007.468095635585, 6030.065339872327, 6031.276246850406, 4668.393108895822, 5216.113260745607, 5919.378465261258, 5929.762809487572, 5970.910436343545, 5007.716858714091, 5766.365699772938, 6226.62640241587, 6299.96850015747, 6321.0, 3216.887408940676, 3934.4295077214215, 3970.404439334123, 4000.579939106352, 4041.0705537727076, 5730.742116604846, 5801.419858014165, 5844.211031510692, 5856.443637854397, 5866.6186697864505, 5720.3707592164, 5857.26784151981, 5860.472557469848, 5870.765169393177, 5892.469677729025, 5618.522425593706, 5710.086386178357, 5787.2187254720075, 5838.912416313674, 5840.977828879844, 5195.337492002523, 5501.587380946525, 5678.943210568007, 5688.720037991418, 5752.391418367059, 4691.695039822401, 4872.756362181947, 5167.6641018333685, 5789.392113828156, 5822.097574875901, 5481.588880833874, 5699.487046165865, 5739.110437882135, 5739.547429941489, 5785.681787501728], "value": 4124.2845570060645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.8682056998886, 703.6270776488462, 720.2365492577865, 765.062798072361, 809.2352726673295, 14796.260186990648, 15146.16696081715, 15538.689226215469, 15565.844341556609, 15592.766108508367, 13942.024058315921, 14118.0, 14227.430902763877, 14236.501722439716, 14246.074005189656, 783.6434422337851, 791.9506653683864, 834.9666013359458, 848.4697064334791, 859.6303589456531, 816.7917181118806, 839.8866153069349, 847.1232274595794, 851.948883067018, 856.2379482260793, 908.2461556907783, 909.727081875438, 911.589784596934, 912.4981260306838, 913.9223166030862, 902.3548163063375, 907.7095329494564, 909.663424532927, 909.7862002429424, 912.3567884641345, 669.4945316286221, 675.1897722732691, 676.8274090107041, 676.8612434450926, 678.9626570538618, 14724.33740481681, 14732.631684207874, 14995.700085998218, 15043.548693539211, 15049.0, 11213.439328033648, 13529.661758456019, 13652.453901843914, 13972.0, 13982.370793314325, 11464.25482343645, 11633.825492617618, 11651.300921944625, 11659.06727461801, 11726.648200553997, 3583.2475180212186, 3674.3386190485703, 3699.2971335446177, 3736.346139425617, 3870.554886188096, 94908.52545737228, 95579.0442095584, 95774.0, 96755.54866677006, 97925.0, 10236.744081398025, 10355.94822025885, 10443.32118412316, 10513.421761803174, 10717.0, 20681.379558612964, 20723.481912951996, 20731.689024664644, 20751.0, 20755.0, 7172.852343624995, 7483.476156668981, 7751.621151478568, 7808.6095695216145, 7987.16134805837, 3839.7120215983914, 4261.978690106592, 4308.913821723548, 4464.598186163261, 4466.218411777926, 3452.2577645806273, 3511.7892926424497, 3553.200529880756, 3562.839672214757, 3582.1044738815294, 555.6666000399728, 637.9393957574023, 643.797203880776, 647.9125318082093, 659.5548005096541, 598.8173607049805, 656.8522082531392, 657.4871600151889, 667.4593579200863, 698.7833771530842, 8083.312918401884, 8935.0, 9170.541472926461, 9335.159835614828, 9429.3399462037, 596.1415561591294, 603.604638961481, 627.8461776864698, 654.8395643067479, 655.7868692674899, 4179.080602267557, 4586.518415566317, 4599.67802253839, 4628.467726211461, 4663.463701674351, 115923.42038289754, 116372.0, 117130.0, 119304.0, 123235.76764232422, 70056.29943700497, 75754.62122689352, 104322.0, 106115.0, 108147.0, 53584.0, 57668.134977975365, 73954.63022684852, 74479.0, 92281.0, 9477.763055923657, 9646.324757267204, 9802.411855288705, 9871.506424678593, 9923.0, 39860.0, 51251.48748512616, 52031.617944833466, 52540.73729631327, 53959.460405395446, 54672.0, 64371.0, 64624.35375646183, 71952.64023679848, 76633.61683191548, 10304.484775761332, 11080.335179889233, 11991.22057066288, 12377.072420945715, 12477.75044499123, 14061.156330620195, 14166.220857852504, 14214.431422742975, 14520.636984075483, 14592.978491505493, 13444.798328024892, 13589.252591107188, 13603.455861765418, 13646.385912633757, 13936.860631393556, 13000.479980800663, 13171.0, 13288.40202190923, 13421.145782958476, 13435.395407206504, 11552.018078463425, 12594.370281485706, 13175.0, 13496.05527613097, 13725.588232353046, 9556.856647150438, 10396.165528661422, 10829.67510974672, 10943.45282735844, 11680.824787628362, 9681.564329605044, 10654.786904261717, 11143.72140696489, 11541.249818761753, 11544.59593914209], "value": 7349.804660038492, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 131.0, 175.0, 158.0, 118.0, 118.0, 118.0, 116.0, 117.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 111.0, 150.0, 118.0, 119.0, 116.0, 137.0, 174.0, 110.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 199.0, 196.0, 201.0, 199.0, 193.0, 201.0, 194.0, 197.0, 191.0], "value": 196.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 85.0, 60.0, 63.0, 63.0, 59.0, 76.0, 59.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 90.0, 79.0, 92.0, 57.0, 109.0, 87.0, 57.0, 73.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 89.0, 87.0, 91.0, 93.0, 91.0, 88.0, 91.0, 79.0], "value": 88.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 143.0, 133.0, 107.0, 113.0, 106.0, 141.0, 150.0, 153.0, 95.0], "value": 124.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 88.0, 131.0, 127.0, 127.0, 147.0, 134.0, 87.0, 91.0], "value": 111.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 57.0, 59.0, 60.0, 60.0, 69.0, 82.0, 80.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 83.0, 109.0, 101.0, 75.0, 69.0, 68.0, 69.0, 68.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 86.0, 89.0, 97.0, 96.0, 102.0, 70.0, 100.0, 103.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 159.0, 154.0, 148.0, 152.0, 145.0, 143.0, 200.0, 145.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 166.0, 172.0, 169.0, 201.0, 172.0, 170.0, 166.0, 165.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 72.0, 67.0, 71.0, 67.0, 66.0, 65.0, 68.0, 60.0], "value": 66.9, "unit": "score"}]}]} 21:05:44 INFO - Return code: 0 21:05:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:05:44 ERROR - # TBPL SUCCESS # 21:05:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:05:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:05:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:05:44 INFO - 2017-02-15 21:05:44.289 screenresolution[1658:10999] starting screenresolution argv=screenresolution get 21:05:44 INFO - 2017-02-15 21:05:44.293 screenresolution[1658:10999] Display 0: 1600x1200x32@60 21:05:44 INFO - 2017-02-15 21:05:44.299 screenresolution[1659:11002] starting screenresolution argv=screenresolution list 21:05:44 INFO - Available Modes on Display 0 21:05:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:05:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:05:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:05:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:05:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:05:44 INFO - Intel Iris: 21:05:44 INFO - Chipset Model: Intel Iris 21:05:44 INFO - Type: GPU 21:05:44 INFO - Bus: Built-In 21:05:44 INFO - VRAM (Dynamic, Max): 1536 MB 21:05:44 INFO - Vendor: Intel (0x8086) 21:05:44 INFO - Device ID: 0x0a2e 21:05:44 INFO - Revision ID: 0x0009 21:05:44 INFO - Displays: 21:05:44 INFO - Display: 21:05:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:05:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:05:44 INFO - Display Serial Number: 1600x1200 60 21:05:44 INFO - Main Display: Yes 21:05:44 INFO - Mirror: Off 21:05:44 INFO - Online: Yes 21:05:44 INFO - Rotation: Supported 21:05:44 INFO - Return code: 0 21:05:44 INFO - Running post-action listener: _resource_record_post_action 21:05:44 INFO - [mozharness: 2017-02-16 05:05:44.541470Z] Finished run-tests step (success) 21:05:44 INFO - Running post-run listener: _resource_record_post_run 21:05:44 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 41801728; Write bytes: 502317056; Read time: 410; Write time: 1698 21:05:44 INFO - TinderboxPrint: CPU usage
54.1% 21:05:44 INFO - TinderboxPrint: I/O read bytes / time
41,801,728 / 410 21:05:44 INFO - TinderboxPrint: I/O write bytes / time
502,317,056 / 1,698 21:05:44 INFO - TinderboxPrint: CPU idle
2,196.2 (45.9%) 21:05:44 INFO - TinderboxPrint: CPU system
966.0 (20.2%) 21:05:44 INFO - TinderboxPrint: CPU user
1,627.5 (34.0%) 21:05:44 INFO - TinderboxPrint: Swap in / out
232,189,952 / 0 21:05:44 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181502464; Write bytes: 174858240; Read time: 16588; Write time: 321 21:05:44 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 40814592; Write bytes: 305858560; Read time: 394; Write time: 1253 21:05:45 INFO - Running post-run listener: _upload_blobber_files 21:05:45 INFO - Blob upload gear active. 21:05:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:05:45 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:05:45 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:05:45 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:05:45 INFO - (blobuploader) - INFO - Open directory for files ... 21:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:05:46 INFO - (blobuploader) - INFO - Done attempting. 21:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:05:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:05:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:05:47 INFO - (blobuploader) - INFO - Done attempting. 21:05:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:05:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:05:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:05:50 INFO - (blobuploader) - INFO - Done attempting. 21:05:50 INFO - (blobuploader) - INFO - Iteration through files over. 21:05:50 INFO - Return code: 0 21:05:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:05:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:05:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfacc14fcd3671df4f61073ec3f6b0bf67b9b57d989da2186a82a8b85c48bd345e3b7600d4cce55cad740f9757b3d757efe06d3f696853fb4707edf56272c268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c91b5915081e7d0f9886ca05fef2680693715c90ad80cee3be144e1a868a868f548b57c5bd4c45f495376986374b9a1a029a4a8d597f4c999b2530d53dfbec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83be5c7c46c52be9d5451ff6b21ee02ea22811cf2f6c6b8105fae3c3c61e957e3a5b1b25e18b9791ce048c4d239e5053abfc2341716d5ec0ea41075ed17d7f32"} 21:05:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:05:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:05:50 INFO - Contents: 21:05:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfacc14fcd3671df4f61073ec3f6b0bf67b9b57d989da2186a82a8b85c48bd345e3b7600d4cce55cad740f9757b3d757efe06d3f696853fb4707edf56272c268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c91b5915081e7d0f9886ca05fef2680693715c90ad80cee3be144e1a868a868f548b57c5bd4c45f495376986374b9a1a029a4a8d597f4c999b2530d53dfbec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83be5c7c46c52be9d5451ff6b21ee02ea22811cf2f6c6b8105fae3c3c61e957e3a5b1b25e18b9791ce048c4d239e5053abfc2341716d5ec0ea41075ed17d7f32"} 21:05:50 INFO - Running post-run listener: copy_logs_to_upload_dir 21:05:50 INFO - Copying logs to upload dir... 21:05:50 INFO - mkdir: /builds/slave/test/build/upload/logs 21:05:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.806050 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-15 21:05:50.392738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 21:05:50.396860) ========= 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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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/bfacc14fcd3671df4f61073ec3f6b0bf67b9b57d989da2186a82a8b85c48bd345e3b7600d4cce55cad740f9757b3d757efe06d3f696853fb4707edf56272c268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c91b5915081e7d0f9886ca05fef2680693715c90ad80cee3be144e1a868a868f548b57c5bd4c45f495376986374b9a1a029a4a8d597f4c999b2530d53dfbec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83be5c7c46c52be9d5451ff6b21ee02ea22811cf2f6c6b8105fae3c3c61e957e3a5b1b25e18b9791ce048c4d239e5053abfc2341716d5ec0ea41075ed17d7f32"} build_url:https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010735 build_url: 'https://queue.taskcluster.net/v1/task/S1cv2nXKQ2e7f2fXUZpyjQ/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/bfacc14fcd3671df4f61073ec3f6b0bf67b9b57d989da2186a82a8b85c48bd345e3b7600d4cce55cad740f9757b3d757efe06d3f696853fb4707edf56272c268", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c91b5915081e7d0f9886ca05fef2680693715c90ad80cee3be144e1a868a868f548b57c5bd4c45f495376986374b9a1a029a4a8d597f4c999b2530d53dfbec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83be5c7c46c52be9d5451ff6b21ee02ea22811cf2f6c6b8105fae3c3c61e957e3a5b1b25e18b9791ce048c4d239e5053abfc2341716d5ec0ea41075ed17d7f32"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 21:05:50.438256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 21:05:50.438823) ========= 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.DFHR4yeW7S/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.FkM7lmMLa8/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.004855 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 21:05:50.489530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 21:05:50.489860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 21:05:50.490179) ========= ========= Total master_lag: 0.20 =========