builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0360 starttime: 1484087405.41 results: success (0) buildid: 20170110132304 builduid: c3ae05dd9d954449b954bfb71fab2e50 revision: d173a8f450cfb713f2f076d5571b723a3e9637f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.410337) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.410882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.411191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.441157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.441578) ========= 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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-10 14:30:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-01-10 14:30:05 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.574484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.574884) ========= 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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.020182 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:05.624283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-10 14:30:05.624729) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d173a8f450cfb713f2f076d5571b723a3e9637f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d173a8f450cfb713f2f076d5571b723a3e9637f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VMIe6E6Lza/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.5xyfWPaqTw/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-10 14:30:05,710 truncating revision to first 12 chars 2017-01-10 14:30:05,710 Setting DEBUG logging. 2017-01-10 14:30:05,710 attempt 1/10 2017-01-10 14:30:05,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d173a8f450cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 14:30:06,869 unpacking tar archive at: mozilla-aurora-d173a8f450cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.420476 ========= master_lag: 2.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-01-10 14:30:09.573508) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:09.573932) ========= script_repo_revision: d173a8f450cfb713f2f076d5571b723a3e9637f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 14:30:09.574421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-01-10 14:30:09.574704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-01-10 14:30:10.695194) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-10 14:30:10.695651) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VMIe6E6Lza/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.5xyfWPaqTw/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30:10 INFO - MultiFileLogger online at 20170110 14:30:10 in /builds/slave/test 14:30:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:30:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:10 INFO - {'append_to_log': False, 14:30:10 INFO - 'base_work_dir': '/builds/slave/test', 14:30:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:30:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:10 INFO - 'branch': 'Mozilla-Aurora', 14:30:10 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:10 INFO - 'config_files': ('talos/mac_config.py',), 14:30:10 INFO - 'default_actions': ('clobber', 14:30:10 INFO - 'read-buildbot-config', 14:30:10 INFO - 'download-and-extract', 14:30:10 INFO - 'populate-webroot', 14:30:10 INFO - 'create-virtualenv', 14:30:10 INFO - 'install', 14:30:10 INFO - 'run-tests'), 14:30:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:10 INFO - 'download_minidump_stackwalk': True, 14:30:10 INFO - 'download_symbols': 'ondemand', 14:30:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:10 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:10 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:10 INFO - 'installer_path': 'installer.exe', 14:30:10 INFO - 'log_level': 'info', 14:30:10 INFO - 'log_name': 'talos', 14:30:10 INFO - 'log_to_console': True, 14:30:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:30:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:30:10 INFO - 'opt_config_files': (), 14:30:10 INFO - 'pip_index': False, 14:30:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:30:10 INFO - 'cmd': ('bash', 14:30:10 INFO - '-c', 14:30:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:30:10 INFO - 'enabled': True, 14:30:10 INFO - 'halt_on_failure': False, 14:30:10 INFO - 'name': 'check_screen_resolution'},), 14:30:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:30:10 INFO - 'cmd': ('bash', 14:30:10 INFO - '-c', 14:30:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:30:10 INFO - 'enabled': True, 14:30:10 INFO - 'halt_on_failure': False, 14:30:10 INFO - 'name': 'check_screen_resolution'},), 14:30:10 INFO - 'run_cmd_checks_enabled': True, 14:30:10 INFO - 'sps_profile': False, 14:30:10 INFO - 'sps_profile_interval': 0, 14:30:10 INFO - 'suite': 'dromaeojs-e10s', 14:30:10 INFO - 'system_bits': '32', 14:30:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:10 INFO - 'title': 't-yosemite-r7-0360', 14:30:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:10 INFO - 'use_talos_json': True, 14:30:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:10 INFO - 'work_dir': 'build'} 14:30:10 INFO - [mozharness: 2017-01-10 22:30:10.905284Z] Running clobber step. 14:30:10 INFO - Running pre-action listener: _resource_record_pre_action 14:30:10 INFO - Running main action method: clobber 14:30:10 INFO - rmtree: /builds/slave/test/build 14:30:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:12 INFO - Running post-action listener: _resource_record_post_action 14:30:12 INFO - [mozharness: 2017-01-10 22:30:12.430951Z] Finished clobber step (success) 14:30:12 INFO - [mozharness: 2017-01-10 22:30:12.431128Z] Running read-buildbot-config step. 14:30:12 INFO - Running pre-action listener: _resource_record_pre_action 14:30:12 INFO - Running main action method: read_buildbot_config 14:30:12 INFO - Using buildbot properties: 14:30:12 INFO - { 14:30:12 INFO - "project": "", 14:30:12 INFO - "product": "firefox", 14:30:12 INFO - "script_repo_revision": "production", 14:30:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:30:12 INFO - "repository": "", 14:30:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:30:12 INFO - "buildid": "20170110132304", 14:30:12 INFO - "pgo_build": "False", 14:30:12 INFO - "basedir": "/builds/slave/test", 14:30:12 INFO - "buildnumber": 3, 14:30:12 INFO - "slavename": "t-yosemite-r7-0360", 14:30:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:30:12 INFO - "platform": "yosemite_r7", 14:30:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:30:12 INFO - "branch": "mozilla-aurora", 14:30:12 INFO - "repo_path": "releases/mozilla-aurora", 14:30:12 INFO - "revision": "d173a8f450cfb713f2f076d5571b723a3e9637f5", 14:30:12 INFO - "stage_platform": "macosx64", 14:30:12 INFO - "builduid": "c3ae05dd9d954449b954bfb71fab2e50", 14:30:12 INFO - "slavebuilddir": "test" 14:30:12 INFO - } 14:30:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 14:30:12 INFO - Running post-action listener: _resource_record_post_action 14:30:12 INFO - [mozharness: 2017-01-10 22:30:12.435254Z] Finished read-buildbot-config step (success) 14:30:12 INFO - [mozharness: 2017-01-10 22:30:12.435409Z] Running download-and-extract step. 14:30:12 INFO - Running pre-action listener: _resource_record_pre_action 14:30:12 INFO - Running main action method: download_and_extract 14:30:12 INFO - mkdir: /builds/slave/test/build/tests 14:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:12 INFO - trying https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 14:30:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 14:30:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 14:30:13 INFO - Downloaded 1199 bytes. 14:30:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 14:30:13 INFO - Using the following test package requirements: 14:30:13 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 14:30:13 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 14:30:13 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 14:30:13 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'jsshell-mac.zip'], 14:30:13 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 14:30:13 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 14:30:13 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 14:30:13 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 14:30:13 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 14:30:13 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 14:30:13 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 14:30:13 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:30:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 14:30:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:30:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 14:30:14 INFO - Http code: 200 14:30:14 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 14:30:14 INFO - x-amz-cf-id: N8WCje6MvOSf8_BW67Uosap8cMrcvjzgn2YFT0T0rfIDUc7fMyvPdg== 14:30:14 INFO - x-amz-version-id: 3SmgBhbv.1uFmOg1m7ZIXDW9fkQJXEK0 14:30:14 INFO - Expected file size: 16271690 14:30:14 INFO - Obtained file size: 16271690 14:30:21 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:30:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 14:30:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:30:21 INFO - Fetch https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 14:30:21 INFO - Http code: 200 14:30:21 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 14:30:21 INFO - x-amz-cf-id: Sp0kLpRbRoA3nkv0Bw8M79SXi1wK8AWy6ywg00DS0bBeGH4sjvNOKg== 14:30:21 INFO - x-amz-version-id: 3SmgBhbv.1uFmOg1m7ZIXDW9fkQJXEK0 14:30:22 INFO - Expected file size: 16271690 14:30:22 INFO - Obtained file size: 16271690 14:30:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 14:30:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:30:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 14:30:28 INFO - Http code: 200 14:30:28 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 14:30:28 INFO - x-amz-cf-id: la3p5zDjFRWMVq7HCIVRt6wSLylUNeKmn24rCrkvd9kawWzPZD0bEw== 14:30:28 INFO - x-amz-version-id: 4wJfBJoLIZgWowpj2yfgaePsS0h3fXc. 14:30:29 INFO - Expected file size: 14409038 14:30:29 INFO - Obtained file size: 14409038 14:30:29 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')]} 14:30:29 INFO - trying https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 14:30:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 14:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 14:30:32 INFO - Downloaded 109865801 bytes. 14:30:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 14:30:32 INFO - mkdir: /builds/slave/test/properties 14:30:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:32 INFO - Contents: 14:30:32 INFO - build_url:https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 14:30:33 INFO - Running post-action listener: _resource_record_post_action 14:30:33 INFO - Running post-action listener: set_extra_try_arguments 14:30:33 INFO - [mozharness: 2017-01-10 22:30:33.304273Z] Finished download-and-extract step (success) 14:30:33 INFO - [mozharness: 2017-01-10 22:30:33.304428Z] Running populate-webroot step. 14:30:33 INFO - Running pre-action listener: _resource_record_pre_action 14:30:33 INFO - Running main action method: populate_webroot 14:30:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:33 INFO - '--tppagecycles', 14:30:33 INFO - '7'], 14:30:33 INFO - 'tests': ['tsvgm']}}, 14:30:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:30:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:30:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:30:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['damp', 'tps']}, 14:30:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'tests': ['damp', 'tps']}, 14:30:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['dromaeo_dom']}, 14:30:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['basic_compositor_video']}, 14:30:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:30:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['a11yr', 14:30:33 INFO - 'ts_paint', 14:30:33 INFO - 'tpaint', 14:30:33 INFO - 'sessionrestore', 14:30:33 INFO - 'sessionrestore_no_auto_restore', 14:30:33 INFO - 'tabpaint']}, 14:30:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:30:33 INFO - 'ts_paint', 14:30:33 INFO - 'tpaint', 14:30:33 INFO - 'sessionrestore', 14:30:33 INFO - 'sessionrestore_no_auto_restore', 14:30:33 INFO - 'tabpaint']}, 14:30:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:30:33 INFO - 'ts_paint', 14:30:33 INFO - 'tpaint', 14:30:33 INFO - 'sessionrestore', 14:30:33 INFO - 'sessionrestore_no_auto_restore', 14:30:33 INFO - 'tabpaint']}, 14:30:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:30:33 INFO - 'ts_paint', 14:30:33 INFO - 'tpaint', 14:30:33 INFO - 'sessionrestore', 14:30:33 INFO - 'sessionrestore_no_auto_restore', 14:30:33 INFO - 'tabpaint']}, 14:30:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['a11yr', 14:30:33 INFO - 'ts_paint', 14:30:33 INFO - 'tpaint', 14:30:33 INFO - 'sessionrestore', 14:30:33 INFO - 'sessionrestore_no_auto_restore', 14:30:33 INFO - 'tabpaint']}, 14:30:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['a11yr', 14:30:33 INFO - 'ts_paint', 14:30:33 INFO - 'tpaint', 14:30:33 INFO - 'sessionrestore', 14:30:33 INFO - 'sessionrestore_no_auto_restore', 14:30:33 INFO - 'tabpaint']}, 14:30:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['tsvgx', 14:30:33 INFO - 'tsvgr_opacity', 14:30:33 INFO - 'tart', 14:30:33 INFO - 'tscrollx', 14:30:33 INFO - 'cart']}, 14:30:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:30:33 INFO - 'tsvgr_opacity', 14:30:33 INFO - 'tart', 14:30:33 INFO - 'tscrollx', 14:30:33 INFO - 'cart']}, 14:30:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'talos_options': ['--disable-e10s'], 14:30:33 INFO - 'tests': ['tp5o']}, 14:30:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'tests': ['tp5o']}, 14:30:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'talos_options': ['--disable-e10s', 14:30:33 INFO - '--xperf_path', 14:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:33 INFO - 'tests': ['tp5n']}, 14:30:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:33 INFO - 'talos_options': ['--xperf_path', 14:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:33 INFO - 'tests': ['tp5n']}}, 14:30:33 INFO - 'talos.zip': {'path': '', 14:30:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:33 INFO - Running post-action listener: _resource_record_post_action 14:30:33 INFO - [mozharness: 2017-01-10 22:30:33.323809Z] Finished populate-webroot step (success) 14:30:33 INFO - [mozharness: 2017-01-10 22:30:33.323949Z] Running create-virtualenv step. 14:30:33 INFO - Running pre-action listener: _resource_record_pre_action 14:30:33 INFO - Running main action method: create_virtualenv 14:30:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:33 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 14:30:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:33 INFO - Using real prefix '/tools/python27' 14:30:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:37 INFO - Installing pip.................done. 14:30:37 INFO - Return code: 0 14:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:30:37 INFO - Reading from file tmpfile_stdout 14:30:37 INFO - Output received: 14:30:37 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) 14:30:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30:37 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')]} 14:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:37 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')]} 14:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30: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', 'pip>=1.5'] in /builds/slave/test/build 14:30: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 pip>=1.5 14:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:37 INFO - 'HOME': '/Users/cltbld', 14:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:37 INFO - 'LOGNAME': 'cltbld', 14:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:37 INFO - 'MOZ_NO_REMOTE': '1', 14:30:37 INFO - 'NO_EM_RESTART': '1', 14:30:37 INFO - 'PAGER': '/bin/cat', 14:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:37 INFO - 'PWD': '/builds/slave/test', 14:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:37 INFO - 'SHELL': '/bin/bash', 14:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:30:37 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:37 INFO - 'USER': 'cltbld', 14:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:37 INFO - 'XPC_FLAGS': '0x0', 14:30:37 INFO - 'XPC_SERVICE_NAME': '0', 14:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:37 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 14:30:37 INFO - Cleaning up... 14:30:37 INFO - Return code: 0 14:30:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:30:37 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')]} 14:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:37 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')]} 14:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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', '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 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:30: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 psutil>=3.1.1 14:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:37 INFO - 'HOME': '/Users/cltbld', 14:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:37 INFO - 'LOGNAME': 'cltbld', 14:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:37 INFO - 'MOZ_NO_REMOTE': '1', 14:30:37 INFO - 'NO_EM_RESTART': '1', 14:30:37 INFO - 'PAGER': '/bin/cat', 14:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:37 INFO - 'PWD': '/builds/slave/test', 14:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:37 INFO - 'SHELL': '/bin/bash', 14:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:30:37 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:37 INFO - 'USER': 'cltbld', 14:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:37 INFO - 'XPC_FLAGS': '0x0', 14:30:37 INFO - 'XPC_SERVICE_NAME': '0', 14:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:37 INFO - Downloading/unpacking psutil>=3.1.1 14:30:37 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 14:30:37 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 14:30:37 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 14:30:37 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 14:30:37 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 14:30:37 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 14:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:41 INFO - Installing collected packages: psutil 14:30:41 INFO - Running setup.py install for psutil 14:30:41 INFO - building 'psutil._psutil_osx' extension 14:30:41 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 14:30:41 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 14:30:41 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 14:30:42 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 14:30:42 INFO - building 'psutil._psutil_posix' extension 14:30:42 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 14:30:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:30:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:30:42 INFO - ^ 14:30:42 INFO - 1 warning generated. 14:30:42 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 14:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:42 INFO - Successfully installed psutil 14:30:42 INFO - Cleaning up... 14:30:42 INFO - Return code: 0 14:30:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:42 INFO - 'HOME': '/Users/cltbld', 14:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:42 INFO - 'LOGNAME': 'cltbld', 14:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:42 INFO - 'MOZ_NO_REMOTE': '1', 14:30:42 INFO - 'NO_EM_RESTART': '1', 14:30:42 INFO - 'PAGER': '/bin/cat', 14:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:42 INFO - 'PWD': '/builds/slave/test', 14:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:42 INFO - 'SHELL': '/bin/bash', 14:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:30:42 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:42 INFO - 'USER': 'cltbld', 14:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:42 INFO - 'XPC_FLAGS': '0x0', 14:30:42 INFO - 'XPC_SERVICE_NAME': '0', 14:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:30:45 INFO - Installing collected packages: mozsystemmonitor 14:30:45 INFO - Running setup.py install for mozsystemmonitor 14:30:45 INFO - Successfully installed mozsystemmonitor 14:30:45 INFO - Cleaning up... 14:30:45 INFO - Return code: 0 14:30:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:30:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:30:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:45 INFO - 'HOME': '/Users/cltbld', 14:30:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:45 INFO - 'LOGNAME': 'cltbld', 14:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:45 INFO - 'MOZ_NO_REMOTE': '1', 14:30:45 INFO - 'NO_EM_RESTART': '1', 14:30:45 INFO - 'PAGER': '/bin/cat', 14:30:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:45 INFO - 'PWD': '/builds/slave/test', 14:30:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:45 INFO - 'SHELL': '/bin/bash', 14:30:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:30:45 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:30:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:45 INFO - 'USER': 'cltbld', 14:30:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:45 INFO - 'XPC_FLAGS': '0x0', 14:30:45 INFO - 'XPC_SERVICE_NAME': '0', 14:30:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:45 INFO - Downloading/unpacking jsonschema==2.5.1 14:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:30:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 INFO - Downloading functools32-3.2.3-2.tar.gz 14:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:30:48 INFO - warning: no files found matching '*.txt' 14:30:48 INFO - no previously-included directories found matching 'build' 14:30:48 INFO - no previously-included directories found matching 'dist' 14:30:48 INFO - no previously-included directories found matching '.git*' 14:30:49 INFO - Installing collected packages: jsonschema, functools32 14:30:49 INFO - Running setup.py install for functools32 14:30:49 INFO - warning: no files found matching '*.txt' 14:30:49 INFO - no previously-included directories found matching 'build' 14:30:49 INFO - no previously-included directories found matching 'dist' 14:30:49 INFO - no previously-included directories found matching '.git*' 14:30:49 INFO - Successfully installed jsonschema functools32 14:30:49 INFO - Cleaning up... 14:30:49 INFO - Return code: 0 14:30:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:49 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 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30:49 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 14:30:49 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 14:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:49 INFO - 'HOME': '/Users/cltbld', 14:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:49 INFO - 'LOGNAME': 'cltbld', 14:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:49 INFO - 'MOZ_NO_REMOTE': '1', 14:30:49 INFO - 'NO_EM_RESTART': '1', 14:30:49 INFO - 'PAGER': '/bin/cat', 14:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:49 INFO - 'PWD': '/builds/slave/test', 14:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:49 INFO - 'SHELL': '/bin/bash', 14:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:30:49 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:49 INFO - 'USER': 'cltbld', 14:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:49 INFO - 'XPC_FLAGS': '0x0', 14:30:49 INFO - 'XPC_SERVICE_NAME': '0', 14:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:30:49 INFO - Cleaning up... 14:30:49 INFO - Return code: 0 14:30:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:49 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 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30:49 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 14:30:49 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 14:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:49 INFO - 'HOME': '/Users/cltbld', 14:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:49 INFO - 'LOGNAME': 'cltbld', 14:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:49 INFO - 'MOZ_NO_REMOTE': '1', 14:30:49 INFO - 'NO_EM_RESTART': '1', 14:30:49 INFO - 'PAGER': '/bin/cat', 14:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:49 INFO - 'PWD': '/builds/slave/test', 14:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:49 INFO - 'SHELL': '/bin/bash', 14:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:30:49 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:49 INFO - 'USER': 'cltbld', 14:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:49 INFO - 'XPC_FLAGS': '0x0', 14:30:49 INFO - 'XPC_SERVICE_NAME': '0', 14:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:52 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:52 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 14:30:52 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 14:30:52 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 14:30:52 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 14:30:52 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 14:30:52 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 14:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30:53 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 14:30:53 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 14:30:53 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 14:30:53 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 14:30:53 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 14:30:53 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 14:30:53 INFO - Downloading docopt-0.6.1.tar.gz 14:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:53 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:53 INFO - Running setup.py install for blobuploader 14:30:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:53 INFO - Running setup.py install for requests 14:30:54 INFO - Running setup.py install for docopt 14:30:54 INFO - Successfully installed blobuploader requests docopt 14:30:54 INFO - Cleaning up... 14:30:54 INFO - Return code: 0 14:30:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:54 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')]} 14:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:54 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')]} 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:54 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 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:30:54 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 14:30:54 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 14:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:54 INFO - 'HOME': '/Users/cltbld', 14:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:54 INFO - 'LOGNAME': 'cltbld', 14:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:54 INFO - 'MOZ_NO_REMOTE': '1', 14:30:54 INFO - 'NO_EM_RESTART': '1', 14:30:54 INFO - 'PAGER': '/bin/cat', 14:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:54 INFO - 'PWD': '/builds/slave/test', 14:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:54 INFO - 'SHELL': '/bin/bash', 14:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:30:54 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:54 INFO - 'USER': 'cltbld', 14:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:54 INFO - 'XPC_FLAGS': '0x0', 14:30:54 INFO - 'XPC_SERVICE_NAME': '0', 14:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-vLBa0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-mI4x7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-JtHuwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Z5B2li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-FF6pSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-a6Zqbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-pXIbKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-bMR5MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-PuxjHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-jMOMwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:55 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Adgxi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:56 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-MnRAj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:56 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-bKAphw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:56 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Nx9Bho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:56 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-WGrBXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:56 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-o_PVMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:56 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-jxeluC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:30:56 INFO - Running setup.py install for manifestparser 14:30:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:30:56 INFO - Running setup.py install for mozcrash 14:30:56 INFO - Running setup.py install for mozdebug 14:30:57 INFO - Running setup.py install for mozdevice 14:30:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Running setup.py install for mozfile 14:30:57 INFO - Running setup.py install for mozhttpd 14:30:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Running setup.py install for mozinfo 14:30:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Running setup.py install for mozInstall 14:30:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:30:57 INFO - Running setup.py install for mozleak 14:30:57 INFO - Running setup.py install for mozlog 14:30:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:30:58 INFO - Running setup.py install for moznetwork 14:30:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:30:58 INFO - Running setup.py install for mozprocess 14:30:58 INFO - Running setup.py install for mozprofile 14:30:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:30:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:30:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:30:58 INFO - Running setup.py install for mozrunner 14:30:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:30:58 INFO - Running setup.py install for mozscreenshot 14:30:58 INFO - Running setup.py install for moztest 14:30:59 INFO - Running setup.py install for mozversion 14:30:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:30:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:30:59 INFO - Cleaning up... 14:30:59 INFO - Return code: 0 14:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:00 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')]} 14:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:00 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 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:31:00 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 14:31:00 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 14:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:00 INFO - 'HOME': '/Users/cltbld', 14:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:00 INFO - 'LOGNAME': 'cltbld', 14:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:00 INFO - 'MOZ_NO_REMOTE': '1', 14:31:00 INFO - 'NO_EM_RESTART': '1', 14:31:00 INFO - 'PAGER': '/bin/cat', 14:31:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:00 INFO - 'PWD': '/builds/slave/test', 14:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:00 INFO - 'SHELL': '/bin/bash', 14:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:31:00 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:00 INFO - 'USER': 'cltbld', 14:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:00 INFO - 'XPC_FLAGS': '0x0', 14:31:00 INFO - 'XPC_SERVICE_NAME': '0', 14:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:00 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-1KPx_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-VgRPWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-zn_w3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-xZyN_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-uaFkWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-IEODZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-cXkkJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-eW0UbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-yOCNna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:01 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)) 14:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:01 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-OfmQdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:02 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)) 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:02 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-zAvSMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:02 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)) 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:02 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-WTAX5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:02 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)) 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:02 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-sbc4uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:02 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)) 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:02 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-zmgnie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:02 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)) 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:02 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-24zeye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:02 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)) 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:02 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-M9pt5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:02 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)) 14:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:02 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Ybl9r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:02 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)) 14:31:02 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)) 14:31:02 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)) 14:31:02 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)) 14:31:02 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)) 14:31:02 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)) 14:31:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:05 INFO - Downloading blessings-1.6.tar.gz 14:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:05 INFO - Installing collected packages: blessings 14:31:05 INFO - Running setup.py install for blessings 14:31:06 INFO - Successfully installed blessings 14:31:06 INFO - Cleaning up... 14:31:06 INFO - Return code: 0 14:31:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:06 INFO - Reading from file tmpfile_stdout 14:31:06 INFO - Current package versions: 14:31:06 INFO - blessings == 1.6 14:31:06 INFO - blobuploader == 1.2.4 14:31:06 INFO - docopt == 0.6.1 14:31:06 INFO - functools32 == 3.2.3-2 14:31:06 INFO - jsonschema == 2.5.1 14:31:06 INFO - manifestparser == 1.1 14:31:06 INFO - mozInstall == 1.12 14:31:06 INFO - mozcrash == 1.0 14:31:06 INFO - mozdebug == 0.1 14:31:06 INFO - mozdevice == 0.48 14:31:06 INFO - mozfile == 1.2 14:31:06 INFO - mozhttpd == 0.7 14:31:06 INFO - mozinfo == 0.9 14:31:06 INFO - mozleak == 0.1 14:31:06 INFO - mozlog == 3.4 14:31:06 INFO - moznetwork == 0.27 14:31:06 INFO - mozprocess == 0.23 14:31:06 INFO - mozprofile == 0.28 14:31:06 INFO - mozrunner == 6.13 14:31:06 INFO - mozscreenshot == 0.1 14:31:06 INFO - mozsystemmonitor == 0.3 14:31:06 INFO - moztest == 0.8 14:31:06 INFO - mozversion == 1.4 14:31:06 INFO - psutil == 3.1.1 14:31:06 INFO - requests == 1.2.3 14:31:06 INFO - wsgiref == 0.1.2 14:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:06 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')]} 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:06 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')]} 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:06 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 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:31:06 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 14:31:06 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 14:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:06 INFO - 'HOME': '/Users/cltbld', 14:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:06 INFO - 'LOGNAME': 'cltbld', 14:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:06 INFO - 'MOZ_NO_REMOTE': '1', 14:31:06 INFO - 'NO_EM_RESTART': '1', 14:31:06 INFO - 'PAGER': '/bin/cat', 14:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:06 INFO - 'PWD': '/builds/slave/test', 14:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:06 INFO - 'SHELL': '/bin/bash', 14:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:31:06 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:06 INFO - 'USER': 'cltbld', 14:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:06 INFO - 'XPC_FLAGS': '0x0', 14:31:06 INFO - 'XPC_SERVICE_NAME': '0', 14:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 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)) 14:31:06 INFO - Cleaning up... 14:31:06 INFO - Return code: 0 14:31:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31:06 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')]} 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:06 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')]} 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:06 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 0x10904b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8821474470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, '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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 14:31:06 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 14:31:06 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 14:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:06 INFO - 'HOME': '/Users/cltbld', 14:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:06 INFO - 'LOGNAME': 'cltbld', 14:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:06 INFO - 'MOZ_NO_REMOTE': '1', 14:31:06 INFO - 'NO_EM_RESTART': '1', 14:31:06 INFO - 'PAGER': '/bin/cat', 14:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:06 INFO - 'PWD': '/builds/slave/test', 14:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:06 INFO - 'SHELL': '/bin/bash', 14:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:31:06 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:06 INFO - 'USER': 'cltbld', 14:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:06 INFO - 'XPC_FLAGS': '0x0', 14:31:06 INFO - 'XPC_SERVICE_NAME': '0', 14:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:31:06 INFO - Cleaning up... 14:31:06 INFO - Return code: 0 14:31:06 INFO - Running post-action listener: _resource_record_post_action 14:31:06 INFO - Running post-action listener: _start_resource_monitoring 14:31:06 INFO - Starting resource monitoring. 14:31:06 INFO - [mozharness: 2017-01-10 22:31:06.986926Z] Finished create-virtualenv step (success) 14:31:06 INFO - [mozharness: 2017-01-10 22:31:06.987907Z] Running install step. 14:31:06 INFO - Running pre-action listener: _resource_record_pre_action 14:31:06 INFO - Running main action method: install 14:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:07 INFO - Reading from file tmpfile_stdout 14:31:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:07 INFO - Reading from file tmpfile_stdout 14:31:07 INFO - Output received: 14:31:07 INFO - Usage: mozinstall [options] installer 14:31:07 INFO - Options: 14:31:07 INFO - -h, --help show this help message and exit 14:31:07 INFO - -d DEST, --destination=DEST 14:31:07 INFO - Directory to install application into. [default: 14:31:07 INFO - "/builds/slave/test"] 14:31:07 INFO - --app=APP Application being installed. [default: firefox] 14:31:07 INFO - mkdir: /builds/slave/test/build/application 14:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:31:38 INFO - Reading from file tmpfile_stdout 14:31:38 INFO - Output received: 14:31:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:31:38 INFO - Running post-action listener: _resource_record_post_action 14:31:38 INFO - [mozharness: 2017-01-10 22:31:38.946359Z] Finished install step (success) 14:31:38 INFO - [mozharness: 2017-01-10 22:31:38.946522Z] Running run-tests step. 14:31:38 INFO - Running pre-action listener: _resource_record_pre_action 14:31:38 INFO - Running main action method: run_tests 14:31:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:31:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:31:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:31:38 INFO - 2017-01-10 14:31:38.961 screenresolution[2171:19042] starting screenresolution argv=screenresolution get 14:31:38 INFO - 2017-01-10 14:31:38.964 screenresolution[2171:19042] Display 0: 1600x1200x32@60 14:31:38 INFO - 2017-01-10 14:31:38.970 screenresolution[2172:19044] starting screenresolution argv=screenresolution list 14:31:38 INFO - Available Modes on Display 0 14:31:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:31:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:31:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:31:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:31:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:31:39 INFO - Intel Iris: 14:31:39 INFO - Chipset Model: Intel Iris 14:31:39 INFO - Type: GPU 14:31:39 INFO - Bus: Built-In 14:31:39 INFO - VRAM (Dynamic, Max): 1536 MB 14:31:39 INFO - Vendor: Intel (0x8086) 14:31:39 INFO - Device ID: 0x0a2e 14:31:39 INFO - Revision ID: 0x0009 14:31:39 INFO - Displays: 14:31:39 INFO - Display: 14:31:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:31:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:31:39 INFO - Display Serial Number: 1600x1200 60 14:31:39 INFO - Main Display: Yes 14:31:39 INFO - Mirror: Off 14:31:39 INFO - Online: Yes 14:31:39 INFO - Rotation: Supported 14:31:39 INFO - Return code: 0 14:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:39 INFO - Python 2.7.3 14:31:39 INFO - Return code: 0 14:31:39 INFO - grabbing minidump binary from tooltool 14:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:39 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 0x108e5fd30>, '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 0x108cc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e57b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:39 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 14:31:39 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 14:31:39 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 14:31:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:39 INFO - Return code: 0 14:31:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:31:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:31:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 14:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0360 --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 14:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VMIe6E6Lza/Render', 14:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:39 INFO - 'HOME': '/Users/cltbld', 14:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:39 INFO - 'LOGNAME': 'cltbld', 14:31:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:39 INFO - 'MOZ_NO_REMOTE': '1', 14:31:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:39 INFO - 'NO_EM_RESTART': '1', 14:31:39 INFO - 'PAGER': '/bin/cat', 14:31:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:39 INFO - 'PWD': '/builds/slave/test', 14:31:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:39 INFO - 'SHELL': '/bin/bash', 14:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5xyfWPaqTw/Listeners', 14:31:39 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 14:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:39 INFO - 'USER': 'cltbld', 14:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:39 INFO - 'XPC_FLAGS': '0x0', 14:31:39 INFO - 'XPC_SERVICE_NAME': '0', 14:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 14:31:39 INFO - mozversion application_buildid: 20170110132304 14:31:39 INFO - mozversion application_changeset: d173a8f450cfb713f2f076d5571b723a3e9637f5 14:31:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:31:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:39 INFO - mozversion application_name: Firefox 14:31:39 INFO - mozversion application_remotingname: firefox-dev 14:31:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:31:39 INFO - mozversion application_vendor: Mozilla 14:31:39 INFO - mozversion application_version: 52.0a2 14:31:39 INFO - mozversion platform_buildid: 20170110132304 14:31:39 INFO - mozversion platform_changeset: d173a8f450cfb713f2f076d5571b723a3e9637f5 14:31:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:31:39 INFO - mozversion platform_version: 52.0a2 14:31:39 INFO - using testdate: 1484087499 14:31:39 INFO - actual date: 1484087499 14:31:39 INFO - starting webserver on 'localhost:52713' 14:31:39 INFO - SUITE-START | Running 2 tests 14:31:39 INFO - TEST-START | dromaeo_css 14:31:39 INFO - operating with platform_type : mac_ 14:31:39 INFO - Initialising browser for dromaeo_css test... 14:31:39 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpyBadBk/profile http://localhost:52713/getInfo.html) 14:31:42 INFO - PROCESS | 2182 | 2017-01-10 14:31:42.712 plugin-container[2184:19223] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b37, name = 'com.apple.tsm.portname' 14:31:42 INFO - PROCESS | 2182 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:31:42 INFO - PROCESS | 2182 | 2017-01-10 14:31:42.715 plugin-container[2184:19223] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b07, name = 'com.apple.CFPasteboardClient' 14:31:42 INFO - PROCESS | 2182 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:31:42 INFO - PROCESS | 2182 | 2017-01-10 14:31:42.715 plugin-container[2184:19223] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:31:42 INFO - PROCESS | 2182 | __metrics Screen width/height:1600/1200 14:31:42 INFO - PROCESS | 2182 | colorDepth:24 14:31:42 INFO - PROCESS | 2182 | Browser inner width/height: 1024/689 14:31:42 INFO - PROCESS | 2182 | __metrics 14:31:42 ERROR - PROCESS | 2182 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 14:31:43 INFO - TEST-INFO | 2182: exit 0 14:31:43 INFO - Browser initialized. 14:31:43 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:43 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpyBadBk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:46 INFO - PROCESS | 2185 | 2017-01-10 14:31:46.608 plugin-container[2186:19355] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444f, name = 'com.apple.tsm.portname' 14:31:46 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:31:46 INFO - PROCESS | 2185 | 2017-01-10 14:31:46.609 plugin-container[2186:19355] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 14:31:46 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:31:46 INFO - PROCESS | 2185 | 2017-01-10 14:31:46.609 plugin-container[2186:19355] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:31:56 INFO - PROCESS | 2185 | RSS: Main: 229007360 14:31:56 INFO - PROCESS | 2185 | 14:34:59 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:52713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52713/tests/dromaeo/cssquery-ext.html) 14:35:01 INFO - PROCESS | 2185 | RSS: Main: 239067136 14:35:01 INFO - PROCESS | 2185 | 14:38:03 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:52713/tests/dromaeo/cssquery-ext.html (next: http://localhost:52713/tests/dromaeo/cssquery-jquery.html) 14:38:04 INFO - PROCESS | 2185 | RSS: Main: 246939648 14:38:04 INFO - PROCESS | 2185 | 14:41:06 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:52713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52713/tests/dromaeo/cssquery-mootools.html) 14:41:06 INFO - PROCESS | 2185 | RSS: Main: 249810944 14:41:06 INFO - PROCESS | 2185 | 14:44:08 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:52713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52713/tests/dromaeo/cssquery-prototype.html) 14:44:09 INFO - PROCESS | 2185 | RSS: Main: 249032704 14:44:09 INFO - PROCESS | 2185 | 14:47:12 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:52713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52713/tests/dromaeo/cssquery-yui.html) 14:47:12 INFO - PROCESS | 2185 | RSS: Main: 252485632 14:47:12 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:52713/tests/dromaeo/cssquery-yui.html (next: http://localhost:52713/tests/dromaeo/cssquery-dojo.html) 14:50:15 INFO - PROCESS | 2185 | RSS: Main: 253943808 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | __start_tp_report 14:50:15 INFO - PROCESS | 2185 | _x_x_mozilla_page_load 14:50:15 INFO - PROCESS | 2185 | _x_x_mozilla_page_load_details 14:50:15 INFO - PROCESS | 2185 | |i|pagename|runs| 14:50:15 INFO - PROCESS | 2185 | |0;dojo.html;3235.627902791179;3297.7856439331426;3301.042697617691;3343.648916863729;3373.4939759036142;5514.889702205954;5546.278983732114;5560.193771903072;5566.332040155187;5606.187102870082;5540.612157149001;5616.354119276284;5623.409541998082;5631.8028868989595;5654.349749778777;5078.415982162052;5102.948970510303;5132.332796736419;5151.253068305094;5178.048343064385;5176.715280659562;5196.168613021917;5205;5211.765470553834;5219.425863155069;4201.852935147271;5035.723035233061;5085.364329458817;5163.380394352683;5178.5339319461245;5110.8466745997675;5122;5127.717975511346;5130;5166.992436474889;5056.848294551132;5094.465081166498;5101.566366858821;5159.484051594848;5168;5636.689982050985;5636.859078523029;5647.463490968393;5680.204771332017;5692.943070569283;5871.941280587225;5959.612625179349;6035.155078289043;6074.848128796772;6089.512838972916;6095.542834287447;6118.235220597426;6121.755129794803;6128.38716128388;6131.724072416752;5552.416996215379;5615.691136987464;5630.887382252414;5677.233573467612;5677.347105082886;6172.783952561639;6210.4100110489435;6218.098375735583;6244.968775156186;6253.874922501524;5861.325947516005;5997.670128142994;6004.909926351108;6007.459328660354;6013.1581578579035;5958.374370691102;5999.490043346277;6047.425494578008;6054.182685337423;6070.150178974947;6071.696415179312;6077.179580756541;6077.544184186204;6079.513638908877;6081.270247570232;4979.253112033224;5193.091209038479;5536.4186760390385;6060.545459090586;6079.452849243589;4726.787294571753;4747.928781068286;4770.928436073462;4807.735574543363;4824.927626085611;4290.721103128287;4291.9785401072795;4306.074194048295;4307.590778876001;4331.7834108294455;4427;5668.26312579362;5672.914906276409;5709.571782116358;5716.08542633185;5434.538064264581;5471.5896307777075;5929.73316200772;5973.402659734079;6135.5398345124295;5538.418466061086;5553.694546799884;5587.469190426903;5627.465390787868;5647.209390685307;5199.324087868553;5227.529522342931;5239.973800130975;5241.895162096736;5249.186376111708;6109.0403061477;6129.267100814712;6168.9691551541955;6189.1954045975535;6253.749850006131;5006.49935006511;6125.785597504066;6135;6140.815775526741;6173.722182501709;6205.813825585059;6209.59637623553;6217.253929528486;6218.471429928326;6239.251289845248;5822.679752613478;5869.148973398748;5874.676892770939;5917.940820591911;5993.400659933972;6016.87966240664;6026.578139530191;6117.522930757332;6127.403330890726;6136.3965394158;5903.881922361443;5918.674472904032;5932.377100404568;5938.168656388196;5950.047992321208;5698.686572238401;5789.739461724317;5871.706414679335;5921.200637913998;5964.7912323068485;4981.227909674007;5382.111951528111;5650.830475085754;5726.141078838207;5730.570207234391;5811.883762324815;5837.416258374298;5871.706414679164;5951.880962380815;6010.669413182317;5737.282839645044;5748.993926063006;5767.307923049261;5777.740001700017;5778.566607504538 14:50:15 INFO - PROCESS | 2185 | |1;ext.html;442.83615062426907;487.4004973882125;505.31025150669325;512.513112543084;515.5772266741272;23170.536589268224;38107.85676429708;39227.21545569091;39333.40999885004;40150.996225094386;39899.40150897739;40258.7987060065;40269.597304027026;40335.19329613413;40404.79797601015;9196.172344488994;9282.535873206347;9351.392159509644;9399.718008459722;9434.764130896749;9333.300002499805;9387.249020078412;9391.859122113174;9392.389494682824;9423.199028082621;9371.437713737163;9408.764780880465;9423.764405889873;9424.246060315158;9457.290703197288;9306.348555601111;9377.578008989543;9380.577873995653;9393.20157786582;9394.201492873113;8830.161134692195;8853.822923541493;8883.86674199881;8893.955530222307;8918.910810891874;32273;38004.23991520182;38057.809710951544;38323.425148622795;38419.42370864439;3235;3270.3949769292517;3350.547676063749;3467.7745946513396;3938.645521903014;27581.724182758117;28870.711292887012;29263.561046584317;29655.55516667252;29732.55401168984;2592.8833202505743;2913.863593198654;3162.0197738701077;3198.440272952224;3203.2312245061253;412093;465928;471504;472640;473118;56292.15561766495;56365.7181714097;56408;56594.43405565974;56962.43037569654;58874.705626471594;59497;59540.40459595435;59609;59687.40312596905;15579.766303505456;15798.89407741447;15807.604809879846;15841.762373564407;16000.519984400487;11175.44122793857;11338.489767960296;11340.943295283636;11351.886481135249;11379.544818207345;13869.791953120712;13962.790558141636;14267.42930282777;15059;15129.697406051817;3130.98434507826;3252.642209356969;6352.7776527822225;6445.838854028687;6450.258220304725;766.3983772738374;819.9549024803574;912.3020889019905;925.2228128372066;1075.2956813287153;24608.507829843304;28134.155975320773;28775.85612071926;29768.851155744516;29898.80404783828;991.8264303746815;1021.6628512590827;1025.9846102308472;1036.4662198967537;1041.7499800047933;15436.228188590525;15473.5357939262;15535.223238838013;15722.29249683767;16340;593780;598031;599871;603895;606002;53764.19353709697;53769.73115134399;54164.45835541594;54428.91142177134;54499.91000179974;1161.5992482593492;1345.7375811716818;1347.75066612675;1363.6931690369786;1385.300423286254;29356.412871742017;30152.547711783904;30226.69773302239;30363.033019736078;30475.238119046313;46788.7660561695;47538.28692569683;47668.7616561915;47723.761381192875;47818;472614;473880;474756;475264;476944;25000;25415;25523.744762552138;25566.360840979123;26502;43977.34033989429;44228.89427764332;44748;44900.326495101945;45028.549714502435;36548;37286.62713372832;37821.62178378181;39140;40604.79697601493;37331.626683732815;37586;37968.58282754565;38913.610863891;39006.60993390143;36798.63201367952;37398.8130059348;37655.81172094122;37753.81123094367;37897.052573685876;32407.675923240466;33833.83083084569;34073;34351.82824085864;34739.305213896085;25553.61669574995;25610.487790244464;25659.74340256648;25718.614220787076;25999.350016248987 14:50:15 INFO - PROCESS | 2185 | |2;jquery.html;345.6681585677749;364.87594217965886;368.2708237689374;382.82964080983976;394.54036048004076;14873.256337183138;18129.728054079183;18585.814141858576;19415.32046378377;20106.872747449415;17435.564110897234;18363.632727345477;19417.805821941776;19639.5090122747;19758.30845920393;5648.548116150698;5878.853028674274;5902.409759024106;5905.7342419591005;5914.9112763308585;4360.956390436087;6400;6471.741130354781;6543.280239173687;6558.93441065588;6143.8771224575485;6229.345918678541;6470;6503.187101612299;6515.153030106103;6224.439800417961;6247.281562620288;6283.560150789446;6295.748170073191;6302.716377763011;5253.290805741214;5330.840074797724;5551.139573366095;5602.887942241173;5610.102383618601;24667.25998220056;24703.641299728508;24767.5046499069;24917.87541062301;25052;2224.4994876152737;2316.073570571768;2356.0693526057285;2391.8564886106888;2406.2660888429023;11549.307041577533;15037.323320450607;15210.315535800915;15432.459863904822;15884.682306353809;1741.7909850817857;1823.4347352320824;1825.6531259060869;1843.797182309945;1857.9814201858078;118183;122580;122993.77006229913;127527.3623631876;129686;11170.609028683957;11285.322880627024;11464.369459679798;11522.423878806027;11671.007964322958;14170.787438188436;14312.28438578067;14320.14079155254;14347.92826035863;14365.353559089866;6671.966640166768;8360;8382.07797142314;8445.873311900326;8461.026981897161;8246.155076498599;8264.793380165544;8278.130796266305;8434.746957591282;8440.240378365976;4355.73865568067;4447.266201076786;4456.732596044183;4468.4414448193975;4513.54864513546;1888.2722309087305;1910.9808901910803;1914.636219118363;1916.5208697825544;1921.7693876734882;813.9865866995628;896.9865452018225;937.1706040154376;953.1516949914582;969.9224062075017;17692;19456.805431945784;20227.898860505604;20458.977051147383;20585.58828823415;410.26152924735356;831.4470876866936;924.9398789078823;928.6146249306597;942.886853577575;5692.31692196939;5721.141828725725;5768.971155144198;5835.679037652885;6124.081387791778;547031;556856;558217;562175;586094;77148;124464.37767811104;125208;126312.73687263194;128750;439.44849214235927;445.37647293788956;445.6279007029102;447.3178402935549;448.2693210067569;10637.893621063691;10791.190660700322;11035.282706624044;11101.278416902875;11281.32312061279;34511.79208727682;47051.76474117608;47440.051198976515;51814.740926295126;55787.163192551336;68752.31247687459;72018.63990680013;73152;79952.60023699845;80031.19968800238;6563.9343606563325;7836;7915.366770658448;8068.273855353046;8199.754007379788;10954.233203675667;12141.907228349492;12223.75552488963;12290.938545307215;12415.689607759878;10567;10590.4704764763;10613.257072004886;10650.57397704083;10988.835167472334;10517.21120915919;10642.946785266335;10684;10726.302790318605;10882.129429645767;10596.89403105959;10721.731956701145;11196.888031119584;11233.101351891666;11370.54517819278;5929.495992840657;7640.3505702015955;7949.046114466301;7967.2431119043595;8107.148749381466;10677;10757.569697212024;10778.461076946278;10788.622398216025;10847.24069315172 14:50:15 INFO - PROCESS | 2185 | |3;mootools.html;1328.8338957630294;1457.9635509112275;1624.3421414327195;1812.6555954368662;1822.4077174918154;7579.924200757991;7881.645325960331;8109.472884262519;8584.399092063559;8589.441686290395;8033.91966080339;8284.91715082849;8354.624041918112;8372.665093396257;8382;2303.7811407916265;2355.0697474497565;2363.385519764865;2364.13708996216;2377.5720370333333;2342.227065068523;2385.4513461903684;2390.557746816836;2395.892184851677;2398.760123987605;2338.240071976606;2350.576896158691;2353.3998830298337;2357.0807385119815;2372.406898275431;2299.1493147535434;2309.4688221708934;2333.2650215182334;2333.7082864641834;2339.578875802355;2342.273895092527;2353.2704861492994;2364.869932153731;2374.465745207332;2385.1651921827397;8301.211384918422;8356.874646880302;8407.2433480987;8436.02985656645;8442.535660538668;4973.104841128596;5132.409772876093;5134.486551344873;5135.1270284051425;5136.717480538568;3410.778299410555;3422.349753546818;3460.3044508191056;3480.3387356402204;3563.82180890957;1065.690949624608;1078.0890147825153;1083.0523292119397;1108.130117857478;1114.9888501114965;10807.729806754816;10868.565257389695;10923.126149907988;11001.00990910822;11023.393713345762;4555.567221113989;4686.437627484655;4709.976450117728;4741.668083234141;4754.690945088558;9571.712848614552;9598.616055357708;9610.375325603813;9611.759706007406;9631;5254.211868219798;5258.1849813279005;5258.789648414097;5259.869128137392;5261.421243663271;4302.913941721211;4306.806193721228;4734.810607575727;4741.739204343725;4800.495947925488;3317.552130462405;3363.899083027513;3553.7206605621955;3813.6186381362195;3972.1261322509004;1122.3602546548389;1286.163993404276;1286.3375361688738;1296.8767967043116;1301.531448678475;801.1187693537063;871.5511511571545;872.4808738800403;877.2893955895745;890.4034297021011;5511.3937466878615;5521.613487055948;5608.990381731328;5615.971920140373;5761.711914404263;865.1651156633878;881.2201201936205;908.5638893331106;935.8830146231721;972.5866506734751;3526.0479670488826;3704.7406681532575;3829.100161462054;3829.119302560371;3884.3979183226643;9752.21982241419;9933.950330248303;9982;10137.797244055078;10156.644517442002;10029.29794914349;10037.598496060076;10041.447720375449;10043.598256069676;10088.899111008943;7363.595002274927;7795.14253432122;7904.920950790419;7906.011748531434;7923.088844782808;4941.431735350337;5125.666831655931;5371.919421208607;5395.406505284337;5477.698726569917;9442.10300021497;9483.620655173992;9503.762405939908;9504.809903802023;9530.904690953003;9116.08839116083;9517.904820951979;9529.761755956157;9531.237500999765;9683.951580242054;6437.259715132633;6825.897611535732;6982.301769822977;7143.714251429885;7311.817204569928;7839.33365663925;7941.682332706627;8008;8014.599270036359;8025.317847982987;6992;7172.0676312079095;7174;7194.71221151169;7230.096237970254;6895.6552172392185;6948.513604047668;7007.404370628554;7065.470089743187;7086.574805511686;6545.247296560766;6656.267810540739;6694.364035416627;6711.731530738716;6717.697703603448;4791.377120974391;4813.302071199727;4824.927626085541;4835.879103022453;4874.610031197425;4752.097101550694;4817.325574419654;4841.540053694894;4942.901141977212;4975.253711943237 14:50:15 INFO - PROCESS | 2185 | |4;prototype.html;268.3586228912898;277.18645774651395;304.69135064896267;304.95425686147087;310.07133634763886;4347.934780978288;4356.433663623732;4720.268358404449;5135.64050516464;5413.750206088222;4333.653307735373;5082.440931497542;5155.587552995761;5333.573314134869;5365.919511207335;3007.7593792496546;3243.232438321109;3911.3350730375764;4171.498260626172;4402.236088144622;3800.6507689770146;4192.056787222881;4201.348790937394;4201.537830838605;4232.174725928445;3520.4543295789194;4045.352743561031;4069.470968774055;4080.4083407905837;4108.5686002969705;3430.142464383904;3758.32350176968;4012.0371110933456;4061.289274376972;4067.8983025424454;2629.842209467419;3102.705243001911;3147.040152753409;3480.617132115465;3523.8766643167364;3995.680345572347;4963.081829861487;5099.46455622158;5266.578673706094;5311.760970756325;3671.7980511071883;3960.722749407543;4283.550227226158;4604.907901841944;4636.350910872447;5127.48725127488;5429.429909859447;5630.915536266918;5657.519110875581;5667.716614169275;3383.849491173013;3533.5724347382998;3575.4279315309427;3729.421939599339;3873.6707379872746;5645.887082258373;5914.704264786744;5919.585629005971;5980.43185897339;5995.730192141364;3328.7170590500077;3856.8650097246464;3912.941305880414;3915.6084391560616;3923.0780766519847;3636.581793093775;3693.316736403774;3763.0592351912023;3980.7412518186225;3994.08431844755;3695.020819482839;3927.509061367329;4664.274218539163;4664.854167083112;4675.906481870344;5765.1928729977835;5777.62445441045;5795.710214489343;5807.361190269067;5841.88316233673;1150.3730466895563;1204.7952047952049;1245.2279586656332;1245.5702782540009;1250.3560666256885;734.6914295995695;850.5194565070715;873.9992708349032;880.7798050487378;886.9268185495623;4766.713997160182;4993.800247990112;5018.2650455501835;5018.774155163026;5069.949300506948;4706.576408123286;4817.614590832725;5385.353757549119;5438;5623.790884959753;4503.842365517191;4715.55202255792;5019;5126.641135120506;5141.845744627667;2528.443742376674;2714.850683212442;2783.6937936826935;2873.425314937021;2907.5057240269207;5637.43625637433;5692.715364231854;5694.658320500783;5815.331236907725;5859.853503662443;4104.630583247463;5299.834036511961;5392.379876314196;5591.720413979366;5602.13166959122;4936.383716630192;5542.528885044736;5654.491095801398;5713.171785028834;5744;5048.646594738333;5336.653117547347;5442.516789254801;5520.295055422895;5571.526420254324;4328.896256278632;4334.65322774171;4833.564979151753;5189.792408303626;5363.704996225245;5252.975669744364;5283.947160528499;5389.380221274603;5432.979595099677;5701.458361455655;2983.477891369045;3412.8601686449024;3732.9734323061375;3750.293616404584;3758.1732018955786;4903.95096049035;5074.923876141787;5463.53559947393;5948.762049517971;5949.2266005419015;4626.282926146453;5069.391672999263;5354.7590358434745;5754.280714910637;5756.453136951983;5163.095059693232;5708.457696518824;5750.821081678329;5765.308163020464;5802.997965701826;4796.472388037383;5381.946180538144;5650.915236271377;5693.3168019837885;5751.405371642723;5501.9174712380145;5792.177163072352;5830.329512105993;5830.970845145747;5860.443257890493;4636.721796692209;4958.322505846802;5732.251663242751;5757.136429535603;5786.213786213786 14:50:15 INFO - PROCESS | 2185 | |5;yui.html;628.5537268539337;669.5447095974736;686.5503095472466;704.3590332797156;777.9222077792222;13910.930445347773;14388.92805535971;14521.346539405726;14546.999999999987;14591.051581647185;12915.935420322909;13026.934865325684;13028.306320178364;13051.216926984387;13053.543125990569;637.9808605741836;657.7599176300664;785.9960700196491;801.7594721583516;814.6700586262573;796.9043714754238;808.5310519898445;817.5789468423767;820.335528222139;823.4071468542639;834.4200780457554;845;863.7581477186397;868.0668281597276;872.0451106038877;846.0693237438799;861.2765277167209;864.1962974433774;864.6800683747023;865.6191275838611;624.687656171914;626.5520153090516;643.1125047434557;644.2397970394932;644.4715333426592;13756.105853119616;13984.93007534966;14048.92975535126;14070.15579065249;14438.494652687106;13472.461101555926;13674.111182773187;13996.401439424311;14052.648683782885;14109.535204190843;10994;11138.832917506244;11283.323000619906;11287.943560282147;11449.942750286194;3620.113072297304;3645.216278500135;3694.1503454205413;3710.3135919854913;3744.3634582121103;84669.57665211635;84993.57503212507;88584;91434;92095.07904920932;10470.947645261725;10642.89357106419;10691.35851848876;10708.357498550113;10763.3541987481;20944.952752362628;21063.68404473934;21109.9445027748;21144.259950901953;21514.13943442276;7438.925610743931;7449.813754656177;7536.849263014709;7559.659815308324;7668.808279792938;3956.188981258835;4020.115574573589;4058.2492238935893;4071.043304823364;4073.1446396256524;3335.449650807638;3441.3633477806684;3500.2824420994143;3524.4537096750046;3527.8588856445967;500.2546206152879;590.5541316306161;606.7148440233084;609.5550248318664;616.3374372549528;558.3355806590145;560.9102543593006;588.9057750759944;647.5337756815086;653.1769969838039;8066.596670166468;8353.916460835435;8449.619767110495;8892.553281314435;9037.322200834964;534.4415086234894;615.5227454110171;639.5107742576932;642.7975187815823;643.9098526206335;4243.745375277494;4369;4401.207782599099;4417.734935903856;4443.555644435531;99127.50436247773;110633;112037.3633245816;112439.31341029891;116178;56302.43697562972;77826;80552;82600;83884.74172887411;47792;65109.37226569374;73624.52750945058;73795;74181.25818741851;7516.398688105048;8050.235227653364;9121.635134594808;9444.527773611155;9521.952390238004;46359;49076.75461622669;49387;50897.491025090756;54117.3764787057;61275;61785.69107154435;72444.27555724586;76795;77220;11855.221716742557;12094.818577721166;12239.87760122423;12294.877051229374;12301.753964920472;11600.419979001184;13707.383167757675;14028.438862445388;14204.502842400467;14275.214863182624;10567.63013294531;12730.809037864625;12973.286469244282;13360.265185414506;13578.185308881499;12136.817947730615;12612.306323152316;12779.169353991962;12978;12979.545715899898;12679.619611411672;12853.35733213317;12894.935525322313;12901.161424507753;13492.920566354473;10340.844887326846;10826.89173108259;11072.889271107508;11187.105031597615;11194.608188713355;9061.728148155566;9260;10264.692059238234;11584;11621.76756464883 14:50:15 INFO - PROCESS | 2185 | __end_tp_report 14:50:15 INFO - PROCESS | 2185 | __start_cc_report 14:50:15 INFO - PROCESS | 2185 | _x_x_mozilla_cycle_collect,372 14:50:15 INFO - PROCESS | 2185 | __end_cc_report 14:50:15 INFO - PROCESS | 2185 | __startTimestamp1484088615729__endTimestamp 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | ------- Summary: start ------- 14:50:15 INFO - PROCESS | 2185 | Number of tests: 6 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | [#0] dojo.html Cycles:165 Average:5564.41 Median:5698.69 stddev:625.83 (11.0%) stddev-sans-first:600.49 14:50:15 INFO - PROCESS | 2185 | Values: 3235.6 3297.8 3301.0 3343.6 3373.5 5514.9 5546.3 5560.2 5566.3 5606.2 5540.6 5616.4 5623.4 5631.8 5654.3 5078.4 5102.9 5132.3 5151.3 5178.0 5176.7 5196.2 5205.0 5211.8 5219.4 4201.9 5035.7 5085.4 5163.4 5178.5 5110.8 5122.0 5127.7 5130.0 5167.0 5056.8 5094.5 5101.6 5159.5 5168.0 5636.7 5636.9 5647.5 5680.2 5692.9 5871.9 5959.6 6035.2 6074.8 6089.5 6095.5 6118.2 6121.8 6128.4 6131.7 5552.4 5615.7 5630.9 5677.2 5677.3 6172.8 6210.4 6218.1 6245.0 6253.9 5861.3 5997.7 6004.9 6007.5 6013.2 5958.4 5999.5 6047.4 6054.2 6070.2 6071.7 6077.2 6077.5 6079.5 6081.3 4979.3 5193.1 5536.4 6060.5 6079.5 4726.8 4747.9 4770.9 4807.7 4824.9 4290.7 4292.0 4306.1 4307.6 4331.8 4427.0 5668.3 5672.9 5709.6 5716.1 5434.5 5471.6 5929.7 5973.4 6135.5 5538.4 5553.7 5587.5 5627.5 5647.2 5199.3 5227.5 5240.0 5241.9 5249.2 6109.0 6129.3 6169.0 6189.2 6253.7 5006.5 6125.8 6135.0 6140.8 6173.7 6205.8 6209.6 6217.3 6218.5 6239.3 5822.7 5869.1 5874.7 5917.9 5993.4 6016.9 6026.6 6117.5 6127.4 6136.4 5903.9 5918.7 5932.4 5938.2 5950.0 5698.7 5789.7 5871.7 5921.2 5964.8 4981.2 5382.1 5650.8 5726.1 5730.6 5811.9 5837.4 5871.7 5951.9 6010.7 5737.3 5749.0 5767.3 5777.7 5778.6 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | [#1] ext.html Cycles:180 Average:64305.20 Median:39073.30 stddev:137521.61 (352.0%) stddev-sans-first:137823.80 14:50:15 INFO - PROCESS | 2185 | Values: 442.8 487.4 505.3 512.5 515.6 23170.5 38107.9 39227.2 39333.4 40151.0 39899.4 40258.8 40269.6 40335.2 40404.8 9196.2 9282.5 9351.4 9399.7 9434.8 9333.3 9387.2 9391.9 9392.4 9423.2 9371.4 9408.8 9423.8 9424.2 9457.3 9306.3 9377.6 9380.6 9393.2 9394.2 8830.2 8853.8 8883.9 8894.0 8918.9 32273.0 38004.2 38057.8 38323.4 38419.4 3235.0 3270.4 3350.5 3467.8 3938.6 27581.7 28870.7 29263.6 29655.6 29732.6 2592.9 2913.9 3162.0 3198.4 3203.2 412093.0 465928.0 471504.0 472640.0 473118.0 56292.2 56365.7 56408.0 56594.4 56962.4 58874.7 59497.0 59540.4 59609.0 59687.4 15579.8 15798.9 15807.6 15841.8 16000.5 11175.4 11338.5 11340.9 11351.9 11379.5 13869.8 13962.8 14267.4 15059.0 15129.7 3131.0 3252.6 6352.8 6445.8 6450.3 766.4 820.0 912.3 925.2 1075.3 24608.5 28134.2 28775.9 29768.9 29898.8 991.8 1021.7 1026.0 1036.5 1041.7 15436.2 15473.5 15535.2 15722.3 16340.0 593780.0 598031.0 599871.0 603895.0 606002.0 53764.2 53769.7 54164.5 54428.9 54499.9 1161.6 1345.7 1347.8 1363.7 1385.3 29356.4 30152.5 30226.7 30363.0 30475.2 46788.8 47538.3 47668.8 47723.8 47818.0 472614.0 473880.0 474756.0 475264.0 476944.0 25000.0 25415.0 25523.7 25566.4 26502.0 43977.3 44228.9 44748.0 44900.3 45028.5 36548.0 37286.6 37821.6 39140.0 40604.8 37331.6 37586.0 37968.6 38913.6 39006.6 36798.6 37398.8 37655.8 37753.8 37897.1 32407.7 33833.8 34073.0 34351.8 34739.3 25553.6 25610.5 25659.7 25718.6 25999.4 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | [#2] jquery.html Cycles:180 Average:33150.93 Median:17438.33 stddev:94142.73 (539.9%) stddev-sans-first:94374.60 14:50:15 INFO - PROCESS | 2185 | Values: 345.7 364.9 368.3 382.8 394.5 14873.3 18129.7 18585.8 19415.3 20106.9 17435.6 18363.6 19417.8 19639.5 19758.3 5648.5 5878.9 5902.4 5905.7 5914.9 4361.0 6400.0 6471.7 6543.3 6558.9 6143.9 6229.3 6470.0 6503.2 6515.2 6224.4 6247.3 6283.6 6295.7 6302.7 5253.3 5330.8 5551.1 5602.9 5610.1 24667.3 24703.6 24767.5 24917.9 25052.0 2224.5 2316.1 2356.1 2391.9 2406.3 11549.3 15037.3 15210.3 15432.5 15884.7 1741.8 1823.4 1825.7 1843.8 1858.0 118183.0 122580.0 122993.8 127527.4 129686.0 11170.6 11285.3 11464.4 11522.4 11671.0 14170.8 14312.3 14320.1 14347.9 14365.4 6672.0 8360.0 8382.1 8445.9 8461.0 8246.2 8264.8 8278.1 8434.7 8440.2 4355.7 4447.3 4456.7 4468.4 4513.5 1888.3 1911.0 1914.6 1916.5 1921.8 814.0 897.0 937.2 953.2 969.9 17692.0 19456.8 20227.9 20459.0 20585.6 410.3 831.4 924.9 928.6 942.9 5692.3 5721.1 5769.0 5835.7 6124.1 547031.0 556856.0 558217.0 562175.0 586094.0 77148.0 124464.4 125208.0 126312.7 128750.0 439.4 445.4 445.6 447.3 448.3 10637.9 10791.2 11035.3 11101.3 11281.3 34511.8 47051.8 47440.1 51814.7 55787.2 68752.3 72018.6 73152.0 79952.6 80031.2 6563.9 7836.0 7915.4 8068.3 8199.8 10954.2 12141.9 12223.8 12290.9 12415.7 10567.0 10590.5 10613.3 10650.6 10988.8 10517.2 10642.9 10684.0 10726.3 10882.1 10596.9 10721.7 11196.9 11233.1 11370.5 5929.5 7640.4 7949.0 7967.2 8107.1 10677.0 10757.6 10778.5 10788.6 10847.2 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | [#3] mootools.html Cycles:180 Average:5455.27 Median:5133.45 stddev:2990.97 (58.3%) stddev-sans-first:2983.28 14:50:15 INFO - PROCESS | 2185 | Values: 1328.8 1458.0 1624.3 1812.7 1822.4 7579.9 7881.6 8109.5 8584.4 8589.4 8033.9 8284.9 8354.6 8372.7 8382.0 2303.8 2355.1 2363.4 2364.1 2377.6 2342.2 2385.5 2390.6 2395.9 2398.8 2338.2 2350.6 2353.4 2357.1 2372.4 2299.1 2309.5 2333.3 2333.7 2339.6 2342.3 2353.3 2364.9 2374.5 2385.2 8301.2 8356.9 8407.2 8436.0 8442.5 4973.1 5132.4 5134.5 5135.1 5136.7 3410.8 3422.3 3460.3 3480.3 3563.8 1065.7 1078.1 1083.1 1108.1 1115.0 10807.7 10868.6 10923.1 11001.0 11023.4 4555.6 4686.4 4710.0 4741.7 4754.7 9571.7 9598.6 9610.4 9611.8 9631.0 5254.2 5258.2 5258.8 5259.9 5261.4 4302.9 4306.8 4734.8 4741.7 4800.5 3317.6 3363.9 3553.7 3813.6 3972.1 1122.4 1286.2 1286.3 1296.9 1301.5 801.1 871.6 872.5 877.3 890.4 5511.4 5521.6 5609.0 5616.0 5761.7 865.2 881.2 908.6 935.9 972.6 3526.0 3704.7 3829.1 3829.1 3884.4 9752.2 9934.0 9982.0 10137.8 10156.6 10029.3 10037.6 10041.4 10043.6 10088.9 7363.6 7795.1 7904.9 7906.0 7923.1 4941.4 5125.7 5371.9 5395.4 5477.7 9442.1 9483.6 9503.8 9504.8 9530.9 9116.1 9517.9 9529.8 9531.2 9684.0 6437.3 6825.9 6982.3 7143.7 7311.8 7839.3 7941.7 8008.0 8014.6 8025.3 6992.0 7172.1 7174.0 7194.7 7230.1 6895.7 6948.5 7007.4 7065.5 7086.6 6545.2 6656.3 6694.4 6711.7 6717.7 4791.4 4813.3 4824.9 4835.9 4874.6 4752.1 4817.3 4841.5 4942.9 4975.3 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | [#4] prototype.html Cycles:180 Average:4428.18 Median:4978.44 stddev:1407.72 (28.3%) stddev-sans-first:1376.61 14:50:15 INFO - PROCESS | 2185 | Values: 268.4 277.2 304.7 305.0 310.1 4347.9 4356.4 4720.3 5135.6 5413.8 4333.7 5082.4 5155.6 5333.6 5365.9 3007.8 3243.2 3911.3 4171.5 4402.2 3800.7 4192.1 4201.3 4201.5 4232.2 3520.5 4045.4 4069.5 4080.4 4108.6 3430.1 3758.3 4012.0 4061.3 4067.9 2629.8 3102.7 3147.0 3480.6 3523.9 3995.7 4963.1 5099.5 5266.6 5311.8 3671.8 3960.7 4283.6 4604.9 4636.4 5127.5 5429.4 5630.9 5657.5 5667.7 3383.8 3533.6 3575.4 3729.4 3873.7 5645.9 5914.7 5919.6 5980.4 5995.7 3328.7 3856.9 3912.9 3915.6 3923.1 3636.6 3693.3 3763.1 3980.7 3994.1 3695.0 3927.5 4664.3 4664.9 4675.9 5765.2 5777.6 5795.7 5807.4 5841.9 1150.4 1204.8 1245.2 1245.6 1250.4 734.7 850.5 874.0 880.8 886.9 4766.7 4993.8 5018.3 5018.8 5069.9 4706.6 4817.6 5385.4 5438.0 5623.8 4503.8 4715.6 5019.0 5126.6 5141.8 2528.4 2714.9 2783.7 2873.4 2907.5 5637.4 5692.7 5694.7 5815.3 5859.9 4104.6 5299.8 5392.4 5591.7 5602.1 4936.4 5542.5 5654.5 5713.2 5744.0 5048.6 5336.7 5442.5 5520.3 5571.5 4328.9 4334.7 4833.6 5189.8 5363.7 5253.0 5283.9 5389.4 5433.0 5701.5 2983.5 3412.9 3733.0 3750.3 3758.2 4904.0 5074.9 5463.5 5948.8 5949.2 4626.3 5069.4 5354.8 5754.3 5756.5 5163.1 5708.5 5750.8 5765.3 5803.0 4796.5 5381.9 5650.9 5693.3 5751.4 5501.9 5792.2 5830.3 5831.0 5860.4 4636.7 4958.3 5732.3 5757.1 5786.2 14:50:15 INFO - PROCESS | 2185 | 14:50:15 INFO - PROCESS | 2185 | [#5] yui.html Cycles:180 Average:19219.52 Median:4430.65 stddev:27655.30 (624.2%) stddev-sans-first:27697.64 14:50:15 INFO - PROCESS | 2185 | Values: 628.6 669.5 686.6 704.4 777.9 13910.9 14388.9 14521.3 14547.0 14591.1 12915.9 13026.9 13028.3 13051.2 13053.5 638.0 657.8 786.0 801.8 814.7 796.9 808.5 817.6 820.3 823.4 834.4 845.0 863.8 868.1 872.0 846.1 861.3 864.2 864.7 865.6 624.7 626.6 643.1 644.2 644.5 13756.1 13984.9 14048.9 14070.2 14438.5 13472.5 13674.1 13996.4 14052.6 14109.5 10994.0 11138.8 11283.3 11287.9 11449.9 3620.1 3645.2 3694.2 3710.3 3744.4 84669.6 84993.6 88584.0 91434.0 92095.1 10470.9 10642.9 10691.4 10708.4 10763.4 20945.0 21063.7 21109.9 21144.3 21514.1 7438.9 7449.8 7536.8 7559.7 7668.8 3956.2 4020.1 4058.2 4071.0 4073.1 3335.4 3441.4 3500.3 3524.5 3527.9 500.3 590.6 606.7 609.6 616.3 558.3 560.9 588.9 647.5 653.2 8066.6 8353.9 8449.6 8892.6 9037.3 534.4 615.5 639.5 642.8 643.9 4243.7 4369.0 4401.2 4417.7 4443.6 99127.5 110633.0 112037.4 112439.3 116178.0 56302.4 77826.0 80552.0 82600.0 83884.7 47792.0 65109.4 73624.5 73795.0 74181.3 7516.4 8050.2 9121.6 9444.5 9522.0 46359.0 49076.8 49387.0 50897.5 54117.4 61275.0 61785.7 72444.3 76795.0 77220.0 11855.2 12094.8 12239.9 12294.9 12301.8 11600.4 13707.4 14028.4 14204.5 14275.2 10567.6 12730.8 12973.3 13360.3 13578.2 12136.8 12612.3 12779.2 12978.0 12979.5 12679.6 12853.4 12894.9 12901.2 13492.9 10340.8 10826.9 11072.9 11187.1 11194.6 9061.7 9260.0 10264.7 11584.0 11621.8 14:50:15 INFO - PROCESS | 2185 | -------- Summary: end -------- 14:50:15 INFO - PROCESS | 2185 | 14:50:16 INFO - TEST-INFO | 2185: exit 0 14:50:16 INFO - TEST-OK | dromaeo_css | took 1116842ms 14:50:16 INFO - TEST-START | kraken 14:50:16 INFO - operating with platform_type : mac_ 14:50:16 INFO - Initialising browser for kraken test... 14:50:16 INFO - TEST-INFO | started process 2190 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpDkGzoU/profile http://localhost:52713/getInfo.html) 14:50:19 INFO - PROCESS | 2190 | 2017-01-10 14:50:19.605 plugin-container[2191:21594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8637, name = 'com.apple.tsm.portname' 14:50:19 INFO - PROCESS | 2190 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:19 INFO - PROCESS | 2190 | 2017-01-10 14:50:19.608 plugin-container[2191:21594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 14:50:19 INFO - PROCESS | 2190 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:19 INFO - PROCESS | 2190 | 2017-01-10 14:50:19.608 plugin-container[2191:21594] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:50:19 INFO - PROCESS | 2190 | __metrics Screen width/height:1600/1200 14:50:19 INFO - PROCESS | 2190 | colorDepth:24 14:50:19 INFO - PROCESS | 2190 | Browser inner width/height: 1024/689 14:50:19 INFO - PROCESS | 2190 | __metrics 14:50:19 ERROR - PROCESS | 2190 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 14:50:20 INFO - TEST-INFO | 2190: exit 0 14:50:20 INFO - Browser initialized. 14:50:20 INFO - Running cycle 1/1 for kraken test... 14:50:20 INFO - TEST-INFO | started process 2192 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpDkGzoU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:23 INFO - PROCESS | 2192 | 2017-01-10 14:50:23.262 plugin-container[2193:21717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 14:50:23 INFO - PROCESS | 2192 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:23 INFO - PROCESS | 2192 | 2017-01-10 14:50:23.263 plugin-container[2193:21717] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880b, name = 'com.apple.CFPasteboardClient' 14:50:23 INFO - PROCESS | 2192 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:23 INFO - PROCESS | 2192 | 2017-01-10 14:50:23.263 plugin-container[2193:21717] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:50:32 INFO - PROCESS | 2192 | RSS: Main: 229158912 14:50:32 INFO - PROCESS | 2192 | 14:50:35 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52713/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:36 INFO - PROCESS | 2192 | RSS: Main: 241545216 14:50:36 INFO - PROCESS | 2192 | 14:50:39 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52713/tests/kraken/driver.html?testName=audio-dft) 14:50:40 INFO - PROCESS | 2192 | RSS: Main: 249589760 14:50:40 INFO - PROCESS | 2192 | 14:50:43 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52713/tests/kraken/driver.html?testName=audio-fft) 14:50:43 INFO - PROCESS | 2192 | RSS: Main: 253386752 14:50:43 INFO - PROCESS | 2192 | 14:50:45 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52713/tests/kraken/driver.html?testName=audio-oscillator) 14:50:46 INFO - PROCESS | 2192 | RSS: Main: 253730816 14:50:46 INFO - PROCESS | 2192 | 14:50:48 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:49 INFO - PROCESS | 2192 | RSS: Main: 254881792 14:50:49 INFO - PROCESS | 2192 | 14:50:52 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52713/tests/kraken/driver.html?testName=imaging-darkroom) 14:50:52 INFO - PROCESS | 2192 | RSS: Main: 258801664 14:50:52 INFO - PROCESS | 2192 | 14:50:55 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52713/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:56 INFO - PROCESS | 2192 | RSS: Main: 258441216 14:50:56 INFO - PROCESS | 2192 | 14:50:59 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52713/tests/kraken/driver.html?testName=json-parse-financial) 14:50:59 INFO - PROCESS | 2192 | RSS: Main: 258572288 14:50:59 INFO - PROCESS | 2192 | 14:51:01 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:02 INFO - PROCESS | 2192 | RSS: Main: 257200128 14:51:02 INFO - PROCESS | 2192 | 14:51:04 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:04 INFO - PROCESS | 2192 | RSS: Main: 257265664 14:51:04 INFO - PROCESS | 2192 | 14:51:07 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:07 INFO - PROCESS | 2192 | RSS: Main: 257224704 14:51:07 INFO - PROCESS | 2192 | 14:51:10 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:11 INFO - PROCESS | 2192 | RSS: Main: 257613824 14:51:11 INFO - PROCESS | 2192 | 14:51:14 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:51:15 INFO - PROCESS | 2192 | RSS: Main: 257593344 14:51:15 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:52713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52713/tests/kraken/driver.html?testName=ai-astar) 14:51:17 INFO - PROCESS | 2192 | RSS: Main: 259252224 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | __start_tp_report 14:51:17 INFO - PROCESS | 2192 | _x_x_mozilla_page_load 14:51:17 INFO - PROCESS | 2192 | _x_x_mozilla_page_load_details 14:51:17 INFO - PROCESS | 2192 | |i|pagename|runs| 14:51:17 INFO - PROCESS | 2192 | |0;ai-astar;87;106;101;129;172;175;122;113;119;119 14:51:17 INFO - PROCESS | 2192 | |1;audio-beat-detection;147;112;126;178;114;114;113;118;140;98 14:51:17 INFO - PROCESS | 2192 | |2;audio-dft;197;201;198;195;200;196;195;201;198;202 14:51:17 INFO - PROCESS | 2192 | |3;audio-fft;82;58;58;89;59;60;63;60;79;60 14:51:17 INFO - PROCESS | 2192 | |4;audio-oscillator;95;72;91;73;70;70;90;71;72;109 14:51:17 INFO - PROCESS | 2192 | |5;imaging-gaussian-blur;110;127;136;92;93;106;95;91;77;130 14:51:17 INFO - PROCESS | 2192 | |6;imaging-darkroom;101;103;128;171;102;104;104;112;103;103 14:51:17 INFO - PROCESS | 2192 | |7;imaging-desaturate;89;92;104;139;88;89;90;91;89;125 14:51:17 INFO - PROCESS | 2192 | |8;json-parse-financial;58;57;56;61;61;61;59;58;59;59 14:51:17 INFO - PROCESS | 2192 | |9;json-stringify-tinderbox;77;72;72;95;116;116;73;75;75;74 14:51:17 INFO - PROCESS | 2192 | |10;stanford-crypto-aes;89;83;84;79;86;102;77;97;108;107 14:51:17 INFO - PROCESS | 2192 | |11;stanford-crypto-ccm;144;142;139;141;154;160;170;167;199;284 14:51:17 INFO - PROCESS | 2192 | |12;stanford-crypto-pbkdf2;167;210;199;195;165;216;238;166;193;193 14:51:17 INFO - PROCESS | 2192 | |13;stanford-crypto-sha256-iterative;68;69;69;69;96;91;74;69;67;66 14:51:17 INFO - PROCESS | 2192 | __end_tp_report 14:51:17 INFO - PROCESS | 2192 | __start_cc_report 14:51:17 INFO - PROCESS | 2192 | _x_x_mozilla_cycle_collect,971 14:51:17 INFO - PROCESS | 2192 | __end_cc_report 14:51:17 INFO - PROCESS | 2192 | __startTimestamp1484088677546__endTimestamp 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | ------- Summary: start ------- 14:51:17 INFO - PROCESS | 2192 | Number of tests: 14 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#0] ai-astar Cycles:10 Average:124.30 Median:125.50 stddev:28.53 (22.7%) stddev-sans-first:26.88 14:51:17 INFO - PROCESS | 2192 | Values: 87.0 106.0 101.0 129.0 172.0 175.0 122.0 113.0 119.0 119.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:133.00 stddev:23.19 (17.4%) stddev-sans-first:23.32 14:51:17 INFO - PROCESS | 2192 | Values: 147.0 112.0 126.0 178.0 114.0 114.0 113.0 118.0 140.0 98.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#2] audio-dft Cycles:10 Average:198.30 Median:199.00 stddev:2.58 (1.3%) stddev-sans-first:2.70 14:51:17 INFO - PROCESS | 2192 | Values: 197.0 201.0 198.0 195.0 200.0 196.0 195.0 201.0 198.0 202.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.50 stddev:11.75 (19.1%) stddev-sans-first:11.10 14:51:17 INFO - PROCESS | 2192 | Values: 82.0 58.0 58.0 89.0 59.0 60.0 63.0 60.0 79.0 60.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:72.50 stddev:13.86 (19.1%) stddev-sans-first:13.78 14:51:17 INFO - PROCESS | 2192 | Values: 95.0 72.0 91.0 73.0 70.0 70.0 90.0 71.0 72.0 109.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#5] imaging-gaussian-blur Cycles:10 Average:105.70 Median:84.00 stddev:19.68 (23.4%) stddev-sans-first:20.81 14:51:17 INFO - PROCESS | 2192 | Values: 110.0 127.0 136.0 92.0 93.0 106.0 95.0 91.0 77.0 130.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#6] imaging-darkroom Cycles:10 Average:113.10 Median:104.00 stddev:21.90 (21.1%) stddev-sans-first:22.79 14:51:17 INFO - PROCESS | 2192 | Values: 101.0 103.0 128.0 171.0 102.0 104.0 104.0 112.0 103.0 103.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:89.00 stddev:17.99 (20.2%) stddev-sans-first:18.67 14:51:17 INFO - PROCESS | 2192 | Values: 89.0 92.0 104.0 139.0 88.0 89.0 90.0 91.0 89.0 125.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:1.73 (2.9%) stddev-sans-first:1.80 14:51:17 INFO - PROCESS | 2192 | Values: 58.0 57.0 56.0 61.0 61.0 61.0 59.0 58.0 59.0 59.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#9] json-stringify-tinderbox Cycles:10 Average:84.50 Median:74.50 stddev:17.91 (24.0%) stddev-sans-first:18.79 14:51:17 INFO - PROCESS | 2192 | Values: 77.0 72.0 72.0 95.0 116.0 116.0 73.0 75.0 75.0 74.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:83.50 stddev:11.47 (13.7%) stddev-sans-first:12.14 14:51:17 INFO - PROCESS | 2192 | Values: 89.0 83.0 84.0 79.0 86.0 102.0 77.0 97.0 108.0 107.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#11] stanford-crypto-ccm Cycles:10 Average:170.00 Median:163.50 stddev:44.05 (26.9%) stddev-sans-first:45.71 14:51:17 INFO - PROCESS | 2192 | Values: 144.0 142.0 139.0 141.0 154.0 160.0 170.0 167.0 199.0 284.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.20 Median:197.00 stddev:23.71 (12.0%) stddev-sans-first:23.01 14:51:17 INFO - PROCESS | 2192 | Values: 167.0 210.0 199.0 195.0 165.0 216.0 238.0 166.0 193.0 193.0 14:51:17 INFO - PROCESS | 2192 | 14:51:17 INFO - PROCESS | 2192 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:69.00 stddev:10.65 (15.4%) stddev-sans-first:11.09 14:51:17 INFO - PROCESS | 2192 | Values: 68.0 69.0 69.0 69.0 96.0 91.0 74.0 69.0 67.0 66.0 14:51:17 INFO - PROCESS | 2192 | -------- Summary: end -------- 14:51:17 INFO - PROCESS | 2192 | 14:51:18 INFO - TEST-INFO | 2192: exit 0 14:51:18 INFO - TEST-OK | kraken | took 62207ms 14:51:18 INFO - SUITE-END | took 1179s 14:51:18 INFO - Completed test suite (00:19:39) 14:51:18 INFO - javascript benchmark 14:51:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6972.841322117221, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3235.627902791179, 3297.7856439331426, 3301.042697617691, 3343.648916863729, 3373.4939759036142, 5514.889702205954, 5546.278983732114, 5560.193771903072, 5566.332040155187, 5606.187102870082, 5540.612157149001, 5616.354119276284, 5623.409541998082, 5631.8028868989595, 5654.349749778777, 5078.415982162052, 5102.948970510303, 5132.332796736419, 5151.253068305094, 5178.048343064385, 5176.715280659562, 5196.168613021917, 5205.0, 5211.765470553834, 5219.425863155069, 4201.852935147271, 5035.723035233061, 5085.364329458817, 5163.380394352683, 5178.5339319461245, 5110.8466745997675, 5122.0, 5127.717975511346, 5130.0, 5166.992436474889, 5056.848294551132, 5094.465081166498, 5101.566366858821, 5159.484051594848, 5168.0, 5636.689982050985, 5636.859078523029, 5647.463490968393, 5680.204771332017, 5692.943070569283, 5871.941280587225, 5959.612625179349, 6035.155078289043, 6074.848128796772, 6089.512838972916, 6095.542834287447, 6118.235220597426, 6121.755129794803, 6128.38716128388, 6131.724072416752, 5552.416996215379, 5615.691136987464, 5630.887382252414, 5677.233573467612, 5677.347105082886, 6172.783952561639, 6210.4100110489435, 6218.098375735583, 6244.968775156186, 6253.874922501524, 5861.325947516005, 5997.670128142994, 6004.909926351108, 6007.459328660354, 6013.1581578579035, 5958.374370691102, 5999.490043346277, 6047.425494578008, 6054.182685337423, 6070.150178974947, 6071.696415179312, 6077.179580756541, 6077.544184186204, 6079.513638908877, 6081.270247570232, 4979.253112033224, 5193.091209038479, 5536.4186760390385, 6060.545459090586, 6079.452849243589, 4726.787294571753, 4747.928781068286, 4770.928436073462, 4807.735574543363, 4824.927626085611, 4290.721103128287, 4291.9785401072795, 4306.074194048295, 4307.590778876001, 4331.7834108294455, 4427.0, 5668.26312579362, 5672.914906276409, 5709.571782116358, 5716.08542633185, 5434.538064264581, 5471.5896307777075, 5929.73316200772, 5973.402659734079, 6135.5398345124295, 5538.418466061086, 5553.694546799884, 5587.469190426903, 5627.465390787868, 5647.209390685307, 5199.324087868553, 5227.529522342931, 5239.973800130975, 5241.895162096736, 5249.186376111708, 6109.0403061477, 6129.267100814712, 6168.9691551541955, 6189.1954045975535, 6253.749850006131, 5006.49935006511, 6125.785597504066, 6135.0, 6140.815775526741, 6173.722182501709, 6205.813825585059, 6209.59637623553, 6217.253929528486, 6218.471429928326, 6239.251289845248, 5822.679752613478, 5869.148973398748, 5874.676892770939, 5917.940820591911, 5993.400659933972, 6016.87966240664, 6026.578139530191, 6117.522930757332, 6127.403330890726, 6136.3965394158, 5903.881922361443, 5918.674472904032, 5932.377100404568, 5938.168656388196, 5950.047992321208, 5698.686572238401, 5789.739461724317, 5871.706414679335, 5921.200637913998, 5964.7912323068485, 4981.227909674007, 5382.111951528111, 5650.830475085754, 5726.141078838207, 5730.570207234391, 5811.883762324815, 5837.416258374298, 5871.706414679164, 5951.880962380815, 6010.669413182317, 5737.282839645044, 5748.993926063006, 5767.307923049261, 5777.740001700017, 5778.566607504538], "value": 5526.233692607664, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.83615062426907, 487.4004973882125, 505.31025150669325, 512.513112543084, 515.5772266741272, 23170.536589268224, 38107.85676429708, 39227.21545569091, 39333.40999885004, 40150.996225094386, 39899.40150897739, 40258.7987060065, 40269.597304027026, 40335.19329613413, 40404.79797601015, 9196.172344488994, 9282.535873206347, 9351.392159509644, 9399.718008459722, 9434.764130896749, 9333.300002499805, 9387.249020078412, 9391.859122113174, 9392.389494682824, 9423.199028082621, 9371.437713737163, 9408.764780880465, 9423.764405889873, 9424.246060315158, 9457.290703197288, 9306.348555601111, 9377.578008989543, 9380.577873995653, 9393.20157786582, 9394.201492873113, 8830.161134692195, 8853.822923541493, 8883.86674199881, 8893.955530222307, 8918.910810891874, 32273.0, 38004.23991520182, 38057.809710951544, 38323.425148622795, 38419.42370864439, 3235.0, 3270.3949769292517, 3350.547676063749, 3467.7745946513396, 3938.645521903014, 27581.724182758117, 28870.711292887012, 29263.561046584317, 29655.55516667252, 29732.55401168984, 2592.8833202505743, 2913.863593198654, 3162.0197738701077, 3198.440272952224, 3203.2312245061253, 412093.0, 465928.0, 471504.0, 472640.0, 473118.0, 56292.15561766495, 56365.7181714097, 56408.0, 56594.43405565974, 56962.43037569654, 58874.705626471594, 59497.0, 59540.40459595435, 59609.0, 59687.40312596905, 15579.766303505456, 15798.89407741447, 15807.604809879846, 15841.762373564407, 16000.519984400487, 11175.44122793857, 11338.489767960296, 11340.943295283636, 11351.886481135249, 11379.544818207345, 13869.791953120712, 13962.790558141636, 14267.42930282777, 15059.0, 15129.697406051817, 3130.98434507826, 3252.642209356969, 6352.7776527822225, 6445.838854028687, 6450.258220304725, 766.3983772738374, 819.9549024803574, 912.3020889019905, 925.2228128372066, 1075.2956813287153, 24608.507829843304, 28134.155975320773, 28775.85612071926, 29768.851155744516, 29898.80404783828, 991.8264303746815, 1021.6628512590827, 1025.9846102308472, 1036.4662198967537, 1041.7499800047933, 15436.228188590525, 15473.5357939262, 15535.223238838013, 15722.29249683767, 16340.0, 593780.0, 598031.0, 599871.0, 603895.0, 606002.0, 53764.19353709697, 53769.73115134399, 54164.45835541594, 54428.91142177134, 54499.91000179974, 1161.5992482593492, 1345.7375811716818, 1347.75066612675, 1363.6931690369786, 1385.300423286254, 29356.412871742017, 30152.547711783904, 30226.69773302239, 30363.033019736078, 30475.238119046313, 46788.7660561695, 47538.28692569683, 47668.7616561915, 47723.761381192875, 47818.0, 472614.0, 473880.0, 474756.0, 475264.0, 476944.0, 25000.0, 25415.0, 25523.744762552138, 25566.360840979123, 26502.0, 43977.34033989429, 44228.89427764332, 44748.0, 44900.326495101945, 45028.549714502435, 36548.0, 37286.62713372832, 37821.62178378181, 39140.0, 40604.79697601493, 37331.626683732815, 37586.0, 37968.58282754565, 38913.610863891, 39006.60993390143, 36798.63201367952, 37398.8130059348, 37655.81172094122, 37753.81123094367, 37897.052573685876, 32407.675923240466, 33833.83083084569, 34073.0, 34351.82824085864, 34739.305213896085, 25553.61669574995, 25610.487790244464, 25659.74340256648, 25718.614220787076, 25999.350016248987], "value": 18791.66812861368, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6681585677749, 364.87594217965886, 368.2708237689374, 382.82964080983976, 394.54036048004076, 14873.256337183138, 18129.728054079183, 18585.814141858576, 19415.32046378377, 20106.872747449415, 17435.564110897234, 18363.632727345477, 19417.805821941776, 19639.5090122747, 19758.30845920393, 5648.548116150698, 5878.853028674274, 5902.409759024106, 5905.7342419591005, 5914.9112763308585, 4360.956390436087, 6400.0, 6471.741130354781, 6543.280239173687, 6558.93441065588, 6143.8771224575485, 6229.345918678541, 6470.0, 6503.187101612299, 6515.153030106103, 6224.439800417961, 6247.281562620288, 6283.560150789446, 6295.748170073191, 6302.716377763011, 5253.290805741214, 5330.840074797724, 5551.139573366095, 5602.887942241173, 5610.102383618601, 24667.25998220056, 24703.641299728508, 24767.5046499069, 24917.87541062301, 25052.0, 2224.4994876152737, 2316.073570571768, 2356.0693526057285, 2391.8564886106888, 2406.2660888429023, 11549.307041577533, 15037.323320450607, 15210.315535800915, 15432.459863904822, 15884.682306353809, 1741.7909850817857, 1823.4347352320824, 1825.6531259060869, 1843.797182309945, 1857.9814201858078, 118183.0, 122580.0, 122993.77006229913, 127527.3623631876, 129686.0, 11170.609028683957, 11285.322880627024, 11464.369459679798, 11522.423878806027, 11671.007964322958, 14170.787438188436, 14312.28438578067, 14320.14079155254, 14347.92826035863, 14365.353559089866, 6671.966640166768, 8360.0, 8382.07797142314, 8445.873311900326, 8461.026981897161, 8246.155076498599, 8264.793380165544, 8278.130796266305, 8434.746957591282, 8440.240378365976, 4355.73865568067, 4447.266201076786, 4456.732596044183, 4468.4414448193975, 4513.54864513546, 1888.2722309087305, 1910.9808901910803, 1914.636219118363, 1916.5208697825544, 1921.7693876734882, 813.9865866995628, 896.9865452018225, 937.1706040154376, 953.1516949914582, 969.9224062075017, 17692.0, 19456.805431945784, 20227.898860505604, 20458.977051147383, 20585.58828823415, 410.26152924735356, 831.4470876866936, 924.9398789078823, 928.6146249306597, 942.886853577575, 5692.31692196939, 5721.141828725725, 5768.971155144198, 5835.679037652885, 6124.081387791778, 547031.0, 556856.0, 558217.0, 562175.0, 586094.0, 77148.0, 124464.37767811104, 125208.0, 126312.73687263194, 128750.0, 439.44849214235927, 445.37647293788956, 445.6279007029102, 447.3178402935549, 448.2693210067569, 10637.893621063691, 10791.190660700322, 11035.282706624044, 11101.278416902875, 11281.32312061279, 34511.79208727682, 47051.76474117608, 47440.051198976515, 51814.740926295126, 55787.163192551336, 68752.31247687459, 72018.63990680013, 73152.0, 79952.60023699845, 80031.19968800238, 6563.9343606563325, 7836.0, 7915.366770658448, 8068.273855353046, 8199.754007379788, 10954.233203675667, 12141.907228349492, 12223.75552488963, 12290.938545307215, 12415.689607759878, 10567.0, 10590.4704764763, 10613.257072004886, 10650.57397704083, 10988.835167472334, 10517.21120915919, 10642.946785266335, 10684.0, 10726.302790318605, 10882.129429645767, 10596.89403105959, 10721.731956701145, 11196.888031119584, 11233.101351891666, 11370.54517819278, 5929.495992840657, 7640.3505702015955, 7949.046114466301, 7967.2431119043595, 8107.148749381466, 10677.0, 10757.569697212024, 10778.461076946278, 10788.622398216025, 10847.24069315172], "value": 8917.717698422448, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.8338957630294, 1457.9635509112275, 1624.3421414327195, 1812.6555954368662, 1822.4077174918154, 7579.924200757991, 7881.645325960331, 8109.472884262519, 8584.399092063559, 8589.441686290395, 8033.91966080339, 8284.91715082849, 8354.624041918112, 8372.665093396257, 8382.0, 2303.7811407916265, 2355.0697474497565, 2363.385519764865, 2364.13708996216, 2377.5720370333333, 2342.227065068523, 2385.4513461903684, 2390.557746816836, 2395.892184851677, 2398.760123987605, 2338.240071976606, 2350.576896158691, 2353.3998830298337, 2357.0807385119815, 2372.406898275431, 2299.1493147535434, 2309.4688221708934, 2333.2650215182334, 2333.7082864641834, 2339.578875802355, 2342.273895092527, 2353.2704861492994, 2364.869932153731, 2374.465745207332, 2385.1651921827397, 8301.211384918422, 8356.874646880302, 8407.2433480987, 8436.02985656645, 8442.535660538668, 4973.104841128596, 5132.409772876093, 5134.486551344873, 5135.1270284051425, 5136.717480538568, 3410.778299410555, 3422.349753546818, 3460.3044508191056, 3480.3387356402204, 3563.82180890957, 1065.690949624608, 1078.0890147825153, 1083.0523292119397, 1108.130117857478, 1114.9888501114965, 10807.729806754816, 10868.565257389695, 10923.126149907988, 11001.00990910822, 11023.393713345762, 4555.567221113989, 4686.437627484655, 4709.976450117728, 4741.668083234141, 4754.690945088558, 9571.712848614552, 9598.616055357708, 9610.375325603813, 9611.759706007406, 9631.0, 5254.211868219798, 5258.1849813279005, 5258.789648414097, 5259.869128137392, 5261.421243663271, 4302.913941721211, 4306.806193721228, 4734.810607575727, 4741.739204343725, 4800.495947925488, 3317.552130462405, 3363.899083027513, 3553.7206605621955, 3813.6186381362195, 3972.1261322509004, 1122.3602546548389, 1286.163993404276, 1286.3375361688738, 1296.8767967043116, 1301.531448678475, 801.1187693537063, 871.5511511571545, 872.4808738800403, 877.2893955895745, 890.4034297021011, 5511.3937466878615, 5521.613487055948, 5608.990381731328, 5615.971920140373, 5761.711914404263, 865.1651156633878, 881.2201201936205, 908.5638893331106, 935.8830146231721, 972.5866506734751, 3526.0479670488826, 3704.7406681532575, 3829.100161462054, 3829.119302560371, 3884.3979183226643, 9752.21982241419, 9933.950330248303, 9982.0, 10137.797244055078, 10156.644517442002, 10029.29794914349, 10037.598496060076, 10041.447720375449, 10043.598256069676, 10088.899111008943, 7363.595002274927, 7795.14253432122, 7904.920950790419, 7906.011748531434, 7923.088844782808, 4941.431735350337, 5125.666831655931, 5371.919421208607, 5395.406505284337, 5477.698726569917, 9442.10300021497, 9483.620655173992, 9503.762405939908, 9504.809903802023, 9530.904690953003, 9116.08839116083, 9517.904820951979, 9529.761755956157, 9531.237500999765, 9683.951580242054, 6437.259715132633, 6825.897611535732, 6982.301769822977, 7143.714251429885, 7311.817204569928, 7839.33365663925, 7941.682332706627, 8008.0, 8014.599270036359, 8025.317847982987, 6992.0, 7172.0676312079095, 7174.0, 7194.71221151169, 7230.096237970254, 6895.6552172392185, 6948.513604047668, 7007.404370628554, 7065.470089743187, 7086.574805511686, 6545.247296560766, 6656.267810540739, 6694.364035416627, 6711.731530738716, 6717.697703603448, 4791.377120974391, 4813.302071199727, 4824.927626085541, 4835.879103022453, 4874.610031197425, 4752.097101550694, 4817.325574419654, 4841.540053694894, 4942.901141977212, 4975.253711943237], "value": 4427.184698748856, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.3586228912898, 277.18645774651395, 304.69135064896267, 304.95425686147087, 310.07133634763886, 4347.934780978288, 4356.433663623732, 4720.268358404449, 5135.64050516464, 5413.750206088222, 4333.653307735373, 5082.440931497542, 5155.587552995761, 5333.573314134869, 5365.919511207335, 3007.7593792496546, 3243.232438321109, 3911.3350730375764, 4171.498260626172, 4402.236088144622, 3800.6507689770146, 4192.056787222881, 4201.348790937394, 4201.537830838605, 4232.174725928445, 3520.4543295789194, 4045.352743561031, 4069.470968774055, 4080.4083407905837, 4108.5686002969705, 3430.142464383904, 3758.32350176968, 4012.0371110933456, 4061.289274376972, 4067.8983025424454, 2629.842209467419, 3102.705243001911, 3147.040152753409, 3480.617132115465, 3523.8766643167364, 3995.680345572347, 4963.081829861487, 5099.46455622158, 5266.578673706094, 5311.760970756325, 3671.7980511071883, 3960.722749407543, 4283.550227226158, 4604.907901841944, 4636.350910872447, 5127.48725127488, 5429.429909859447, 5630.915536266918, 5657.519110875581, 5667.716614169275, 3383.849491173013, 3533.5724347382998, 3575.4279315309427, 3729.421939599339, 3873.6707379872746, 5645.887082258373, 5914.704264786744, 5919.585629005971, 5980.43185897339, 5995.730192141364, 3328.7170590500077, 3856.8650097246464, 3912.941305880414, 3915.6084391560616, 3923.0780766519847, 3636.581793093775, 3693.316736403774, 3763.0592351912023, 3980.7412518186225, 3994.08431844755, 3695.020819482839, 3927.509061367329, 4664.274218539163, 4664.854167083112, 4675.906481870344, 5765.1928729977835, 5777.62445441045, 5795.710214489343, 5807.361190269067, 5841.88316233673, 1150.3730466895563, 1204.7952047952049, 1245.2279586656332, 1245.5702782540009, 1250.3560666256885, 734.6914295995695, 850.5194565070715, 873.9992708349032, 880.7798050487378, 886.9268185495623, 4766.713997160182, 4993.800247990112, 5018.2650455501835, 5018.774155163026, 5069.949300506948, 4706.576408123286, 4817.614590832725, 5385.353757549119, 5438.0, 5623.790884959753, 4503.842365517191, 4715.55202255792, 5019.0, 5126.641135120506, 5141.845744627667, 2528.443742376674, 2714.850683212442, 2783.6937936826935, 2873.425314937021, 2907.5057240269207, 5637.43625637433, 5692.715364231854, 5694.658320500783, 5815.331236907725, 5859.853503662443, 4104.630583247463, 5299.834036511961, 5392.379876314196, 5591.720413979366, 5602.13166959122, 4936.383716630192, 5542.528885044736, 5654.491095801398, 5713.171785028834, 5744.0, 5048.646594738333, 5336.653117547347, 5442.516789254801, 5520.295055422895, 5571.526420254324, 4328.896256278632, 4334.65322774171, 4833.564979151753, 5189.792408303626, 5363.704996225245, 5252.975669744364, 5283.947160528499, 5389.380221274603, 5432.979595099677, 5701.458361455655, 2983.477891369045, 3412.8601686449024, 3732.9734323061375, 3750.293616404584, 3758.1732018955786, 4903.95096049035, 5074.923876141787, 5463.53559947393, 5948.762049517971, 5949.2266005419015, 4626.282926146453, 5069.391672999263, 5354.7590358434745, 5754.280714910637, 5756.453136951983, 5163.095059693232, 5708.457696518824, 5750.821081678329, 5765.308163020464, 5802.997965701826, 4796.472388037383, 5381.946180538144, 5650.915236271377, 5693.3168019837885, 5751.405371642723, 5501.9174712380145, 5792.177163072352, 5830.329512105993, 5830.970845145747, 5860.443257890493, 4636.721796692209, 4958.322505846802, 5732.251663242751, 5757.136429535603, 5786.213786213786], "value": 3977.6331405943843, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.5537268539337, 669.5447095974736, 686.5503095472466, 704.3590332797156, 777.9222077792222, 13910.930445347773, 14388.92805535971, 14521.346539405726, 14546.999999999987, 14591.051581647185, 12915.935420322909, 13026.934865325684, 13028.306320178364, 13051.216926984387, 13053.543125990569, 637.9808605741836, 657.7599176300664, 785.9960700196491, 801.7594721583516, 814.6700586262573, 796.9043714754238, 808.5310519898445, 817.5789468423767, 820.335528222139, 823.4071468542639, 834.4200780457554, 845.0, 863.7581477186397, 868.0668281597276, 872.0451106038877, 846.0693237438799, 861.2765277167209, 864.1962974433774, 864.6800683747023, 865.6191275838611, 624.687656171914, 626.5520153090516, 643.1125047434557, 644.2397970394932, 644.4715333426592, 13756.105853119616, 13984.93007534966, 14048.92975535126, 14070.15579065249, 14438.494652687106, 13472.461101555926, 13674.111182773187, 13996.401439424311, 14052.648683782885, 14109.535204190843, 10994.0, 11138.832917506244, 11283.323000619906, 11287.943560282147, 11449.942750286194, 3620.113072297304, 3645.216278500135, 3694.1503454205413, 3710.3135919854913, 3744.3634582121103, 84669.57665211635, 84993.57503212507, 88584.0, 91434.0, 92095.07904920932, 10470.947645261725, 10642.89357106419, 10691.35851848876, 10708.357498550113, 10763.3541987481, 20944.952752362628, 21063.68404473934, 21109.9445027748, 21144.259950901953, 21514.13943442276, 7438.925610743931, 7449.813754656177, 7536.849263014709, 7559.659815308324, 7668.808279792938, 3956.188981258835, 4020.115574573589, 4058.2492238935893, 4071.043304823364, 4073.1446396256524, 3335.449650807638, 3441.3633477806684, 3500.2824420994143, 3524.4537096750046, 3527.8588856445967, 500.2546206152879, 590.5541316306161, 606.7148440233084, 609.5550248318664, 616.3374372549528, 558.3355806590145, 560.9102543593006, 588.9057750759944, 647.5337756815086, 653.1769969838039, 8066.596670166468, 8353.916460835435, 8449.619767110495, 8892.553281314435, 9037.322200834964, 534.4415086234894, 615.5227454110171, 639.5107742576932, 642.7975187815823, 643.9098526206335, 4243.745375277494, 4369.0, 4401.207782599099, 4417.734935903856, 4443.555644435531, 99127.50436247773, 110633.0, 112037.3633245816, 112439.31341029891, 116178.0, 56302.43697562972, 77826.0, 80552.0, 82600.0, 83884.74172887411, 47792.0, 65109.37226569374, 73624.52750945058, 73795.0, 74181.25818741851, 7516.398688105048, 8050.235227653364, 9121.635134594808, 9444.527773611155, 9521.952390238004, 46359.0, 49076.75461622669, 49387.0, 50897.491025090756, 54117.3764787057, 61275.0, 61785.69107154435, 72444.27555724586, 76795.0, 77220.0, 11855.221716742557, 12094.818577721166, 12239.87760122423, 12294.877051229374, 12301.753964920472, 11600.419979001184, 13707.383167757675, 14028.438862445388, 14204.502842400467, 14275.214863182624, 10567.63013294531, 12730.809037864625, 12973.286469244282, 13360.265185414506, 13578.185308881499, 12136.817947730615, 12612.306323152316, 12779.169353991962, 12978.0, 12979.545715899898, 12679.619611411672, 12853.35733213317, 12894.935525322313, 12901.161424507753, 13492.920566354473, 10340.844887326846, 10826.89173108259, 11072.889271107508, 11187.105031597615, 11194.608188713355, 9061.728148155566, 9260.0, 10264.692059238234, 11584.0, 11621.76756464883], "value": 7047.132459875266, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 106.0, 101.0, 129.0, 172.0, 175.0, 122.0, 113.0, 119.0, 119.0], "value": 124.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 126.0, 178.0, 114.0, 114.0, 113.0, 118.0, 140.0, 98.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 201.0, 198.0, 195.0, 200.0, 196.0, 195.0, 201.0, 198.0, 202.0], "value": 198.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 89.0, 59.0, 60.0, 63.0, 60.0, 79.0, 60.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 72.0, 91.0, 73.0, 70.0, 70.0, 90.0, 71.0, 72.0, 109.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 127.0, 136.0, 92.0, 93.0, 106.0, 95.0, 91.0, 77.0, 130.0], "value": 105.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 103.0, 128.0, 171.0, 102.0, 104.0, 104.0, 112.0, 103.0, 103.0], "value": 113.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 104.0, 139.0, 88.0, 89.0, 90.0, 91.0, 89.0, 125.0], "value": 99.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 61.0, 61.0, 61.0, 59.0, 58.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 72.0, 95.0, 116.0, 116.0, 73.0, 75.0, 75.0, 74.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 84.0, 79.0, 86.0, 102.0, 77.0, 97.0, 108.0, 107.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 139.0, 141.0, 154.0, 160.0, 170.0, 167.0, 199.0, 284.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 210.0, 199.0, 195.0, 165.0, 216.0, 238.0, 166.0, 193.0, 193.0], "value": 194.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 96.0, 91.0, 74.0, 69.0, 67.0, 66.0], "value": 73.8, "unit": "score"}]}]} 14:51:18 INFO - Return code: 0 14:51:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:51:18 ERROR - # TBPL SUCCESS # 14:51:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:51:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:51:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:51:18 INFO - 2017-01-10 14:51:18.857 screenresolution[2197:22101] starting screenresolution argv=screenresolution get 14:51:18 INFO - 2017-01-10 14:51:18.860 screenresolution[2197:22101] Display 0: 1600x1200x32@60 14:51:18 INFO - 2017-01-10 14:51:18.867 screenresolution[2198:22104] starting screenresolution argv=screenresolution list 14:51:18 INFO - Available Modes on Display 0 14:51:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:51:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:51:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:51:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:51:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:51:19 INFO - Intel Iris: 14:51:19 INFO - Chipset Model: Intel Iris 14:51:19 INFO - Type: GPU 14:51:19 INFO - Bus: Built-In 14:51:19 INFO - VRAM (Dynamic, Max): 1536 MB 14:51:19 INFO - Vendor: Intel (0x8086) 14:51:19 INFO - Device ID: 0x0a2e 14:51:19 INFO - Revision ID: 0x0009 14:51:19 INFO - Displays: 14:51:19 INFO - Display: 14:51:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:51:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:51:19 INFO - Display Serial Number: 1600x1200 60 14:51:19 INFO - Main Display: Yes 14:51:19 INFO - Mirror: Off 14:51:19 INFO - Online: Yes 14:51:19 INFO - Rotation: Supported 14:51:19 INFO - Return code: 0 14:51:19 INFO - Running post-action listener: _resource_record_post_action 14:51:19 INFO - [mozharness: 2017-01-10 22:51:19.111279Z] Finished run-tests step (success) 14:51:19 INFO - Running post-run listener: _resource_record_post_run 14:51:19 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 544768; Write bytes: 655074816; Read time: 4; Write time: 1961 14:51:19 INFO - TinderboxPrint: CPU usage
54.3% 14:51:19 INFO - TinderboxPrint: I/O read bytes / time
544,768 / 4 14:51:19 INFO - TinderboxPrint: I/O write bytes / time
655,074,816 / 1,961 14:51:19 INFO - TinderboxPrint: CPU idle
2,213.1 (45.7%) 14:51:19 INFO - TinderboxPrint: CPU system
984.6 (20.3%) 14:51:19 INFO - TinderboxPrint: CPU user
1,648.0 (34.0%) 14:51:19 INFO - TinderboxPrint: Swap in / out
348,979,200 / 0 14:51:19 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 334338560; Write bytes: 334133248; Read time: 26512; Write time: 699 14:51:19 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 544768; Write bytes: 303169024; Read time: 4; Write time: 1204 14:51:19 INFO - Running post-run listener: _upload_blobber_files 14:51:19 INFO - Blob upload gear active. 14:51:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:19 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 14:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:51:20 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:20 INFO - (blobuploader) - INFO - Done attempting. 14:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:21 INFO - (blobuploader) - INFO - Done attempting. 14:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:24 INFO - (blobuploader) - INFO - Done attempting. 14:51:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:24 INFO - Return code: 0 14:51:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe70d07e6cdfa216c8af089f06c1113284c59633f02693cc00e5a1d2904f15c11f3ad03e3c63b9bd8f77e19a97a1c08550234e78641fcd3623f498a49bd0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/773841eeb7ccbdbd46f8fd1b02e2831f9e1474023a6ca2ef5913dbdfb8c94456a34f090eeb69781af01813012afe3c4f3a55645eab11701523e28915cfa3265c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a330795d78ee13dba6424e8ba8ce1648e8abfd7bd913c96c7a9beb02130ebd3b82ed84b57e4c9bae51e9cad63d8eff386355ff92b9556ed382c1d17fa01a1378"} 14:51:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:24 INFO - Contents: 14:51:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe70d07e6cdfa216c8af089f06c1113284c59633f02693cc00e5a1d2904f15c11f3ad03e3c63b9bd8f77e19a97a1c08550234e78641fcd3623f498a49bd0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/773841eeb7ccbdbd46f8fd1b02e2831f9e1474023a6ca2ef5913dbdfb8c94456a34f090eeb69781af01813012afe3c4f3a55645eab11701523e28915cfa3265c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a330795d78ee13dba6424e8ba8ce1648e8abfd7bd913c96c7a9beb02130ebd3b82ed84b57e4c9bae51e9cad63d8eff386355ff92b9556ed382c1d17fa01a1378"} 14:51:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:51:24 INFO - Copying logs to upload dir... 14:51:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:51:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.393615 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-10 14:51:24.131048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 14:51:24.134989) ========= 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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe70d07e6cdfa216c8af089f06c1113284c59633f02693cc00e5a1d2904f15c11f3ad03e3c63b9bd8f77e19a97a1c08550234e78641fcd3623f498a49bd0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/773841eeb7ccbdbd46f8fd1b02e2831f9e1474023a6ca2ef5913dbdfb8c94456a34f090eeb69781af01813012afe3c4f3a55645eab11701523e28915cfa3265c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a330795d78ee13dba6424e8ba8ce1648e8abfd7bd913c96c7a9beb02130ebd3b82ed84b57e4c9bae51e9cad63d8eff386355ff92b9556ed382c1d17fa01a1378"} build_url:https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010934 build_url: 'https://queue.taskcluster.net/v1/task/ZDGpKFZQQEaAAeYhC09S9g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3cfe70d07e6cdfa216c8af089f06c1113284c59633f02693cc00e5a1d2904f15c11f3ad03e3c63b9bd8f77e19a97a1c08550234e78641fcd3623f498a49bd0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/773841eeb7ccbdbd46f8fd1b02e2831f9e1474023a6ca2ef5913dbdfb8c94456a34f090eeb69781af01813012afe3c4f3a55645eab11701523e28915cfa3265c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a330795d78ee13dba6424e8ba8ce1648e8abfd7bd913c96c7a9beb02130ebd3b82ed84b57e4c9bae51e9cad63d8eff386355ff92b9556ed382c1d17fa01a1378"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 14:51:24.169334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:51:24.169682) ========= 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.VMIe6E6Lza/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.5xyfWPaqTw/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.005408 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:51:24.219413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 14:51:24.219864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 14:51:24.220280) ========= ========= Total master_lag: 2.69 =========