builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0342 starttime: 1485332310.06 results: success (0) buildid: 20170124212147 builduid: 84e8828162174a6c85eb061ef83ccb2d revision: 05453493c53396a6fbdb5f826db4fe241b5ebfb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.062912) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.063770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.064331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.093085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.093740) ========= 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.iWGScxdIf1/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.U7buEW1BcT/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-25 00:18:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.99M=0.001s 2017-01-25 00:18:30 (7.99 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171166 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.293771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.294533) ========= 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.iWGScxdIf1/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.U7buEW1BcT/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.019932 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.347392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:30.347848) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 05453493c53396a6fbdb5f826db4fe241b5ebfb4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 05453493c53396a6fbdb5f826db4fe241b5ebfb4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iWGScxdIf1/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.U7buEW1BcT/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-25 00:18:30,439 truncating revision to first 12 chars 2017-01-25 00:18:30,439 Setting DEBUG logging. 2017-01-25 00:18:30,439 attempt 1/10 2017-01-25 00:18:30,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/05453493c533?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 00:18:31,022 unpacking tar archive at: mozilla-beta-05453493c533/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849393 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:31.226132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:31.226936) ========= script_repo_revision: 05453493c53396a6fbdb5f826db4fe241b5ebfb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:31.227921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:31.228761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 00:18:31.251565) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-25 00:18:31.252121) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iWGScxdIf1/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.U7buEW1BcT/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:18:31 INFO - MultiFileLogger online at 20170125 00:18:31 in /builds/slave/test 00:18:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 00:18:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:18:31 INFO - {'append_to_log': False, 00:18:31 INFO - 'base_work_dir': '/builds/slave/test', 00:18:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:18:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:18:31 INFO - 'branch': 'Mozilla-Beta', 00:18:31 INFO - 'buildbot_json_path': 'buildprops.json', 00:18:31 INFO - 'config_files': ('talos/mac_config.py',), 00:18:31 INFO - 'default_actions': ('clobber', 00:18:31 INFO - 'read-buildbot-config', 00:18:31 INFO - 'download-and-extract', 00:18:31 INFO - 'populate-webroot', 00:18:31 INFO - 'create-virtualenv', 00:18:31 INFO - 'install', 00:18:31 INFO - 'run-tests'), 00:18:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:18:31 INFO - 'download_minidump_stackwalk': True, 00:18:31 INFO - 'download_symbols': 'ondemand', 00:18:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:18:31 INFO - 'tooltool.py': '/tools/tooltool.py', 00:18:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:18:31 INFO - '/tools/misc-python/virtualenv.py')}, 00:18:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:18:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:18:31 INFO - 'installer_path': 'installer.exe', 00:18:31 INFO - 'log_level': 'info', 00:18:31 INFO - 'log_name': 'talos', 00:18:31 INFO - 'log_to_console': True, 00:18:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:18:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:18:31 INFO - 'opt_config_files': (), 00:18:31 INFO - 'pip_index': False, 00:18:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:18:31 INFO - 'cmd': ('bash', 00:18:31 INFO - '-c', 00:18:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:18:31 INFO - 'enabled': True, 00:18:31 INFO - 'halt_on_failure': False, 00:18:31 INFO - 'name': 'check_screen_resolution'},), 00:18:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:18:31 INFO - 'cmd': ('bash', 00:18:31 INFO - '-c', 00:18:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:18:31 INFO - 'enabled': True, 00:18:31 INFO - 'halt_on_failure': False, 00:18:31 INFO - 'name': 'check_screen_resolution'},), 00:18:31 INFO - 'run_cmd_checks_enabled': True, 00:18:31 INFO - 'sps_profile': False, 00:18:31 INFO - 'sps_profile_interval': 0, 00:18:31 INFO - 'suite': 'dromaeojs-e10s', 00:18:31 INFO - 'system_bits': '32', 00:18:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:18:31 INFO - 'title': 't-yosemite-r7-0342', 00:18:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:18:31 INFO - 'use_talos_json': True, 00:18:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:18:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:18:31 INFO - 'work_dir': 'build'} 00:18:31 INFO - [mozharness: 2017-01-25 08:18:31.464205Z] Running clobber step. 00:18:31 INFO - Running pre-action listener: _resource_record_pre_action 00:18:31 INFO - Running main action method: clobber 00:18:31 INFO - rmtree: /builds/slave/test/build 00:18:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:18:32 INFO - Running post-action listener: _resource_record_post_action 00:18:32 INFO - [mozharness: 2017-01-25 08:18:32.363840Z] Finished clobber step (success) 00:18:32 INFO - [mozharness: 2017-01-25 08:18:32.363920Z] Running read-buildbot-config step. 00:18:32 INFO - Running pre-action listener: _resource_record_pre_action 00:18:32 INFO - Running main action method: read_buildbot_config 00:18:32 INFO - Using buildbot properties: 00:18:32 INFO - { 00:18:32 INFO - "project": "", 00:18:32 INFO - "product": "firefox", 00:18:32 INFO - "script_repo_revision": "production", 00:18:32 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 00:18:32 INFO - "repository": "", 00:18:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 00:18:32 INFO - "buildid": "20170124212147", 00:18:32 INFO - "pgo_build": "False", 00:18:32 INFO - "basedir": "/builds/slave/test", 00:18:32 INFO - "buildnumber": 15, 00:18:32 INFO - "slavename": "t-yosemite-r7-0342", 00:18:32 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 00:18:32 INFO - "platform": "yosemite_r7", 00:18:32 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 00:18:32 INFO - "branch": "mozilla-beta", 00:18:32 INFO - "repo_path": "releases/mozilla-beta", 00:18:32 INFO - "revision": "05453493c53396a6fbdb5f826db4fe241b5ebfb4", 00:18:32 INFO - "stage_platform": "macosx64", 00:18:32 INFO - "builduid": "84e8828162174a6c85eb061ef83ccb2d", 00:18:32 INFO - "slavebuilddir": "test" 00:18:32 INFO - } 00:18:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 00:18:32 INFO - Running post-action listener: _resource_record_post_action 00:18:32 INFO - [mozharness: 2017-01-25 08:18:32.367375Z] Finished read-buildbot-config step (success) 00:18:32 INFO - [mozharness: 2017-01-25 08:18:32.367492Z] Running download-and-extract step. 00:18:32 INFO - Running pre-action listener: _resource_record_pre_action 00:18:32 INFO - Running main action method: download_and_extract 00:18:32 INFO - mkdir: /builds/slave/test/build/tests 00:18:32 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')]} 00:18:32 INFO - trying https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 00:18:32 INFO - Downloading https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 00:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 00:18:33 INFO - Downloaded 1165 bytes. 00:18:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 00:18:33 INFO - Using the following test package requirements: 00:18:33 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 00:18:33 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:18:33 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 00:18:33 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:18:33 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 00:18:33 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 00:18:33 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:18:33 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 00:18:33 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 00:18:33 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:18:33 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 00:18:33 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:18:33 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 00:18:33 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:18:33 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 00:18:33 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:18:33 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 00:18:33 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 00:18:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 00:18:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 00:18:33 INFO - Fetch https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 00:18:34 INFO - Http code: 200 00:18:34 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 00:18:34 INFO - x-amz-cf-id: WhPEQpukZ-CA5cy1n4oMXqCpjAviyUx70XN-0HEYEKJKhWQsU1Hd6A== 00:18:34 INFO - x-amz-version-id: YcXs8fpMRyVzSU7nDpua5QxhMYB3G9n4 00:18:34 INFO - Expected file size: 16086208 00:18:34 INFO - Obtained file size: 16086208 00:18:41 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 00:18:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 00:18:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 00:18:41 INFO - Fetch https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 00:18:41 INFO - Http code: 200 00:18:41 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 00:18:41 INFO - x-amz-cf-id: PofU8KNOHVB1FCjPEtl8fujHFJ6qB6XWCkKL5CHDyl_AMN5_Uru8bg== 00:18:41 INFO - x-amz-version-id: YcXs8fpMRyVzSU7nDpua5QxhMYB3G9n4 00:18:42 INFO - Expected file size: 16086208 00:18:42 INFO - Obtained file size: 16086208 00:18:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 00:18:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 00:18:48 INFO - Fetch https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 00:18:49 INFO - Http code: 200 00:18:49 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 00:18:49 INFO - x-amz-cf-id: uIy5VLVmiOA6UPtnJLAXRiL177obAJNEU1ptA48CdahFyEcIKLJWnw== 00:18:49 INFO - x-amz-version-id: 1wCMcTZcbRr.stbIqQ2hQmvp1m8nWkEN 00:18:49 INFO - Expected file size: 14402992 00:18:49 INFO - Obtained file size: 14402992 00:18: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')]} 00:18:49 INFO - trying https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 00:18:49 INFO - Downloading https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 00:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 00:18:52 INFO - Downloaded 82124009 bytes. 00:18:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 00:18:52 INFO - mkdir: /builds/slave/test/properties 00:18:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:18:52 INFO - Writing to file /builds/slave/test/properties/build_url 00:18:52 INFO - Contents: 00:18:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 00:18:52 INFO - Running post-action listener: _resource_record_post_action 00:18:52 INFO - Running post-action listener: set_extra_try_arguments 00:18:52 INFO - [mozharness: 2017-01-25 08:18:52.843853Z] Finished download-and-extract step (success) 00:18:52 INFO - [mozharness: 2017-01-25 08:18:52.843962Z] Running populate-webroot step. 00:18:52 INFO - Running pre-action listener: _resource_record_pre_action 00:18:52 INFO - Running main action method: populate_webroot 00:18:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:18:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:18:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:18:52 INFO - '--tppagecycles', 00:18:52 INFO - '7'], 00:18:52 INFO - 'tests': ['tsvgm']}}, 00:18:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:18:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:18:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:18:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:18:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:18:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['damp', 'tps']}, 00:18:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'tests': ['damp', 'tps']}, 00:18:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['dromaeo_dom']}, 00:18:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:18:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['basic_compositor_video']}, 00:18:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:18:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['a11yr', 00:18:52 INFO - 'ts_paint', 00:18:52 INFO - 'tpaint', 00:18:52 INFO - 'sessionrestore', 00:18:52 INFO - 'sessionrestore_no_auto_restore', 00:18:52 INFO - 'tabpaint']}, 00:18:52 INFO - 'other-e10s': {'tests': ['a11yr', 00:18:52 INFO - 'ts_paint', 00:18:52 INFO - 'tpaint', 00:18:52 INFO - 'sessionrestore', 00:18:52 INFO - 'sessionrestore_no_auto_restore', 00:18:52 INFO - 'tabpaint']}, 00:18:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:18:52 INFO - 'ts_paint', 00:18:52 INFO - 'tpaint', 00:18:52 INFO - 'sessionrestore', 00:18:52 INFO - 'sessionrestore_no_auto_restore', 00:18:52 INFO - 'tabpaint']}, 00:18:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:18:52 INFO - 'ts_paint', 00:18:52 INFO - 'tpaint', 00:18:52 INFO - 'sessionrestore', 00:18:52 INFO - 'sessionrestore_no_auto_restore', 00:18:52 INFO - 'tabpaint']}, 00:18:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['a11yr', 00:18:52 INFO - 'ts_paint', 00:18:52 INFO - 'tpaint', 00:18:52 INFO - 'sessionrestore', 00:18:52 INFO - 'sessionrestore_no_auto_restore', 00:18:52 INFO - 'tabpaint']}, 00:18:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['a11yr', 00:18:52 INFO - 'ts_paint', 00:18:52 INFO - 'tpaint', 00:18:52 INFO - 'sessionrestore', 00:18:52 INFO - 'sessionrestore_no_auto_restore', 00:18:52 INFO - 'tabpaint']}, 00:18:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['tsvgx', 00:18:52 INFO - 'tsvgr_opacity', 00:18:52 INFO - 'tart', 00:18:52 INFO - 'tscrollx', 00:18:52 INFO - 'cart']}, 00:18:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:18:52 INFO - 'tsvgr_opacity', 00:18:52 INFO - 'tart', 00:18:52 INFO - 'tscrollx', 00:18:52 INFO - 'cart']}, 00:18:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'talos_options': ['--disable-e10s'], 00:18:52 INFO - 'tests': ['tp5o']}, 00:18:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'tests': ['tp5o']}, 00:18:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'talos_options': ['--disable-e10s', 00:18:52 INFO - '--xperf_path', 00:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:52 INFO - 'tests': ['tp5n']}, 00:18:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:18:52 INFO - 'talos_options': ['--xperf_path', 00:18:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:18:52 INFO - 'tests': ['tp5n']}}, 00:18:52 INFO - 'talos.zip': {'path': '', 00:18:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:18:52 INFO - Running post-action listener: _resource_record_post_action 00:18:52 INFO - [mozharness: 2017-01-25 08:18:52.862797Z] Finished populate-webroot step (success) 00:18:52 INFO - [mozharness: 2017-01-25 08:18:52.862939Z] Running create-virtualenv step. 00:18:52 INFO - Running pre-action listener: _resource_record_pre_action 00:18:52 INFO - Running main action method: create_virtualenv 00:18:52 INFO - Creating virtualenv /builds/slave/test/build/venv 00:18:52 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 00:18:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:18:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:18:52 INFO - Using real prefix '/tools/python27' 00:18:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:18:53 INFO - Installing distribute.............................................................................................................................................................................................done. 00:18:56 INFO - Installing pip.................done. 00:18:56 INFO - Return code: 0 00:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:18:56 INFO - Reading from file tmpfile_stdout 00:18:56 INFO - Output received: 00:18:56 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) 00:18:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:56 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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:18:56 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 00:18:56 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 00:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:56 INFO - 'HOME': '/Users/cltbld', 00:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:56 INFO - 'LOGNAME': 'cltbld', 00:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:56 INFO - 'MOZ_NO_REMOTE': '1', 00:18:56 INFO - 'NO_EM_RESTART': '1', 00:18:56 INFO - 'PAGER': '/bin/cat', 00:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:56 INFO - 'PWD': '/builds/slave/test', 00:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:56 INFO - 'SHELL': '/bin/bash', 00:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:18:56 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:56 INFO - 'USER': 'cltbld', 00:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:56 INFO - 'XPC_FLAGS': '0x0', 00:18:56 INFO - 'XPC_SERVICE_NAME': '0', 00:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:57 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 00:18:57 INFO - Cleaning up... 00:18:57 INFO - Return code: 0 00:18:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:18:57 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')]} 00:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:57 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')]} 00:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:18:57 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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:18:57 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 00:18:57 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 00:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:18:57 INFO - 'HOME': '/Users/cltbld', 00:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:18:57 INFO - 'LOGNAME': 'cltbld', 00:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:18:57 INFO - 'MOZ_NO_REMOTE': '1', 00:18:57 INFO - 'NO_EM_RESTART': '1', 00:18:57 INFO - 'PAGER': '/bin/cat', 00:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:18:57 INFO - 'PWD': '/builds/slave/test', 00:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:18:57 INFO - 'SHELL': '/bin/bash', 00:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:18:57 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:18:57 INFO - 'USER': 'cltbld', 00:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:18:57 INFO - 'XPC_FLAGS': '0x0', 00:18:57 INFO - 'XPC_SERVICE_NAME': '0', 00:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:18:57 INFO - Downloading/unpacking psutil>=3.1.1 00:18:57 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 00:18:57 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 00:18:57 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 00:18:57 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 00:18:57 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 00:18:57 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 00:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:19:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:19:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:19:01 INFO - Installing collected packages: psutil 00:19:01 INFO - Running setup.py install for psutil 00:19:01 INFO - building 'psutil._psutil_osx' extension 00:19:01 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 00:19:01 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 00:19:01 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 00:19:01 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 00:19:01 INFO - building 'psutil._psutil_posix' extension 00:19:01 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 00:19:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:19:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:19:01 INFO - ^ 00:19:01 INFO - 1 warning generated. 00:19:01 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 00:19:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:19:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:19:01 INFO - Successfully installed psutil 00:19:01 INFO - Cleaning up... 00:19:01 INFO - Return code: 0 00:19:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:01 INFO - 'HOME': '/Users/cltbld', 00:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:01 INFO - 'LOGNAME': 'cltbld', 00:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:01 INFO - 'MOZ_NO_REMOTE': '1', 00:19:01 INFO - 'NO_EM_RESTART': '1', 00:19:01 INFO - 'PAGER': '/bin/cat', 00:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:01 INFO - 'PWD': '/builds/slave/test', 00:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:01 INFO - 'SHELL': '/bin/bash', 00:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:01 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:01 INFO - 'USER': 'cltbld', 00:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:01 INFO - 'XPC_FLAGS': '0x0', 00:19:01 INFO - 'XPC_SERVICE_NAME': '0', 00:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:19: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 00:19: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 00:19: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 00:19: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 00:19: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 00:19: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 00:19:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:19:04 INFO - Installing collected packages: mozsystemmonitor 00:19:04 INFO - Running setup.py install for mozsystemmonitor 00:19:05 INFO - Successfully installed mozsystemmonitor 00:19:05 INFO - Cleaning up... 00:19:05 INFO - Return code: 0 00:19:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:19:05 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')]} 00:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:05 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')]} 00:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:05 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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:05 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 00:19:05 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 00:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:05 INFO - 'HOME': '/Users/cltbld', 00:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:05 INFO - 'LOGNAME': 'cltbld', 00:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:05 INFO - 'MOZ_NO_REMOTE': '1', 00:19:05 INFO - 'NO_EM_RESTART': '1', 00:19:05 INFO - 'PAGER': '/bin/cat', 00:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:05 INFO - 'PWD': '/builds/slave/test', 00:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:05 INFO - 'SHELL': '/bin/bash', 00:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:05 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:05 INFO - 'USER': 'cltbld', 00:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:05 INFO - 'XPC_FLAGS': '0x0', 00:19:05 INFO - 'XPC_SERVICE_NAME': '0', 00:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:05 INFO - Downloading/unpacking jsonschema==2.5.1 00:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:19:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:19:08 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 00:19:08 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 00:19:08 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 00:19:08 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 00:19:08 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 00:19:08 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 00:19:08 INFO - Downloading functools32-3.2.3-2.tar.gz 00:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:19:08 INFO - warning: no files found matching '*.txt' 00:19:08 INFO - no previously-included directories found matching 'build' 00:19:08 INFO - no previously-included directories found matching 'dist' 00:19:08 INFO - no previously-included directories found matching '.git*' 00:19:08 INFO - Installing collected packages: jsonschema, functools32 00:19:08 INFO - Running setup.py install for functools32 00:19:08 INFO - warning: no files found matching '*.txt' 00:19:08 INFO - no previously-included directories found matching 'build' 00:19:08 INFO - no previously-included directories found matching 'dist' 00:19:08 INFO - no previously-included directories found matching '.git*' 00:19:08 INFO - Successfully installed jsonschema functools32 00:19:08 INFO - Cleaning up... 00:19:08 INFO - Return code: 0 00:19:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:19:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:08 INFO - 'HOME': '/Users/cltbld', 00:19:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:08 INFO - 'LOGNAME': 'cltbld', 00:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:08 INFO - 'MOZ_NO_REMOTE': '1', 00:19:08 INFO - 'NO_EM_RESTART': '1', 00:19:08 INFO - 'PAGER': '/bin/cat', 00:19:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:08 INFO - 'PWD': '/builds/slave/test', 00:19:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:08 INFO - 'SHELL': '/bin/bash', 00:19:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:08 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:08 INFO - 'USER': 'cltbld', 00:19:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:08 INFO - 'XPC_FLAGS': '0x0', 00:19:08 INFO - 'XPC_SERVICE_NAME': '0', 00:19:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:19:09 INFO - Cleaning up... 00:19:09 INFO - Return code: 0 00:19:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:09 INFO - 'HOME': '/Users/cltbld', 00:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:09 INFO - 'LOGNAME': 'cltbld', 00:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:09 INFO - 'MOZ_NO_REMOTE': '1', 00:19:09 INFO - 'NO_EM_RESTART': '1', 00:19:09 INFO - 'PAGER': '/bin/cat', 00:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:09 INFO - 'PWD': '/builds/slave/test', 00:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:09 INFO - 'SHELL': '/bin/bash', 00:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:09 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:09 INFO - 'USER': 'cltbld', 00:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:09 INFO - 'XPC_FLAGS': '0x0', 00:19:09 INFO - 'XPC_SERVICE_NAME': '0', 00:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:09 INFO - Downloading/unpacking blobuploader==1.2.4 00:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:19:11 INFO - Downloading blobuploader-1.2.4.tar.gz 00:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:19:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:19:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:12 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 00:19:13 INFO - Downloading docopt-0.6.1.tar.gz 00:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:19:13 INFO - Installing collected packages: blobuploader, requests, docopt 00:19:13 INFO - Running setup.py install for blobuploader 00:19:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:19:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:19:13 INFO - Running setup.py install for requests 00:19:13 INFO - Running setup.py install for docopt 00:19:14 INFO - Successfully installed blobuploader requests docopt 00:19:14 INFO - Cleaning up... 00:19:14 INFO - Return code: 0 00:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:19:14 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')]} 00:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:14 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')]} 00:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:14 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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:14 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 00:19:14 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 00:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:14 INFO - 'HOME': '/Users/cltbld', 00:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:14 INFO - 'LOGNAME': 'cltbld', 00:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:14 INFO - 'MOZ_NO_REMOTE': '1', 00:19:14 INFO - 'NO_EM_RESTART': '1', 00:19:14 INFO - 'PAGER': '/bin/cat', 00:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:14 INFO - 'PWD': '/builds/slave/test', 00:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:14 INFO - 'SHELL': '/bin/bash', 00:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:14 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:14 INFO - 'USER': 'cltbld', 00:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:14 INFO - 'XPC_FLAGS': '0x0', 00:19:14 INFO - 'XPC_SERVICE_NAME': '0', 00:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:19:14 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-MEArPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:19:14 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Z2ciNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:19:14 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-sYunya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:19:14 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-YyaNWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:19:14 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-0WqYpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:19:14 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-mLlEaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-qHSOmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-oP65vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-tnSNR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-siMMet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-8GY9Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-5O_GIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-QjoTH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-0QEfwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-k6Heaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:19:15 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-rjCtYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:19:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-mEXbwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:19:16 INFO - Running setup.py install for manifestparser 00:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:19:16 INFO - Running setup.py install for mozcrash 00:19:16 INFO - Running setup.py install for mozdebug 00:19:16 INFO - Running setup.py install for mozdevice 00:19:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:19:16 INFO - Running setup.py install for mozfile 00:19:16 INFO - Running setup.py install for mozhttpd 00:19:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Running setup.py install for mozinfo 00:19:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Running setup.py install for mozInstall 00:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Running setup.py install for mozleak 00:19:17 INFO - Running setup.py install for mozlog 00:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Running setup.py install for moznetwork 00:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:19:17 INFO - Running setup.py install for mozprocess 00:19:18 INFO - Running setup.py install for mozprofile 00:19:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Running setup.py install for mozrunner 00:19:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Running setup.py install for mozscreenshot 00:19:18 INFO - Running setup.py install for moztest 00:19:18 INFO - Running setup.py install for mozversion 00:19:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:19:18 INFO - Cleaning up... 00:19:18 INFO - Return code: 0 00:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:18 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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:18 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 00:19:18 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 00:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:18 INFO - 'HOME': '/Users/cltbld', 00:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:18 INFO - 'LOGNAME': 'cltbld', 00:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:18 INFO - 'MOZ_NO_REMOTE': '1', 00:19:18 INFO - 'NO_EM_RESTART': '1', 00:19:18 INFO - 'PAGER': '/bin/cat', 00:19:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:18 INFO - 'PWD': '/builds/slave/test', 00:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:18 INFO - 'SHELL': '/bin/bash', 00:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:18 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:18 INFO - 'USER': 'cltbld', 00:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:18 INFO - 'XPC_FLAGS': '0x0', 00:19:18 INFO - 'XPC_SERVICE_NAME': '0', 00:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-GtXwCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-HDs1Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-1qUoIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-6TvYLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-kxd9il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-yV8mIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-zqxwg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-t5xUj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:19:19 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)) 00:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:19:19 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-gNZhrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-2BDibI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-PfEQqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-hrmo5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-XTmWfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-IS7RHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-t58eRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-1qrxdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:19:20 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)) 00:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:19:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-__pFu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:19:20 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)) 00:19:20 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)) 00:19:20 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)) 00:19:20 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)) 00:19:20 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)) 00:19:20 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)) 00:19:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:19:20 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 00:19:20 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 00:19:20 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 00:19:20 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 00:19:20 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 00:19:20 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 00:19:23 INFO - Downloading blessings-1.6.tar.gz 00:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:19:23 INFO - Installing collected packages: blessings 00:19:23 INFO - Running setup.py install for blessings 00:19:23 INFO - Successfully installed blessings 00:19:23 INFO - Cleaning up... 00:19:23 INFO - Return code: 0 00:19:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:19:24 INFO - Reading from file tmpfile_stdout 00:19:24 INFO - Current package versions: 00:19:24 INFO - blessings == 1.6 00:19:24 INFO - blobuploader == 1.2.4 00:19:24 INFO - docopt == 0.6.1 00:19:24 INFO - functools32 == 3.2.3-2 00:19:24 INFO - jsonschema == 2.5.1 00:19:24 INFO - manifestparser == 1.1 00:19:24 INFO - mozInstall == 1.12 00:19:24 INFO - mozcrash == 1.0 00:19:24 INFO - mozdebug == 0.1 00:19:24 INFO - mozdevice == 0.48 00:19:24 INFO - mozfile == 1.2 00:19:24 INFO - mozhttpd == 0.7 00:19:24 INFO - mozinfo == 0.9 00:19:24 INFO - mozleak == 0.1 00:19:24 INFO - mozlog == 3.4 00:19:24 INFO - moznetwork == 0.27 00:19:24 INFO - mozprocess == 0.23 00:19:24 INFO - mozprofile == 0.28 00:19:24 INFO - mozrunner == 6.13 00:19:24 INFO - mozscreenshot == 0.1 00:19:24 INFO - mozsystemmonitor == 0.3 00:19:24 INFO - moztest == 0.8 00:19:24 INFO - mozversion == 1.4 00:19:24 INFO - psutil == 3.1.1 00:19:24 INFO - requests == 1.2.3 00:19:24 INFO - wsgiref == 0.1.2 00:19:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:24 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 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:24 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 00:19:24 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 00:19:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:24 INFO - 'HOME': '/Users/cltbld', 00:19:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:24 INFO - 'LOGNAME': 'cltbld', 00:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:24 INFO - 'MOZ_NO_REMOTE': '1', 00:19:24 INFO - 'NO_EM_RESTART': '1', 00:19:24 INFO - 'PAGER': '/bin/cat', 00:19:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:24 INFO - 'PWD': '/builds/slave/test', 00:19:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:24 INFO - 'SHELL': '/bin/bash', 00:19:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:24 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:24 INFO - 'USER': 'cltbld', 00:19:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:24 INFO - 'XPC_FLAGS': '0x0', 00:19:24 INFO - 'XPC_SERVICE_NAME': '0', 00:19:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 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)) 00:19:24 INFO - Cleaning up... 00:19:24 INFO - Return code: 0 00:19:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:19:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca80490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa368589440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, '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.iWGScxdIf1/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.U7buEW1BcT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 00:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:19:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:24 INFO - 'HOME': '/Users/cltbld', 00:19:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:24 INFO - 'LOGNAME': 'cltbld', 00:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:24 INFO - 'MOZ_NO_REMOTE': '1', 00:19:24 INFO - 'NO_EM_RESTART': '1', 00:19:24 INFO - 'PAGER': '/bin/cat', 00:19:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:24 INFO - 'PWD': '/builds/slave/test', 00:19:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:24 INFO - 'SHELL': '/bin/bash', 00:19:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:24 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:24 INFO - 'USER': 'cltbld', 00:19:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:24 INFO - 'XPC_FLAGS': '0x0', 00:19:24 INFO - 'XPC_SERVICE_NAME': '0', 00:19:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:19:24 INFO - Cleaning up... 00:19:24 INFO - Return code: 0 00:19:24 INFO - Running post-action listener: _resource_record_post_action 00:19:24 INFO - Running post-action listener: _start_resource_monitoring 00:19:24 INFO - Starting resource monitoring. 00:19:24 INFO - [mozharness: 2017-01-25 08:19:24.771409Z] Finished create-virtualenv step (success) 00:19:24 INFO - [mozharness: 2017-01-25 08:19:24.772410Z] Running install step. 00:19:24 INFO - Running pre-action listener: _resource_record_pre_action 00:19:24 INFO - Running main action method: install 00:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:19:25 INFO - Reading from file tmpfile_stdout 00:19:25 INFO - Detecting whether we're running mozinstall >=1.0... 00:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:19:25 INFO - Reading from file tmpfile_stdout 00:19:25 INFO - Output received: 00:19:25 INFO - Usage: mozinstall [options] installer 00:19:25 INFO - Options: 00:19:25 INFO - -h, --help show this help message and exit 00:19:25 INFO - -d DEST, --destination=DEST 00:19:25 INFO - Directory to install application into. [default: 00:19:25 INFO - "/builds/slave/test"] 00:19:25 INFO - --app=APP Application being installed. [default: firefox] 00:19:25 INFO - mkdir: /builds/slave/test/build/application 00:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 00:19:46 INFO - Reading from file tmpfile_stdout 00:19:46 INFO - Output received: 00:19:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 00:19:46 INFO - Running post-action listener: _resource_record_post_action 00:19:46 INFO - [mozharness: 2017-01-25 08:19:46.825067Z] Finished install step (success) 00:19:46 INFO - [mozharness: 2017-01-25 08:19:46.825188Z] Running run-tests step. 00:19:46 INFO - Running pre-action listener: _resource_record_pre_action 00:19:46 INFO - Running main action method: run_tests 00:19:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:19:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:19:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:19:46 INFO - 2017-01-25 00:19:46.839 screenresolution[1899:10493] starting screenresolution argv=screenresolution get 00:19:46 INFO - 2017-01-25 00:19:46.842 screenresolution[1899:10493] Display 0: 1600x1200x32@60 00:19:46 INFO - 2017-01-25 00:19:46.848 screenresolution[1900:10496] starting screenresolution argv=screenresolution list 00:19:46 INFO - Available Modes on Display 0 00:19:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:19:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:19:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:19:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:19:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:19:47 INFO - Intel Iris: 00:19:47 INFO - Chipset Model: Intel Iris 00:19:47 INFO - Type: GPU 00:19:47 INFO - Bus: Built-In 00:19:47 INFO - VRAM (Dynamic, Max): 1536 MB 00:19:47 INFO - Vendor: Intel (0x8086) 00:19:47 INFO - Device ID: 0x0a2e 00:19:47 INFO - Revision ID: 0x0009 00:19:47 INFO - Displays: 00:19:47 INFO - Display: 00:19:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:19:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:19:47 INFO - Display Serial Number: 1600x1200 60 00:19:47 INFO - Main Display: Yes 00:19:47 INFO - Mirror: Off 00:19:47 INFO - Online: Yes 00:19:47 INFO - Rotation: Supported 00:19:47 INFO - Return code: 0 00:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:19:47 INFO - Python 2.7.3 00:19:47 INFO - Return code: 0 00:19:47 INFO - grabbing minidump binary from tooltool 00:19:47 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')]} 00:19:47 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 0x10c894d30>, '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 0x10c6fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c88cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:19:47 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 00:19:47 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 00:19:47 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 00:19:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:19:47 INFO - Return code: 0 00:19:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:19:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:19:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:19:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:19:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--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 00:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0342 --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 00:19:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iWGScxdIf1/Render', 00:19:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:19:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:19:47 INFO - 'HOME': '/Users/cltbld', 00:19:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:19:47 INFO - 'LOGNAME': 'cltbld', 00:19:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:19:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:19:47 INFO - 'MOZ_NO_REMOTE': '1', 00:19:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:19:47 INFO - 'NO_EM_RESTART': '1', 00:19:47 INFO - 'PAGER': '/bin/cat', 00:19:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:19:47 INFO - 'PWD': '/builds/slave/test', 00:19:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:19:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:19:47 INFO - 'SHELL': '/bin/bash', 00:19:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U7buEW1BcT/Listeners', 00:19:47 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 00:19:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:19:47 INFO - 'USER': 'cltbld', 00:19:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:19:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:19:47 INFO - 'XPC_FLAGS': '0x0', 00:19:47 INFO - 'XPC_SERVICE_NAME': '0', 00:19:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:19:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--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 00:19:47 INFO - mozversion application_buildid: 20170124212147 00:19:47 INFO - mozversion application_changeset: 05453493c53396a6fbdb5f826db4fe241b5ebfb4 00:19:47 INFO - mozversion application_display_name: Firefox 00:19:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:19:47 INFO - mozversion application_name: Firefox 00:19:47 INFO - mozversion application_remotingname: firefox 00:19:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:19:47 INFO - mozversion application_vendor: Mozilla 00:19:47 INFO - mozversion application_version: 52.0 00:19:47 INFO - mozversion platform_buildid: 20170124212147 00:19:47 INFO - mozversion platform_changeset: 05453493c53396a6fbdb5f826db4fe241b5ebfb4 00:19:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:19:47 INFO - mozversion platform_version: 52.0 00:19:47 INFO - using testdate: 1485332387 00:19:47 INFO - actual date: 1485332387 00:19:47 INFO - starting webserver on 'localhost:49691' 00:19:47 INFO - SUITE-START | Running 2 tests 00:19:47 INFO - TEST-START | dromaeo_css 00:19:47 INFO - operating with platform_type : mac_ 00:19:47 INFO - Initialising browser for dromaeo_css test... 00:19:47 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmp6uKGf4/profile http://localhost:49691/getInfo.html) 00:19:50 INFO - PROCESS | 1910 | 2017-01-25 00:19:50.279 plugin-container[1913:10668] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b2b, name = 'com.apple.tsm.portname' 00:19:50 INFO - PROCESS | 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:19:50 INFO - PROCESS | 1910 | 2017-01-25 00:19:50.280 plugin-container[1913:10668] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b2f, name = 'com.apple.CFPasteboardClient' 00:19:50 INFO - PROCESS | 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:19:50 INFO - PROCESS | 1910 | 2017-01-25 00:19:50.280 plugin-container[1913:10668] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:19:50 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 00:19:50 INFO - PROCESS | 1910 | colorDepth:24 00:19:50 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 00:19:50 INFO - PROCESS | 1910 | __metrics 00:19:50 ERROR - PROCESS | 1910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 00:19:51 INFO - TEST-INFO | 1910: exit 0 00:19:51 INFO - Browser initialized. 00:19:51 INFO - Running cycle 1/1 for dromaeo_css test... 00:19:51 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmp6uKGf4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:19:53 INFO - PROCESS | 1914 | 2017-01-25 00:19:53.505 plugin-container[1915:10793] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 00:19:53 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:19:53 INFO - PROCESS | 1914 | 2017-01-25 00:19:53.505 plugin-container[1915:10793] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 00:19:53 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:19:53 INFO - PROCESS | 1914 | 2017-01-25 00:19:53.505 plugin-container[1915:10793] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:20:03 INFO - PROCESS | 1914 | RSS: Main: 177020928 00:20:03 INFO - PROCESS | 1914 | 00:23:06 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49691/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49691/tests/dromaeo/cssquery-ext.html) 00:23:08 INFO - PROCESS | 1914 | RSS: Main: 180731904 00:23:08 INFO - PROCESS | 1914 | 00:26:10 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49691/tests/dromaeo/cssquery-ext.html (next: http://localhost:49691/tests/dromaeo/cssquery-jquery.html) 00:26:11 INFO - PROCESS | 1914 | RSS: Main: 192466944 00:26:11 INFO - PROCESS | 1914 | 00:29:13 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49691/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49691/tests/dromaeo/cssquery-mootools.html) 00:29:13 INFO - PROCESS | 1914 | RSS: Main: 193806336 00:29:13 INFO - PROCESS | 1914 | 00:32:15 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49691/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49691/tests/dromaeo/cssquery-prototype.html) 00:32:16 INFO - PROCESS | 1914 | RSS: Main: 197206016 00:32:16 INFO - PROCESS | 1914 | 00:35:19 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49691/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49691/tests/dromaeo/cssquery-yui.html) 00:35:19 INFO - PROCESS | 1914 | RSS: Main: 198664192 00:35:19 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:49691/tests/dromaeo/cssquery-yui.html (next: http://localhost:49691/tests/dromaeo/cssquery-dojo.html) 00:38:22 INFO - PROCESS | 1914 | RSS: Main: 197308416 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | __start_tp_report 00:38:22 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 00:38:22 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 00:38:22 INFO - PROCESS | 1914 | |i|pagename|runs| 00:38:22 INFO - PROCESS | 1914 | |0;dojo.html;3525.806080665563;3552.591451983021;3558.5729712434513;3578.338007468617;3604.9098772530683;5883.646981181127;5938.732757025939;5962.373950735176;5962.8807423851495;6032.547558933075;4764.737939413331;5883.794067207648;5955.553333499983;6016.909746353808;6023.759049638009;5402.756875940572;5449.891002179954;5483.040467918118;5491;5499.560035197194;5505.504504594585;5512.614117011811;5512.862178445531;5531.723413829312;5543.584231182657;4546.909061818762;5279.260903473517;5359.892802143955;5493.807716729915;5502.642328248671;5379.300690910157;5442.673439593637;5447.918281225785;5474.753636086386;5492.642978206404;5384.434634363413;5449.4005659377435;5469.808556700496;5513.889722205534;5522.199281104257;5951.940480595182;6038.27540695115;6074.605150665237;6077.726502307407;6093.756249750005;5086.46592107827;6003.699815009276;6192.256929168483;6217.067439884054;6274.403931626488;6236.96881515594;6260.186175797117;6267.279262884781;6311.558190926637;6330.335314791927;6031.45716885478;6037.336422234108;6042.57701960863;6044.093385992049;6050.818475445743;6299.748010079637;6327.335629758901;6370.968145159244;6477.384648458389;6491.026346048131;5191.377034755854;6271.341509141565;6278.246610406781;6280.560360774702;6306.243250809932;6287.462382172241;6316.526260530387;6324.652144132025;6327.145835312266;6342.651154186472;6147.846303842351;6211.0372892201785;6234.251889773165;6271.059341098871;6280.152179455807;6240.843978900473;6261.843453913598;6278.183836101278;6280.2777680566405;6284.465820405226;5088.898222035538;5131.589472842164;5138.511841375063;5151.5106064923775;5165.612579056586;3764.3412402829395;4428.291473364311;4456.197884380843;4493.640508759291;4576.794044268016;4700.788464519105;6102.664353460514;6160.168377269101;6187.81436556895;6191;6300.243970723543;6329.240491141092;6340.048992651139;6345.746170153142;6364;5981.192539007266;6107.15847211733;6133.570650054453;6153.892299386064;6221.906671399933;5509.47659972302;5540.36285827127;5574.916376254359;5600.27196464457;5675.120356344773;6557.9344206557325;6576.606129285545;6608.768693095911;6614.636195009224;6630.038644396439;6318.968405157945;6380.457661098859;6381;6391.58454700443;6428.517861160338;6317.778877739257;6373.298937117006;6410;6420.133282006869;6463.095166676575;6264.906026409699;6267.122602835516;6272;6280.874382512416;6288.088227207121;6231.719572619152;6348.904766428415;6358;6373.458256048102;6379.776707815204;6119.173911521888;6120.294761999531;6170.10533472635;6185.041318595445;6204.968975155095;6236.251649802053;6240.625562466266;6251.6561589113035;6262.2172228471445;6268.52986026059;6074.453299203093;6146.262448506208;6214.9067763982675;6246.969250073687;6252.468540174136;6070.7875224366935;6184.979478386196;6185.628862268279;6209.906851397142;6255.374462553708;5606.719664016864;6159.630422174684;6164.137020817179;6193.876122477435;6243.157173781481 00:38:22 INFO - PROCESS | 1914 | |1;ext.html;505.15134573915816;514.1131548079561;518.8610998857508;520.6537652461113;535.2666846420404;40324;41089;42289.15421691568;42395.152096958045;42397.36403953943;43623.12753744923;44002.55997440025;44043.77978110105;44079.77960110203;44946.55053449464;9654.324197306192;9789.314747967645;9814.754631134207;9837.90162098377;9880.011998800135;9631.036896310383;9699;9708.417494950325;9721.17370023549;9721.611135554569;9624.23006159509;9690.612375504972;9730.026997300283;9745.658901938434;9753.853692194623;9637.71086867395;9652.565634546392;9704.563294651793;9717.708468745948;9737.367071140354;9713;9769.560369783378;9776.853347199798;9806.852897206547;9818.018198180196;41119.588804111874;41461.79269103635;41567.96080097991;41597.58402415998;41707.582924170674;3334.9666503335143;3375.3418083473734;3489.2672538766888;3495.563054618173;3566.6433356664384;29786.255343616365;30246.84876575625;31269.8436507816;31860.681393186;32615.347693046242;3178.9364212715845;3202;3221.01758963516;3222.46829273172;3224.8226347550876;457585;463315;463828.9999999966;464331;465329;62068;62179.68910155511;62482.687586562686;62491;62558.37441625616;62519.6874015627;63531.04703429452;64712.67643661846;64792.028119578245;64879;16329.510114696579;16541;16610.916945415196;16621.168941552874;16625.168741563117;12745.299008554619;12867.742645147044;12894.226346419246;12896;12908.806367904488;17232.104468508453;17661.911690441466;17696.469105926844;17743.201555930013;17779.377721779936;3327.168207948013;6985.89521157183;7185.820354491075;7198.71205151788;7256.7460138894885;854.2525290370926;962.2638681408588;1012.2104758288547;1015.6445244164483;1148.2880614019361;25316.45569620256;27420.040298589454;28612.713872861004;29734.959276425223;30962.53556196659;979.5494072726625;1078.7282361847174;1090.8200146975819;1107.4186052322596;1246.663400881775;15517.068975861484;15970.281337339848;15992;16116.919415402848;16242.350305987864;636676;637948;646808;647978.7601062058;650784;59112.70443647754;59130.70434647799;59763.10355344673;59793.402065978786;59833.70083149557;1371.8010888421322;1392.8258967629047;1406.3530775843226;1407.1346122134814;1412.491503058898;29755.55366669545;30332.545011824397;32522.349553008335;32824.179395515304;32942.835285823414;59260.70369648124;61046;62517.06224406729;62836.68581657062;62985.68507157435;578784;584374;594455;594536;596101;37895.621043790314;39346.40980385354;45410.864728382054;45749.77125114353;46284.53715462937;40997.59002409938;49273.058155348204;50056.749716251186;50185;51534.74232628813;41097;41425.79287103545;41934;42020.78989605032;43334.34998475089;41004.38493422541;41104.38343424791;42043.7897810509;42299;42846.78576607097;35900.82049589735;39926.40110398405;40080;40138.799306004454;40729.38905916473;30099.54850677198;35170.47244291286;36544.81727591345;37189.44215836711;37318.067048322926;21951;23978.28065158048;26673.33316667099;26973.921043158054;27086.458270834868 00:38:22 INFO - PROCESS | 1914 | |2;jquery.html;326.68801294763495;383.41146340367544;385.93246181918164;397.62821761652873;412.5255955651001;19048.238070477182;20512.589748205028;21071.578568428624;21291.893540532314;21294.787052129475;17268.30926762928;17463.47609571715;17748.46754597361;20858.895705521452;21010.264640737576;5822.9809783287965;5834.124881267812;5917.289925208959;5920.733566989475;6089.02575587906;4276.871693849174;5942.465178133967;6038.879222415549;6046.7883624073165;6047.727852246638;4481.462224533045;6253.499720022387;6543.1821022372205;6576;6610.8677826443445;5443.455654434564;6396.360363963589;6614.570052946568;6640;6644.637849240894;5786.016377215841;5793.826185214451;5794.913076303858;5810.883782324372;5816.534677225812;24059.759402406104;24687.87656061726;25279.36801579957;25982;26379.604305935427;2043.754749430063;2095.19335056003;2565.307367010915;2739.876705548255;3020.9848950755104;10686.412247326394;10893.618723344724;14698.632534186623;15103.924480377527;15702;1972.142118178597;1981.5442448236843;1996.1616121228974;2007.598480303945;2027.844128846558;121436;122349.38825305905;124754;126268.36865815612;127848;11594.072474202043;11688;11872.990795782454;12111.031117510578;12242.44908979098;14941.477048303257;14976.550703478913;14977.550673479813;15011.324490397958;15027.549173524812;7061.046758687511;7337.119545654556;7630.931669566266;7924.920750792418;8284.958575207085;8427.662893484192;8544.145585441405;8568.314534837198;8724.956375218084;8763.693270735494;4632.907341853144;4669.509701481364;4687.71873687573;4703.623710103184;4725.669203155746;1626.471396796046;1956.1197461142258;1988.1152886965162;2017.8385729141633;2026.6554685703466;834.4325858416336;852.194676031157;925.3938670171049;999.3753903810118;1040.698197522725;20693.17227310921;21289.78710212878;21311.78688213129;21358.679619805716;21408.357749267547;924.306769922558;934.8971613122551;960.8943016268205;977.0717818072859;1022.2690776095128;10723.249372543847;11102.777944441066;11173.10615150786;11198.832017519744;11199.384033878216;494298;537087;589741;609653.9517302385;610004;106649;131052.44737763074;131321;146493;148779;993.4436715439233;1014.7767491151787;1041.5261056219401;1042.9634962776418;1043.0508237503834;19215.807841921403;19592.80407195967;19744.30894918671;19745.60508789845;19787.802121978595;34858.825705871306;54573;55356;58500;60428.39571604403;75103.62448187724;81256.18743812486;82143;83076.16923830926;83905.5804720997;8002.239787220205;8311;8399.816047827486;8539.615717292862;8735.344849136467;8706.564671766513;12654.810177847156;13163.956166678116;13372.130811497222;13599.184048957095;7928.484648497829;8191.83616327682;8204.876926845982;8207.179282071746;8288.958555207186;5826.592138550261;6761.492888033319;7402.000729901394;7876.251756083163;8157.592120393838;8050.637721302438;8247.793805154919;8404.243618074403;8429.747107586782;8567.528785916835;12514.561990330294;12925.482980680668;12937.870621294043;13048.564657887815;13248.536301229411;8101.716439924574;10058.698239052841;10522.526846241686;11971.3487386348;12009.099317551394 00:38:22 INFO - PROCESS | 1914 | |3;mootools.html;1486.5986183730392;1526.381815364777;1717.9949729408295;1801.2704854533902;1871.616318654675;7624.771256862289;7850.411219158572;8123.796905077369;8524.147585241473;8550.315974722023;8043.597820109;8283.627236774344;8320.66717331306;8364.916350836489;8389.916100839006;2365.1367250953363;2413.9396515087174;2418.1657328221736;2419.1532963462737;2419.7822196002357;2388.2596395117484;2410.95178096438;2418.2019933422016;2427.0291883246664;2464.1745015419856;2394.736578976311;2398.028798336668;2418.177819541356;2422.5760491913843;2429.9757002430015;2336.497653004595;2368.4078980254935;2383.30884043628;2402.2192787344097;2411.30072279038;1993.6710442776925;2391.2109004028803;2391.928242152738;2400.603900356439;2420.5279970405777;8315.875261871077;8413.83172336556;8460.619272132768;8476.152384761535;8514.106018867991;5165.612579056548;5291.735413229361;5310.256564081032;5323.787048518055;5325.547328477084;2856.4144350408324;3202.4235637585225;3312.03950854252;3351.692839792483;3547.467879818022;980.4019548075668;1015.9593616255341;1032.9690109296732;1035.6789395287485;1043.8434234864756;10830.40432776205;10845.83731244032;10879.945600271947;10917.945410272898;10924.126069914388;4320.632746216544;4476.552344765498;4509.255972764523;4550.681452298308;4558.293464513005;8634.568271586395;8681.56592170389;8708.608112634947;8748.037715851251;8752;5079.466656001141;5106.259592359162;5153.922691159635;5171.4052883918075;5183.196604526304;3842.5773164951834;4371.453568303962;4670.462896766848;4793.712377257306;4825.758712064383;3750.737448378642;3776.2258736959407;3779.6220377961986;3878.398848178537;3885.786281754474;1180.3449085757486;1196.2642974570576;1196.3420118934725;1203.7472130852443;1206.252123683322;844.7507985144397;848.9235968762841;902.7878448564582;917.2295271971576;925.9166674999148;5471.398146203915;5538.446155384429;5592.412796656374;5601.226139055322;5725.026745453283;934.9859752103724;956.8134213828237;959.4531117263233;960.1071003966379;982.597135174575;3580.695640870555;3702.0559757261726;3774.584795672474;3799.7340186187253;3825.5600605930117;9777.706668799947;10126.189904807597;10179.982001799908;10190;10204.132648724793;9543.9045609543;9956.651517196864;10095.192384609214;10113.393196408239;10140.543675534618;7797.883031754528;7975.202479752094;7984.361251099898;7997.440179187517;8014.759557213293;5521.723913804213;5544.223808666709;5580.9441905580425;5607.383187849415;5771.884562308815;7188.568685878864;9341.906580934103;9438.292128090283;9477.526123693926;9532.332736708364;9028.277737781093;9275.443473391619;9404.247660187031;9540.713778586654;9598;6422.807315780534;7138.39323657495;7160.892586611101;7238.819029524304;7338.192798792022;7955.363570914429;7970.681172753257;8016.478928869605;8049.356051515982;8072.798180045545;7105.25394833535;7258.20159782413;7299;7328.267173282629;7375.262473752582;6056.424639659225;6580.934190658224;6620.304867988792;7095.858082838417;7187.8562428752175;6702.597844129368;6752.324767523209;6834.974753786972;6868.587884726932;6882.621455819978;4812.205986012409;4837.612990960785;4867.5132486751045;4867.5132486751045;4874.390701162355;4748.59636930851;4849.4908034655855;4902.779374928208;4923.965967146939;4929.457759646364 00:38:22 INFO - PROCESS | 1914 | |4;prototype.html;257.4182347893761;294.90857834071437;298.6371558556354;305.207985278203;305.55236578412627;4380.759058251795;5586.83239502815;5611.887762244753;5699.896074826129;5720.942790572093;4870.683405578635;4885.658003939726;5089.694618322903;5465.836024919249;5474.39781624021;3606.3148001879626;3995.1610161865897;4195.286801243796;4198.8110535026;4216.704830661855;3373.1398493384154;3723.7765734055906;3964.086396498571;4037.4953130858644;4254.340577210537;4147.336426171813;4163.375493675958;4166.270902592049;4175.185838761443;4179.519355274152;3808.9809550952205;3941.1476605995135;4161.791910404468;4178.310578754532;4197.893558766521;3143.0413723814227;3198.200449887528;3517.402041652925;3548.1484443733575;3561.679448849616;4414.470263568361;4456.08650226706;5312.76092575835;5326.7070311132875;5382.838514844561;3958.199019446145;4464.508904020555;4638.281066434708;4714.316424118518;4719.480857105716;4887.095887260868;5556.416576259516;5703.3441154267375;5795.681237531934;5831.212786273841;3693.817978246962;3846.673032792216;3883.4369016492733;3898.3762597984187;3911.3155197840547;5472.9054189161925;5875;6110.419510146529;6138.447539721402;6210;3795.3927371620407;3822.3502004659276;3882.301185786529;3918.2555314490155;3946.8421263149153;3362.915927101842;3959.2279505496153;3985.867560854929;4026.295398305285;4058.7068306406786;4662.836800711959;4676.532346765296;4742.762861856893;4755.548222918817;4778.928316075262;4597.356370108188;4706.905861882743;5340.973295133499;5538.753780399378;5873.882522349614;1239.1016513027982;1277.9297138657464;1322.3916998180753;1340.3030424179371;1354.4897439355047;790.8695065314158;802.8193656427374;836.4437648963493;937.7936853892269;942.79258563116;5202.947970520322;5376.784928602812;5379.35447746273;5382.381026182039;5436.347638283352;4809.374781278411;5103.030424219386;5353.9196912046355;5663.461971112738;5677.274908044079;4498.423753116281;4709.882252943704;4775.474697783241;5093.9490605094215;5202.81790137351;2638.353603367187;2654.66816647919;2935.163478408686;2958.319586495118;3001.6097907271915;4838.564529192389;4863.957138002048;5063.556676572699;5828.766849326064;5917.230760001173;4741.502142275081;4763.023345311657;5128.948565544055;5435.619506634498;5740.512056475246;5161.974190129101;5231.346081739783;5706.400827913009;5844.655729182312;5921.437463440966;4814.903701926012;5281.600375900466;5588.720563971867;5614.578906581941;5642.887142257214;4874.390701162355;5601;5658.529761488378;5695.601307908407;5716.628419152742;4738.407699037621;5679.233303503974;5691.54865509309;5946.702664866652;6000.279966404059;3309.619393769747;3418.538497302832;3650.81745912698;3876.8836934891997;3897.5517815450453;4372.672049596356;5305.549028332481;5604.299462567179;5627.8593035174445;5634.6337488063145;5636.392708666539;5653.3498647654405;5753.971230143822;5825.621334613236;5967.880642387041;4658.324542941323;5498.690549968943;5805.82582522525;5820.76716931335;5851.9329066298515;5270.708676374313;5397.676139431646;5409.6213265071065;5632.380438151882;5785.508231800344;4837.4920633334405;5783.8554036149435;5808.564357673107;5825.41745825431;5835.94164058354;4997.225430058202;5042.873928151679;5677.630953987978;5714.314282286152;5725.742341594555 00:38:22 INFO - PROCESS | 1914 | |5;yui.html;667.0974797435002;675.3651567526522;758.4084414156956;780.964856581454;829.2660995019407;14574.70850582989;14910.030847994873;15339.923300383496;15385.846141538581;15413.691726165483;13606.93196534016;13829.654258643539;13853.93073034636;13876;13936.303184840743;818.0306336990685;825.591332290517;831.085805613823;845.6025667936091;846.1792061700141;815.3925325632412;835.2691395029349;835.5488036460304;840.5377042626561;842.8988521377444;856.6744637037917;861.0614430271004;880.7489865388366;882.1663527966075;886.2821114896955;844.2359664503634;844.5692696724715;871.2028493928049;874.8250349930007;877.232421631076;630.4767043354005;631.4096319940824;631.5989346764792;649.327945576331;651.4788169464409;12380.00959923204;12642.49430022798;13346.332683365792;13505.459781608724;13588.116772409761;9845.360051596695;11720.941395292968;11782.351970641612;11846.644600661994;12227.938860305641;10345;10663;10775.35347879122;10801.621943231949;11131.109511239081;3408.670618458803;3643.653852883972;3674.8713795017047;3680.429533422324;3736.9626303736886;75648;90008;90077;90204;90326;8845.911540884508;8878.334124940655;8969.623049891783;9245.676401326056;9255.722328330161;14994.70010599782;18428.539286517676;18539.81460185408;18707.251709931723;18756.34352797673;7676.501027433199;7956.403269754792;7980.68077276914;8039.196080391914;8137.98275215598;3964.365701487806;4418.226810308183;4423.203823311835;4522.932156017662;4568.565986231302;3394.8472318745717;3502.2820321833965;3531.841067151984;3534.5581802274714;3542.4686297055646;554.433724727646;649.2728144478215;651.7849109793757;663.1577896071962;669.6015870557011;545.6589631480325;602.2381687165739;602.8643555200044;612.2622240200548;647.8607099473636;9047.317289796549;9186;9190.218831399407;9417.717468475958;9455.487122060438;612.9233845769279;639.5523133806354;664.8803215421174;670.8691805098057;680.618853442074;4341.283688191413;4501.977490112594;4516.796744146522;4522.547745225517;4636.5131661175765;91963.08036919679;98879.50560247297;101484.49257753664;107382;114321.42839285916;73572;75296;87985.12014879897;89201.55399223093;90397;68653.2836679077;72514.2748572518;81699;82862.58568707238;84797.15202848017;7195.640217989185;7382.52013619113;8532.488050716976;8813.471191728517;9711.27165462579;50602.49397505978;52603.47396525986;52792.47207528029;53403.19895201497;54151.45848541622;69195.65402172957;71507;73912;75207;77712;11134.109271258118;11155.219134660496;11178.385188814693;11330.376829274139;11342.60300889465;12298.385080745747;12362.876371236172;12365.07261955339;12372.381380931098;12380.31908245019;11692.883071169179;11770.82343764827;11927.582534611247;11966.940165299118;12034.819477707666;12005;12026.15816892809;12051.638450846489;12056.457459414523;12097.939510302744;11634.592789252674;11721.824172637587;11857.584984525845;11967;12025.338606376734;9500.809983800424;9779.462129582656;10055.899441005497;10058.396496210251;10130.898691012995;9789.363691360039;10013.74965625836;10040.799184016132;10044.547995340374;10054.145397641283 00:38:22 INFO - PROCESS | 1914 | __end_tp_report 00:38:22 INFO - PROCESS | 1914 | __start_cc_report 00:38:22 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,342 00:38:22 INFO - PROCESS | 1914 | __end_cc_report 00:38:22 INFO - PROCESS | 1914 | __startTimestamp1485333502329__endTimestamp 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | ------- Summary: start ------- 00:38:22 INFO - PROCESS | 1914 | Number of tests: 6 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | [#0] dojo.html Cycles:165 Average:5885.23 Median:6160.17 stddev:649.49 (10.5%) stddev-sans-first:624.55 00:38:22 INFO - PROCESS | 1914 | Values: 3525.8 3552.6 3558.6 3578.3 3604.9 5883.6 5938.7 5962.4 5962.9 6032.5 4764.7 5883.8 5955.6 6016.9 6023.8 5402.8 5449.9 5483.0 5491.0 5499.6 5505.5 5512.6 5512.9 5531.7 5543.6 4546.9 5279.3 5359.9 5493.8 5502.6 5379.3 5442.7 5447.9 5474.8 5492.6 5384.4 5449.4 5469.8 5513.9 5522.2 5951.9 6038.3 6074.6 6077.7 6093.8 5086.5 6003.7 6192.3 6217.1 6274.4 6237.0 6260.2 6267.3 6311.6 6330.3 6031.5 6037.3 6042.6 6044.1 6050.8 6299.7 6327.3 6371.0 6477.4 6491.0 5191.4 6271.3 6278.2 6280.6 6306.2 6287.5 6316.5 6324.7 6327.1 6342.7 6147.8 6211.0 6234.3 6271.1 6280.2 6240.8 6261.8 6278.2 6280.3 6284.5 5088.9 5131.6 5138.5 5151.5 5165.6 3764.3 4428.3 4456.2 4493.6 4576.8 4700.8 6102.7 6160.2 6187.8 6191.0 6300.2 6329.2 6340.0 6345.7 6364.0 5981.2 6107.2 6133.6 6153.9 6221.9 5509.5 5540.4 5574.9 5600.3 5675.1 6557.9 6576.6 6608.8 6614.6 6630.0 6319.0 6380.5 6381.0 6391.6 6428.5 6317.8 6373.3 6410.0 6420.1 6463.1 6264.9 6267.1 6272.0 6280.9 6288.1 6231.7 6348.9 6358.0 6373.5 6379.8 6119.2 6120.3 6170.1 6185.0 6205.0 6236.3 6240.6 6251.7 6262.2 6268.5 6074.5 6146.3 6214.9 6247.0 6252.5 6070.8 6185.0 6185.6 6209.9 6255.4 5606.7 6159.6 6164.1 6193.9 6243.2 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | [#1] ext.html Cycles:180 Average:71296.97 Median:42294.08 stddev:152272.64 (360.0%) stddev-sans-first:152607.05 00:38:22 INFO - PROCESS | 1914 | Values: 505.2 514.1 518.9 520.7 535.3 40324.0 41089.0 42289.2 42395.2 42397.4 43623.1 44002.6 44043.8 44079.8 44946.6 9654.3 9789.3 9814.8 9837.9 9880.0 9631.0 9699.0 9708.4 9721.2 9721.6 9624.2 9690.6 9730.0 9745.7 9753.9 9637.7 9652.6 9704.6 9717.7 9737.4 9713.0 9769.6 9776.9 9806.9 9818.0 41119.6 41461.8 41568.0 41597.6 41707.6 3335.0 3375.3 3489.3 3495.6 3566.6 29786.3 30246.8 31269.8 31860.7 32615.3 3178.9 3202.0 3221.0 3222.5 3224.8 457585.0 463315.0 463829.0 464331.0 465329.0 62068.0 62179.7 62482.7 62491.0 62558.4 62519.7 63531.0 64712.7 64792.0 64879.0 16329.5 16541.0 16610.9 16621.2 16625.2 12745.3 12867.7 12894.2 12896.0 12908.8 17232.1 17661.9 17696.5 17743.2 17779.4 3327.2 6985.9 7185.8 7198.7 7256.7 854.3 962.3 1012.2 1015.6 1148.3 25316.5 27420.0 28612.7 29735.0 30962.5 979.5 1078.7 1090.8 1107.4 1246.7 15517.1 15970.3 15992.0 16116.9 16242.4 636676.0 637948.0 646808.0 647978.8 650784.0 59112.7 59130.7 59763.1 59793.4 59833.7 1371.8 1392.8 1406.4 1407.1 1412.5 29755.6 30332.5 32522.3 32824.2 32942.8 59260.7 61046.0 62517.1 62836.7 62985.7 578784.0 584374.0 594455.0 594536.0 596101.0 37895.6 39346.4 45410.9 45749.8 46284.5 40997.6 49273.1 50056.7 50185.0 51534.7 41097.0 41425.8 41934.0 42020.8 43334.3 41004.4 41104.4 42043.8 42299.0 42846.8 35900.8 39926.4 40080.0 40138.8 40729.4 30099.5 35170.5 36544.8 37189.4 37318.1 21951.0 23978.3 26673.3 26973.9 27086.5 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | [#2] jquery.html Cycles:180 Average:34576.35 Median:17621.12 stddev:95814.58 (543.7%) stddev-sans-first:96048.86 00:38:22 INFO - PROCESS | 1914 | Values: 326.7 383.4 385.9 397.6 412.5 19048.2 20512.6 21071.6 21291.9 21294.8 17268.3 17463.5 17748.5 20858.9 21010.3 5823.0 5834.1 5917.3 5920.7 6089.0 4276.9 5942.5 6038.9 6046.8 6047.7 4481.5 6253.5 6543.2 6576.0 6610.9 5443.5 6396.4 6614.6 6640.0 6644.6 5786.0 5793.8 5794.9 5810.9 5816.5 24059.8 24687.9 25279.4 25982.0 26379.6 2043.8 2095.2 2565.3 2739.9 3021.0 10686.4 10893.6 14698.6 15103.9 15702.0 1972.1 1981.5 1996.2 2007.6 2027.8 121436.0 122349.4 124754.0 126268.4 127848.0 11594.1 11688.0 11873.0 12111.0 12242.4 14941.5 14976.6 14977.6 15011.3 15027.5 7061.0 7337.1 7630.9 7924.9 8285.0 8427.7 8544.1 8568.3 8725.0 8763.7 4632.9 4669.5 4687.7 4703.6 4725.7 1626.5 1956.1 1988.1 2017.8 2026.7 834.4 852.2 925.4 999.4 1040.7 20693.2 21289.8 21311.8 21358.7 21408.4 924.3 934.9 960.9 977.1 1022.3 10723.2 11102.8 11173.1 11198.8 11199.4 494298.0 537087.0 589741.0 609654.0 610004.0 106649.0 131052.4 131321.0 146493.0 148779.0 993.4 1014.8 1041.5 1043.0 1043.1 19215.8 19592.8 19744.3 19745.6 19787.8 34858.8 54573.0 55356.0 58500.0 60428.4 75103.6 81256.2 82143.0 83076.2 83905.6 8002.2 8311.0 8399.8 8539.6 8735.3 8706.6 12654.8 13164.0 13372.1 13599.2 7928.5 8191.8 8204.9 8207.2 8289.0 5826.6 6761.5 7402.0 7876.3 8157.6 8050.6 8247.8 8404.2 8429.7 8567.5 12514.6 12925.5 12937.9 13048.6 13248.5 8101.7 10058.7 10522.5 11971.3 12009.1 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | [#3] mootools.html Cycles:180 Average:5430.41 Median:5177.30 stddev:2946.89 (56.9%) stddev-sans-first:2940.26 00:38:22 INFO - PROCESS | 1914 | Values: 1486.6 1526.4 1718.0 1801.3 1871.6 7624.8 7850.4 8123.8 8524.1 8550.3 8043.6 8283.6 8320.7 8364.9 8389.9 2365.1 2413.9 2418.2 2419.2 2419.8 2388.3 2411.0 2418.2 2427.0 2464.2 2394.7 2398.0 2418.2 2422.6 2430.0 2336.5 2368.4 2383.3 2402.2 2411.3 1993.7 2391.2 2391.9 2400.6 2420.5 8315.9 8413.8 8460.6 8476.2 8514.1 5165.6 5291.7 5310.3 5323.8 5325.5 2856.4 3202.4 3312.0 3351.7 3547.5 980.4 1016.0 1033.0 1035.7 1043.8 10830.4 10845.8 10879.9 10917.9 10924.1 4320.6 4476.6 4509.3 4550.7 4558.3 8634.6 8681.6 8708.6 8748.0 8752.0 5079.5 5106.3 5153.9 5171.4 5183.2 3842.6 4371.5 4670.5 4793.7 4825.8 3750.7 3776.2 3779.6 3878.4 3885.8 1180.3 1196.3 1196.3 1203.7 1206.3 844.8 848.9 902.8 917.2 925.9 5471.4 5538.4 5592.4 5601.2 5725.0 935.0 956.8 959.5 960.1 982.6 3580.7 3702.1 3774.6 3799.7 3825.6 9777.7 10126.2 10180.0 10190.0 10204.1 9543.9 9956.7 10095.2 10113.4 10140.5 7797.9 7975.2 7984.4 7997.4 8014.8 5521.7 5544.2 5580.9 5607.4 5771.9 7188.6 9341.9 9438.3 9477.5 9532.3 9028.3 9275.4 9404.2 9540.7 9598.0 6422.8 7138.4 7160.9 7238.8 7338.2 7955.4 7970.7 8016.5 8049.4 8072.8 7105.3 7258.2 7299.0 7328.3 7375.3 6056.4 6580.9 6620.3 7095.9 7187.9 6702.6 6752.3 6835.0 6868.6 6882.6 4812.2 4837.6 4867.5 4867.5 4874.4 4748.6 4849.5 4902.8 4924.0 4929.5 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | [#4] prototype.html Cycles:180 Average:4521.57 Median:4886.38 stddev:1395.63 (28.6%) stddev-sans-first:1362.35 00:38:22 INFO - PROCESS | 1914 | Values: 257.4 294.9 298.6 305.2 305.6 4380.8 5586.8 5611.9 5699.9 5720.9 4870.7 4885.7 5089.7 5465.8 5474.4 3606.3 3995.2 4195.3 4198.8 4216.7 3373.1 3723.8 3964.1 4037.5 4254.3 4147.3 4163.4 4166.3 4175.2 4179.5 3809.0 3941.1 4161.8 4178.3 4197.9 3143.0 3198.2 3517.4 3548.1 3561.7 4414.5 4456.1 5312.8 5326.7 5382.8 3958.2 4464.5 4638.3 4714.3 4719.5 4887.1 5556.4 5703.3 5795.7 5831.2 3693.8 3846.7 3883.4 3898.4 3911.3 5472.9 5875.0 6110.4 6138.4 6210.0 3795.4 3822.4 3882.3 3918.3 3946.8 3362.9 3959.2 3985.9 4026.3 4058.7 4662.8 4676.5 4742.8 4755.5 4778.9 4597.4 4706.9 5341.0 5538.8 5873.9 1239.1 1277.9 1322.4 1340.3 1354.5 790.9 802.8 836.4 937.8 942.8 5202.9 5376.8 5379.4 5382.4 5436.3 4809.4 5103.0 5353.9 5663.5 5677.3 4498.4 4709.9 4775.5 5093.9 5202.8 2638.4 2654.7 2935.2 2958.3 3001.6 4838.6 4864.0 5063.6 5828.8 5917.2 4741.5 4763.0 5128.9 5435.6 5740.5 5162.0 5231.3 5706.4 5844.7 5921.4 4814.9 5281.6 5588.7 5614.6 5642.9 4874.4 5601.0 5658.5 5695.6 5716.6 4738.4 5679.2 5691.5 5946.7 6000.3 3309.6 3418.5 3650.8 3876.9 3897.6 4372.7 5305.5 5604.3 5627.9 5634.6 5636.4 5653.3 5754.0 5825.6 5967.9 4658.3 5498.7 5805.8 5820.8 5851.9 5270.7 5397.7 5409.6 5632.4 5785.5 4837.5 5783.9 5808.6 5825.4 5835.9 4997.2 5042.9 5677.6 5714.3 5725.7 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - PROCESS | 1914 | [#5] yui.html Cycles:180 Average:19342.84 Median:578.34 stddev:28246.16 (4884.0%) stddev-sans-first:28290.59 00:38:22 INFO - PROCESS | 1914 | Values: 667.1 675.4 758.4 781.0 829.3 14574.7 14910.0 15339.9 15385.8 15413.7 13606.9 13829.7 13853.9 13876.0 13936.3 818.0 825.6 831.1 845.6 846.2 815.4 835.3 835.5 840.5 842.9 856.7 861.1 880.7 882.2 886.3 844.2 844.6 871.2 874.8 877.2 630.5 631.4 631.6 649.3 651.5 12380.0 12642.5 13346.3 13505.5 13588.1 9845.4 11720.9 11782.4 11846.6 12227.9 10345.0 10663.0 10775.4 10801.6 11131.1 3408.7 3643.7 3674.9 3680.4 3737.0 75648.0 90008.0 90077.0 90204.0 90326.0 8845.9 8878.3 8969.6 9245.7 9255.7 14994.7 18428.5 18539.8 18707.3 18756.3 7676.5 7956.4 7980.7 8039.2 8138.0 3964.4 4418.2 4423.2 4522.9 4568.6 3394.8 3502.3 3531.8 3534.6 3542.5 554.4 649.3 651.8 663.2 669.6 545.7 602.2 602.9 612.3 647.9 9047.3 9186.0 9190.2 9417.7 9455.5 612.9 639.6 664.9 670.9 680.6 4341.3 4502.0 4516.8 4522.5 4636.5 91963.1 98879.5 101484.5 107382.0 114321.4 73572.0 75296.0 87985.1 89201.6 90397.0 68653.3 72514.3 81699.0 82862.6 84797.2 7195.6 7382.5 8532.5 8813.5 9711.3 50602.5 52603.5 52792.5 53403.2 54151.5 69195.7 71507.0 73912.0 75207.0 77712.0 11134.1 11155.2 11178.4 11330.4 11342.6 12298.4 12362.9 12365.1 12372.4 12380.3 11692.9 11770.8 11927.6 11966.9 12034.8 12005.0 12026.2 12051.6 12056.5 12097.9 11634.6 11721.8 11857.6 11967.0 12025.3 9500.8 9779.5 10055.9 10058.4 10130.9 9789.4 10013.7 10040.8 10044.5 10054.1 00:38:22 INFO - PROCESS | 1914 | -------- Summary: end -------- 00:38:22 INFO - PROCESS | 1914 | 00:38:22 INFO - TEST-INFO | 1914: exit 0 00:38:22 INFO - TEST-OK | dromaeo_css | took 1115567ms 00:38:22 INFO - TEST-START | kraken 00:38:22 INFO - operating with platform_type : mac_ 00:38:22 INFO - Initialising browser for kraken test... 00:38:23 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpEBrT0P/profile http://localhost:49691/getInfo.html) 00:38:25 INFO - PROCESS | 1920 | 2017-01-25 00:38:25.780 plugin-container[1922:12719] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 00:38:25 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:25 INFO - PROCESS | 1920 | 2017-01-25 00:38:25.781 plugin-container[1922:12719] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 00:38:25 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:25 INFO - PROCESS | 1920 | 2017-01-25 00:38:25.781 plugin-container[1922:12719] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:38:25 INFO - PROCESS | 1920 | __metrics Screen width/height:1600/1200 00:38:25 INFO - PROCESS | 1920 | colorDepth:24 00:38:25 INFO - PROCESS | 1920 | Browser inner width/height: 1024/689 00:38:25 INFO - PROCESS | 1920 | __metrics 00:38:25 ERROR - PROCESS | 1920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 00:38:26 INFO - TEST-INFO | 1920: exit 0 00:38:26 INFO - Browser initialized. 00:38:26 INFO - Running cycle 1/1 for kraken test... 00:38:26 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpEBrT0P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:38:29 INFO - PROCESS | 1923 | 2017-01-25 00:38:29.065 plugin-container[1924:12845] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 00:38:29 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:29 INFO - PROCESS | 1923 | 2017-01-25 00:38:29.065 plugin-container[1924:12845] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 00:38:29 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:29 INFO - PROCESS | 1923 | 2017-01-25 00:38:29.065 plugin-container[1924:12845] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:38:38 INFO - PROCESS | 1923 | RSS: Main: 177033216 00:38:38 INFO - PROCESS | 1923 | 00:38:41 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49691/tests/kraken/driver.html?testName=audio-beat-detection) 00:38:42 INFO - PROCESS | 1923 | RSS: Main: 189857792 00:38:42 INFO - PROCESS | 1923 | 00:38:45 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49691/tests/kraken/driver.html?testName=audio-dft) 00:38:45 INFO - PROCESS | 1923 | RSS: Main: 197836800 00:38:45 INFO - PROCESS | 1923 | 00:38:49 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49691/tests/kraken/driver.html?testName=audio-fft) 00:38:49 INFO - PROCESS | 1923 | RSS: Main: 201654272 00:38:49 INFO - PROCESS | 1923 | 00:38:51 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49691/tests/kraken/driver.html?testName=audio-oscillator) 00:38:52 INFO - PROCESS | 1923 | RSS: Main: 202072064 00:38:52 INFO - PROCESS | 1923 | 00:38:54 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49691/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:38:54 INFO - PROCESS | 1923 | RSS: Main: 203366400 00:38:54 INFO - PROCESS | 1923 | 00:38:57 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49691/tests/kraken/driver.html?testName=imaging-darkroom) 00:38:58 INFO - PROCESS | 1923 | RSS: Main: 207769600 00:38:58 INFO - PROCESS | 1923 | 00:39:01 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49691/tests/kraken/driver.html?testName=imaging-desaturate) 00:39:02 INFO - PROCESS | 1923 | RSS: Main: 207785984 00:39:02 INFO - PROCESS | 1923 | 00:39:05 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49691/tests/kraken/driver.html?testName=json-parse-financial) 00:39:05 INFO - PROCESS | 1923 | RSS: Main: 206999552 00:39:05 INFO - PROCESS | 1923 | 00:39:07 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49691/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:39:07 INFO - PROCESS | 1923 | RSS: Main: 206217216 00:39:07 INFO - PROCESS | 1923 | 00:39:09 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:39:10 INFO - PROCESS | 1923 | RSS: Main: 206204928 00:39:10 INFO - PROCESS | 1923 | 00:39:12 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:39:13 INFO - PROCESS | 1923 | RSS: Main: 206254080 00:39:13 INFO - PROCESS | 1923 | 00:39:15 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:39:16 INFO - PROCESS | 1923 | RSS: Main: 206217216 00:39:16 INFO - PROCESS | 1923 | 00:39:19 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:39:19 INFO - PROCESS | 1923 | RSS: Main: 206487552 00:39:19 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49691/tests/kraken/driver.html?testName=ai-astar) 00:39:21 INFO - PROCESS | 1923 | RSS: Main: 208461824 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | __start_tp_report 00:39:21 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 00:39:21 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 00:39:21 INFO - PROCESS | 1923 | |i|pagename|runs| 00:39:21 INFO - PROCESS | 1923 | |0;ai-astar;103;140;117;117;117;118;117;118;119;116 00:39:21 INFO - PROCESS | 1923 | |1;audio-beat-detection;159;142;146;165;114;119;147;142;145;141 00:39:21 INFO - PROCESS | 1923 | |2;audio-dft;199;200;196;200;201;195;197;197;199;200 00:39:21 INFO - PROCESS | 1923 | |3;audio-fft;86;58;60;93;51;68;82;53;86;83 00:39:21 INFO - PROCESS | 1923 | |4;audio-oscillator;89;73;92;72;70;71;84;69;73;88 00:39:21 INFO - PROCESS | 1923 | |5;imaging-gaussian-blur;101;89;85;131;135;92;106;90;98;89 00:39:21 INFO - PROCESS | 1923 | |6;imaging-darkroom;95;97;97;91;152;152;98;97;95;97 00:39:21 INFO - PROCESS | 1923 | |7;imaging-desaturate;71;144;142;90;87;88;76;149;132;87 00:39:21 INFO - PROCESS | 1923 | |8;json-parse-financial;56;54;56;56;58;60;57;58;59;58 00:39:21 INFO - PROCESS | 1923 | |9;json-stringify-tinderbox;69;75;68;79;72;69;69;69;69;71 00:39:21 INFO - PROCESS | 1923 | |10;stanford-crypto-aes;82;83;82;81;84;81;80;83;80;87 00:39:21 INFO - PROCESS | 1923 | |11;stanford-crypto-ccm;145;130;137;138;135;141;140;148;201;147 00:39:21 INFO - PROCESS | 1923 | |12;stanford-crypto-pbkdf2;166;164;163;166;163;166;165;168;164;164 00:39:21 INFO - PROCESS | 1923 | |13;stanford-crypto-sha256-iterative;68;65;67;66;70;73;84;90;74;67 00:39:21 INFO - PROCESS | 1923 | __end_tp_report 00:39:21 INFO - PROCESS | 1923 | __start_cc_report 00:39:21 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,905 00:39:21 INFO - PROCESS | 1923 | __end_cc_report 00:39:21 INFO - PROCESS | 1923 | __startTimestamp1485333561974__endTimestamp 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | ------- Summary: start ------- 00:39:21 INFO - PROCESS | 1923 | Number of tests: 14 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#0] ai-astar Cycles:10 Average:118.20 Median:117.50 stddev:8.93 (7.6%) stddev-sans-first:7.59 00:39:21 INFO - PROCESS | 1923 | Values: 103.0 140.0 117.0 117.0 117.0 118.0 117.0 118.0 119.0 116.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:145.50 stddev:15.57 (10.7%) stddev-sans-first:15.25 00:39:21 INFO - PROCESS | 1923 | Values: 159.0 142.0 146.0 165.0 114.0 119.0 147.0 142.0 145.0 141.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#2] audio-dft Cycles:10 Average:198.40 Median:199.50 stddev:2.01 (1.0%) stddev-sans-first:2.12 00:39:21 INFO - PROCESS | 1923 | Values: 199.0 200.0 196.0 200.0 201.0 195.0 197.0 197.0 199.0 200.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#3] audio-fft Cycles:10 Average:72.00 Median:82.50 stddev:15.68 (19.0%) stddev-sans-first:15.79 00:39:21 INFO - PROCESS | 1923 | Values: 86.0 58.0 60.0 93.0 51.0 68.0 82.0 53.0 86.0 83.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.50 stddev:9.02 (11.5%) stddev-sans-first:8.67 00:39:21 INFO - PROCESS | 1923 | Values: 89.0 73.0 92.0 72.0 70.0 71.0 84.0 69.0 73.0 88.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:101.60 Median:89.00 stddev:17.74 (19.9%) stddev-sans-first:18.81 00:39:21 INFO - PROCESS | 1923 | Values: 101.0 89.0 85.0 131.0 135.0 92.0 106.0 90.0 98.0 89.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#6] imaging-darkroom Cycles:10 Average:107.10 Median:97.00 stddev:23.75 (24.5%) stddev-sans-first:24.78 00:39:21 INFO - PROCESS | 1923 | Values: 95.0 97.0 97.0 91.0 152.0 152.0 98.0 97.0 95.0 97.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#7] imaging-desaturate Cycles:10 Average:106.60 Median:81.50 stddev:31.07 (38.1%) stddev-sans-first:30.17 00:39:21 INFO - PROCESS | 1923 | Values: 71.0 144.0 142.0 90.0 87.0 88.0 76.0 149.0 132.0 87.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.75 (3.0%) stddev-sans-first:1.80 00:39:21 INFO - PROCESS | 1923 | Values: 56.0 54.0 56.0 56.0 58.0 60.0 57.0 58.0 59.0 58.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:70.00 stddev:3.50 (5.0%) stddev-sans-first:3.63 00:39:21 INFO - PROCESS | 1923 | Values: 69.0 75.0 68.0 79.0 72.0 69.0 69.0 69.0 69.0 71.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:2.11 (2.6%) stddev-sans-first:2.24 00:39:21 INFO - PROCESS | 1923 | Values: 82.0 83.0 82.0 81.0 84.0 81.0 80.0 83.0 80.0 87.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:143.00 stddev:20.04 (14.0%) stddev-sans-first:21.25 00:39:21 INFO - PROCESS | 1923 | Values: 145.0 130.0 137.0 138.0 135.0 141.0 140.0 148.0 201.0 147.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:1.60 (1.0%) stddev-sans-first:1.64 00:39:21 INFO - PROCESS | 1923 | Values: 166.0 164.0 163.0 166.0 163.0 166.0 165.0 168.0 164.0 164.0 00:39:21 INFO - PROCESS | 1923 | 00:39:21 INFO - PROCESS | 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:71.50 stddev:8.34 (11.7%) stddev-sans-first:8.70 00:39:21 INFO - PROCESS | 1923 | Values: 68.0 65.0 67.0 66.0 70.0 73.0 84.0 90.0 74.0 67.0 00:39:21 INFO - PROCESS | 1923 | -------- Summary: end -------- 00:39:21 INFO - PROCESS | 1923 | 00:39:22 INFO - TEST-INFO | 1923: exit 0 00:39:22 INFO - TEST-OK | kraken | took 59892ms 00:39:22 INFO - SUITE-END | took 1175s 00:39:23 INFO - Completed test suite (00:19:35) 00:39:23 INFO - javascript benchmark 00:39:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7258.779906055995, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3525.806080665563, 3552.591451983021, 3558.5729712434513, 3578.338007468617, 3604.9098772530683, 5883.646981181127, 5938.732757025939, 5962.373950735176, 5962.8807423851495, 6032.547558933075, 4764.737939413331, 5883.794067207648, 5955.553333499983, 6016.909746353808, 6023.759049638009, 5402.756875940572, 5449.891002179954, 5483.040467918118, 5491.0, 5499.560035197194, 5505.504504594585, 5512.614117011811, 5512.862178445531, 5531.723413829312, 5543.584231182657, 4546.909061818762, 5279.260903473517, 5359.892802143955, 5493.807716729915, 5502.642328248671, 5379.300690910157, 5442.673439593637, 5447.918281225785, 5474.753636086386, 5492.642978206404, 5384.434634363413, 5449.4005659377435, 5469.808556700496, 5513.889722205534, 5522.199281104257, 5951.940480595182, 6038.27540695115, 6074.605150665237, 6077.726502307407, 6093.756249750005, 5086.46592107827, 6003.699815009276, 6192.256929168483, 6217.067439884054, 6274.403931626488, 6236.96881515594, 6260.186175797117, 6267.279262884781, 6311.558190926637, 6330.335314791927, 6031.45716885478, 6037.336422234108, 6042.57701960863, 6044.093385992049, 6050.818475445743, 6299.748010079637, 6327.335629758901, 6370.968145159244, 6477.384648458389, 6491.026346048131, 5191.377034755854, 6271.341509141565, 6278.246610406781, 6280.560360774702, 6306.243250809932, 6287.462382172241, 6316.526260530387, 6324.652144132025, 6327.145835312266, 6342.651154186472, 6147.846303842351, 6211.0372892201785, 6234.251889773165, 6271.059341098871, 6280.152179455807, 6240.843978900473, 6261.843453913598, 6278.183836101278, 6280.2777680566405, 6284.465820405226, 5088.898222035538, 5131.589472842164, 5138.511841375063, 5151.5106064923775, 5165.612579056586, 3764.3412402829395, 4428.291473364311, 4456.197884380843, 4493.640508759291, 4576.794044268016, 4700.788464519105, 6102.664353460514, 6160.168377269101, 6187.81436556895, 6191.0, 6300.243970723543, 6329.240491141092, 6340.048992651139, 6345.746170153142, 6364.0, 5981.192539007266, 6107.15847211733, 6133.570650054453, 6153.892299386064, 6221.906671399933, 5509.47659972302, 5540.36285827127, 5574.916376254359, 5600.27196464457, 5675.120356344773, 6557.9344206557325, 6576.606129285545, 6608.768693095911, 6614.636195009224, 6630.038644396439, 6318.968405157945, 6380.457661098859, 6381.0, 6391.58454700443, 6428.517861160338, 6317.778877739257, 6373.298937117006, 6410.0, 6420.133282006869, 6463.095166676575, 6264.906026409699, 6267.122602835516, 6272.0, 6280.874382512416, 6288.088227207121, 6231.719572619152, 6348.904766428415, 6358.0, 6373.458256048102, 6379.776707815204, 6119.173911521888, 6120.294761999531, 6170.10533472635, 6185.041318595445, 6204.968975155095, 6236.251649802053, 6240.625562466266, 6251.6561589113035, 6262.2172228471445, 6268.52986026059, 6074.453299203093, 6146.262448506208, 6214.9067763982675, 6246.969250073687, 6252.468540174136, 6070.7875224366935, 6184.979478386196, 6185.628862268279, 6209.906851397142, 6255.374462553708, 5606.719664016864, 6159.630422174684, 6164.137020817179, 6193.876122477435, 6243.157173781481], "value": 5846.538319402426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.15134573915816, 514.1131548079561, 518.8610998857508, 520.6537652461113, 535.2666846420404, 40324.0, 41089.0, 42289.15421691568, 42395.152096958045, 42397.36403953943, 43623.12753744923, 44002.55997440025, 44043.77978110105, 44079.77960110203, 44946.55053449464, 9654.324197306192, 9789.314747967645, 9814.754631134207, 9837.90162098377, 9880.011998800135, 9631.036896310383, 9699.0, 9708.417494950325, 9721.17370023549, 9721.611135554569, 9624.23006159509, 9690.612375504972, 9730.026997300283, 9745.658901938434, 9753.853692194623, 9637.71086867395, 9652.565634546392, 9704.563294651793, 9717.708468745948, 9737.367071140354, 9713.0, 9769.560369783378, 9776.853347199798, 9806.852897206547, 9818.018198180196, 41119.588804111874, 41461.79269103635, 41567.96080097991, 41597.58402415998, 41707.582924170674, 3334.9666503335143, 3375.3418083473734, 3489.2672538766888, 3495.563054618173, 3566.6433356664384, 29786.255343616365, 30246.84876575625, 31269.8436507816, 31860.681393186, 32615.347693046242, 3178.9364212715845, 3202.0, 3221.01758963516, 3222.46829273172, 3224.8226347550876, 457585.0, 463315.0, 463828.9999999966, 464331.0, 465329.0, 62068.0, 62179.68910155511, 62482.687586562686, 62491.0, 62558.37441625616, 62519.6874015627, 63531.04703429452, 64712.67643661846, 64792.028119578245, 64879.0, 16329.510114696579, 16541.0, 16610.916945415196, 16621.168941552874, 16625.168741563117, 12745.299008554619, 12867.742645147044, 12894.226346419246, 12896.0, 12908.806367904488, 17232.104468508453, 17661.911690441466, 17696.469105926844, 17743.201555930013, 17779.377721779936, 3327.168207948013, 6985.89521157183, 7185.820354491075, 7198.71205151788, 7256.7460138894885, 854.2525290370926, 962.2638681408588, 1012.2104758288547, 1015.6445244164483, 1148.2880614019361, 25316.45569620256, 27420.040298589454, 28612.713872861004, 29734.959276425223, 30962.53556196659, 979.5494072726625, 1078.7282361847174, 1090.8200146975819, 1107.4186052322596, 1246.663400881775, 15517.068975861484, 15970.281337339848, 15992.0, 16116.919415402848, 16242.350305987864, 636676.0, 637948.0, 646808.0, 647978.7601062058, 650784.0, 59112.70443647754, 59130.70434647799, 59763.10355344673, 59793.402065978786, 59833.70083149557, 1371.8010888421322, 1392.8258967629047, 1406.3530775843226, 1407.1346122134814, 1412.491503058898, 29755.55366669545, 30332.545011824397, 32522.349553008335, 32824.179395515304, 32942.835285823414, 59260.70369648124, 61046.0, 62517.06224406729, 62836.68581657062, 62985.68507157435, 578784.0, 584374.0, 594455.0, 594536.0, 596101.0, 37895.621043790314, 39346.40980385354, 45410.864728382054, 45749.77125114353, 46284.53715462937, 40997.59002409938, 49273.058155348204, 50056.749716251186, 50185.0, 51534.74232628813, 41097.0, 41425.79287103545, 41934.0, 42020.78989605032, 43334.34998475089, 41004.38493422541, 41104.38343424791, 42043.7897810509, 42299.0, 42846.78576607097, 35900.82049589735, 39926.40110398405, 40080.0, 40138.799306004454, 40729.38905916473, 30099.54850677198, 35170.47244291286, 36544.81727591345, 37189.44215836711, 37318.067048322926, 21951.0, 23978.28065158048, 26673.33316667099, 26973.921043158054, 27086.458270834868], "value": 20631.753139459648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.68801294763495, 383.41146340367544, 385.93246181918164, 397.62821761652873, 412.5255955651001, 19048.238070477182, 20512.589748205028, 21071.578568428624, 21291.893540532314, 21294.787052129475, 17268.30926762928, 17463.47609571715, 17748.46754597361, 20858.895705521452, 21010.264640737576, 5822.9809783287965, 5834.124881267812, 5917.289925208959, 5920.733566989475, 6089.02575587906, 4276.871693849174, 5942.465178133967, 6038.879222415549, 6046.7883624073165, 6047.727852246638, 4481.462224533045, 6253.499720022387, 6543.1821022372205, 6576.0, 6610.8677826443445, 5443.455654434564, 6396.360363963589, 6614.570052946568, 6640.0, 6644.637849240894, 5786.016377215841, 5793.826185214451, 5794.913076303858, 5810.883782324372, 5816.534677225812, 24059.759402406104, 24687.87656061726, 25279.36801579957, 25982.0, 26379.604305935427, 2043.754749430063, 2095.19335056003, 2565.307367010915, 2739.876705548255, 3020.9848950755104, 10686.412247326394, 10893.618723344724, 14698.632534186623, 15103.924480377527, 15702.0, 1972.142118178597, 1981.5442448236843, 1996.1616121228974, 2007.598480303945, 2027.844128846558, 121436.0, 122349.38825305905, 124754.0, 126268.36865815612, 127848.0, 11594.072474202043, 11688.0, 11872.990795782454, 12111.031117510578, 12242.44908979098, 14941.477048303257, 14976.550703478913, 14977.550673479813, 15011.324490397958, 15027.549173524812, 7061.046758687511, 7337.119545654556, 7630.931669566266, 7924.920750792418, 8284.958575207085, 8427.662893484192, 8544.145585441405, 8568.314534837198, 8724.956375218084, 8763.693270735494, 4632.907341853144, 4669.509701481364, 4687.71873687573, 4703.623710103184, 4725.669203155746, 1626.471396796046, 1956.1197461142258, 1988.1152886965162, 2017.8385729141633, 2026.6554685703466, 834.4325858416336, 852.194676031157, 925.3938670171049, 999.3753903810118, 1040.698197522725, 20693.17227310921, 21289.78710212878, 21311.78688213129, 21358.679619805716, 21408.357749267547, 924.306769922558, 934.8971613122551, 960.8943016268205, 977.0717818072859, 1022.2690776095128, 10723.249372543847, 11102.777944441066, 11173.10615150786, 11198.832017519744, 11199.384033878216, 494298.0, 537087.0, 589741.0, 609653.9517302385, 610004.0, 106649.0, 131052.44737763074, 131321.0, 146493.0, 148779.0, 993.4436715439233, 1014.7767491151787, 1041.5261056219401, 1042.9634962776418, 1043.0508237503834, 19215.807841921403, 19592.80407195967, 19744.30894918671, 19745.60508789845, 19787.802121978595, 34858.825705871306, 54573.0, 55356.0, 58500.0, 60428.39571604403, 75103.62448187724, 81256.18743812486, 82143.0, 83076.16923830926, 83905.5804720997, 8002.239787220205, 8311.0, 8399.816047827486, 8539.615717292862, 8735.344849136467, 8706.564671766513, 12654.810177847156, 13163.956166678116, 13372.130811497222, 13599.184048957095, 7928.484648497829, 8191.83616327682, 8204.876926845982, 8207.179282071746, 8288.958555207186, 5826.592138550261, 6761.492888033319, 7402.000729901394, 7876.251756083163, 8157.592120393838, 8050.637721302438, 8247.793805154919, 8404.243618074403, 8429.747107586782, 8567.528785916835, 12514.561990330294, 12925.482980680668, 12937.870621294043, 13048.564657887815, 13248.536301229411, 8101.716439924574, 10058.698239052841, 10522.526846241686, 11971.3487386348, 12009.099317551394], "value": 9607.634878121722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.5986183730392, 1526.381815364777, 1717.9949729408295, 1801.2704854533902, 1871.616318654675, 7624.771256862289, 7850.411219158572, 8123.796905077369, 8524.147585241473, 8550.315974722023, 8043.597820109, 8283.627236774344, 8320.66717331306, 8364.916350836489, 8389.916100839006, 2365.1367250953363, 2413.9396515087174, 2418.1657328221736, 2419.1532963462737, 2419.7822196002357, 2388.2596395117484, 2410.95178096438, 2418.2019933422016, 2427.0291883246664, 2464.1745015419856, 2394.736578976311, 2398.028798336668, 2418.177819541356, 2422.5760491913843, 2429.9757002430015, 2336.497653004595, 2368.4078980254935, 2383.30884043628, 2402.2192787344097, 2411.30072279038, 1993.6710442776925, 2391.2109004028803, 2391.928242152738, 2400.603900356439, 2420.5279970405777, 8315.875261871077, 8413.83172336556, 8460.619272132768, 8476.152384761535, 8514.106018867991, 5165.612579056548, 5291.735413229361, 5310.256564081032, 5323.787048518055, 5325.547328477084, 2856.4144350408324, 3202.4235637585225, 3312.03950854252, 3351.692839792483, 3547.467879818022, 980.4019548075668, 1015.9593616255341, 1032.9690109296732, 1035.6789395287485, 1043.8434234864756, 10830.40432776205, 10845.83731244032, 10879.945600271947, 10917.945410272898, 10924.126069914388, 4320.632746216544, 4476.552344765498, 4509.255972764523, 4550.681452298308, 4558.293464513005, 8634.568271586395, 8681.56592170389, 8708.608112634947, 8748.037715851251, 8752.0, 5079.466656001141, 5106.259592359162, 5153.922691159635, 5171.4052883918075, 5183.196604526304, 3842.5773164951834, 4371.453568303962, 4670.462896766848, 4793.712377257306, 4825.758712064383, 3750.737448378642, 3776.2258736959407, 3779.6220377961986, 3878.398848178537, 3885.786281754474, 1180.3449085757486, 1196.2642974570576, 1196.3420118934725, 1203.7472130852443, 1206.252123683322, 844.7507985144397, 848.9235968762841, 902.7878448564582, 917.2295271971576, 925.9166674999148, 5471.398146203915, 5538.446155384429, 5592.412796656374, 5601.226139055322, 5725.026745453283, 934.9859752103724, 956.8134213828237, 959.4531117263233, 960.1071003966379, 982.597135174575, 3580.695640870555, 3702.0559757261726, 3774.584795672474, 3799.7340186187253, 3825.5600605930117, 9777.706668799947, 10126.189904807597, 10179.982001799908, 10190.0, 10204.132648724793, 9543.9045609543, 9956.651517196864, 10095.192384609214, 10113.393196408239, 10140.543675534618, 7797.883031754528, 7975.202479752094, 7984.361251099898, 7997.440179187517, 8014.759557213293, 5521.723913804213, 5544.223808666709, 5580.9441905580425, 5607.383187849415, 5771.884562308815, 7188.568685878864, 9341.906580934103, 9438.292128090283, 9477.526123693926, 9532.332736708364, 9028.277737781093, 9275.443473391619, 9404.247660187031, 9540.713778586654, 9598.0, 6422.807315780534, 7138.39323657495, 7160.892586611101, 7238.819029524304, 7338.192798792022, 7955.363570914429, 7970.681172753257, 8016.478928869605, 8049.356051515982, 8072.798180045545, 7105.25394833535, 7258.20159782413, 7299.0, 7328.267173282629, 7375.262473752582, 6056.424639659225, 6580.934190658224, 6620.304867988792, 7095.858082838417, 7187.8562428752175, 6702.597844129368, 6752.324767523209, 6834.974753786972, 6868.587884726932, 6882.621455819978, 4812.205986012409, 4837.612990960785, 4867.5132486751045, 4867.5132486751045, 4874.390701162355, 4748.59636930851, 4849.4908034655855, 4902.779374928208, 4923.965967146939, 4929.457759646364], "value": 4422.0505883337555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.4182347893761, 294.90857834071437, 298.6371558556354, 305.207985278203, 305.55236578412627, 4380.759058251795, 5586.83239502815, 5611.887762244753, 5699.896074826129, 5720.942790572093, 4870.683405578635, 4885.658003939726, 5089.694618322903, 5465.836024919249, 5474.39781624021, 3606.3148001879626, 3995.1610161865897, 4195.286801243796, 4198.8110535026, 4216.704830661855, 3373.1398493384154, 3723.7765734055906, 3964.086396498571, 4037.4953130858644, 4254.340577210537, 4147.336426171813, 4163.375493675958, 4166.270902592049, 4175.185838761443, 4179.519355274152, 3808.9809550952205, 3941.1476605995135, 4161.791910404468, 4178.310578754532, 4197.893558766521, 3143.0413723814227, 3198.200449887528, 3517.402041652925, 3548.1484443733575, 3561.679448849616, 4414.470263568361, 4456.08650226706, 5312.76092575835, 5326.7070311132875, 5382.838514844561, 3958.199019446145, 4464.508904020555, 4638.281066434708, 4714.316424118518, 4719.480857105716, 4887.095887260868, 5556.416576259516, 5703.3441154267375, 5795.681237531934, 5831.212786273841, 3693.817978246962, 3846.673032792216, 3883.4369016492733, 3898.3762597984187, 3911.3155197840547, 5472.9054189161925, 5875.0, 6110.419510146529, 6138.447539721402, 6210.0, 3795.3927371620407, 3822.3502004659276, 3882.301185786529, 3918.2555314490155, 3946.8421263149153, 3362.915927101842, 3959.2279505496153, 3985.867560854929, 4026.295398305285, 4058.7068306406786, 4662.836800711959, 4676.532346765296, 4742.762861856893, 4755.548222918817, 4778.928316075262, 4597.356370108188, 4706.905861882743, 5340.973295133499, 5538.753780399378, 5873.882522349614, 1239.1016513027982, 1277.9297138657464, 1322.3916998180753, 1340.3030424179371, 1354.4897439355047, 790.8695065314158, 802.8193656427374, 836.4437648963493, 937.7936853892269, 942.79258563116, 5202.947970520322, 5376.784928602812, 5379.35447746273, 5382.381026182039, 5436.347638283352, 4809.374781278411, 5103.030424219386, 5353.9196912046355, 5663.461971112738, 5677.274908044079, 4498.423753116281, 4709.882252943704, 4775.474697783241, 5093.9490605094215, 5202.81790137351, 2638.353603367187, 2654.66816647919, 2935.163478408686, 2958.319586495118, 3001.6097907271915, 4838.564529192389, 4863.957138002048, 5063.556676572699, 5828.766849326064, 5917.230760001173, 4741.502142275081, 4763.023345311657, 5128.948565544055, 5435.619506634498, 5740.512056475246, 5161.974190129101, 5231.346081739783, 5706.400827913009, 5844.655729182312, 5921.437463440966, 4814.903701926012, 5281.600375900466, 5588.720563971867, 5614.578906581941, 5642.887142257214, 4874.390701162355, 5601.0, 5658.529761488378, 5695.601307908407, 5716.628419152742, 4738.407699037621, 5679.233303503974, 5691.54865509309, 5946.702664866652, 6000.279966404059, 3309.619393769747, 3418.538497302832, 3650.81745912698, 3876.8836934891997, 3897.5517815450453, 4372.672049596356, 5305.549028332481, 5604.299462567179, 5627.8593035174445, 5634.6337488063145, 5636.392708666539, 5653.3498647654405, 5753.971230143822, 5825.621334613236, 5967.880642387041, 4658.324542941323, 5498.690549968943, 5805.82582522525, 5820.76716931335, 5851.9329066298515, 5270.708676374313, 5397.676139431646, 5409.6213265071065, 5632.380438151882, 5785.508231800344, 4837.4920633334405, 5783.8554036149435, 5808.564357673107, 5825.41745825431, 5835.94164058354, 4997.225430058202, 5042.873928151679, 5677.630953987978, 5714.314282286152, 5725.742341594555], "value": 4071.92986941095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.0974797435002, 675.3651567526522, 758.4084414156956, 780.964856581454, 829.2660995019407, 14574.70850582989, 14910.030847994873, 15339.923300383496, 15385.846141538581, 15413.691726165483, 13606.93196534016, 13829.654258643539, 13853.93073034636, 13876.0, 13936.303184840743, 818.0306336990685, 825.591332290517, 831.085805613823, 845.6025667936091, 846.1792061700141, 815.3925325632412, 835.2691395029349, 835.5488036460304, 840.5377042626561, 842.8988521377444, 856.6744637037917, 861.0614430271004, 880.7489865388366, 882.1663527966075, 886.2821114896955, 844.2359664503634, 844.5692696724715, 871.2028493928049, 874.8250349930007, 877.232421631076, 630.4767043354005, 631.4096319940824, 631.5989346764792, 649.327945576331, 651.4788169464409, 12380.00959923204, 12642.49430022798, 13346.332683365792, 13505.459781608724, 13588.116772409761, 9845.360051596695, 11720.941395292968, 11782.351970641612, 11846.644600661994, 12227.938860305641, 10345.0, 10663.0, 10775.35347879122, 10801.621943231949, 11131.109511239081, 3408.670618458803, 3643.653852883972, 3674.8713795017047, 3680.429533422324, 3736.9626303736886, 75648.0, 90008.0, 90077.0, 90204.0, 90326.0, 8845.911540884508, 8878.334124940655, 8969.623049891783, 9245.676401326056, 9255.722328330161, 14994.70010599782, 18428.539286517676, 18539.81460185408, 18707.251709931723, 18756.34352797673, 7676.501027433199, 7956.403269754792, 7980.68077276914, 8039.196080391914, 8137.98275215598, 3964.365701487806, 4418.226810308183, 4423.203823311835, 4522.932156017662, 4568.565986231302, 3394.8472318745717, 3502.2820321833965, 3531.841067151984, 3534.5581802274714, 3542.4686297055646, 554.433724727646, 649.2728144478215, 651.7849109793757, 663.1577896071962, 669.6015870557011, 545.6589631480325, 602.2381687165739, 602.8643555200044, 612.2622240200548, 647.8607099473636, 9047.317289796549, 9186.0, 9190.218831399407, 9417.717468475958, 9455.487122060438, 612.9233845769279, 639.5523133806354, 664.8803215421174, 670.8691805098057, 680.618853442074, 4341.283688191413, 4501.977490112594, 4516.796744146522, 4522.547745225517, 4636.5131661175765, 91963.08036919679, 98879.50560247297, 101484.49257753664, 107382.0, 114321.42839285916, 73572.0, 75296.0, 87985.12014879897, 89201.55399223093, 90397.0, 68653.2836679077, 72514.2748572518, 81699.0, 82862.58568707238, 84797.15202848017, 7195.640217989185, 7382.52013619113, 8532.488050716976, 8813.471191728517, 9711.27165462579, 50602.49397505978, 52603.47396525986, 52792.47207528029, 53403.19895201497, 54151.45848541622, 69195.65402172957, 71507.0, 73912.0, 75207.0, 77712.0, 11134.109271258118, 11155.219134660496, 11178.385188814693, 11330.376829274139, 11342.60300889465, 12298.385080745747, 12362.876371236172, 12365.07261955339, 12372.381380931098, 12380.31908245019, 11692.883071169179, 11770.82343764827, 11927.582534611247, 11966.940165299118, 12034.819477707666, 12005.0, 12026.15816892809, 12051.638450846489, 12056.457459414523, 12097.939510302744, 11634.592789252674, 11721.824172637587, 11857.584984525845, 11967.0, 12025.338606376734, 9500.809983800424, 9779.462129582656, 10055.899441005497, 10058.396496210251, 10130.898691012995, 9789.363691360039, 10013.74965625836, 10040.799184016132, 10044.547995340374, 10054.145397641283], "value": 7009.031000266246, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.0000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 140.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0, 116.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 142.0, 146.0, 165.0, 114.0, 119.0, 147.0, 142.0, 145.0, 141.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 200.0, 196.0, 200.0, 201.0, 195.0, 197.0, 197.0, 199.0, 200.0], "value": 198.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 60.0, 93.0, 51.0, 68.0, 82.0, 53.0, 86.0, 83.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 73.0, 92.0, 72.0, 70.0, 71.0, 84.0, 69.0, 73.0, 88.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 89.0, 85.0, 131.0, 135.0, 92.0, 106.0, 90.0, 98.0, 89.0], "value": 101.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 91.0, 152.0, 152.0, 98.0, 97.0, 95.0, 97.0], "value": 107.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 144.0, 142.0, 90.0, 87.0, 88.0, 76.0, 149.0, 132.0, 87.0], "value": 106.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 56.0, 58.0, 60.0, 57.0, 58.0, 59.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 68.0, 79.0, 72.0, 69.0, 69.0, 69.0, 69.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 81.0, 84.0, 81.0, 80.0, 83.0, 80.0, 87.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 130.0, 137.0, 138.0, 135.0, 141.0, 140.0, 148.0, 201.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 166.0, 163.0, 166.0, 165.0, 168.0, 164.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 66.0, 70.0, 73.0, 84.0, 90.0, 74.0, 67.0], "value": 72.4, "unit": "score"}]}]} 00:39:23 INFO - Return code: 0 00:39:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:39:23 ERROR - # TBPL SUCCESS # 00:39:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:39:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:39:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:39:23 INFO - 2017-01-25 00:39:23.332 screenresolution[1928:13222] starting screenresolution argv=screenresolution get 00:39:23 INFO - 2017-01-25 00:39:23.335 screenresolution[1928:13222] Display 0: 1600x1200x32@60 00:39:23 INFO - 2017-01-25 00:39:23.341 screenresolution[1929:13225] starting screenresolution argv=screenresolution list 00:39:23 INFO - Available Modes on Display 0 00:39:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:39:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:39:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:39:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:39:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:39:23 INFO - Intel Iris: 00:39:23 INFO - Chipset Model: Intel Iris 00:39:23 INFO - Type: GPU 00:39:23 INFO - Bus: Built-In 00:39:23 INFO - VRAM (Dynamic, Max): 1536 MB 00:39:23 INFO - Vendor: Intel (0x8086) 00:39:23 INFO - Device ID: 0x0a2e 00:39:23 INFO - Revision ID: 0x0009 00:39:23 INFO - Displays: 00:39:23 INFO - Display: 00:39:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:39:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:39:23 INFO - Display Serial Number: 1600x1200 60 00:39:23 INFO - Main Display: Yes 00:39:23 INFO - Mirror: Off 00:39:23 INFO - Online: Yes 00:39:23 INFO - Rotation: Supported 00:39:23 INFO - Return code: 0 00:39:23 INFO - Running post-action listener: _resource_record_post_action 00:39:23 INFO - [mozharness: 2017-01-25 08:39:23.576784Z] Finished run-tests step (success) 00:39:23 INFO - Running post-run listener: _resource_record_post_run 00:39:23 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 2794496; Write bytes: 500859904; Read time: 22; Write time: 1622 00:39:23 INFO - TinderboxPrint: CPU usage
54.1% 00:39:23 INFO - TinderboxPrint: I/O read bytes / time
2,794,496 / 22 00:39:23 INFO - TinderboxPrint: I/O write bytes / time
500,859,904 / 1,622 00:39:23 INFO - TinderboxPrint: CPU idle
2,201.1 (45.9%) 00:39:23 INFO - TinderboxPrint: CPU system
966.8 (20.2%) 00:39:23 INFO - TinderboxPrint: CPU user
1,625.8 (33.9%) 00:39:23 INFO - TinderboxPrint: Swap in / out
194,699,264 / 0 00:39:23 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192143872; Write bytes: 193537536; Read time: 17793; Write time: 449 00:39:23 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1577984; Write bytes: 305937920; Read time: 18; Write time: 1163 00:39:24 INFO - Running post-run listener: _upload_blobber_files 00:39:24 INFO - Blob upload gear active. 00:39:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:39:24 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 00:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:39:24 INFO - (blobuploader) - INFO - Open directory for files ... 00:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:39:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:25 INFO - (blobuploader) - INFO - Done attempting. 00:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:26 INFO - (blobuploader) - INFO - Done attempting. 00:39:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:39:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:39:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:39:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:39:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:39:28 INFO - (blobuploader) - INFO - Done attempting. 00:39:28 INFO - (blobuploader) - INFO - Iteration through files over. 00:39:28 INFO - Return code: 0 00:39:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:39:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:39:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14ec842320454d017fb8c03319b2192a00f1bebd7ace0491a96d70baada21c2d2fba080493df6859c576ac88bd058fc25958d2d33e0743a353feeab5fe7bc6a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c73d14d9ca1ed91b31ebaf9315b3d450e200fbea7340223eb60bba8a999be9a7363cde382ffb38b49bf39dd306d325dc78b68df95c3ce08be91c7c30fe64ec2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175e777b5bf88bf59a6e1079a3f5ac4dce107d3259335f4ae64a36e91af0303276877a509b083ef63b2934861397f999cd66964a4ac8c4be74c5555603d421bf"} 00:39:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:39:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:39:28 INFO - Contents: 00:39:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14ec842320454d017fb8c03319b2192a00f1bebd7ace0491a96d70baada21c2d2fba080493df6859c576ac88bd058fc25958d2d33e0743a353feeab5fe7bc6a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c73d14d9ca1ed91b31ebaf9315b3d450e200fbea7340223eb60bba8a999be9a7363cde382ffb38b49bf39dd306d325dc78b68df95c3ce08be91c7c30fe64ec2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175e777b5bf88bf59a6e1079a3f5ac4dce107d3259335f4ae64a36e91af0303276877a509b083ef63b2934861397f999cd66964a4ac8c4be74c5555603d421bf"} 00:39:28 INFO - Running post-run listener: copy_logs_to_upload_dir 00:39:28 INFO - Copying logs to upload dir... 00:39:28 INFO - mkdir: /builds/slave/test/build/upload/logs 00:39:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.095490 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-01-25 00:39:28.389386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 00:39:28.393102) ========= 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.iWGScxdIf1/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.U7buEW1BcT/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14ec842320454d017fb8c03319b2192a00f1bebd7ace0491a96d70baada21c2d2fba080493df6859c576ac88bd058fc25958d2d33e0743a353feeab5fe7bc6a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c73d14d9ca1ed91b31ebaf9315b3d450e200fbea7340223eb60bba8a999be9a7363cde382ffb38b49bf39dd306d325dc78b68df95c3ce08be91c7c30fe64ec2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175e777b5bf88bf59a6e1079a3f5ac4dce107d3259335f4ae64a36e91af0303276877a509b083ef63b2934861397f999cd66964a4ac8c4be74c5555603d421bf"} build_url:https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/AWktLcQ6RBWO2bowdSanuQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14ec842320454d017fb8c03319b2192a00f1bebd7ace0491a96d70baada21c2d2fba080493df6859c576ac88bd058fc25958d2d33e0743a353feeab5fe7bc6a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c73d14d9ca1ed91b31ebaf9315b3d450e200fbea7340223eb60bba8a999be9a7363cde382ffb38b49bf39dd306d325dc78b68df95c3ce08be91c7c30fe64ec2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175e777b5bf88bf59a6e1079a3f5ac4dce107d3259335f4ae64a36e91af0303276877a509b083ef63b2934861397f999cd66964a4ac8c4be74c5555603d421bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 00:39:28.427241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:39:28.427565) ========= 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.iWGScxdIf1/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.U7buEW1BcT/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.005307 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 00:39:28.487593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 00:39:28.487914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 00:39:28.488222) ========= ========= Total master_lag: 0.21 =========