builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1487009559.31 results: success (0) buildid: 20170213070939 builduid: b508a4afe1b444679e720e34d43554d3 revision: 7b8aa893944b94d35e47314e52e0abff576c5ce2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.315213) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.315673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.315942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.340782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.341212) ========= 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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-13 10:12:39-- 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% 161M=0s 2017-02-13 10:12:39 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.452151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.455518) ========= 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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.020438 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:39.504140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 10:12:39.507548) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7b8aa893944b94d35e47314e52e0abff576c5ce2 --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 7b8aa893944b94d35e47314e52e0abff576c5ce2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UlEtZyUkTq/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.zdnWyOs0FU/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-13 10:12:39,590 truncating revision to first 12 chars 2017-02-13 10:12:39,590 Setting DEBUG logging. 2017-02-13 10:12:39,590 attempt 1/10 2017-02-13 10:12:39,590 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7b8aa893944b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 10:12:40,705 unpacking tar archive at: mozilla-beta-7b8aa893944b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.391170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 10:12:40.922182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:40.925532) ========= script_repo_revision: 7b8aa893944b94d35e47314e52e0abff576c5ce2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:40.925924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:40.926185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 10:12:40.945869) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-13 10:12:40.946247) ========= /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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:12:41 INFO - MultiFileLogger online at 20170213 10:12:41 in /builds/slave/test 10:12:41 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 10:12:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:41 INFO - {'append_to_log': False, 10:12:41 INFO - 'base_work_dir': '/builds/slave/test', 10:12:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:12:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:41 INFO - 'branch': 'Mozilla-Beta', 10:12:41 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:41 INFO - 'config_files': ('talos/mac_config.py',), 10:12:41 INFO - 'default_actions': ('clobber', 10:12:41 INFO - 'read-buildbot-config', 10:12:41 INFO - 'download-and-extract', 10:12:41 INFO - 'populate-webroot', 10:12:41 INFO - 'create-virtualenv', 10:12:41 INFO - 'install', 10:12:41 INFO - 'run-tests'), 10:12:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:41 INFO - 'download_minidump_stackwalk': True, 10:12:41 INFO - 'download_symbols': 'ondemand', 10:12:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:41 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:41 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:41 INFO - 'installer_path': 'installer.exe', 10:12:41 INFO - 'log_level': 'info', 10:12:41 INFO - 'log_name': 'talos', 10:12:41 INFO - 'log_to_console': True, 10:12:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:12:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:12:41 INFO - 'opt_config_files': (), 10:12:41 INFO - 'pip_index': False, 10:12:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:41 INFO - 'cmd': ('bash', 10:12:41 INFO - '-c', 10:12:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:41 INFO - 'enabled': True, 10:12:41 INFO - 'halt_on_failure': False, 10:12:41 INFO - 'name': 'check_screen_resolution'},), 10:12:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:41 INFO - 'cmd': ('bash', 10:12:41 INFO - '-c', 10:12:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:41 INFO - 'enabled': True, 10:12:41 INFO - 'halt_on_failure': False, 10:12:41 INFO - 'name': 'check_screen_resolution'},), 10:12:41 INFO - 'run_cmd_checks_enabled': True, 10:12:41 INFO - 'sps_profile': False, 10:12:41 INFO - 'sps_profile_interval': 0, 10:12:41 INFO - 'suite': 'dromaeojs-e10s', 10:12:41 INFO - 'system_bits': '32', 10:12:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:41 INFO - 'title': 't-yosemite-r7-0073', 10:12:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:41 INFO - 'use_talos_json': True, 10:12:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:41 INFO - 'work_dir': 'build'} 10:12:41 INFO - [mozharness: 2017-02-13 18:12:41.157854Z] Running clobber step. 10:12:41 INFO - Running pre-action listener: _resource_record_pre_action 10:12:41 INFO - Running main action method: clobber 10:12:41 INFO - rmtree: /builds/slave/test/build 10:12:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:44 INFO - Running post-action listener: _resource_record_post_action 10:12:44 INFO - [mozharness: 2017-02-13 18:12:44.545147Z] Finished clobber step (success) 10:12:44 INFO - [mozharness: 2017-02-13 18:12:44.545227Z] Running read-buildbot-config step. 10:12:44 INFO - Running pre-action listener: _resource_record_pre_action 10:12:44 INFO - Running main action method: read_buildbot_config 10:12:44 INFO - Using buildbot properties: 10:12:44 INFO - { 10:12:44 INFO - "project": "", 10:12:44 INFO - "product": "firefox", 10:12:44 INFO - "script_repo_revision": "production", 10:12:44 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:12:44 INFO - "repository": "", 10:12:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:12:44 INFO - "buildid": "20170213070939", 10:12:44 INFO - "pgo_build": "False", 10:12:44 INFO - "basedir": "/builds/slave/test", 10:12:44 INFO - "buildnumber": 14, 10:12:44 INFO - "slavename": "t-yosemite-r7-0073", 10:12:44 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:12:44 INFO - "platform": "yosemite_r7", 10:12:44 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:12:44 INFO - "branch": "mozilla-beta", 10:12:44 INFO - "repo_path": "releases/mozilla-beta", 10:12:44 INFO - "revision": "7b8aa893944b94d35e47314e52e0abff576c5ce2", 10:12:44 INFO - "stage_platform": "macosx64", 10:12:44 INFO - "builduid": "b508a4afe1b444679e720e34d43554d3", 10:12:44 INFO - "slavebuilddir": "test" 10:12:44 INFO - } 10:12:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 10:12:44 INFO - Running post-action listener: _resource_record_post_action 10:12:44 INFO - [mozharness: 2017-02-13 18:12:44.549839Z] Finished read-buildbot-config step (success) 10:12:44 INFO - [mozharness: 2017-02-13 18:12:44.550011Z] Running download-and-extract step. 10:12:44 INFO - Running pre-action listener: _resource_record_pre_action 10:12:44 INFO - Running main action method: download_and_extract 10:12:44 INFO - mkdir: /builds/slave/test/build/tests 10:12: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')]} 10:12:44 INFO - trying https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 10:12:44 INFO - Downloading https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/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 10:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/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 10:12:46 INFO - Downloaded 1165 bytes. 10:12:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:12:46 INFO - Using the following test package requirements: 10:12:46 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:12:46 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:12:46 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 10:12:46 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:12:46 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 10:12:46 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:12:46 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:12:46 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 10:12:46 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:12:46 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:12:46 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 10:12:46 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:12:46 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 10:12:46 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:12:46 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 10:12:46 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:12:46 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 10:12:46 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 10:12:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:12:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:12:46 INFO - Fetch https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:12:46 INFO - Http code: 200 10:12:46 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 10:12:46 INFO - x-amz-cf-id: C7po5Jw0U81z6336bqHbf1TO_9QRFJ1t7h9NtT70X5cNGyUJl0jIug== 10:12:46 INFO - x-amz-version-id: KnjGlxpcrwakuhr9KuMZRc6pEIkq8Aki 10:12:46 INFO - Expected file size: 16094117 10:12:46 INFO - Obtained file size: 16094117 10:12:53 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 10:12:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:12:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:12:53 INFO - Fetch https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:12:54 INFO - Http code: 200 10:12:54 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 10:12:54 INFO - x-amz-cf-id: qx_ygn018amgZtoI2mjKQIhCwlqwfS-FDvSuO327-uRrU1EUxSKElQ== 10:12:54 INFO - x-amz-version-id: KnjGlxpcrwakuhr9KuMZRc6pEIkq8Aki 10:12:54 INFO - Expected file size: 16094117 10:12:54 INFO - Obtained file size: 16094117 10:13:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 10:13:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 10:13:00 INFO - Fetch https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 10:13:01 INFO - Http code: 200 10:13:01 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 10:13:01 INFO - x-amz-cf-id: kJYBC75121amMmw49RRPMoYlao8wZd7OvzAXZpPeA4nY3D5k2aU2_A== 10:13:01 INFO - x-amz-version-id: fJDxjLBD4_UgmdLw5Y6kMJ9MIqRNArH4 10:13:01 INFO - Expected file size: 14403005 10:13:01 INFO - Obtained file size: 14403005 10:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:02 INFO - trying https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:13:02 INFO - Downloading https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 10:13:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/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 10:13:04 INFO - Downloaded 82134931 bytes. 10:13:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:13:04 INFO - mkdir: /builds/slave/test/properties 10:13:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:04 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:04 INFO - Contents: 10:13:04 INFO - build_url:https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:13:04 INFO - Running post-action listener: _resource_record_post_action 10:13:04 INFO - Running post-action listener: set_extra_try_arguments 10:13:04 INFO - [mozharness: 2017-02-13 18:13:04.955192Z] Finished download-and-extract step (success) 10:13:04 INFO - [mozharness: 2017-02-13 18:13:04.955357Z] Running populate-webroot step. 10:13:04 INFO - Running pre-action listener: _resource_record_pre_action 10:13:04 INFO - Running main action method: populate_webroot 10:13:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:04 INFO - '--tppagecycles', 10:13:04 INFO - '7'], 10:13:04 INFO - 'tests': ['tsvgm']}}, 10:13:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['damp', 'tps']}, 10:13:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'tests': ['damp', 'tps']}, 10:13:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['dromaeo_dom']}, 10:13:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['basic_compositor_video']}, 10:13:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:13:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['a11yr', 10:13:04 INFO - 'ts_paint', 10:13:04 INFO - 'tpaint', 10:13:04 INFO - 'sessionrestore', 10:13:04 INFO - 'sessionrestore_no_auto_restore', 10:13:04 INFO - 'tabpaint']}, 10:13:04 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:04 INFO - 'ts_paint', 10:13:04 INFO - 'tpaint', 10:13:04 INFO - 'sessionrestore', 10:13:04 INFO - 'sessionrestore_no_auto_restore', 10:13:04 INFO - 'tabpaint']}, 10:13:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:04 INFO - 'ts_paint', 10:13:04 INFO - 'tpaint', 10:13:04 INFO - 'sessionrestore', 10:13:04 INFO - 'sessionrestore_no_auto_restore', 10:13:04 INFO - 'tabpaint']}, 10:13:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:04 INFO - 'ts_paint', 10:13:04 INFO - 'tpaint', 10:13:04 INFO - 'sessionrestore', 10:13:04 INFO - 'sessionrestore_no_auto_restore', 10:13:04 INFO - 'tabpaint']}, 10:13:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['a11yr', 10:13:04 INFO - 'ts_paint', 10:13:04 INFO - 'tpaint', 10:13:04 INFO - 'sessionrestore', 10:13:04 INFO - 'sessionrestore_no_auto_restore', 10:13:04 INFO - 'tabpaint']}, 10:13:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['a11yr', 10:13:04 INFO - 'ts_paint', 10:13:04 INFO - 'tpaint', 10:13:04 INFO - 'sessionrestore', 10:13:04 INFO - 'sessionrestore_no_auto_restore', 10:13:04 INFO - 'tabpaint']}, 10:13:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['tsvgx', 10:13:04 INFO - 'tsvgr_opacity', 10:13:04 INFO - 'tart', 10:13:04 INFO - 'tscrollx', 10:13:04 INFO - 'cart']}, 10:13:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:04 INFO - 'tsvgr_opacity', 10:13:04 INFO - 'tart', 10:13:04 INFO - 'tscrollx', 10:13:04 INFO - 'cart']}, 10:13:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'talos_options': ['--disable-e10s'], 10:13:04 INFO - 'tests': ['tp5o']}, 10:13:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'tests': ['tp5o']}, 10:13:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'talos_options': ['--disable-e10s', 10:13:04 INFO - '--xperf_path', 10:13:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:04 INFO - 'tests': ['tp5n']}, 10:13:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:04 INFO - 'talos_options': ['--xperf_path', 10:13:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:04 INFO - 'tests': ['tp5n']}}, 10:13:04 INFO - 'talos.zip': {'path': '', 10:13:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:04 INFO - Running post-action listener: _resource_record_post_action 10:13:04 INFO - [mozharness: 2017-02-13 18:13:04.974089Z] Finished populate-webroot step (success) 10:13:04 INFO - [mozharness: 2017-02-13 18:13:04.974200Z] Running create-virtualenv step. 10:13:04 INFO - Running pre-action listener: _resource_record_pre_action 10:13:04 INFO - Running main action method: create_virtualenv 10:13:04 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:04 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 10:13:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:05 INFO - Using real prefix '/tools/python27' 10:13:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:05 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:08 INFO - Installing pip.................done. 10:13:08 INFO - Return code: 0 10:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:13:08 INFO - Reading from file tmpfile_stdout 10:13:08 INFO - Output received: 10:13:08 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) 10:13:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:08 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:08 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 10:13:08 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 10:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:08 INFO - 'HOME': '/Users/cltbld', 10:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:08 INFO - 'LOGNAME': 'cltbld', 10:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:08 INFO - 'MOZ_NO_REMOTE': '1', 10:13:08 INFO - 'NO_EM_RESTART': '1', 10:13:08 INFO - 'PAGER': '/bin/cat', 10:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:08 INFO - 'PWD': '/builds/slave/test', 10:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:08 INFO - 'SHELL': '/bin/bash', 10:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:08 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:08 INFO - 'USER': 'cltbld', 10:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:08 INFO - 'XPC_FLAGS': '0x0', 10:13:08 INFO - 'XPC_SERVICE_NAME': '0', 10:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:09 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 10:13:09 INFO - Cleaning up... 10:13:09 INFO - Return code: 0 10:13:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:13:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:09 INFO - 'HOME': '/Users/cltbld', 10:13:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:09 INFO - 'LOGNAME': 'cltbld', 10:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:09 INFO - 'MOZ_NO_REMOTE': '1', 10:13:09 INFO - 'NO_EM_RESTART': '1', 10:13:09 INFO - 'PAGER': '/bin/cat', 10:13:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:09 INFO - 'PWD': '/builds/slave/test', 10:13:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:09 INFO - 'SHELL': '/bin/bash', 10:13:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:09 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:09 INFO - 'USER': 'cltbld', 10:13:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:09 INFO - 'XPC_FLAGS': '0x0', 10:13:09 INFO - 'XPC_SERVICE_NAME': '0', 10:13:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:09 INFO - Downloading/unpacking psutil>=3.1.1 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:13 INFO - Installing collected packages: psutil 10:13:13 INFO - Running setup.py install for psutil 10:13:13 INFO - building 'psutil._psutil_osx' extension 10:13:13 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 10:13:13 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 10:13:13 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 10:13:13 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 10:13:13 INFO - building 'psutil._psutil_posix' extension 10:13:13 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 10:13:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:13:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:13:13 INFO - ^ 10:13:13 INFO - 1 warning generated. 10:13:13 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 10:13:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:13 INFO - Successfully installed psutil 10:13:13 INFO - Cleaning up... 10:13:13 INFO - Return code: 0 10:13:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:13 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')]} 10:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:13 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')]} 10:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:13 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:13 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 10:13:13 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 10:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:13 INFO - 'HOME': '/Users/cltbld', 10:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:13 INFO - 'LOGNAME': 'cltbld', 10:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:13 INFO - 'MOZ_NO_REMOTE': '1', 10:13:13 INFO - 'NO_EM_RESTART': '1', 10:13:13 INFO - 'PAGER': '/bin/cat', 10:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:13 INFO - 'PWD': '/builds/slave/test', 10:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:13 INFO - 'SHELL': '/bin/bash', 10:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:13 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:13 INFO - 'USER': 'cltbld', 10:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:13 INFO - 'XPC_FLAGS': '0x0', 10:13:13 INFO - 'XPC_SERVICE_NAME': '0', 10:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:16 INFO - Installing collected packages: mozsystemmonitor 10:13:16 INFO - Running setup.py install for mozsystemmonitor 10:13:17 INFO - Successfully installed mozsystemmonitor 10:13:17 INFO - Cleaning up... 10:13:17 INFO - Return code: 0 10:13:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:17 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:17 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 10:13:17 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 10:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:17 INFO - 'HOME': '/Users/cltbld', 10:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:17 INFO - 'LOGNAME': 'cltbld', 10:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:17 INFO - 'MOZ_NO_REMOTE': '1', 10:13:17 INFO - 'NO_EM_RESTART': '1', 10:13:17 INFO - 'PAGER': '/bin/cat', 10:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:17 INFO - 'PWD': '/builds/slave/test', 10:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:17 INFO - 'SHELL': '/bin/bash', 10:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:17 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:17 INFO - 'USER': 'cltbld', 10:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:17 INFO - 'XPC_FLAGS': '0x0', 10:13:17 INFO - 'XPC_SERVICE_NAME': '0', 10:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:17 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:13:19 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 10:13:19 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 10:13:19 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 10:13:19 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 10:13:19 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 10:13:19 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 10:13:20 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:20 INFO - warning: no files found matching '*.txt' 10:13:20 INFO - no previously-included directories found matching 'build' 10:13:20 INFO - no previously-included directories found matching 'dist' 10:13:20 INFO - no previously-included directories found matching '.git*' 10:13:20 INFO - Installing collected packages: jsonschema, functools32 10:13:20 INFO - Running setup.py install for functools32 10:13:20 INFO - warning: no files found matching '*.txt' 10:13:20 INFO - no previously-included directories found matching 'build' 10:13:20 INFO - no previously-included directories found matching 'dist' 10:13:20 INFO - no previously-included directories found matching '.git*' 10:13:20 INFO - Successfully installed jsonschema functools32 10:13:20 INFO - Cleaning up... 10:13:20 INFO - Return code: 0 10:13:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:13:20 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')]} 10:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 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')]} 10:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:20 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 10:13:20 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 10:13:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:20 INFO - 'HOME': '/Users/cltbld', 10:13:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:20 INFO - 'LOGNAME': 'cltbld', 10:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:20 INFO - 'MOZ_NO_REMOTE': '1', 10:13:20 INFO - 'NO_EM_RESTART': '1', 10:13:20 INFO - 'PAGER': '/bin/cat', 10:13:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:20 INFO - 'PWD': '/builds/slave/test', 10:13:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:20 INFO - 'SHELL': '/bin/bash', 10:13:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:20 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:20 INFO - 'USER': 'cltbld', 10:13:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:20 INFO - 'XPC_FLAGS': '0x0', 10:13:20 INFO - 'XPC_SERVICE_NAME': '0', 10:13:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:13:20 INFO - Cleaning up... 10:13:20 INFO - Return code: 0 10:13:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:20 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')]} 10:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 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')]} 10:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:20 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 10:13:20 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 10:13:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:20 INFO - 'HOME': '/Users/cltbld', 10:13:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:20 INFO - 'LOGNAME': 'cltbld', 10:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:20 INFO - 'MOZ_NO_REMOTE': '1', 10:13:20 INFO - 'NO_EM_RESTART': '1', 10:13:20 INFO - 'PAGER': '/bin/cat', 10:13:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:20 INFO - 'PWD': '/builds/slave/test', 10:13:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:20 INFO - 'SHELL': '/bin/bash', 10:13:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:20 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:20 INFO - 'USER': 'cltbld', 10:13:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:20 INFO - 'XPC_FLAGS': '0x0', 10:13:20 INFO - 'XPC_SERVICE_NAME': '0', 10:13:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:21 INFO - Downloading/unpacking blobuploader==1.2.4 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:23 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:23 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 10:13:23 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 10:13:23 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 10:13:23 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 10:13:23 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 10:13:23 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 10:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:25 INFO - Downloading docopt-0.6.1.tar.gz 10:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:25 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:25 INFO - Running setup.py install for blobuploader 10:13:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:25 INFO - Running setup.py install for requests 10:13:25 INFO - Running setup.py install for docopt 10:13:25 INFO - Successfully installed blobuploader requests docopt 10:13:25 INFO - Cleaning up... 10:13:26 INFO - Return code: 0 10:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:26 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:26 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 10:13:26 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 10:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:26 INFO - 'HOME': '/Users/cltbld', 10:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:26 INFO - 'LOGNAME': 'cltbld', 10:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:26 INFO - 'MOZ_NO_REMOTE': '1', 10:13:26 INFO - 'NO_EM_RESTART': '1', 10:13:26 INFO - 'PAGER': '/bin/cat', 10:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:26 INFO - 'PWD': '/builds/slave/test', 10:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:26 INFO - 'SHELL': '/bin/bash', 10:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:26 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:26 INFO - 'USER': 'cltbld', 10:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:26 INFO - 'XPC_FLAGS': '0x0', 10:13:26 INFO - 'XPC_SERVICE_NAME': '0', 10:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-3uuogK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5Rqnuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lcvGdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-g87RuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-4mY8vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-AZ7dhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-KKS0Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MicW3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-JhhPHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-dxxACt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-yBMPm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-SuMJVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-bsHKm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-XPAAzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-VWCEej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-fHmj1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:27 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-udTeVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:28 INFO - Running setup.py install for manifestparser 10:13:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:28 INFO - Running setup.py install for mozcrash 10:13:28 INFO - Running setup.py install for mozdebug 10:13:28 INFO - Running setup.py install for mozdevice 10:13:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:28 INFO - Running setup.py install for mozfile 10:13:28 INFO - Running setup.py install for mozhttpd 10:13:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:28 INFO - Running setup.py install for mozinfo 10:13:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:29 INFO - Running setup.py install for mozInstall 10:13:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:29 INFO - Running setup.py install for mozleak 10:13:29 INFO - Running setup.py install for mozlog 10:13:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:29 INFO - Running setup.py install for moznetwork 10:13:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:29 INFO - Running setup.py install for mozprocess 10:13:29 INFO - Running setup.py install for mozprofile 10:13:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Running setup.py install for mozrunner 10:13:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Running setup.py install for mozscreenshot 10:13:30 INFO - Running setup.py install for moztest 10:13:30 INFO - Running setup.py install for mozversion 10:13:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:30 INFO - Cleaning up... 10:13:30 INFO - Return code: 0 10:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:30 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:30 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 10:13:30 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 10:13:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:30 INFO - 'HOME': '/Users/cltbld', 10:13:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:30 INFO - 'LOGNAME': 'cltbld', 10:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:30 INFO - 'MOZ_NO_REMOTE': '1', 10:13:30 INFO - 'NO_EM_RESTART': '1', 10:13:30 INFO - 'PAGER': '/bin/cat', 10:13:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:30 INFO - 'PWD': '/builds/slave/test', 10:13:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:30 INFO - 'SHELL': '/bin/bash', 10:13:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:30 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:30 INFO - 'USER': 'cltbld', 10:13:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:30 INFO - 'XPC_FLAGS': '0x0', 10:13:30 INFO - 'XPC_SERVICE_NAME': '0', 10:13:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-rPmx2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-sufW8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-vhwLYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6kILOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-CZA_yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-rbQKEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-T3PPSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-b6Eaxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-TKKZaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:31 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)) 10:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-gEqTWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:32 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)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-KsX2qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:32 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)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-kFVqYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:32 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)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-S7Jkzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:32 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)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pf3cEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:32 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)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-buAISN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:32 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)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-9_SUly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:32 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)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:32 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ZlIeWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 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)) 10:13:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:35 INFO - Downloading blessings-1.6.tar.gz 10:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:35 INFO - Installing collected packages: blessings 10:13:35 INFO - Running setup.py install for blessings 10:13:35 INFO - Successfully installed blessings 10:13:35 INFO - Cleaning up... 10:13:35 INFO - Return code: 0 10:13:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:36 INFO - Reading from file tmpfile_stdout 10:13:36 INFO - Current package versions: 10:13:36 INFO - blessings == 1.6 10:13:36 INFO - blobuploader == 1.2.4 10:13:36 INFO - docopt == 0.6.1 10:13:36 INFO - functools32 == 3.2.3-2 10:13:36 INFO - jsonschema == 2.5.1 10:13:36 INFO - manifestparser == 1.1 10:13:36 INFO - mozInstall == 1.12 10:13:36 INFO - mozcrash == 1.0 10:13:36 INFO - mozdebug == 0.1 10:13:36 INFO - mozdevice == 0.48 10:13:36 INFO - mozfile == 1.2 10:13:36 INFO - mozhttpd == 0.7 10:13:36 INFO - mozinfo == 0.9 10:13:36 INFO - mozleak == 0.1 10:13:36 INFO - mozlog == 3.4 10:13:36 INFO - moznetwork == 0.27 10:13:36 INFO - mozprocess == 0.23 10:13:36 INFO - mozprofile == 0.28 10:13:36 INFO - mozrunner == 6.13 10:13:36 INFO - mozscreenshot == 0.1 10:13:36 INFO - mozsystemmonitor == 0.3 10:13:36 INFO - moztest == 0.8 10:13:36 INFO - mozversion == 1.4 10:13:36 INFO - psutil == 3.1.1 10:13:36 INFO - requests == 1.2.3 10:13:36 INFO - wsgiref == 0.1.2 10:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:36 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')]} 10:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 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')]} 10:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:36 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 10:13:36 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 10:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:36 INFO - 'HOME': '/Users/cltbld', 10:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:36 INFO - 'LOGNAME': 'cltbld', 10:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:36 INFO - 'MOZ_NO_REMOTE': '1', 10:13:36 INFO - 'NO_EM_RESTART': '1', 10:13:36 INFO - 'PAGER': '/bin/cat', 10:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:36 INFO - 'PWD': '/builds/slave/test', 10:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:36 INFO - 'SHELL': '/bin/bash', 10:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:36 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:36 INFO - 'USER': 'cltbld', 10:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:36 INFO - 'XPC_FLAGS': '0x0', 10:13:36 INFO - 'XPC_SERVICE_NAME': '0', 10:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 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)) 10:13:36 INFO - Cleaning up... 10:13:36 INFO - Return code: 0 10:13:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:36 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')]} 10:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 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')]} 10:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:37 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 0x10a12d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec15bae50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, '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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 10:13:37 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 10:13:37 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 10:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:37 INFO - 'HOME': '/Users/cltbld', 10:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:37 INFO - 'LOGNAME': 'cltbld', 10:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:37 INFO - 'MOZ_NO_REMOTE': '1', 10:13:37 INFO - 'NO_EM_RESTART': '1', 10:13:37 INFO - 'PAGER': '/bin/cat', 10:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:37 INFO - 'PWD': '/builds/slave/test', 10:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:37 INFO - 'SHELL': '/bin/bash', 10:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:37 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:37 INFO - 'USER': 'cltbld', 10:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:37 INFO - 'XPC_FLAGS': '0x0', 10:13:37 INFO - 'XPC_SERVICE_NAME': '0', 10:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:13:37 INFO - Cleaning up... 10:13:37 INFO - Return code: 0 10:13:37 INFO - Running post-action listener: _resource_record_post_action 10:13:37 INFO - Running post-action listener: _start_resource_monitoring 10:13:37 INFO - Starting resource monitoring. 10:13:37 INFO - [mozharness: 2017-02-13 18:13:37.333451Z] Finished create-virtualenv step (success) 10:13:37 INFO - [mozharness: 2017-02-13 18:13:37.334444Z] Running install step. 10:13:37 INFO - Running pre-action listener: _resource_record_pre_action 10:13:37 INFO - Running main action method: install 10:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:37 INFO - Reading from file tmpfile_stdout 10:13:37 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:37 INFO - Reading from file tmpfile_stdout 10:13:37 INFO - Output received: 10:13:37 INFO - Usage: mozinstall [options] installer 10:13:37 INFO - Options: 10:13:37 INFO - -h, --help show this help message and exit 10:13:37 INFO - -d DEST, --destination=DEST 10:13:37 INFO - Directory to install application into. [default: 10:13:37 INFO - "/builds/slave/test"] 10:13:37 INFO - --app=APP Application being installed. [default: firefox] 10:13:37 INFO - mkdir: /builds/slave/test/build/application 10:13:37 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'] 10:13:37 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 10:13:59 INFO - Reading from file tmpfile_stdout 10:13:59 INFO - Output received: 10:13:59 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:13:59 INFO - Running post-action listener: _resource_record_post_action 10:13:59 INFO - [mozharness: 2017-02-13 18:13:59.020496Z] Finished install step (success) 10:13:59 INFO - [mozharness: 2017-02-13 18:13:59.020661Z] Running run-tests step. 10:13:59 INFO - Running pre-action listener: _resource_record_pre_action 10:13:59 INFO - Running main action method: run_tests 10:13:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:13:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:13:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:13:59 INFO - 2017-02-13 10:13:59.035 screenresolution[1963:10572] starting screenresolution argv=screenresolution get 10:13:59 INFO - 2017-02-13 10:13:59.038 screenresolution[1963:10572] Display 0: 1600x1200x32@60 10:13:59 INFO - 2017-02-13 10:13:59.044 screenresolution[1964:10574] starting screenresolution argv=screenresolution list 10:13:59 INFO - Available Modes on Display 0 10:13:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:13:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:13:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:13:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:13:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:13:59 INFO - Intel Iris: 10:13:59 INFO - Chipset Model: Intel Iris 10:13:59 INFO - Type: GPU 10:13:59 INFO - Bus: Built-In 10:13:59 INFO - VRAM (Dynamic, Max): 1536 MB 10:13:59 INFO - Vendor: Intel (0x8086) 10:13:59 INFO - Device ID: 0x0a2e 10:13:59 INFO - Revision ID: 0x0009 10:13:59 INFO - Displays: 10:13:59 INFO - Display: 10:13:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:13:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:13:59 INFO - Display Serial Number: 1600x1200 60 10:13:59 INFO - Main Display: Yes 10:13:59 INFO - Mirror: Off 10:13:59 INFO - Online: Yes 10:13:59 INFO - Rotation: Supported 10:13:59 INFO - Return code: 0 10:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:59 INFO - Python 2.7.3 10:13:59 INFO - Return code: 0 10:13:59 INFO - grabbing minidump binary from tooltool 10:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f41d30>, '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 0x109da7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f39b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:13:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:13:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:13:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:59 INFO - Return code: 0 10:13:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:13:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:13:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:59 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/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 10:13:59 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/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --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 10:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UlEtZyUkTq/Render', 10:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:59 INFO - 'HOME': '/Users/cltbld', 10:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:59 INFO - 'LOGNAME': 'cltbld', 10:13:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:59 INFO - 'MOZ_NO_REMOTE': '1', 10:13:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:59 INFO - 'NO_EM_RESTART': '1', 10:13:59 INFO - 'PAGER': '/bin/cat', 10:13:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:59 INFO - 'PWD': '/builds/slave/test', 10:13:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:59 INFO - 'SHELL': '/bin/bash', 10:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zdnWyOs0FU/Listeners', 10:13:59 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 10:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:59 INFO - 'USER': 'cltbld', 10:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:59 INFO - 'XPC_FLAGS': '0x0', 10:13:59 INFO - 'XPC_SERVICE_NAME': '0', 10:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:59 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/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 10:13:59 INFO - mozversion application_buildid: 20170213070939 10:13:59 INFO - mozversion application_changeset: 7b8aa893944b94d35e47314e52e0abff576c5ce2 10:13:59 INFO - mozversion application_display_name: Firefox 10:13:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:59 INFO - mozversion application_name: Firefox 10:13:59 INFO - mozversion application_remotingname: firefox 10:13:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:59 INFO - mozversion application_vendor: Mozilla 10:13:59 INFO - mozversion application_version: 52.0 10:13:59 INFO - mozversion platform_buildid: 20170213070939 10:13:59 INFO - mozversion platform_changeset: 7b8aa893944b94d35e47314e52e0abff576c5ce2 10:13:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:59 INFO - mozversion platform_version: 52.0 10:13:59 INFO - using testdate: 1487009639 10:13:59 INFO - actual date: 1487009639 10:13:59 INFO - starting webserver on 'localhost:49350' 10:13:59 INFO - SUITE-START | Running 2 tests 10:13:59 INFO - TEST-START | dromaeo_css 10:13:59 INFO - operating with platform_type : mac_ 10:13:59 INFO - Initialising browser for dromaeo_css test... 10:13:59 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpB__fkD/profile http://localhost:49350/getInfo.html) 10:14:02 INFO - PROCESS | 1974 | 2017-02-13 10:14:02.767 plugin-container[1977:10746] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 10:14:02 INFO - PROCESS | 1974 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:14:02 INFO - PROCESS | 1974 | 2017-02-13 10:14:02.767 plugin-container[1977:10746] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3b, name = 'com.apple.CFPasteboardClient' 10:14:02 INFO - PROCESS | 1974 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:14:02 INFO - PROCESS | 1974 | 2017-02-13 10:14:02.767 plugin-container[1977:10746] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:14:02 INFO - PROCESS | 1974 | __metrics Screen width/height:1600/1200 10:14:02 INFO - PROCESS | 1974 | colorDepth:24 10:14:02 INFO - PROCESS | 1974 | Browser inner width/height: 1024/689 10:14:02 INFO - PROCESS | 1974 | __metrics 10:14:02 ERROR - PROCESS | 1974 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:14:03 INFO - TEST-INFO | 1974: exit 0 10:14:03 INFO - Browser initialized. 10:14:03 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:03 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpB__fkD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:06 INFO - PROCESS | 1978 | 2017-02-13 10:14:06.064 plugin-container[1979:10869] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.tsm.portname' 10:14:06 INFO - PROCESS | 1978 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:14:06 INFO - PROCESS | 1978 | 2017-02-13 10:14:06.065 plugin-container[1979:10869] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.CFPasteboardClient' 10:14:06 INFO - PROCESS | 1978 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:14:06 INFO - PROCESS | 1978 | 2017-02-13 10:14:06.065 plugin-container[1979:10869] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:14:15 INFO - PROCESS | 1978 | RSS: Main: 177270784 10:14:15 INFO - PROCESS | 1978 | 10:17:17 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49350/tests/dromaeo/cssquery-ext.html) 10:17:19 INFO - PROCESS | 1978 | RSS: Main: 183046144 10:17:19 INFO - PROCESS | 1978 | 10:20:21 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-ext.html (next: http://localhost:49350/tests/dromaeo/cssquery-jquery.html) 10:20:21 INFO - PROCESS | 1978 | RSS: Main: 191508480 10:20:21 INFO - PROCESS | 1978 | 10:23:23 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49350/tests/dromaeo/cssquery-mootools.html) 10:23:24 INFO - PROCESS | 1978 | RSS: Main: 194838528 10:23:24 INFO - PROCESS | 1978 | 10:26:26 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49350/tests/dromaeo/cssquery-prototype.html) 10:26:26 INFO - PROCESS | 1978 | RSS: Main: 197591040 10:26:26 INFO - PROCESS | 1978 | 10:29:29 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49350/tests/dromaeo/cssquery-yui.html) 10:29:30 INFO - PROCESS | 1978 | RSS: Main: 200540160 10:29:30 INFO - PROCESS | 1978 | 10:32:32 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-yui.html (next: http://localhost:49350/tests/dromaeo/cssquery-dojo.html) 10:32:33 INFO - PROCESS | 1978 | RSS: Main: 200728576 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | __start_tp_report 10:32:33 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 10:32:33 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 10:32:33 INFO - PROCESS | 1978 | |i|pagename|runs| 10:32:33 INFO - PROCESS | 1978 | |0;dojo.html;3381.8985430437087;3478.6869181773645;3500.7549471537004;3507.6843084122424;3557.5019497270387;5684.346300175481;5764.25064741583;5781.277340332458;5799.420057994198;5803.390643982384;4595.5634214749625;5784.98762716525;5790.971045144768;5808.070708686611;5874.5006674432725;5224.921626175601;5303;5304.92042619361;5339.038972984861;5359.383670877841;5370.7046112463795;5397.946020539804;5420.728963551826;5424.1321388577835;5451.972740136293;5234.528892399683;5238.5023422774775;5376.731163441812;5382.058139825534;5383.919241211385;5278.973605131969;5326.866828329284;5358.33020872391;5386.622936394454;5444.40111587725;5162.638615296931;5301.920471192935;5322.20166974953;5355.812546560891;5362.195670649395;5621.156826476021;5762.4525670061275;5772.653640781525;5853.09277062056;5958.433948774903;6144.187464697925;6144.893919094561;6147.801178770142;6182.629042257479;6289.182406287199;6286.151369565096;6294.622322660609;6297.6536290504;6304;6310.5898116622275;5836.095405212199;5861.41385861419;5864.208331875185;5873.177755114288;5917.497012753965;5177.430482646906;6175.938240617626;6191.566590338633;6196.225471816023;6230.657313847782;6164.969175154096;6198.504119670415;6200.410960958701;6203.6587987660205;6243.7814676486105;5332.33345831771;6259.489543456483;6267.5299352548745;6273.62358258506;6284.874302514016;6059.182010428536;6112.41229444207;6131.162586540582;6147.170132032208;6213.751449941951;6227.09707092469;6269.96865015672;6287.591306565058;6291.811245662638;6320.146780184708;4260.55264197261;4940.2342636891335;5013.824516141917;5027.271045698353;5029.245613158056;4397.34039894012;4411.514733379326;4435.955640443619;4496.123255965055;4514.525974772667;5738.913916291259;5809.88380232393;5925.4074592541265;5933.495652869468;5936.406359364029;6239.844003899848;6252.187215662026;6260.968695156495;6272.18461599989;6277;5780.913286300709;5800.854978625568;5917.31950825652;5953.672548009815;5956.791512297049;5499.945000549943;5508.421615730371;5512.972435137879;5519.779208831682;5521;5124.205748109049;6318.304986451395;6319.431251187323;6353.872922541524;6364.809055728336;6152.938470615237;6162.322144564184;6162.414570615784;6182.258129024546;6237.282712488122;6335.65153916539;6340.778072767431;6343.841403964938;6347.71435285404;6354.745810167541;6201.193844800147;6267.0286105653695;6275.748970041147;6290.622562646256;6302.180716506825;6125.816225513242;6132.447291485866;6195.628262304276;6281.842953926189;6294.748210071546;6150.907736383869;6261.655608941552;6262.060690896402;6266.091416744638;6277.403646653561;6205.193324867739;6269.059641053878;6277.686115694106;6279.246490421178;6283.183186185766;5783.797567085132;5857.58996870232;5927.673977931255;6124.724387402489;6138.386161383826;6128.625347140905;6156.907646385218;6171.1360409543595;6231.065340199007;6299.149614802126;5745.511631511368;6099.359567245376;6118.60229085108;6119.2350956130485;6143.662098584442 10:32:33 INFO - PROCESS | 1978 | |1;ext.html;507.4215394450325;511.7594730476676;536.1047051424123;552.1827695011383;558.6843433460094;37074.25851482972;39552;39692;39725.20549589006;39773.80113099434;41500.37749433753;41521.584784152146;42046.57953420465;42129.36805947906;42369.94075148123;9630.470324132188;9771.95114024429;9805.31362804604;9813.754656133582;9837.311388202828;9698.660546880861;9701.320907536476;9710.854337184948;9729.270304727139;9805.411675299505;8302.501849888995;9716.465594392306;9731.270154738388;9798.853017204749;9812.90187098127;9718.708438746778;9722.659706910259;9791.510424478818;9794.559244834;9809.509524523744;9686.854697179548;9690.515474226331;9714;9744.75638109046;9815.558299876451;39424;39550;39554.40668389977;39839.60160398417;39937.201255974716;3150.2754366495833;3345.3476572068457;3588.3002814451193;3739.6487419144564;4035.9394609080887;30743;30875.845620771754;30964.38071238585;31109.098328837677;31167.90912318058;3173.7143657070974;3201.9199520011953;3260.2664400509934;3273.1489812648647;3365.3774051800497;471593;475713;476043.61978190235;476179;485257;58498.7075064622;58666.706666466394;58759.70620146872;58845;58984;57797.71101144468;60023;61424.38575614187;62008;62186;16495.91752041232;16542.0901850397;16725.498235052968;16842.32630694783;16898.493045208663;11018.338899666045;12928.03039772021;13002.154859934264;13183.736325273441;13219.867801322056;14080.718385632435;14681.339339729524;15287.464938727091;15930.920345398199;16017.759733604005;6210.944139496297;6617.239017512951;6726.596404215763;7434.814129646802;7448.1434635016585;849.1847826087026;852.1989330029752;991.0881988570533;1027.3733022856052;1051.8579991701022;28921.96319386476;29107.56338654922;29592.704072959426;29650.1104966847;29933.25166870802;1003.3829195045141;1035.2287545778443;1036.2383648018852;1088.455772113943;1123.7246874515633;13231.669208269677;15355.923220383827;15518.534443966699;15544.450158010623;15597.610059748371;623148;639140;639513;639749;640493;57791;58301.416985830445;58471;58590.70704646449;58720.70639646774;1355.8169647097516;1375.4704438791136;1393.1501783911806;1396.9720605587831;1397.0709478197089;28663.856680716464;29412.411751765274;29471;29593.85203073971;30771.230719232197;47841.5215847851;48056.03887922152;48166;48187.5181248183;48243.82902769314;562916;568196;569788;570472;571525;21421.78578214198;25773.742262577136;25838.870805646602;26329;26402.603960940218;46077.539224607324;46467;47211.76394118008;47746;47925.76037119792;34976;35572.7549535765;37668.43497347487;37847.62152378441;39537.406938896514;27426.725732743216;37558.43662345122;37837;38055.429168563045;38183.61816381912;35260.294794104484;37516.62483375131;38453;38478;39445.2110957785;32847;34044.829775851955;34582.96251112471;34660;34689.959301221;24125.155619553232;25670;25682.743172568036;25826.35434114162;26163.738362616892 10:32:33 INFO - PROCESS | 1978 | |2;jquery.html;336.4616613418531;371.65621799835145;375.40310905659993;386.4743948230404;404.40552387989663;19047.047647617634;19443.708344374845;19928.50178745532;20140;20338.983050847473;11831.935125838672;12025.579104731314;19496.805031949676;19543.60912781747;19629.31297404591;5318.707471089079;5523.364813046491;5535.335759708841;5536.058869992091;5554.833354999357;5299.178627312754;5982.8504287392725;6041.516678665696;6042.607230530023;6066.817995460143;5855.502282306009;5916.053431450969;5944.7324870380935;5946.643201407907;6000.2199714037115;5930.88138237235;6001.039833626599;6006.069059295773;6014.909776353358;6024.825159093978;5098.694078355274;5312;5345.492178243099;5374.435684253136;5374.838754837361;13182.274974876378;13300.733985320336;13401.932990334986;13430.664233394244;13487.527936522272;1933.8839669619867;2726.3184203949013;2786.70739572346;2941.617589713345;2956.674765775763;9688.660896868647;10136.695899123039;10448.947755261252;10452.581896724121;10522.526486308134;1892.7255547945472;1894.5547796267865;1902.857285703564;1921;2005.3783327168624;122519.38740306241;123715;124852;126678;130480.04279935714;10308;10732.819389867109;11763.117766167572;11817.645470635895;11980.460879260454;14602.12387256768;14770.335334909954;14917.850821491864;14931.477398291225;14934.178620175995;8468.661253549912;8675.132486751401;8709.346798990102;8782.560871956504;8801.735947921572;6956.373926346653;8637.222649961534;8648.26489748366;8714.346424018097;8737.21365077146;4498.370228168059;4542.88642783933;4570.8171673133365;4629.722216667011;4730.337752714623;1926.248762982438;1929.6623090959026;1971.8619696621386;1979.6634572122773;1990.8407327413772;369.3923495849313;807.9515229086273;858.9699360522352;901.3195037746459;915.158054589779;11029.669109926715;11891.405429728478;11900.940495297642;11908;12018.399080045963;421.37425922505054;430.9353596960418;443.76702231328164;447.6709618430451;461.0686413444823;10812;11051.850222686497;11760.58837940668;11817.763644727229;12044.81932771009;305175;307178;307189;307372;629543;110259;113586;118513.40743296228;119512;126192.1071183933;965.7392504024015;994.264244459095;997.2670087485692;1009.258195226508;1011.2567263061644;18538.351157709414;18770.812291877453;18849.340273090376;18888.15003324826;18901.621967560848;36731.163441828336;38223.80888095542;50054.74972625114;50126.74683132951;53043.20435193398;72999.27000729924;75773.96904123774;78568;79690.20309796827;80761;5758.683272420057;7347.26527347261;7419.517731347445;7434.4795864291145;7638.770836874903;9550.665726699532;10273.589056437957;12315.322657253937;12454.501819927102;12652.17760845542;9559.474228917476;10088.54601542947;10783.784324313312;10958.342499450058;10990.945045274722;9474.810503790024;10624.309419887682;10716.089132423831;10801.621943231949;10805.351678899291;10958.397288149228;10963.83554246671;11063.004329610052;11081.445927703744;11385.487653055798;6816.943373777072;6817.488688348294;7266.636668166676;7277.963610181915;8256.711015114442;8967;10591.364518128938;10704.197185210984;10786.298890572089;10900.781984360427 10:32:33 INFO - PROCESS | 1978 | |3;mootools.html;1327.7012672148767;1484.547213100004;1535.5853919441759;1635.1252080137122;1751.4482937874577;7605.391568674507;7852.097008843971;8134.959325203373;8507.91492085079;8525.658973641062;8064.959675201616;8337.666493340274;8347;8462.53456059918;8480.491170529773;2367.7632236776312;2387.6776635154292;2396.664466974616;2399.664047033417;2402.8318017738766;2388.653645221442;2412.2763171048614;2422.0432928993037;2435.427674496492;2437.4515733959806;2078.490769761411;2284.154862700803;2366.810655147584;2388.5103553771437;2393.2939782764124;2344.2146880794867;2351.95296094078;2356.15178535727;2369.478714682767;2391.5456063347997;2364.3616223619524;2376.7147942247043;2384.403899025244;2388.581998150334;2401.3396316013063;8369.246767790868;8424.283935865458;8491.74524764258;8538.146185381413;8543.95728021362;5107.872303192413;5245.606579506514;5264.210368444764;5270.894582108336;5303;2921.5033444314304;3462.255615042778;3513.2973405318785;3525.065857547752;3571.607123216444;1027.0705011964185;1035.6323505155713;1071.983920241197;1081.2485322700727;1082.5994382078682;10888.564457421693;10923.508442120125;10931.672049838518;10963.177761667826;10978.945105274503;3851.2105018471148;4494.5505449454795;4688.5545873142;4695.81216751333;4761.666683332202;9552.522373881278;9558.856617150748;9568.56941437637;9570.808583828284;9570.856437153448;4479.977600111979;5204.141316682705;5214.843554693365;5260.368755749258;5302.257683924254;4327.502337231196;4402.58787966457;4682.157211701926;4792.880177995578;4891.388576427947;3190.2502911815704;3863.092173339263;3880.3015457217407;3905.2189562087697;3991;1250.056207563302;1275.7002104505434;1281.2568710148091;1283.9871601284055;1298.1367390685277;721.5923003503004;764.2663043478212;801.5190885468672;863.9870401943975;891.6166048599035;4651.395318608559;5529.585281103933;5552.583556233299;5647.37878833328;5699.4585514376895;364.9069487280726;417.0116823129143;418.25341764949417;422.204145186326;427.65573713161206;3475.63505831884;3648.7776594841025;3736.5142531470733;3738.794366309879;3768.679662228741;9896.307258491837;10277.537510812032;10294.794104117876;10296.382217067;10331.535080921376;9669.70990870275;10196.38821670702;10242.436665983294;10301.53643086063;10306.433146176882;6637.336266373324;7908.565028923349;7952.244536769113;7952.602369881482;8006.119326874039;5446.891062178655;5505.146702261156;5584.86037849057;5584.972075139598;5618.6628802272;9263.76840578991;9300.534973251446;9383.343165978316;9420.528973551158;9486.098820612031;9443.433393996382;9469.431834089977;9482.19401350893;9560.235181185628;9574.808503830023;6558.475321974326;6783.016462612794;7126.572405655677;7221.061262035902;7514.436417268617;7744.728934487266;7876.369890408868;7970.083440404196;7976.202379761978;7984;7011;7267.709291628275;7268.164161121327;7277.345038946521;7284.635768211674;6501.382368674968;6531;6884.51808373409;7076.25699301566;7134.643267836484;6458.22501299847;6629.270780214269;6724.663766811737;6729.2934241903895;6795.558288711218;4782.7847746850775;4796.712197268175;4861.51384861511;4865.343178670834;4874.6344024197615;4657.371254880548;4674.462436819809;4701.553352431513;4794.664373493822;4880.46314905353 10:32:33 INFO - PROCESS | 1978 | |4;prototype.html;302.41029991516535;313.7756504099569;313.9874405023799;317.67279701907046;317.741041051543;4549.976255342551;4760.2859571064355;5407.24298598196;5421.9457805421935;5442.863928401792;4383.232934236504;4712.787924543395;5009.474005229453;5255.608698042391;5375.892482150354;3578.2843431313713;3781.4894989176523;4152.709310348277;4154.774341569229;4189.3087640539425;3716.089558058266;4034.9912521869533;4073.63337299643;4091;4196.803910885398;4054.3918412238254;4088.0974508099284;4093.263212621727;4107.158032603309;4113.177364527107;3756.7370284080125;4071.3282308419075;4082.1223436961195;4108.424820525129;4115.650169735576;2748.2579703480146;3225.2581906161713;3416.26550291686;3602.657747513982;3619.239959608485;4584.67044557078;4948.703077815307;5249.186376111671;5267.710275934822;5284.1465608571325;4614.284785858197;4656.022235330584;4675.976620116878;4678.578927896506;4680.3681502997;5411.242426060355;5585.245991791137;5608.383077861432;5619.775208991636;5628.7766332298925;3263.400933542571;3693.169036966688;3867.361885288924;3886.7667939923695;3893.240818040483;5299.8410047698635;5901.940980590182;5909.4090590941;5938.495227905633;5954.583179177459;3082.9075127746205;3769.1896242308035;3794.317022935898;3933.645971862546;4017.5580686124504;3952.5849785772657;3954.0822700989997;3967.8809635710977;3975.6223158799867;3992.923679686605;4603.700759450625;4604.608608268268;4615.215413379734;4639.280911458729;4654.674172807939;4790.826247569368;5315.817078348579;5673.149027645886;5689.800856970069;5702.407483285504;1114.6011755247114;1154.839386416646;1197.1560050164612;1291.4059532614915;1293.224065560656;812.7118517150265;849.222960990699;859.7233108833377;881.850085485469;886.9866951995725;4526.502084770673;5056;5078.958813443235;5109.514596113363;5118.564921981673;4315.05822379924;4864.038680545824;4943.406791185081;5081.415637201769;5248.921266181011;4132.752034877917;4287.656987440997;4307.590778876001;4529.230030894756;5139.177731562932;2706.687256680508;2835.2911772056987;2892.8284044961824;2898.7391134797967;2930.384619229943;4860.416749990024;5451.836444906659;5490.3411590609385;5725.255716756878;5765.654060756368;5426.534835594446;5674.97162514193;5679.858003549944;5724.227229323988;5758.88482230353;5541.639793413416;6004.369541198199;6062.787802426894;6065.848353791191;6106.755729770848;5863.970680146572;5891.263592050994;5897.319264009737;5906.70466476683;5907;5035.345405097461;5454.3818966895315;5744.4829965303325;5815.011448053926;5839.7372118255635;4738.028704115579;5031.52200540948;5923.881522369615;6033.336333003454;6105.9694701526205;3722.6277372262557;3786.450964610171;3796.696264298794;3813.7521061130938;3882.845021013252;5555.833325000095;5809.356742682154;5819.79630712923;5823.35943046273;5842.649441033552;5150;5658.773649053992;5668.829935101953;5683.396448876423;5715.085586306171;4810.735409552508;5294.293994203996;5365.624406291522;5721.884232574608;5754.079347304411;4489.595936365743;5583.330000399816;5586.636868603528;5589.524890384363;5615.522680572034;5443;5640.88718225625;5668.404817494269;5684.039006542736;5706.487780738191;4722.291656251589;5454.699991500505;5496.120620700669;5555.666580067554;5586.972065139648 10:32:33 INFO - PROCESS | 1978 | |5;yui.html;669.5480550628325;682.3858527325409;707.5648476187147;722.8409749855032;796.2913007423394;14522.491712790055;15376.538703838904;15387.92306038471;15390.769138462903;15419;13937.860621393784;13951.790723139162;13959.860401395983;14029.017968742166;14070.788938165935;671.3990978074609;705.9294070592925;833.6623667414707;850.5194565070715;872.6596627315353;843.4981186194235;847.7287268074218;861.5304658960881;866.0473479172922;867.405827008498;916.4592890194783;921.0007142250666;921.216965579259;923.1829830599934;924.7364501117183;886.3618194899661;915.0620613870802;916.4592890194783;918.8024574716401;919.9908000920005;664.385443464798;678.759040540606;683.8392977650249;686.0703746423574;687.3950923187613;14303.570892873231;14414.351354189086;14479.131252124906;14487.710245795026;15031.924840375728;14177.220252886087;14347.847624708991;14416.207108609022;14461.710765784625;14741.336639851232;9482.762930926712;10556.049955504042;10809.83785243222;10858.61994830185;11016.669499915015;3601.081724160322;3644.1071937375514;3751.437284407361;3813.504244448232;3816.637419445148;99645;99959;100132;100196.49705254428;100395.99604003939;10052.246081543914;10268.794624107475;10321.122704570196;10329.9483502582;10347.247453004331;16029.759553606706;17624.20691068905;19141;19180.328688495836;19327.323543676186;7373.5575865448245;7654.2345765423015;7673.769786906401;7708.461890638446;7869.567173805495;4371.475422949266;4397.692161548661;4424.756638384855;4473;4583.72497650142;2971.925701857471;3378.459446488599;3490.4415293553416;3492.6681965213265;3505.211327451303;626.8464226264595;636.0173531893236;646.6863571167979;648.4909346163239;655.9508036897251;584.8596336879203;645.5868244323636;647.795944277551;651.7523341130341;669.2604671837549;7621.618919054025;8007.159248278964;8570.571771291534;9126.133017363472;9211.309151813506;651.3681728723132;658.52478600413;663.6880666086931;667.732906837269;675.6959368284291;4280.486341638961;4463.687541872037;4485.215087359699;4502.909941801211;4661.230896901973;118919.40540297417;122570;126170.73829261774;128198.35900820623;130733;94543;108570.45714771375;112152.4392378033;114164.42917785358;115269.4236528812;95502.5224873885;97077;97321.51339243258;99525.50237248912;99793;8739.169778870997;8752.34357423183;8807.823843523222;8827.205551500396;8830.867536986822;54813.725931370085;62474.68762656158;62481.68759156175;62840.05739913813;63709;72162.63918680583;72991.63504182445;74135.62932185305;79674.80487792804;80730.19269807462;12580.245185288912;12953.740925181632;12961;12977.740445191232;13437.932810335886;13896.888248939858;14317.498887538886;14372.49696260626;14528.418863245352;14767;12277.20198187115;13593.79609305881;13710.931445342709;13784.517541885985;14194.3612537434;13628.386722597308;13629.386677599334;13894.583162505141;13975.860241397455;14251.714965700836;11003.449827508754;12938.159019663692;13054.477820887058;13188.540614755648;13287.933560332136;11189.608363707232;11816.172867899164;11844.466998984894;11857.16999810005;11948.940255299016;11192.328460292409;11565.884341156818;11610.24533405326;11696.181267311207;11908.583199587973 10:32:33 INFO - PROCESS | 1978 | __end_tp_report 10:32:33 INFO - PROCESS | 1978 | __start_cc_report 10:32:33 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,352 10:32:33 INFO - PROCESS | 1978 | __end_cc_report 10:32:33 INFO - PROCESS | 1978 | __startTimestamp1487010753044__endTimestamp 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | ------- Summary: start ------- 10:32:33 INFO - PROCESS | 1978 | Number of tests: 6 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | [#0] dojo.html Cycles:165 Average:5787.87 Median:6059.18 stddev:631.14 (10.4%) stddev-sans-first:604.19 10:32:33 INFO - PROCESS | 1978 | Values: 3381.9 3478.7 3500.8 3507.7 3557.5 5684.3 5764.3 5781.3 5799.4 5803.4 4595.6 5785.0 5791.0 5808.1 5874.5 5224.9 5303.0 5304.9 5339.0 5359.4 5370.7 5397.9 5420.7 5424.1 5452.0 5234.5 5238.5 5376.7 5382.1 5383.9 5279.0 5326.9 5358.3 5386.6 5444.4 5162.6 5301.9 5322.2 5355.8 5362.2 5621.2 5762.5 5772.7 5853.1 5958.4 6144.2 6144.9 6147.8 6182.6 6289.2 6286.2 6294.6 6297.7 6304.0 6310.6 5836.1 5861.4 5864.2 5873.2 5917.5 5177.4 6175.9 6191.6 6196.2 6230.7 6165.0 6198.5 6200.4 6203.7 6243.8 5332.3 6259.5 6267.5 6273.6 6284.9 6059.2 6112.4 6131.2 6147.2 6213.8 6227.1 6270.0 6287.6 6291.8 6320.1 4260.6 4940.2 5013.8 5027.3 5029.2 4397.3 4411.5 4436.0 4496.1 4514.5 5738.9 5809.9 5925.4 5933.5 5936.4 6239.8 6252.2 6261.0 6272.2 6277.0 5780.9 5800.9 5917.3 5953.7 5956.8 5499.9 5508.4 5513.0 5519.8 5521.0 5124.2 6318.3 6319.4 6353.9 6364.8 6152.9 6162.3 6162.4 6182.3 6237.3 6335.7 6340.8 6343.8 6347.7 6354.7 6201.2 6267.0 6275.7 6290.6 6302.2 6125.8 6132.4 6195.6 6281.8 6294.7 6150.9 6261.7 6262.1 6266.1 6277.4 6205.2 6269.1 6277.7 6279.2 6283.2 5783.8 5857.6 5927.7 6124.7 6138.4 6128.6 6156.9 6171.1 6231.1 6299.1 5745.5 6099.4 6118.6 6119.2 6143.7 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | [#1] ext.html Cycles:180 Average:69082.96 Median:39623.20 stddev:150854.87 (380.7%) stddev-sans-first:151190.19 10:32:33 INFO - PROCESS | 1978 | Values: 507.4 511.8 536.1 552.2 558.7 37074.3 39552.0 39692.0 39725.2 39773.8 41500.4 41521.6 42046.6 42129.4 42369.9 9630.5 9772.0 9805.3 9813.8 9837.3 9698.7 9701.3 9710.9 9729.3 9805.4 8302.5 9716.5 9731.3 9798.9 9812.9 9718.7 9722.7 9791.5 9794.6 9809.5 9686.9 9690.5 9714.0 9744.8 9815.6 39424.0 39550.0 39554.4 39839.6 39937.2 3150.3 3345.3 3588.3 3739.6 4035.9 30743.0 30875.8 30964.4 31109.1 31167.9 3173.7 3201.9 3260.3 3273.1 3365.4 471593.0 475713.0 476043.6 476179.0 485257.0 58498.7 58666.7 58759.7 58845.0 58984.0 57797.7 60023.0 61424.4 62008.0 62186.0 16495.9 16542.1 16725.5 16842.3 16898.5 11018.3 12928.0 13002.2 13183.7 13219.9 14080.7 14681.3 15287.5 15930.9 16017.8 6210.9 6617.2 6726.6 7434.8 7448.1 849.2 852.2 991.1 1027.4 1051.9 28922.0 29107.6 29592.7 29650.1 29933.3 1003.4 1035.2 1036.2 1088.5 1123.7 13231.7 15355.9 15518.5 15544.5 15597.6 623148.0 639140.0 639513.0 639749.0 640493.0 57791.0 58301.4 58471.0 58590.7 58720.7 1355.8 1375.5 1393.2 1397.0 1397.1 28663.9 29412.4 29471.0 29593.9 30771.2 47841.5 48056.0 48166.0 48187.5 48243.8 562916.0 568196.0 569788.0 570472.0 571525.0 21421.8 25773.7 25838.9 26329.0 26402.6 46077.5 46467.0 47211.8 47746.0 47925.8 34976.0 35572.8 37668.4 37847.6 39537.4 27426.7 37558.4 37837.0 38055.4 38183.6 35260.3 37516.6 38453.0 38478.0 39445.2 32847.0 34044.8 34583.0 34660.0 34690.0 24125.2 25670.0 25682.7 25826.4 26163.7 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | [#2] jquery.html Cycles:180 Average:27597.01 Median:2949.15 stddev:68481.89 (2322.1%) stddev-sans-first:68643.42 10:32:33 INFO - PROCESS | 1978 | Values: 336.5 371.7 375.4 386.5 404.4 19047.0 19443.7 19928.5 20140.0 20339.0 11831.9 12025.6 19496.8 19543.6 19629.3 5318.7 5523.4 5535.3 5536.1 5554.8 5299.2 5982.9 6041.5 6042.6 6066.8 5855.5 5916.1 5944.7 5946.6 6000.2 5930.9 6001.0 6006.1 6014.9 6024.8 5098.7 5312.0 5345.5 5374.4 5374.8 13182.3 13300.7 13401.9 13430.7 13487.5 1933.9 2726.3 2786.7 2941.6 2956.7 9688.7 10136.7 10448.9 10452.6 10522.5 1892.7 1894.6 1902.9 1921.0 2005.4 122519.4 123715.0 124852.0 126678.0 130480.0 10308.0 10732.8 11763.1 11817.6 11980.5 14602.1 14770.3 14917.9 14931.5 14934.2 8468.7 8675.1 8709.3 8782.6 8801.7 6956.4 8637.2 8648.3 8714.3 8737.2 4498.4 4542.9 4570.8 4629.7 4730.3 1926.2 1929.7 1971.9 1979.7 1990.8 369.4 808.0 859.0 901.3 915.2 11029.7 11891.4 11900.9 11908.0 12018.4 421.4 430.9 443.8 447.7 461.1 10812.0 11051.9 11760.6 11817.8 12044.8 305175.0 307178.0 307189.0 307372.0 629543.0 110259.0 113586.0 118513.4 119512.0 126192.1 965.7 994.3 997.3 1009.3 1011.3 18538.4 18770.8 18849.3 18888.2 18901.6 36731.2 38223.8 50054.7 50126.7 53043.2 72999.3 75774.0 78568.0 79690.2 80761.0 5758.7 7347.3 7419.5 7434.5 7638.8 9550.7 10273.6 12315.3 12454.5 12652.2 9559.5 10088.5 10783.8 10958.3 10990.9 9474.8 10624.3 10716.1 10801.6 10805.4 10958.4 10963.8 11063.0 11081.4 11385.5 6816.9 6817.5 7266.6 7278.0 8256.7 8967.0 10591.4 10704.2 10786.3 10900.8 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | [#3] mootools.html Cycles:180 Average:5439.59 Median:4863.43 stddev:3030.86 (62.3%) stddev-sans-first:3023.61 10:32:33 INFO - PROCESS | 1978 | Values: 1327.7 1484.5 1535.6 1635.1 1751.4 7605.4 7852.1 8135.0 8507.9 8525.7 8065.0 8337.7 8347.0 8462.5 8480.5 2367.8 2387.7 2396.7 2399.7 2402.8 2388.7 2412.3 2422.0 2435.4 2437.5 2078.5 2284.2 2366.8 2388.5 2393.3 2344.2 2352.0 2356.2 2369.5 2391.5 2364.4 2376.7 2384.4 2388.6 2401.3 8369.2 8424.3 8491.7 8538.1 8544.0 5107.9 5245.6 5264.2 5270.9 5303.0 2921.5 3462.3 3513.3 3525.1 3571.6 1027.1 1035.6 1072.0 1081.2 1082.6 10888.6 10923.5 10931.7 10963.2 10978.9 3851.2 4494.6 4688.6 4695.8 4761.7 9552.5 9558.9 9568.6 9570.8 9570.9 4480.0 5204.1 5214.8 5260.4 5302.3 4327.5 4402.6 4682.2 4792.9 4891.4 3190.3 3863.1 3880.3 3905.2 3991.0 1250.1 1275.7 1281.3 1284.0 1298.1 721.6 764.3 801.5 864.0 891.6 4651.4 5529.6 5552.6 5647.4 5699.5 364.9 417.0 418.3 422.2 427.7 3475.6 3648.8 3736.5 3738.8 3768.7 9896.3 10277.5 10294.8 10296.4 10331.5 9669.7 10196.4 10242.4 10301.5 10306.4 6637.3 7908.6 7952.2 7952.6 8006.1 5446.9 5505.1 5584.9 5585.0 5618.7 9263.8 9300.5 9383.3 9420.5 9486.1 9443.4 9469.4 9482.2 9560.2 9574.8 6558.5 6783.0 7126.6 7221.1 7514.4 7744.7 7876.4 7970.1 7976.2 7984.0 7011.0 7267.7 7268.2 7277.3 7284.6 6501.4 6531.0 6884.5 7076.3 7134.6 6458.2 6629.3 6724.7 6729.3 6795.6 4782.8 4796.7 4861.5 4865.3 4874.6 4657.4 4674.5 4701.6 4794.7 4880.5 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | [#4] prototype.html Cycles:180 Average:4518.10 Median:5020.50 stddev:1406.81 (28.0%) stddev-sans-first:1374.71 10:32:33 INFO - PROCESS | 1978 | Values: 302.4 313.8 314.0 317.7 317.7 4550.0 4760.3 5407.2 5421.9 5442.9 4383.2 4712.8 5009.5 5255.6 5375.9 3578.3 3781.5 4152.7 4154.8 4189.3 3716.1 4035.0 4073.6 4091.0 4196.8 4054.4 4088.1 4093.3 4107.2 4113.2 3756.7 4071.3 4082.1 4108.4 4115.7 2748.3 3225.3 3416.3 3602.7 3619.2 4584.7 4948.7 5249.2 5267.7 5284.1 4614.3 4656.0 4676.0 4678.6 4680.4 5411.2 5585.2 5608.4 5619.8 5628.8 3263.4 3693.2 3867.4 3886.8 3893.2 5299.8 5901.9 5909.4 5938.5 5954.6 3082.9 3769.2 3794.3 3933.6 4017.6 3952.6 3954.1 3967.9 3975.6 3992.9 4603.7 4604.6 4615.2 4639.3 4654.7 4790.8 5315.8 5673.1 5689.8 5702.4 1114.6 1154.8 1197.2 1291.4 1293.2 812.7 849.2 859.7 881.9 887.0 4526.5 5056.0 5079.0 5109.5 5118.6 4315.1 4864.0 4943.4 5081.4 5248.9 4132.8 4287.7 4307.6 4529.2 5139.2 2706.7 2835.3 2892.8 2898.7 2930.4 4860.4 5451.8 5490.3 5725.3 5765.7 5426.5 5675.0 5679.9 5724.2 5758.9 5541.6 6004.4 6062.8 6065.8 6106.8 5864.0 5891.3 5897.3 5906.7 5907.0 5035.3 5454.4 5744.5 5815.0 5839.7 4738.0 5031.5 5923.9 6033.3 6106.0 3722.6 3786.5 3796.7 3813.8 3882.8 5555.8 5809.4 5819.8 5823.4 5842.6 5150.0 5658.8 5668.8 5683.4 5715.1 4810.7 5294.3 5365.6 5721.9 5754.1 4489.6 5583.3 5586.6 5589.5 5615.5 5443.0 5640.9 5668.4 5684.0 5706.5 4722.3 5454.7 5496.1 5555.7 5587.0 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - PROCESS | 1978 | [#5] yui.html Cycles:180 Average:22366.21 Median:4048.56 stddev:34102.16 (842.3%) stddev-sans-first:34158.91 10:32:33 INFO - PROCESS | 1978 | Values: 669.5 682.4 707.6 722.8 796.3 14522.5 15376.5 15387.9 15390.8 15419.0 13937.9 13951.8 13959.9 14029.0 14070.8 671.4 705.9 833.7 850.5 872.7 843.5 847.7 861.5 866.0 867.4 916.5 921.0 921.2 923.2 924.7 886.4 915.1 916.5 918.8 920.0 664.4 678.8 683.8 686.1 687.4 14303.6 14414.4 14479.1 14487.7 15031.9 14177.2 14347.8 14416.2 14461.7 14741.3 9482.8 10556.0 10809.8 10858.6 11016.7 3601.1 3644.1 3751.4 3813.5 3816.6 99645.0 99959.0 100132.0 100196.5 100396.0 10052.2 10268.8 10321.1 10329.9 10347.2 16029.8 17624.2 19141.0 19180.3 19327.3 7373.6 7654.2 7673.8 7708.5 7869.6 4371.5 4397.7 4424.8 4473.0 4583.7 2971.9 3378.5 3490.4 3492.7 3505.2 626.8 636.0 646.7 648.5 656.0 584.9 645.6 647.8 651.8 669.3 7621.6 8007.2 8570.6 9126.1 9211.3 651.4 658.5 663.7 667.7 675.7 4280.5 4463.7 4485.2 4502.9 4661.2 118919.4 122570.0 126170.7 128198.4 130733.0 94543.0 108570.5 112152.4 114164.4 115269.4 95502.5 97077.0 97321.5 99525.5 99793.0 8739.2 8752.3 8807.8 8827.2 8830.9 54813.7 62474.7 62481.7 62840.1 63709.0 72162.6 72991.6 74135.6 79674.8 80730.2 12580.2 12953.7 12961.0 12977.7 13437.9 13896.9 14317.5 14372.5 14528.4 14767.0 12277.2 13593.8 13710.9 13784.5 14194.4 13628.4 13629.4 13894.6 13975.9 14251.7 11003.4 12938.2 13054.5 13188.5 13287.9 11189.6 11816.2 11844.5 11857.2 11948.9 11192.3 11565.9 11610.2 11696.2 11908.6 10:32:33 INFO - PROCESS | 1978 | -------- Summary: end -------- 10:32:33 INFO - PROCESS | 1978 | 10:32:33 INFO - TEST-INFO | 1978: exit 0 10:32:33 INFO - TEST-OK | dromaeo_css | took 1113973ms 10:32:33 INFO - TEST-START | kraken 10:32:33 INFO - operating with platform_type : mac_ 10:32:33 INFO - Initialising browser for kraken test... 10:32:33 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpFxEXMe/profile http://localhost:49350/getInfo.html) 10:32:36 INFO - PROCESS | 1984 | 2017-02-13 10:32:36.580 plugin-container[1986:12858] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 10:32:36 INFO - PROCESS | 1984 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:36 INFO - PROCESS | 1984 | 2017-02-13 10:32:36.581 plugin-container[1986:12858] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 10:32:36 INFO - PROCESS | 1984 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:36 INFO - PROCESS | 1984 | 2017-02-13 10:32:36.581 plugin-container[1986:12858] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:36 INFO - PROCESS | 1984 | __metrics Screen width/height:1600/1200 10:32:36 INFO - PROCESS | 1984 | colorDepth:24 10:32:36 INFO - PROCESS | 1984 | Browser inner width/height: 1024/689 10:32:36 INFO - PROCESS | 1984 | __metrics 10:32:36 ERROR - PROCESS | 1984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:32:37 INFO - TEST-INFO | 1984: exit 0 10:32:37 INFO - Browser initialized. 10:32:37 INFO - Running cycle 1/1 for kraken test... 10:32:37 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpFxEXMe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:40 INFO - PROCESS | 1987 | 2017-02-13 10:32:40.069 plugin-container[1988:12992] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x424b, name = 'com.apple.tsm.portname' 10:32:40 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:40 INFO - PROCESS | 1987 | 2017-02-13 10:32:40.069 plugin-container[1988:12992] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 10:32:40 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:40 INFO - PROCESS | 1987 | 2017-02-13 10:32:40.069 plugin-container[1988:12992] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:49 INFO - PROCESS | 1987 | RSS: Main: 177381376 10:32:49 INFO - PROCESS | 1987 | 10:32:52 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:53 INFO - PROCESS | 1987 | RSS: Main: 190500864 10:32:53 INFO - PROCESS | 1987 | 10:32:56 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-dft) 10:32:57 INFO - PROCESS | 1987 | RSS: Main: 198426624 10:32:57 INFO - PROCESS | 1987 | 10:33:00 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-fft) 10:33:01 INFO - PROCESS | 1987 | RSS: Main: 200359936 10:33:01 INFO - PROCESS | 1987 | 10:33:03 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-oscillator) 10:33:04 INFO - PROCESS | 1987 | RSS: Main: 202858496 10:33:04 INFO - PROCESS | 1987 | 10:33:06 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:06 INFO - PROCESS | 1987 | RSS: Main: 203157504 10:33:06 INFO - PROCESS | 1987 | 10:33:09 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49350/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:10 INFO - PROCESS | 1987 | RSS: Main: 207478784 10:33:10 INFO - PROCESS | 1987 | 10:33:13 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49350/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:13 INFO - PROCESS | 1987 | RSS: Main: 206749696 10:33:13 INFO - PROCESS | 1987 | 10:33:16 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49350/tests/kraken/driver.html?testName=json-parse-financial) 10:33:17 INFO - PROCESS | 1987 | RSS: Main: 206987264 10:33:17 INFO - PROCESS | 1987 | 10:33:19 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:19 INFO - PROCESS | 1987 | RSS: Main: 206295040 10:33:19 INFO - PROCESS | 1987 | 10:33:21 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:22 INFO - PROCESS | 1987 | RSS: Main: 206282752 10:33:22 INFO - PROCESS | 1987 | 10:33:24 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:25 INFO - PROCESS | 1987 | RSS: Main: 206303232 10:33:25 INFO - PROCESS | 1987 | 10:33:28 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:28 INFO - PROCESS | 1987 | RSS: Main: 206716928 10:33:28 INFO - PROCESS | 1987 | 10:33:31 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:32 INFO - PROCESS | 1987 | RSS: Main: 206487552 10:33:32 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49350/tests/kraken/driver.html?testName=ai-astar) 10:33:34 INFO - PROCESS | 1987 | RSS: Main: 208322560 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | __start_tp_report 10:33:34 INFO - PROCESS | 1987 | _x_x_mozilla_page_load 10:33:34 INFO - PROCESS | 1987 | _x_x_mozilla_page_load_details 10:33:34 INFO - PROCESS | 1987 | |i|pagename|runs| 10:33:34 INFO - PROCESS | 1987 | |0;ai-astar;86;138;141;138;102;110;97;173;171;94 10:33:34 INFO - PROCESS | 1987 | |1;audio-beat-detection;174;98;101;136;119;147;142;122;175;113 10:33:34 INFO - PROCESS | 1987 | |2;audio-dft;212;256;280;260;227;278;275;194;223;184 10:33:34 INFO - PROCESS | 1987 | |3;audio-fft;79;59;59;87;69;60;58;60;79;62 10:33:34 INFO - PROCESS | 1987 | |4;audio-oscillator;88;74;109;62;82;94;123;101;103;96 10:33:34 INFO - PROCESS | 1987 | |5;imaging-gaussian-blur;91;89;102;89;90;88;92;89;90;87 10:33:34 INFO - PROCESS | 1987 | |6;imaging-darkroom;100;103;109;169;130;101;103;100;100;103 10:33:34 INFO - PROCESS | 1987 | |7;imaging-desaturate;135;137;87;87;86;112;135;144;77;141 10:33:34 INFO - PROCESS | 1987 | |8;json-parse-financial;56;56;56;59;59;60;59;62;64;90 10:33:34 INFO - PROCESS | 1987 | |9;json-stringify-tinderbox;68;75;68;82;79;78;70;58;80;68 10:33:34 INFO - PROCESS | 1987 | |10;stanford-crypto-aes;84;83;86;85;93;107;88;84;103;73 10:33:34 INFO - PROCESS | 1987 | |11;stanford-crypto-ccm;135;141;135;137;149;153;147;169;209;182 10:33:34 INFO - PROCESS | 1987 | |12;stanford-crypto-pbkdf2;163;165;164;167;165;160;167;170;165;165 10:33:34 INFO - PROCESS | 1987 | |13;stanford-crypto-sha256-iterative;67;69;65;80;90;86;89;81;67;77 10:33:34 INFO - PROCESS | 1987 | __end_tp_report 10:33:34 INFO - PROCESS | 1987 | __start_cc_report 10:33:34 INFO - PROCESS | 1987 | _x_x_mozilla_cycle_collect,917 10:33:34 INFO - PROCESS | 1987 | __end_cc_report 10:33:34 INFO - PROCESS | 1987 | __startTimestamp1487010814374__endTimestamp 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | ------- Summary: start ------- 10:33:34 INFO - PROCESS | 1987 | Number of tests: 14 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#0] ai-astar Cycles:10 Average:125.00 Median:172.00 stddev:31.68 (18.4%) stddev-sans-first:30.30 10:33:34 INFO - PROCESS | 1987 | Values: 86.0 138.0 141.0 138.0 102.0 110.0 97.0 173.0 171.0 94.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:144.50 stddev:27.28 (18.9%) stddev-sans-first:24.50 10:33:34 INFO - PROCESS | 1987 | Values: 174.0 98.0 101.0 136.0 119.0 147.0 142.0 122.0 175.0 113.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#2] audio-dft Cycles:10 Average:238.90 Median:258.00 stddev:35.60 (13.8%) stddev-sans-first:36.41 10:33:34 INFO - PROCESS | 1987 | Values: 212.0 256.0 280.0 260.0 227.0 278.0 275.0 194.0 223.0 184.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#3] audio-fft Cycles:10 Average:67.20 Median:65.50 stddev:10.66 (16.3%) stddev-sans-first:10.42 10:33:34 INFO - PROCESS | 1987 | Values: 79.0 59.0 59.0 87.0 69.0 60.0 58.0 60.0 79.0 62.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:78.00 stddev:17.63 (22.6%) stddev-sans-first:18.60 10:33:34 INFO - PROCESS | 1987 | Values: 88.0 74.0 109.0 62.0 82.0 94.0 123.0 101.0 103.0 96.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:89.50 stddev:4.22 (4.7%) stddev-sans-first:4.47 10:33:34 INFO - PROCESS | 1987 | Values: 91.0 89.0 102.0 89.0 90.0 88.0 92.0 89.0 90.0 87.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#6] imaging-darkroom Cycles:10 Average:111.80 Median:103.00 stddev:22.05 (21.4%) stddev-sans-first:22.98 10:33:34 INFO - PROCESS | 1987 | Values: 100.0 103.0 109.0 169.0 130.0 101.0 103.0 100.0 100.0 103.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#7] imaging-desaturate Cycles:10 Average:114.10 Median:110.50 stddev:27.19 (24.6%) stddev-sans-first:27.77 10:33:34 INFO - PROCESS | 1987 | Values: 135.0 137.0 87.0 87.0 86.0 112.0 135.0 144.0 77.0 141.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:59.50 stddev:10.15 (17.1%) stddev-sans-first:10.52 10:33:34 INFO - PROCESS | 1987 | Values: 56.0 56.0 56.0 59.0 59.0 60.0 59.0 62.0 64.0 90.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:76.50 stddev:7.47 (9.8%) stddev-sans-first:7.74 10:33:34 INFO - PROCESS | 1987 | Values: 68.0 75.0 68.0 82.0 79.0 78.0 70.0 58.0 80.0 68.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:84.50 stddev:10.01 (11.9%) stddev-sans-first:10.48 10:33:34 INFO - PROCESS | 1987 | Values: 84.0 83.0 86.0 85.0 93.0 107.0 88.0 84.0 103.0 73.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:151.00 stddev:24.18 (16.0%) stddev-sans-first:24.45 10:33:34 INFO - PROCESS | 1987 | Values: 135.0 141.0 135.0 137.0 149.0 153.0 147.0 169.0 209.0 182.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:2.64 (1.6%) stddev-sans-first:2.69 10:33:34 INFO - PROCESS | 1987 | Values: 163.0 165.0 164.0 167.0 165.0 160.0 167.0 170.0 165.0 165.0 10:33:34 INFO - PROCESS | 1987 | 10:33:34 INFO - PROCESS | 1987 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:80.50 stddev:9.59 (11.9%) stddev-sans-first:9.44 10:33:34 INFO - PROCESS | 1987 | Values: 67.0 69.0 65.0 80.0 90.0 86.0 89.0 81.0 67.0 77.0 10:33:34 INFO - PROCESS | 1987 | -------- Summary: end -------- 10:33:34 INFO - PROCESS | 1987 | 10:33:35 INFO - TEST-INFO | 1987: exit 0 10:33:35 INFO - TEST-OK | kraken | took 62007ms 10:33:35 INFO - SUITE-END | took 1175s 10:33:36 INFO - Completed test suite (00:19:36) 10:33:36 INFO - javascript benchmark 10:33:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7121.434802158243, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.8985430437087, 3478.6869181773645, 3500.7549471537004, 3507.6843084122424, 3557.5019497270387, 5684.346300175481, 5764.25064741583, 5781.277340332458, 5799.420057994198, 5803.390643982384, 4595.5634214749625, 5784.98762716525, 5790.971045144768, 5808.070708686611, 5874.5006674432725, 5224.921626175601, 5303.0, 5304.92042619361, 5339.038972984861, 5359.383670877841, 5370.7046112463795, 5397.946020539804, 5420.728963551826, 5424.1321388577835, 5451.972740136293, 5234.528892399683, 5238.5023422774775, 5376.731163441812, 5382.058139825534, 5383.919241211385, 5278.973605131969, 5326.866828329284, 5358.33020872391, 5386.622936394454, 5444.40111587725, 5162.638615296931, 5301.920471192935, 5322.20166974953, 5355.812546560891, 5362.195670649395, 5621.156826476021, 5762.4525670061275, 5772.653640781525, 5853.09277062056, 5958.433948774903, 6144.187464697925, 6144.893919094561, 6147.801178770142, 6182.629042257479, 6289.182406287199, 6286.151369565096, 6294.622322660609, 6297.6536290504, 6304.0, 6310.5898116622275, 5836.095405212199, 5861.41385861419, 5864.208331875185, 5873.177755114288, 5917.497012753965, 5177.430482646906, 6175.938240617626, 6191.566590338633, 6196.225471816023, 6230.657313847782, 6164.969175154096, 6198.504119670415, 6200.410960958701, 6203.6587987660205, 6243.7814676486105, 5332.33345831771, 6259.489543456483, 6267.5299352548745, 6273.62358258506, 6284.874302514016, 6059.182010428536, 6112.41229444207, 6131.162586540582, 6147.170132032208, 6213.751449941951, 6227.09707092469, 6269.96865015672, 6287.591306565058, 6291.811245662638, 6320.146780184708, 4260.55264197261, 4940.2342636891335, 5013.824516141917, 5027.271045698353, 5029.245613158056, 4397.34039894012, 4411.514733379326, 4435.955640443619, 4496.123255965055, 4514.525974772667, 5738.913916291259, 5809.88380232393, 5925.4074592541265, 5933.495652869468, 5936.406359364029, 6239.844003899848, 6252.187215662026, 6260.968695156495, 6272.18461599989, 6277.0, 5780.913286300709, 5800.854978625568, 5917.31950825652, 5953.672548009815, 5956.791512297049, 5499.945000549943, 5508.421615730371, 5512.972435137879, 5519.779208831682, 5521.0, 5124.205748109049, 6318.304986451395, 6319.431251187323, 6353.872922541524, 6364.809055728336, 6152.938470615237, 6162.322144564184, 6162.414570615784, 6182.258129024546, 6237.282712488122, 6335.65153916539, 6340.778072767431, 6343.841403964938, 6347.71435285404, 6354.745810167541, 6201.193844800147, 6267.0286105653695, 6275.748970041147, 6290.622562646256, 6302.180716506825, 6125.816225513242, 6132.447291485866, 6195.628262304276, 6281.842953926189, 6294.748210071546, 6150.907736383869, 6261.655608941552, 6262.060690896402, 6266.091416744638, 6277.403646653561, 6205.193324867739, 6269.059641053878, 6277.686115694106, 6279.246490421178, 6283.183186185766, 5783.797567085132, 5857.58996870232, 5927.673977931255, 6124.724387402489, 6138.386161383826, 6128.625347140905, 6156.907646385218, 6171.1360409543595, 6231.065340199007, 6299.149614802126, 5745.511631511368, 6099.359567245376, 6118.60229085108, 6119.2350956130485, 6143.662098584442], "value": 5750.140744795627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.4215394450325, 511.7594730476676, 536.1047051424123, 552.1827695011383, 558.6843433460094, 37074.25851482972, 39552.0, 39692.0, 39725.20549589006, 39773.80113099434, 41500.37749433753, 41521.584784152146, 42046.57953420465, 42129.36805947906, 42369.94075148123, 9630.470324132188, 9771.95114024429, 9805.31362804604, 9813.754656133582, 9837.311388202828, 9698.660546880861, 9701.320907536476, 9710.854337184948, 9729.270304727139, 9805.411675299505, 8302.501849888995, 9716.465594392306, 9731.270154738388, 9798.853017204749, 9812.90187098127, 9718.708438746778, 9722.659706910259, 9791.510424478818, 9794.559244834, 9809.509524523744, 9686.854697179548, 9690.515474226331, 9714.0, 9744.75638109046, 9815.558299876451, 39424.0, 39550.0, 39554.40668389977, 39839.60160398417, 39937.201255974716, 3150.2754366495833, 3345.3476572068457, 3588.3002814451193, 3739.6487419144564, 4035.9394609080887, 30743.0, 30875.845620771754, 30964.38071238585, 31109.098328837677, 31167.90912318058, 3173.7143657070974, 3201.9199520011953, 3260.2664400509934, 3273.1489812648647, 3365.3774051800497, 471593.0, 475713.0, 476043.61978190235, 476179.0, 485257.0, 58498.7075064622, 58666.706666466394, 58759.70620146872, 58845.0, 58984.0, 57797.71101144468, 60023.0, 61424.38575614187, 62008.0, 62186.0, 16495.91752041232, 16542.0901850397, 16725.498235052968, 16842.32630694783, 16898.493045208663, 11018.338899666045, 12928.03039772021, 13002.154859934264, 13183.736325273441, 13219.867801322056, 14080.718385632435, 14681.339339729524, 15287.464938727091, 15930.920345398199, 16017.759733604005, 6210.944139496297, 6617.239017512951, 6726.596404215763, 7434.814129646802, 7448.1434635016585, 849.1847826087026, 852.1989330029752, 991.0881988570533, 1027.3733022856052, 1051.8579991701022, 28921.96319386476, 29107.56338654922, 29592.704072959426, 29650.1104966847, 29933.25166870802, 1003.3829195045141, 1035.2287545778443, 1036.2383648018852, 1088.455772113943, 1123.7246874515633, 13231.669208269677, 15355.923220383827, 15518.534443966699, 15544.450158010623, 15597.610059748371, 623148.0, 639140.0, 639513.0, 639749.0, 640493.0, 57791.0, 58301.416985830445, 58471.0, 58590.70704646449, 58720.70639646774, 1355.8169647097516, 1375.4704438791136, 1393.1501783911806, 1396.9720605587831, 1397.0709478197089, 28663.856680716464, 29412.411751765274, 29471.0, 29593.85203073971, 30771.230719232197, 47841.5215847851, 48056.03887922152, 48166.0, 48187.5181248183, 48243.82902769314, 562916.0, 568196.0, 569788.0, 570472.0, 571525.0, 21421.78578214198, 25773.742262577136, 25838.870805646602, 26329.0, 26402.603960940218, 46077.539224607324, 46467.0, 47211.76394118008, 47746.0, 47925.76037119792, 34976.0, 35572.7549535765, 37668.43497347487, 37847.62152378441, 39537.406938896514, 27426.725732743216, 37558.43662345122, 37837.0, 38055.429168563045, 38183.61816381912, 35260.294794104484, 37516.62483375131, 38453.0, 38478.0, 39445.2110957785, 32847.0, 34044.829775851955, 34582.96251112471, 34660.0, 34689.959301221, 24125.155619553232, 25670.0, 25682.743172568036, 25826.35434114162, 26163.738362616892], "value": 19688.665565235322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.4616613418531, 371.65621799835145, 375.40310905659993, 386.4743948230404, 404.40552387989663, 19047.047647617634, 19443.708344374845, 19928.50178745532, 20140.0, 20338.983050847473, 11831.935125838672, 12025.579104731314, 19496.805031949676, 19543.60912781747, 19629.31297404591, 5318.707471089079, 5523.364813046491, 5535.335759708841, 5536.058869992091, 5554.833354999357, 5299.178627312754, 5982.8504287392725, 6041.516678665696, 6042.607230530023, 6066.817995460143, 5855.502282306009, 5916.053431450969, 5944.7324870380935, 5946.643201407907, 6000.2199714037115, 5930.88138237235, 6001.039833626599, 6006.069059295773, 6014.909776353358, 6024.825159093978, 5098.694078355274, 5312.0, 5345.492178243099, 5374.435684253136, 5374.838754837361, 13182.274974876378, 13300.733985320336, 13401.932990334986, 13430.664233394244, 13487.527936522272, 1933.8839669619867, 2726.3184203949013, 2786.70739572346, 2941.617589713345, 2956.674765775763, 9688.660896868647, 10136.695899123039, 10448.947755261252, 10452.581896724121, 10522.526486308134, 1892.7255547945472, 1894.5547796267865, 1902.857285703564, 1921.0, 2005.3783327168624, 122519.38740306241, 123715.0, 124852.0, 126678.0, 130480.04279935714, 10308.0, 10732.819389867109, 11763.117766167572, 11817.645470635895, 11980.460879260454, 14602.12387256768, 14770.335334909954, 14917.850821491864, 14931.477398291225, 14934.178620175995, 8468.661253549912, 8675.132486751401, 8709.346798990102, 8782.560871956504, 8801.735947921572, 6956.373926346653, 8637.222649961534, 8648.26489748366, 8714.346424018097, 8737.21365077146, 4498.370228168059, 4542.88642783933, 4570.8171673133365, 4629.722216667011, 4730.337752714623, 1926.248762982438, 1929.6623090959026, 1971.8619696621386, 1979.6634572122773, 1990.8407327413772, 369.3923495849313, 807.9515229086273, 858.9699360522352, 901.3195037746459, 915.158054589779, 11029.669109926715, 11891.405429728478, 11900.940495297642, 11908.0, 12018.399080045963, 421.37425922505054, 430.9353596960418, 443.76702231328164, 447.6709618430451, 461.0686413444823, 10812.0, 11051.850222686497, 11760.58837940668, 11817.763644727229, 12044.81932771009, 305175.0, 307178.0, 307189.0, 307372.0, 629543.0, 110259.0, 113586.0, 118513.40743296228, 119512.0, 126192.1071183933, 965.7392504024015, 994.264244459095, 997.2670087485692, 1009.258195226508, 1011.2567263061644, 18538.351157709414, 18770.812291877453, 18849.340273090376, 18888.15003324826, 18901.621967560848, 36731.163441828336, 38223.80888095542, 50054.74972625114, 50126.74683132951, 53043.20435193398, 72999.27000729924, 75773.96904123774, 78568.0, 79690.20309796827, 80761.0, 5758.683272420057, 7347.26527347261, 7419.517731347445, 7434.4795864291145, 7638.770836874903, 9550.665726699532, 10273.589056437957, 12315.322657253937, 12454.501819927102, 12652.17760845542, 9559.474228917476, 10088.54601542947, 10783.784324313312, 10958.342499450058, 10990.945045274722, 9474.810503790024, 10624.309419887682, 10716.089132423831, 10801.621943231949, 10805.351678899291, 10958.397288149228, 10963.83554246671, 11063.004329610052, 11081.445927703744, 11385.487653055798, 6816.943373777072, 6817.488688348294, 7266.636668166676, 7277.963610181915, 8256.711015114442, 8967.0, 10591.364518128938, 10704.197185210984, 10786.298890572089, 10900.781984360427], "value": 8721.15030908184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.7012672148767, 1484.547213100004, 1535.5853919441759, 1635.1252080137122, 1751.4482937874577, 7605.391568674507, 7852.097008843971, 8134.959325203373, 8507.91492085079, 8525.658973641062, 8064.959675201616, 8337.666493340274, 8347.0, 8462.53456059918, 8480.491170529773, 2367.7632236776312, 2387.6776635154292, 2396.664466974616, 2399.664047033417, 2402.8318017738766, 2388.653645221442, 2412.2763171048614, 2422.0432928993037, 2435.427674496492, 2437.4515733959806, 2078.490769761411, 2284.154862700803, 2366.810655147584, 2388.5103553771437, 2393.2939782764124, 2344.2146880794867, 2351.95296094078, 2356.15178535727, 2369.478714682767, 2391.5456063347997, 2364.3616223619524, 2376.7147942247043, 2384.403899025244, 2388.581998150334, 2401.3396316013063, 8369.246767790868, 8424.283935865458, 8491.74524764258, 8538.146185381413, 8543.95728021362, 5107.872303192413, 5245.606579506514, 5264.210368444764, 5270.894582108336, 5303.0, 2921.5033444314304, 3462.255615042778, 3513.2973405318785, 3525.065857547752, 3571.607123216444, 1027.0705011964185, 1035.6323505155713, 1071.983920241197, 1081.2485322700727, 1082.5994382078682, 10888.564457421693, 10923.508442120125, 10931.672049838518, 10963.177761667826, 10978.945105274503, 3851.2105018471148, 4494.5505449454795, 4688.5545873142, 4695.81216751333, 4761.666683332202, 9552.522373881278, 9558.856617150748, 9568.56941437637, 9570.808583828284, 9570.856437153448, 4479.977600111979, 5204.141316682705, 5214.843554693365, 5260.368755749258, 5302.257683924254, 4327.502337231196, 4402.58787966457, 4682.157211701926, 4792.880177995578, 4891.388576427947, 3190.2502911815704, 3863.092173339263, 3880.3015457217407, 3905.2189562087697, 3991.0, 1250.056207563302, 1275.7002104505434, 1281.2568710148091, 1283.9871601284055, 1298.1367390685277, 721.5923003503004, 764.2663043478212, 801.5190885468672, 863.9870401943975, 891.6166048599035, 4651.395318608559, 5529.585281103933, 5552.583556233299, 5647.37878833328, 5699.4585514376895, 364.9069487280726, 417.0116823129143, 418.25341764949417, 422.204145186326, 427.65573713161206, 3475.63505831884, 3648.7776594841025, 3736.5142531470733, 3738.794366309879, 3768.679662228741, 9896.307258491837, 10277.537510812032, 10294.794104117876, 10296.382217067, 10331.535080921376, 9669.70990870275, 10196.38821670702, 10242.436665983294, 10301.53643086063, 10306.433146176882, 6637.336266373324, 7908.565028923349, 7952.244536769113, 7952.602369881482, 8006.119326874039, 5446.891062178655, 5505.146702261156, 5584.86037849057, 5584.972075139598, 5618.6628802272, 9263.76840578991, 9300.534973251446, 9383.343165978316, 9420.528973551158, 9486.098820612031, 9443.433393996382, 9469.431834089977, 9482.19401350893, 9560.235181185628, 9574.808503830023, 6558.475321974326, 6783.016462612794, 7126.572405655677, 7221.061262035902, 7514.436417268617, 7744.728934487266, 7876.369890408868, 7970.083440404196, 7976.202379761978, 7984.0, 7011.0, 7267.709291628275, 7268.164161121327, 7277.345038946521, 7284.635768211674, 6501.382368674968, 6531.0, 6884.51808373409, 7076.25699301566, 7134.643267836484, 6458.22501299847, 6629.270780214269, 6724.663766811737, 6729.2934241903895, 6795.558288711218, 4782.7847746850775, 4796.712197268175, 4861.51384861511, 4865.343178670834, 4874.6344024197615, 4657.371254880548, 4674.462436819809, 4701.553352431513, 4794.664373493822, 4880.46314905353], "value": 4316.598876744051, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.41029991516535, 313.7756504099569, 313.9874405023799, 317.67279701907046, 317.741041051543, 4549.976255342551, 4760.2859571064355, 5407.24298598196, 5421.9457805421935, 5442.863928401792, 4383.232934236504, 4712.787924543395, 5009.474005229453, 5255.608698042391, 5375.892482150354, 3578.2843431313713, 3781.4894989176523, 4152.709310348277, 4154.774341569229, 4189.3087640539425, 3716.089558058266, 4034.9912521869533, 4073.63337299643, 4091.0, 4196.803910885398, 4054.3918412238254, 4088.0974508099284, 4093.263212621727, 4107.158032603309, 4113.177364527107, 3756.7370284080125, 4071.3282308419075, 4082.1223436961195, 4108.424820525129, 4115.650169735576, 2748.2579703480146, 3225.2581906161713, 3416.26550291686, 3602.657747513982, 3619.239959608485, 4584.67044557078, 4948.703077815307, 5249.186376111671, 5267.710275934822, 5284.1465608571325, 4614.284785858197, 4656.022235330584, 4675.976620116878, 4678.578927896506, 4680.3681502997, 5411.242426060355, 5585.245991791137, 5608.383077861432, 5619.775208991636, 5628.7766332298925, 3263.400933542571, 3693.169036966688, 3867.361885288924, 3886.7667939923695, 3893.240818040483, 5299.8410047698635, 5901.940980590182, 5909.4090590941, 5938.495227905633, 5954.583179177459, 3082.9075127746205, 3769.1896242308035, 3794.317022935898, 3933.645971862546, 4017.5580686124504, 3952.5849785772657, 3954.0822700989997, 3967.8809635710977, 3975.6223158799867, 3992.923679686605, 4603.700759450625, 4604.608608268268, 4615.215413379734, 4639.280911458729, 4654.674172807939, 4790.826247569368, 5315.817078348579, 5673.149027645886, 5689.800856970069, 5702.407483285504, 1114.6011755247114, 1154.839386416646, 1197.1560050164612, 1291.4059532614915, 1293.224065560656, 812.7118517150265, 849.222960990699, 859.7233108833377, 881.850085485469, 886.9866951995725, 4526.502084770673, 5056.0, 5078.958813443235, 5109.514596113363, 5118.564921981673, 4315.05822379924, 4864.038680545824, 4943.406791185081, 5081.415637201769, 5248.921266181011, 4132.752034877917, 4287.656987440997, 4307.590778876001, 4529.230030894756, 5139.177731562932, 2706.687256680508, 2835.2911772056987, 2892.8284044961824, 2898.7391134797967, 2930.384619229943, 4860.416749990024, 5451.836444906659, 5490.3411590609385, 5725.255716756878, 5765.654060756368, 5426.534835594446, 5674.97162514193, 5679.858003549944, 5724.227229323988, 5758.88482230353, 5541.639793413416, 6004.369541198199, 6062.787802426894, 6065.848353791191, 6106.755729770848, 5863.970680146572, 5891.263592050994, 5897.319264009737, 5906.70466476683, 5907.0, 5035.345405097461, 5454.3818966895315, 5744.4829965303325, 5815.011448053926, 5839.7372118255635, 4738.028704115579, 5031.52200540948, 5923.881522369615, 6033.336333003454, 6105.9694701526205, 3722.6277372262557, 3786.450964610171, 3796.696264298794, 3813.7521061130938, 3882.845021013252, 5555.833325000095, 5809.356742682154, 5819.79630712923, 5823.35943046273, 5842.649441033552, 5150.0, 5658.773649053992, 5668.829935101953, 5683.396448876423, 5715.085586306171, 4810.735409552508, 5294.293994203996, 5365.624406291522, 5721.884232574608, 5754.079347304411, 4489.595936365743, 5583.330000399816, 5586.636868603528, 5589.524890384363, 5615.522680572034, 5443.0, 5640.88718225625, 5668.404817494269, 5684.039006542736, 5706.487780738191, 4722.291656251589, 5454.699991500505, 5496.120620700669, 5555.666580067554, 5586.972065139648], "value": 4065.8891677310035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.5480550628325, 682.3858527325409, 707.5648476187147, 722.8409749855032, 796.2913007423394, 14522.491712790055, 15376.538703838904, 15387.92306038471, 15390.769138462903, 15419.0, 13937.860621393784, 13951.790723139162, 13959.860401395983, 14029.017968742166, 14070.788938165935, 671.3990978074609, 705.9294070592925, 833.6623667414707, 850.5194565070715, 872.6596627315353, 843.4981186194235, 847.7287268074218, 861.5304658960881, 866.0473479172922, 867.405827008498, 916.4592890194783, 921.0007142250666, 921.216965579259, 923.1829830599934, 924.7364501117183, 886.3618194899661, 915.0620613870802, 916.4592890194783, 918.8024574716401, 919.9908000920005, 664.385443464798, 678.759040540606, 683.8392977650249, 686.0703746423574, 687.3950923187613, 14303.570892873231, 14414.351354189086, 14479.131252124906, 14487.710245795026, 15031.924840375728, 14177.220252886087, 14347.847624708991, 14416.207108609022, 14461.710765784625, 14741.336639851232, 9482.762930926712, 10556.049955504042, 10809.83785243222, 10858.61994830185, 11016.669499915015, 3601.081724160322, 3644.1071937375514, 3751.437284407361, 3813.504244448232, 3816.637419445148, 99645.0, 99959.0, 100132.0, 100196.49705254428, 100395.99604003939, 10052.246081543914, 10268.794624107475, 10321.122704570196, 10329.9483502582, 10347.247453004331, 16029.759553606706, 17624.20691068905, 19141.0, 19180.328688495836, 19327.323543676186, 7373.5575865448245, 7654.2345765423015, 7673.769786906401, 7708.461890638446, 7869.567173805495, 4371.475422949266, 4397.692161548661, 4424.756638384855, 4473.0, 4583.72497650142, 2971.925701857471, 3378.459446488599, 3490.4415293553416, 3492.6681965213265, 3505.211327451303, 626.8464226264595, 636.0173531893236, 646.6863571167979, 648.4909346163239, 655.9508036897251, 584.8596336879203, 645.5868244323636, 647.795944277551, 651.7523341130341, 669.2604671837549, 7621.618919054025, 8007.159248278964, 8570.571771291534, 9126.133017363472, 9211.309151813506, 651.3681728723132, 658.52478600413, 663.6880666086931, 667.732906837269, 675.6959368284291, 4280.486341638961, 4463.687541872037, 4485.215087359699, 4502.909941801211, 4661.230896901973, 118919.40540297417, 122570.0, 126170.73829261774, 128198.35900820623, 130733.0, 94543.0, 108570.45714771375, 112152.4392378033, 114164.42917785358, 115269.4236528812, 95502.5224873885, 97077.0, 97321.51339243258, 99525.50237248912, 99793.0, 8739.169778870997, 8752.34357423183, 8807.823843523222, 8827.205551500396, 8830.867536986822, 54813.725931370085, 62474.68762656158, 62481.68759156175, 62840.05739913813, 63709.0, 72162.63918680583, 72991.63504182445, 74135.62932185305, 79674.80487792804, 80730.19269807462, 12580.245185288912, 12953.740925181632, 12961.0, 12977.740445191232, 13437.932810335886, 13896.888248939858, 14317.498887538886, 14372.49696260626, 14528.418863245352, 14767.0, 12277.20198187115, 13593.79609305881, 13710.931445342709, 13784.517541885985, 14194.3612537434, 13628.386722597308, 13629.386677599334, 13894.583162505141, 13975.860241397455, 14251.714965700836, 11003.449827508754, 12938.159019663692, 13054.477820887058, 13188.540614755648, 13287.933560332136, 11189.608363707232, 11816.172867899164, 11844.466998984894, 11857.16999810005, 11948.940255299016, 11192.328460292409, 11565.884341156818, 11610.24533405326, 11696.181267311207, 11908.583199587973], "value": 7526.493054000923, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 138.0, 141.0, 138.0, 102.0, 110.0, 97.0, 173.0, 171.0, 94.0], "value": 125.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 98.0, 101.0, 136.0, 119.0, 147.0, 142.0, 122.0, 175.0, 113.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 256.0, 280.0, 260.0, 227.0, 278.0, 275.0, 194.0, 223.0, 184.0], "value": 238.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 87.0, 69.0, 60.0, 58.0, 60.0, 79.0, 62.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 74.0, 109.0, 62.0, 82.0, 94.0, 123.0, 101.0, 103.0, 96.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 102.0, 89.0, 90.0, 88.0, 92.0, 89.0, 90.0, 87.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 103.0, 109.0, 169.0, 130.0, 101.0, 103.0, 100.0, 100.0, 103.0], "value": 111.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 87.0, 87.0, 86.0, 112.0, 135.0, 144.0, 77.0, 141.0], "value": 114.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 59.0, 59.0, 60.0, 59.0, 62.0, 64.0, 90.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 68.0, 82.0, 79.0, 78.0, 70.0, 58.0, 80.0, 68.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 86.0, 85.0, 93.0, 107.0, 88.0, 84.0, 103.0, 73.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 135.0, 137.0, 149.0, 153.0, 147.0, 169.0, 209.0, 182.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 167.0, 165.0, 160.0, 167.0, 170.0, 165.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 80.0, 90.0, 86.0, 89.0, 81.0, 67.0, 77.0], "value": 77.1, "unit": "score"}]}]} 10:33:36 INFO - Return code: 0 10:33:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:33:36 ERROR - # TBPL SUCCESS # 10:33:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:36 INFO - 2017-02-13 10:33:36.204 screenresolution[1992:13376] starting screenresolution argv=screenresolution get 10:33:36 INFO - 2017-02-13 10:33:36.206 screenresolution[1992:13376] Display 0: 1600x1200x32@60 10:33:36 INFO - 2017-02-13 10:33:36.212 screenresolution[1993:13379] starting screenresolution argv=screenresolution list 10:33:36 INFO - Available Modes on Display 0 10:33:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:36 INFO - Intel Iris: 10:33:36 INFO - Chipset Model: Intel Iris 10:33:36 INFO - Type: GPU 10:33:36 INFO - Bus: Built-In 10:33:36 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:36 INFO - Vendor: Intel (0x8086) 10:33:36 INFO - Device ID: 0x0a2e 10:33:36 INFO - Revision ID: 0x0009 10:33:36 INFO - Displays: 10:33:36 INFO - Display: 10:33:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:36 INFO - Display Serial Number: 1600x1200 60 10:33:36 INFO - Main Display: Yes 10:33:36 INFO - Mirror: Off 10:33:36 INFO - Online: Yes 10:33:36 INFO - Rotation: Supported 10:33:36 INFO - Return code: 0 10:33:36 INFO - Running post-action listener: _resource_record_post_action 10:33:36 INFO - [mozharness: 2017-02-13 18:33:36.448580Z] Finished run-tests step (success) 10:33:36 INFO - Running post-run listener: _resource_record_post_run 10:33:36 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 1795072; Write bytes: 503377408; Read time: 21; Write time: 1847 10:33:36 INFO - TinderboxPrint: CPU usage
54.1% 10:33:36 INFO - TinderboxPrint: I/O read bytes / time
1,795,072 / 21 10:33:36 INFO - TinderboxPrint: I/O write bytes / time
503,377,408 / 1,847 10:33:36 INFO - TinderboxPrint: CPU idle
2,198.6 (45.9%) 10:33:36 INFO - TinderboxPrint: CPU system
970.5 (20.2%) 10:33:36 INFO - TinderboxPrint: CPU user
1,624.6 (33.9%) 10:33:36 INFO - TinderboxPrint: Swap in / out
193,548,288 / 0 10:33:36 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183003648; Write bytes: 175550464; Read time: 16803; Write time: 310 10:33:36 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1795072; Write bytes: 311139840; Read time: 21; Write time: 1487 10:33:36 INFO - Running post-run listener: _upload_blobber_files 10:33:36 INFO - Blob upload gear active. 10:33:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:36 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 10:33:36 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'] 10:33:36 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 10:33:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:38 INFO - (blobuploader) - INFO - Done attempting. 10:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:39 INFO - (blobuploader) - INFO - Done attempting. 10:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:41 INFO - (blobuploader) - INFO - Done attempting. 10:33:41 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:41 INFO - Return code: 0 10:33:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba35066e07ea8c95027eadeeb204dbff33c39f1f9c33836d132ea4fa63b0e912ee5bc064b94c0459b015b7ca76e119b840dbdce4aee46c5487b6de253fc108c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/753d3a7a2e0a88ca6469f5d62178d9ec2f9cfa8856400440895387f886b4c5cd7dcb5ceaaad84fd3c62794cc395ade6e937302a2c3e4bbe7c9a2ea89a428d05f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b48c2c49c01049457a0ba56405498d38a69417b71d33746c148dae0c9a9ed181129fb39836edca08186a9c30b3e0acf4ddda1582350f231c1721fb920a53c04"} 10:33:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:41 INFO - Contents: 10:33:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba35066e07ea8c95027eadeeb204dbff33c39f1f9c33836d132ea4fa63b0e912ee5bc064b94c0459b015b7ca76e119b840dbdce4aee46c5487b6de253fc108c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/753d3a7a2e0a88ca6469f5d62178d9ec2f9cfa8856400440895387f886b4c5cd7dcb5ceaaad84fd3c62794cc395ade6e937302a2c3e4bbe7c9a2ea89a428d05f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b48c2c49c01049457a0ba56405498d38a69417b71d33746c148dae0c9a9ed181129fb39836edca08186a9c30b3e0acf4ddda1582350f231c1721fb920a53c04"} 10:33:41 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:41 INFO - Copying logs to upload dir... 10:33:41 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.525042 ========= master_lag: 3.18 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-13 10:33:44.656220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-02-13 10:33:44.664957) ========= 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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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/ba35066e07ea8c95027eadeeb204dbff33c39f1f9c33836d132ea4fa63b0e912ee5bc064b94c0459b015b7ca76e119b840dbdce4aee46c5487b6de253fc108c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/753d3a7a2e0a88ca6469f5d62178d9ec2f9cfa8856400440895387f886b4c5cd7dcb5ceaaad84fd3c62794cc395ade6e937302a2c3e4bbe7c9a2ea89a428d05f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b48c2c49c01049457a0ba56405498d38a69417b71d33746c148dae0c9a9ed181129fb39836edca08186a9c30b3e0acf4ddda1582350f231c1721fb920a53c04"} build_url:https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010978 build_url: 'https://queue.taskcluster.net/v1/task/apKqd6M8SPent4aoukwHxA/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/ba35066e07ea8c95027eadeeb204dbff33c39f1f9c33836d132ea4fa63b0e912ee5bc064b94c0459b015b7ca76e119b840dbdce4aee46c5487b6de253fc108c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/753d3a7a2e0a88ca6469f5d62178d9ec2f9cfa8856400440895387f886b4c5cd7dcb5ceaaad84fd3c62794cc395ade6e937302a2c3e4bbe7c9a2ea89a428d05f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b48c2c49c01049457a0ba56405498d38a69417b71d33746c148dae0c9a9ed181129fb39836edca08186a9c30b3e0acf4ddda1582350f231c1721fb920a53c04"}' ========= master_lag: 1.78 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-02-13 10:33:46.453413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 10:33:46.453812) ========= 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.UlEtZyUkTq/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.zdnWyOs0FU/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005249 ========= master_lag: 0.25 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 10:33:46.712964) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 10:33:46.713365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 10:33:46.721605) ========= ========= Total master_lag: 5.29 =========