builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0023 starttime: 1476189109.91 results: success (0) buildid: 20161011030212 builduid: c8b18b67ab494b4ca852b70243c96ad1 revision: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.910607) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.911049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.911329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.988253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.988544) ========= 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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 --2016-10-11 05:31:49-- 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% 20.9M=0.001s 2016-10-11 05:31:50 (20.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.463498 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:50.473206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:50.473491) ========= 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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.021431 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:50.521117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:50.521411) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pbKIhbq8sW/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.7LmGXC28ZG/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 2016-10-11 05:31:50,594 truncating revision to first 12 chars 2016-10-11 05:31:50,594 Setting DEBUG logging. 2016-10-11 05:31:50,594 attempt 1/10 2016-10-11 05:31:50,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f4c28b59a8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 05:31:51,298 unpacking tar archive at: mozilla-central-8f4c28b59a8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.971589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.514585) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.514904) ========= script_repo_revision: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.515289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.515547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.533112) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-11 05:31:51.533373) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pbKIhbq8sW/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.7LmGXC28ZG/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:31:51 INFO - MultiFileLogger online at 20161011 05:31:51 in /builds/slave/test 05:31:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:51 INFO - {'append_to_log': False, 05:31:51 INFO - 'base_work_dir': '/builds/slave/test', 05:31:51 INFO - 'blob_upload_branch': 'Firefox', 05:31:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:51 INFO - 'branch': 'Firefox', 05:31:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:51 INFO - 'config_files': ('talos/mac_config.py',), 05:31:51 INFO - 'default_actions': ('clobber', 05:31:51 INFO - 'read-buildbot-config', 05:31:51 INFO - 'download-and-extract', 05:31:51 INFO - 'populate-webroot', 05:31:51 INFO - 'create-virtualenv', 05:31:51 INFO - 'install', 05:31:51 INFO - 'run-tests'), 05:31:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:51 INFO - 'download_minidump_stackwalk': True, 05:31:51 INFO - 'download_symbols': 'ondemand', 05:31:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:51 INFO - 'installer_path': 'installer.exe', 05:31:51 INFO - 'log_level': 'info', 05:31:51 INFO - 'log_name': 'talos', 05:31:51 INFO - 'log_to_console': True, 05:31:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:51 INFO - 'opt_config_files': (), 05:31:51 INFO - 'pip_index': False, 05:31:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:51 INFO - 'cmd': ('bash', 05:31:51 INFO - '-c', 05:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:51 INFO - 'enabled': True, 05:31:51 INFO - 'halt_on_failure': False, 05:31:51 INFO - 'name': 'check_screen_resolution'},), 05:31:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:51 INFO - 'cmd': ('bash', 05:31:51 INFO - '-c', 05:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:51 INFO - 'enabled': True, 05:31:51 INFO - 'halt_on_failure': False, 05:31:51 INFO - 'name': 'check_screen_resolution'},), 05:31:51 INFO - 'run_cmd_checks_enabled': True, 05:31:51 INFO - 'sps_profile': False, 05:31:51 INFO - 'sps_profile_interval': 0, 05:31:51 INFO - 'suite': 'dromaeojs-e10s', 05:31:51 INFO - 'system_bits': '32', 05:31:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:51 INFO - 'title': 't-yosemite-r7-0023', 05:31:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:51 INFO - 'use_talos_json': True, 05:31:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:51 INFO - 'work_dir': 'build'} 05:31:51 INFO - [mozharness: 2016-10-11 12:31:51.736651Z] Running clobber step. 05:31:51 INFO - Running pre-action listener: _resource_record_pre_action 05:31:51 INFO - Running main action method: clobber 05:31:51 INFO - rmtree: /builds/slave/test/build 05:31:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:53 INFO - Running post-action listener: _resource_record_post_action 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.702108Z] Finished clobber step (success) 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.702378Z] Running read-buildbot-config step. 05:31:53 INFO - Running pre-action listener: _resource_record_pre_action 05:31:53 INFO - Running main action method: read_buildbot_config 05:31:53 INFO - Using buildbot properties: 05:31:53 INFO - { 05:31:53 INFO - "project": "", 05:31:53 INFO - "product": "firefox", 05:31:53 INFO - "script_repo_revision": "production", 05:31:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:31:53 INFO - "repository": "", 05:31:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:31:53 INFO - "buildid": "20161011030212", 05:31:53 INFO - "stage_platform": "macosx64", 05:31:53 INFO - "basedir": "/builds/slave/test", 05:31:53 INFO - "nightly_build": "True", 05:31:53 INFO - "buildnumber": 71, 05:31:53 INFO - "slavename": "t-yosemite-r7-0023", 05:31:53 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:31:53 INFO - "platform": "yosemite_r7", 05:31:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:53 INFO - "branch": "mozilla-central", 05:31:53 INFO - "repo_path": "mozilla-central", 05:31:53 INFO - "revision": "8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb", 05:31:53 INFO - "pgo_build": "False", 05:31:53 INFO - "builduid": "c8b18b67ab494b4ca852b70243c96ad1", 05:31:53 INFO - "slavebuilddir": "test" 05:31:53 INFO - } 05:31:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:31:53 INFO - Running post-action listener: _resource_record_post_action 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.708449Z] Finished read-buildbot-config step (success) 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.708675Z] Running download-and-extract step. 05:31:53 INFO - Running pre-action listener: _resource_record_pre_action 05:31:53 INFO - Running main action method: download_and_extract 05:31:53 INFO - mkdir: /builds/slave/test/build/tests 05:31:53 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')]} 05:31:53 INFO - trying https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:31:53 INFO - Downloading https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:31:54 INFO - Downloaded 1199 bytes. 05:31:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:31:54 INFO - Using the following test package requirements: 05:31:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:31:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:31:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'jsshell-mac.zip'], 05:31:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:31:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:31:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:31:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:31:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:31:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:31:55 INFO - Http code: 200 05:31:55 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 05:31:55 INFO - x-amz-cf-id: xxWe_AR-R9ptzfHgF7PWbFA1BcoSWcwVvK4BxOruZlqfW_TY31D7BA== 05:31:55 INFO - x-amz-version-id: dPqUYccmk9TkqckgTYVZ46ZIrXdr1NTU 05:31:55 INFO - Expected file size: 16508662 05:31:55 INFO - Obtained file size: 16508662 05:32:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:32:02 INFO - Http code: 200 05:32:02 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 05:32:02 INFO - x-amz-cf-id: NBHPeUttpSnS5YsvQBK5QelHA0J3hQE1wIuXsWRXv43DJFsNmz4Dag== 05:32:02 INFO - x-amz-version-id: dPqUYccmk9TkqckgTYVZ46ZIrXdr1NTU 05:32:03 INFO - Expected file size: 16508662 05:32:03 INFO - Obtained file size: 16508662 05:32:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:32:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:09 INFO - Fetch https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:32:10 INFO - Http code: 200 05:32:10 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 05:32:10 INFO - x-amz-cf-id: jDttNddJD1gWXH-JYulzUKsdhNRpC6y-3swMLhdWwt4AL-z65MeZOA== 05:32:10 INFO - x-amz-version-id: lzqvBS932gvp9foLWZ1WiIdSAN1yFZwI 05:32:10 INFO - Expected file size: 14409006 05:32:10 INFO - Obtained file size: 14409006 05:32:11 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')]} 05:32:11 INFO - trying https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:32:13 INFO - Downloaded 111886471 bytes. 05:32:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:13 INFO - mkdir: /builds/slave/test/properties 05:32:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:13 INFO - Contents: 05:32:13 INFO - build_url:https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:14 INFO - Running post-action listener: _resource_record_post_action 05:32:14 INFO - Running post-action listener: set_extra_try_arguments 05:32:14 INFO - [mozharness: 2016-10-11 12:32:14.591448Z] Finished download-and-extract step (success) 05:32:14 INFO - [mozharness: 2016-10-11 12:32:14.591605Z] Running populate-webroot step. 05:32:14 INFO - Running pre-action listener: _resource_record_pre_action 05:32:14 INFO - Running main action method: populate_webroot 05:32:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:14 INFO - '--tppagecycles', 05:32:14 INFO - '7'], 05:32:14 INFO - 'tests': ['tsvgm']}}, 05:32:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['damp', 'tps']}, 05:32:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'tests': ['damp', 'tps']}, 05:32:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['dromaeo_dom']}, 05:32:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['basic_compositor_video']}, 05:32:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['a11yr', 05:32:14 INFO - 'ts_paint', 05:32:14 INFO - 'tpaint', 05:32:14 INFO - 'sessionrestore', 05:32:14 INFO - 'sessionrestore_no_auto_restore', 05:32:14 INFO - 'tabpaint']}, 05:32:14 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:14 INFO - 'ts_paint', 05:32:14 INFO - 'tpaint', 05:32:14 INFO - 'sessionrestore', 05:32:14 INFO - 'sessionrestore_no_auto_restore', 05:32:14 INFO - 'tabpaint']}, 05:32:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:14 INFO - 'ts_paint', 05:32:14 INFO - 'tpaint', 05:32:14 INFO - 'sessionrestore', 05:32:14 INFO - 'sessionrestore_no_auto_restore', 05:32:14 INFO - 'tabpaint']}, 05:32:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:14 INFO - 'ts_paint', 05:32:14 INFO - 'tpaint', 05:32:14 INFO - 'sessionrestore', 05:32:14 INFO - 'sessionrestore_no_auto_restore', 05:32:14 INFO - 'tabpaint']}, 05:32:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['a11yr', 05:32:14 INFO - 'ts_paint', 05:32:14 INFO - 'tpaint', 05:32:14 INFO - 'sessionrestore', 05:32:14 INFO - 'sessionrestore_no_auto_restore', 05:32:14 INFO - 'tabpaint']}, 05:32:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['a11yr', 05:32:14 INFO - 'ts_paint', 05:32:14 INFO - 'tpaint', 05:32:14 INFO - 'sessionrestore', 05:32:14 INFO - 'sessionrestore_no_auto_restore', 05:32:14 INFO - 'tabpaint']}, 05:32:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['tsvgx', 05:32:14 INFO - 'tsvgr_opacity', 05:32:14 INFO - 'tart', 05:32:14 INFO - 'tscrollx', 05:32:14 INFO - 'cart']}, 05:32:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:14 INFO - 'tsvgr_opacity', 05:32:14 INFO - 'tart', 05:32:14 INFO - 'tscrollx', 05:32:14 INFO - 'cart']}, 05:32:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'talos_options': ['--disable-e10s'], 05:32:14 INFO - 'tests': ['tp5o']}, 05:32:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'tests': ['tp5o']}, 05:32:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'talos_options': ['--disable-e10s', 05:32:14 INFO - '--xperf_path', 05:32:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:14 INFO - 'tests': ['tp5n']}, 05:32:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:14 INFO - 'talos_options': ['--xperf_path', 05:32:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:14 INFO - 'tests': ['tp5n']}}, 05:32:14 INFO - 'talos.zip': {'path': '', 05:32:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:14 INFO - Running post-action listener: _resource_record_post_action 05:32:14 INFO - [mozharness: 2016-10-11 12:32:14.610395Z] Finished populate-webroot step (success) 05:32:14 INFO - [mozharness: 2016-10-11 12:32:14.610523Z] Running create-virtualenv step. 05:32:14 INFO - Running pre-action listener: _resource_record_pre_action 05:32:14 INFO - Running main action method: create_virtualenv 05:32:14 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:14 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 05:32:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:14 INFO - Using real prefix '/tools/python27' 05:32:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:15 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:18 INFO - Installing pip.................done. 05:32:18 INFO - Return code: 0 05:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:18 INFO - Reading from file tmpfile_stdout 05:32:18 INFO - Output received: 05:32:18 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) 05:32:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:18 INFO - 'HOME': '/Users/cltbld', 05:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:18 INFO - 'LOGNAME': 'cltbld', 05:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:18 INFO - 'MOZ_NO_REMOTE': '1', 05:32:18 INFO - 'NO_EM_RESTART': '1', 05:32:18 INFO - 'PAGER': '/bin/cat', 05:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:18 INFO - 'PWD': '/builds/slave/test', 05:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:18 INFO - 'SHELL': '/bin/bash', 05:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:18 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:18 INFO - 'USER': 'cltbld', 05:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:18 INFO - 'XPC_FLAGS': '0x0', 05:32:18 INFO - 'XPC_SERVICE_NAME': '0', 05:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:18 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 05:32:18 INFO - Cleaning up... 05:32:18 INFO - Return code: 0 05:32:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:18 INFO - 'HOME': '/Users/cltbld', 05:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:18 INFO - 'LOGNAME': 'cltbld', 05:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:18 INFO - 'MOZ_NO_REMOTE': '1', 05:32:18 INFO - 'NO_EM_RESTART': '1', 05:32:18 INFO - 'PAGER': '/bin/cat', 05:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:18 INFO - 'PWD': '/builds/slave/test', 05:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:18 INFO - 'SHELL': '/bin/bash', 05:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:18 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:18 INFO - 'USER': 'cltbld', 05:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:18 INFO - 'XPC_FLAGS': '0x0', 05:32:18 INFO - 'XPC_SERVICE_NAME': '0', 05:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 INFO - Downloading/unpacking psutil>=3.1.1 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:23 INFO - Installing collected packages: psutil 05:32:23 INFO - Running setup.py install for psutil 05:32:23 INFO - building 'psutil._psutil_osx' extension 05:32:23 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 05:32:23 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 05:32:23 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 05:32:23 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 05:32:23 INFO - building 'psutil._psutil_posix' extension 05:32:23 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 05:32:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:23 INFO - ^ 05:32:23 INFO - 1 warning generated. 05:32:23 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 05:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:23 INFO - Successfully installed psutil 05:32:23 INFO - Cleaning up... 05:32:23 INFO - Return code: 0 05:32:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:23 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')]} 05:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:23 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')]} 05:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:23 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 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:23 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 05:32:23 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 05:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:23 INFO - 'HOME': '/Users/cltbld', 05:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:23 INFO - 'LOGNAME': 'cltbld', 05:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:23 INFO - 'MOZ_NO_REMOTE': '1', 05:32:23 INFO - 'NO_EM_RESTART': '1', 05:32:23 INFO - 'PAGER': '/bin/cat', 05:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:23 INFO - 'PWD': '/builds/slave/test', 05:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:23 INFO - 'SHELL': '/bin/bash', 05:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:23 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:23 INFO - 'USER': 'cltbld', 05:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:23 INFO - 'XPC_FLAGS': '0x0', 05:32:23 INFO - 'XPC_SERVICE_NAME': '0', 05:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:26 INFO - Installing collected packages: mozsystemmonitor 05:32:26 INFO - Running setup.py install for mozsystemmonitor 05:32:26 INFO - Successfully installed mozsystemmonitor 05:32:26 INFO - Cleaning up... 05:32:26 INFO - Return code: 0 05:32:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:26 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 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:26 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 05:32:26 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 05:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:26 INFO - 'HOME': '/Users/cltbld', 05:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:26 INFO - 'LOGNAME': 'cltbld', 05:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:26 INFO - 'MOZ_NO_REMOTE': '1', 05:32:26 INFO - 'NO_EM_RESTART': '1', 05:32:26 INFO - 'PAGER': '/bin/cat', 05:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:26 INFO - 'PWD': '/builds/slave/test', 05:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:26 INFO - 'SHELL': '/bin/bash', 05:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:26 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:26 INFO - 'USER': 'cltbld', 05:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:26 INFO - 'XPC_FLAGS': '0x0', 05:32:26 INFO - 'XPC_SERVICE_NAME': '0', 05:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:29 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 05:32:29 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 05:32:29 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 05:32:29 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 05:32:29 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 05:32:29 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 05:32:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:30 INFO - warning: no files found matching '*.txt' 05:32:30 INFO - no previously-included directories found matching 'build' 05:32:30 INFO - no previously-included directories found matching 'dist' 05:32:30 INFO - no previously-included directories found matching '.git*' 05:32:30 INFO - Installing collected packages: jsonschema, functools32 05:32:30 INFO - Running setup.py install for functools32 05:32:30 INFO - warning: no files found matching '*.txt' 05:32:30 INFO - no previously-included directories found matching 'build' 05:32:30 INFO - no previously-included directories found matching 'dist' 05:32:30 INFO - no previously-included directories found matching '.git*' 05:32:30 INFO - Successfully installed jsonschema functools32 05:32:30 INFO - Cleaning up... 05:32:30 INFO - Return code: 0 05:32:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:30 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 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:30 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 05:32:30 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 05:32:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:30 INFO - 'HOME': '/Users/cltbld', 05:32:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:30 INFO - 'LOGNAME': 'cltbld', 05:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:30 INFO - 'MOZ_NO_REMOTE': '1', 05:32:30 INFO - 'NO_EM_RESTART': '1', 05:32:30 INFO - 'PAGER': '/bin/cat', 05:32:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:30 INFO - 'PWD': '/builds/slave/test', 05:32:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:30 INFO - 'SHELL': '/bin/bash', 05:32:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:30 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:30 INFO - 'USER': 'cltbld', 05:32:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:30 INFO - 'XPC_FLAGS': '0x0', 05:32:30 INFO - 'XPC_SERVICE_NAME': '0', 05:32:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:30 INFO - Cleaning up... 05:32:30 INFO - Return code: 0 05:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:30 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 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:30 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 05:32:30 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 05:32:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:30 INFO - 'HOME': '/Users/cltbld', 05:32:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:30 INFO - 'LOGNAME': 'cltbld', 05:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:30 INFO - 'MOZ_NO_REMOTE': '1', 05:32:30 INFO - 'NO_EM_RESTART': '1', 05:32:30 INFO - 'PAGER': '/bin/cat', 05:32:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:30 INFO - 'PWD': '/builds/slave/test', 05:32:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:30 INFO - 'SHELL': '/bin/bash', 05:32:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:30 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:30 INFO - 'USER': 'cltbld', 05:32:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:30 INFO - 'XPC_FLAGS': '0x0', 05:32:30 INFO - 'XPC_SERVICE_NAME': '0', 05:32:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:30 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 05:32:30 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 05:32:30 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 05:32:30 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 05:32:30 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 05:32:30 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 05:32:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:34 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 05:32:34 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 05:32:34 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 05:32:34 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 05:32:34 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 05:32:34 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 05:32:34 INFO - Downloading docopt-0.6.1.tar.gz 05:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:34 INFO - Running setup.py install for blobuploader 05:32:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:34 INFO - Running setup.py install for requests 05:32:35 INFO - Running setup.py install for docopt 05:32:35 INFO - Successfully installed blobuploader requests docopt 05:32:35 INFO - Cleaning up... 05:32:35 INFO - Return code: 0 05:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:35 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')]} 05:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:35 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')]} 05:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:35 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 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:35 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 05:32:35 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 05:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:35 INFO - 'HOME': '/Users/cltbld', 05:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:35 INFO - 'LOGNAME': 'cltbld', 05:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:35 INFO - 'MOZ_NO_REMOTE': '1', 05:32:35 INFO - 'NO_EM_RESTART': '1', 05:32:35 INFO - 'PAGER': '/bin/cat', 05:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:35 INFO - 'PWD': '/builds/slave/test', 05:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:35 INFO - 'SHELL': '/bin/bash', 05:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:35 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:35 INFO - 'USER': 'cltbld', 05:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:35 INFO - 'XPC_FLAGS': '0x0', 05:32:35 INFO - 'XPC_SERVICE_NAME': '0', 05:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:35 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-2PqoAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CbYKbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-tJhLzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-5B2hX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-oqFU8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-lRaJcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-O_UQ7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-A6xT0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MYZ7AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WLYwAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:36 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZrmVRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:37 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-0q_XLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:37 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Pt1Q8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:37 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-J4Wo1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:37 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-sMfryH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:37 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-QnEHwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:37 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-FD0btG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:37 INFO - Running setup.py install for manifestparser 05:32:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:37 INFO - Running setup.py install for mozcrash 05:32:37 INFO - Running setup.py install for mozdebug 05:32:38 INFO - Running setup.py install for mozdevice 05:32:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Running setup.py install for mozfile 05:32:38 INFO - Running setup.py install for mozhttpd 05:32:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Running setup.py install for mozinfo 05:32:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Running setup.py install for mozInstall 05:32:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Running setup.py install for mozleak 05:32:39 INFO - Running setup.py install for mozlog 05:32:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for moznetwork 05:32:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozprocess 05:32:39 INFO - Running setup.py install for mozprofile 05:32:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozrunner 05:32:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozscreenshot 05:32:39 INFO - Running setup.py install for moztest 05:32:40 INFO - Running setup.py install for mozversion 05:32:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:40 INFO - Cleaning up... 05:32:40 INFO - Return code: 0 05:32:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:40 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 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:40 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 05:32:40 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 05:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:40 INFO - 'HOME': '/Users/cltbld', 05:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:40 INFO - 'LOGNAME': 'cltbld', 05:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:40 INFO - 'MOZ_NO_REMOTE': '1', 05:32:40 INFO - 'NO_EM_RESTART': '1', 05:32:40 INFO - 'PAGER': '/bin/cat', 05:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:40 INFO - 'PWD': '/builds/slave/test', 05:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:40 INFO - 'SHELL': '/bin/bash', 05:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:40 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:40 INFO - 'USER': 'cltbld', 05:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:40 INFO - 'XPC_FLAGS': '0x0', 05:32:40 INFO - 'XPC_SERVICE_NAME': '0', 05:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:40 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WJGZrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:40 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)) 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:40 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-asrYIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:40 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-GMLvMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:40 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)) 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:40 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-b9dCJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-l8WVRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fYsmzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-OhLHiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-QCKM5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-LAjGe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-NH2mGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-G5Q3in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ACGv0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-0Nn8Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:41 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fCJaM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:42 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-IzOywn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:42 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gBRTth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:42 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-qE_7dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:42 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)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:44 INFO - Downloading blessings-1.6.tar.gz 05:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:44 INFO - Installing collected packages: blessings 05:32:44 INFO - Running setup.py install for blessings 05:32:45 INFO - Successfully installed blessings 05:32:45 INFO - Cleaning up... 05:32:45 INFO - Return code: 0 05:32:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:45 INFO - Reading from file tmpfile_stdout 05:32:45 INFO - Current package versions: 05:32:45 INFO - blessings == 1.6 05:32:45 INFO - blobuploader == 1.2.4 05:32:45 INFO - docopt == 0.6.1 05:32:45 INFO - functools32 == 3.2.3-2 05:32:45 INFO - jsonschema == 2.5.1 05:32:45 INFO - manifestparser == 1.1 05:32:45 INFO - mozInstall == 1.12 05:32:45 INFO - mozcrash == 0.17 05:32:45 INFO - mozdebug == 0.1 05:32:45 INFO - mozdevice == 0.48 05:32:45 INFO - mozfile == 1.2 05:32:45 INFO - mozhttpd == 0.7 05:32:45 INFO - mozinfo == 0.9 05:32:45 INFO - mozleak == 0.1 05:32:45 INFO - mozlog == 3.4 05:32:45 INFO - moznetwork == 0.27 05:32:45 INFO - mozprocess == 0.23 05:32:45 INFO - mozprofile == 0.28 05:32:45 INFO - mozrunner == 6.12 05:32:45 INFO - mozscreenshot == 0.1 05:32:45 INFO - mozsystemmonitor == 0.3 05:32:45 INFO - moztest == 0.7 05:32:45 INFO - mozversion == 1.4 05:32:45 INFO - psutil == 3.1.1 05:32:45 INFO - requests == 1.2.3 05:32:45 INFO - wsgiref == 0.1.2 05:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:45 INFO - 'HOME': '/Users/cltbld', 05:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:45 INFO - 'LOGNAME': 'cltbld', 05:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:45 INFO - 'MOZ_NO_REMOTE': '1', 05:32:45 INFO - 'NO_EM_RESTART': '1', 05:32:45 INFO - 'PAGER': '/bin/cat', 05:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:45 INFO - 'PWD': '/builds/slave/test', 05:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:45 INFO - 'SHELL': '/bin/bash', 05:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:45 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:45 INFO - 'USER': 'cltbld', 05:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:45 INFO - 'XPC_FLAGS': '0x0', 05:32:45 INFO - 'XPC_SERVICE_NAME': '0', 05:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:45 INFO - Cleaning up... 05:32:45 INFO - Return code: 0 05:32:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10510f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105085570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e05abbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, '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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 05:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:45 INFO - 'HOME': '/Users/cltbld', 05:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:45 INFO - 'LOGNAME': 'cltbld', 05:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:45 INFO - 'MOZ_NO_REMOTE': '1', 05:32:45 INFO - 'NO_EM_RESTART': '1', 05:32:45 INFO - 'PAGER': '/bin/cat', 05:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:45 INFO - 'PWD': '/builds/slave/test', 05:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:45 INFO - 'SHELL': '/bin/bash', 05:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:32:45 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:45 INFO - 'USER': 'cltbld', 05:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:45 INFO - 'XPC_FLAGS': '0x0', 05:32:45 INFO - 'XPC_SERVICE_NAME': '0', 05:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:46 INFO - Cleaning up... 05:32:46 INFO - Return code: 0 05:32:46 INFO - Running post-action listener: _resource_record_post_action 05:32:46 INFO - Running post-action listener: _start_resource_monitoring 05:32:46 INFO - Starting resource monitoring. 05:32:46 INFO - [mozharness: 2016-10-11 12:32:46.150793Z] Finished create-virtualenv step (success) 05:32:46 INFO - [mozharness: 2016-10-11 12:32:46.151871Z] Running install step. 05:32:46 INFO - Running pre-action listener: _resource_record_pre_action 05:32:46 INFO - Running main action method: install 05:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:46 INFO - Reading from file tmpfile_stdout 05:32:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:46 INFO - Reading from file tmpfile_stdout 05:32:46 INFO - Output received: 05:32:46 INFO - Usage: mozinstall [options] installer 05:32:46 INFO - Options: 05:32:46 INFO - -h, --help show this help message and exit 05:32:46 INFO - -d DEST, --destination=DEST 05:32:46 INFO - Directory to install application into. [default: 05:32:46 INFO - "/builds/slave/test"] 05:32:46 INFO - --app=APP Application being installed. [default: firefox] 05:32:46 INFO - mkdir: /builds/slave/test/build/application 05:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:33:21 INFO - Reading from file tmpfile_stdout 05:33:21 INFO - Output received: 05:33:21 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:21 INFO - Running post-action listener: _resource_record_post_action 05:33:21 INFO - [mozharness: 2016-10-11 12:33:21.495253Z] Finished install step (success) 05:33:21 INFO - [mozharness: 2016-10-11 12:33:21.495389Z] Running run-tests step. 05:33:21 INFO - Running pre-action listener: _resource_record_pre_action 05:33:21 INFO - Running main action method: run_tests 05:33:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:21 INFO - 2016-10-11 05:33:21.510 screenresolution[1989:11911] starting screenresolution argv=screenresolution get 05:33:21 INFO - 2016-10-11 05:33:21.512 screenresolution[1989:11911] Display 0: 1600x1200x32@60 05:33:21 INFO - 2016-10-11 05:33:21.519 screenresolution[1990:11913] starting screenresolution argv=screenresolution list 05:33:21 INFO - Available Modes on Display 0 05:33:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:21 INFO - Intel Iris: 05:33:21 INFO - Chipset Model: Intel Iris 05:33:21 INFO - Type: GPU 05:33:21 INFO - Bus: Built-In 05:33:21 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:21 INFO - Vendor: Intel (0x8086) 05:33:21 INFO - Device ID: 0x0a2e 05:33:21 INFO - Revision ID: 0x0009 05:33:21 INFO - Displays: 05:33:21 INFO - Display: 05:33:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:21 INFO - Display Serial Number: 1600x1200 60 05:33:21 INFO - Main Display: Yes 05:33:21 INFO - Mirror: Off 05:33:21 INFO - Online: Yes 05:33:21 INFO - Rotation: Supported 05:33:21 INFO - Return code: 0 05:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:21 INFO - Python 2.7.3 05:33:21 INFO - Return code: 0 05:33:21 INFO - grabbing minidump binary from tooltool 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 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 0x104f23d30>, '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 0x104d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:21 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 05:33:21 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 05:33:21 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 05:33:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:21 INFO - Return code: 0 05:33:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 05:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 05:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pbKIhbq8sW/Render', 05:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:21 INFO - 'HOME': '/Users/cltbld', 05:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:21 INFO - 'LOGNAME': 'cltbld', 05:33:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:21 INFO - 'MOZ_NO_REMOTE': '1', 05:33:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:21 INFO - 'NO_EM_RESTART': '1', 05:33:21 INFO - 'PAGER': '/bin/cat', 05:33:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:21 INFO - 'PWD': '/builds/slave/test', 05:33:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:21 INFO - 'SHELL': '/bin/bash', 05:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7LmGXC28ZG/Listeners', 05:33:21 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 05:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:21 INFO - 'USER': 'cltbld', 05:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:21 INFO - 'XPC_FLAGS': '0x0', 05:33:21 INFO - 'XPC_SERVICE_NAME': '0', 05:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 05:33:22 INFO - mozversion application_buildid: 20161011030212 05:33:22 INFO - mozversion application_changeset: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb 05:33:22 INFO - mozversion application_display_name: Nightly 05:33:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:22 INFO - mozversion application_name: Firefox 05:33:22 INFO - mozversion application_remotingname: firefox 05:33:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:22 INFO - mozversion application_vendor: Mozilla 05:33:22 INFO - mozversion application_version: 52.0a1 05:33:22 INFO - mozversion platform_buildid: 20161011030212 05:33:22 INFO - mozversion platform_changeset: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb 05:33:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:22 INFO - mozversion platform_version: 52.0a1 05:33:22 INFO - using testdate: 1476189202 05:33:22 INFO - actual date: 1476189202 05:33:22 INFO - starting webserver on 'localhost:49395' 05:33:22 INFO - SUITE-START | Running 2 tests 05:33:22 INFO - TEST-START | dromaeo_css 05:33:22 INFO - operating with platform_type : mac_ 05:33:22 INFO - Initialising browser for dromaeo_css test... 05:33:22 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp82zM5P/profile http://localhost:49395/getInfo.html) 05:33:24 INFO - PROCESS | 2000 | 2016-10-11 05:33:24.916 plugin-container[2003:12072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 05:33:24 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:24 INFO - PROCESS | 2000 | 2016-10-11 05:33:24.916 plugin-container[2003:12072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e1b, name = 'com.apple.CFPasteboardClient' 05:33:24 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:24 INFO - PROCESS | 2000 | 2016-10-11 05:33:24.916 plugin-container[2003:12072] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:24 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 05:33:24 INFO - PROCESS | 2000 | colorDepth:24 05:33:24 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 05:33:24 INFO - PROCESS | 2000 | __metrics 05:33:25 ERROR - PROCESS | 2000 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 05:33:25 INFO - TEST-INFO | 2000: exit 0 05:33:25 INFO - Browser initialized. 05:33:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:25 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp82zM5P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:28 INFO - PROCESS | 2004 | 2016-10-11 05:33:28.111 plugin-container[2005:12191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 05:33:28 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:28 INFO - PROCESS | 2004 | 2016-10-11 05:33:28.111 plugin-container[2005:12191] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 05:33:28 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:28 INFO - PROCESS | 2004 | 2016-10-11 05:33:28.111 plugin-container[2005:12191] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:37 INFO - PROCESS | 2004 | RSS: Main: 238764032 05:33:37 INFO - PROCESS | 2004 | 05:34:27 INFO - PROCESS | 2004 | 1476189267331 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:39 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49395/tests/dromaeo/cssquery-ext.html) 05:36:41 INFO - PROCESS | 2004 | RSS: Main: 253845504 05:36:41 INFO - PROCESS | 2004 | 05:39:43 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-ext.html (next: http://localhost:49395/tests/dromaeo/cssquery-jquery.html) 05:39:44 INFO - PROCESS | 2004 | RSS: Main: 265351168 05:39:44 INFO - PROCESS | 2004 | 05:42:46 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49395/tests/dromaeo/cssquery-mootools.html) 05:42:46 INFO - PROCESS | 2004 | RSS: Main: 268484608 05:42:46 INFO - PROCESS | 2004 | 05:45:48 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49395/tests/dromaeo/cssquery-prototype.html) 05:45:49 INFO - PROCESS | 2004 | RSS: Main: 268042240 05:45:49 INFO - PROCESS | 2004 | 05:48:52 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49395/tests/dromaeo/cssquery-yui.html) 05:48:52 INFO - PROCESS | 2004 | RSS: Main: 273399808 05:48:52 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-yui.html (next: http://localhost:49395/tests/dromaeo/cssquery-dojo.html) 05:51:55 INFO - PROCESS | 2004 | RSS: Main: 277233664 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | __start_tp_report 05:51:55 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 05:51:55 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 05:51:55 INFO - PROCESS | 2004 | |i|pagename|runs| 05:51:55 INFO - PROCESS | 2004 | |0;dojo.html;2758.2001219646304;3113.859876305569;3237.692419220173;3280.557124788153;3302.9339413211737;5327.387350454689;5352.661834541364;5378.381486129097;5395.730213489324;5435.592330575213;5336.946630533694;5374.247605335257;5400.945990540094;5419.647722898018;5437.238786569884;4304.720193187432;4905.043516514281;4920.434150072742;5040.798368065273;5051.595872330205;4950.306957026001;5031.22016087507;5078.1874900016;5089.134847076006;5117.360329958755;3713.4615480755274;5065.012322597095;5067.391912970449;5080.288759573663;5192;5029.698218106925;5039.118154322979;5048.899022019539;5053.9494605054215;5072.34059572257;4967.627427942883;4970.82602108928;4973.204287314049;4983.302337672729;4994.35073440454;5157.381114266312;5230.293910322096;5310.20346947957;5397;5465.9726701366635;5616.297962754656;5780.988327042793;5802.071668533056;5803.187553742479;5858.76564937402;5702.2301989231755;5792.131180322943;5839.7664093436215;5919.49684276837;5936.990711579042;5516.089845175581;5524.889502209973;5526.088195447706;5559.9444005559835;5579.832605021856;6083.939160608337;6100.298465676504;6105.633661980295;6106.053561697944;6125.448709616156;5582.218489411485;5639.943600564024;5705.914411283834;5749.712514374348;5765.3369862465515;5773.134029895466;5808.419158084158;5835.037218858925;5847.210626565445;5986.790462333797;5804.651720896675;5836.795712150054;5838.620489668158;5842.269716285465;5868.207791948118;4665.650076244296;5737.540996720252;5841.503472204825;5855.355910849803;5879;4687.343771871872;4695.577398034194;4702.36518070063;4717.056588682209;4720.504347043511;3539.486774417695;4198.1393814268;4243.957560424418;4244.830206791756;4289.335153051282;5358.062339090644;5407.378151512627;5409.43200963901;5485.040117979338;5523.226748255248;5841.532677385799;5974.4324289192455;5985.521158307412;5991.700414979234;5994.700264986734;5509.228707980886;5529.142982837667;5534.501894829485;5536.944630553643;5541.778328866801;5001.72490513018;5045;5077.898442031139;5137.946720922202;5140.897182056338;6209.906851397323;6215;6227.813165605039;6234.750609975641;6238.719257633417;5911.467967882912;5931.288245410578;5962.2249107615735;5964.8807023860145;5972.940270597239;5984.16221728967;6052.757889684363;6139.84650383744;6201;6267.874642507216;5762.510186634016;5838.591298609226;5852.7658893643775;5858.765649373977;5900.43945825146;4550.7712917512745;4967.776450059829;5100.566451851486;5602.383737788921;5968.104784282219;4176.2691528981695;4280.822773737247;4972.0801651694555;5619.522340600931;5734.856628584319;4621.3530105785885;4731.763411829464;5683.147527870852;5685.260916081049;5781.190633311256;4608.700434471749;5573.6098473106495;5603.187537807076;5606.187102870143;5611.607187496836;5580.665160090408;5673.234113394639;5681.829545113653;5708.857278568069;5796;5471.945280547303;5483.533899618577;5538.113901775697;5588.105903055654;5647.943520564741 05:51:55 INFO - PROCESS | 2004 | |1;ext.html;483.7315290014043;487.22044728434497;489.6278828090652;517.7204309672777;536.2894165231068;39503.80248098759;41372.793136034314;41440.17119657609;42694.7865260674;43538.911527211836;36585.63414365862;43294.35058474117;43337.34993975093;43340;43403.914902127464;9724.076212759794;9841;9861.852072218922;9883.604655813759;9907.157891579225;9647.372920760163;9662.903370966305;9746.853797193047;9777.804443911118;9796.755081122994;9760.707178784647;9816.656417025406;9819.70540883771;9845.40927544346;9873.160781333596;9724.270679699015;9743.95128024359;9768.755781105458;9778.266630002778;9814.803703925918;9631.90368096317;9707.805843883083;9714.22286217101;9741.659041933499;9745.951270243604;39946.800265998776;40116.59591914269;40284.99287517835;40385.59614403848;40396.596034039576;3199.9520007199912;3273.9017829465156;3418.6923176913947;3451.8446669899663;3665.5784584772828;30715.9249426269;31072.37855242905;31443.213919651964;31888.521672174935;32355.838220808746;3208.5187221916667;3253.9349213015844;3259.7555183361105;3343.8160901150427;3355.7147642450423;491046;499991;505253;505836;509302;61117;61384;61499.38500615026;61616.075758863655;61707.074393884126;62536.687316563126;63884;64459.355406445335;64596.677016614616;64836.67581662061;15330;15586.376544938303;15598.688026239412;15604.68790624204;15609.765853512206;11807.701152873176;11867.347295898808;11875.524979000917;11901.940490297493;11902.761944761056;15556.533304000897;16354.754678679828;16908.661826763397;17979.650247713085;18932.526686832665;6028.8794224116145;6117.36953110158;6393;6849.04113424121;7649.6557654904545;812.3095368936475;884.8628462588309;937.329809186435;969.7672558585889;1051.784384201237;23177.88411057934;23591.29226123219;24783.752162478144;27912.463634818487;30298.69701303003;1007.2445665750687;1078.654830454247;1085.9791795712006;1105.8009558279587;1121.8709848367541;14920.317729929473;15498.767518487231;15548.455804046804;15608.765868511982;15699.921500392426;658307;661536;666451.6677416582;667149;669260;55707;56036.71981640147;56682.43317566854;56696.43303566911;56850.71574642183;1194.970125746846;1292.9612111636666;1299.259422129377;1370.3490841850041;1371.1430356027483;26357.868210658824;26845.328866778487;29524.704752953054;29672.851635741685;30057.491376293732;48951;49195.016099677094;49255;49283.01433971372;49318.013639727724;575078;575821;579027;579400;580519;25900.35249118787;25984.74015259823;26107.73892261053;26347.473050539265;26373.34066648349;45581.54418455773;45941.54058459373;46431.76784116193;46531.06937861291;46896.53103469058;29886.252843678212;31459.84270078635;37685.05787355338;38731.207108572875;40838.79580602078;33031.50452743259;33779.66220337765;36515.63484365229;39015.80492097521;39198.0965721406;37879.81060094682;37963.810180948916;38267.23465530729;38363.23273534458;38590.614093858705;25863;25999.870000649877;30292;32321;32762.0342779434;25275.620865687397;25334.74665253324;25356.366090847878;25417.424081072004;25698.61452078183 05:51:55 INFO - PROCESS | 2004 | |2;jquery.html;367.68195510883083;368.0632789550595;373.42865415913656;376.91330993871424;393.13118009199667;14901.478448254313;20316.492087697814;20521.281755138574;20883.269085582007;21105.788942110576;20063.799362006375;20246.69629955552;20451.386458406236;20558.89720551399;20756.584868302623;4833.9516604834025;5791.681457519845;5914.418366240493;6035.5473339499495;6098.786542471014;5913.7338819752995;6033.758649654031;6049.455549000589;6057.606255593372;6058.818235452944;5687.459691329317;5879.294484661847;5914.940850591482;5921.73352199152;5971.37300583439;5840.795572154954;5915.645061296336;5927.496162826165;5955.672438015908;5961.612495187821;5061.013102445025;5113.795448182068;5115.028144652504;5141.794328226866;5150.124478838607;24879;25350.746492535207;25394.492110157695;25745.098921537843;25847.353816154748;2283.9771602284095;2420.580879986127;2462.273629279367;2509.736477669837;3034.2262723005715;14996;15830.604234894105;15982;16033.35866565336;16278.186090695537;1839.4113883557268;1848.4454663600866;1985.7418535590425;2009.6483115454737;2022.2315520102413;97257;119647.4017629915;122501.16248256373;124134.37932810368;124418;11283.943580282046;11518.769624607461;11541.518573506568;11565.653030409101;11737.35444550558;14319.997600167888;14358.928205359116;14362.353694083582;14369.78445323321;14379.78430323546;6703.530752847254;7814.3748500119855;7869.685212591432;8021.478603890729;8126.55303958288;7813.726519571787;7923.603819808986;7948.602569871599;8081.313088387553;8103;4476.306172543196;4499.842505512292;4500.572445617661;4537.909241815145;4599;1464.406915199346;1612.540425978614;1862.050354319307;1872.5225067607946;1902.73361729358;856.5160684213399;861.6381119929645;869.6912596028445;895.632790555869;926.6247169896203;16306.53241208297;20047.599048018958;21776.128954841628;21824.672629910565;21913.890430547744;760.5626764610371;797.2983774278714;858.6522458404356;873.921347078766;892.6027917576616;5884.852878678067;8606.612702428405;10763.677089687322;11066.667999960015;11349.865013498584;428724;440725;530577;534054;592194;130720;132942.3352883249;133387.66612333947;135586;135829.3208533951;926.4858003807817;951.5480146930291;960.596549449233;961.8220629183623;967.6322997261136;15198.620034499227;18467.81532184661;19565.80434195697;19608.215671372986;19974.400767976986;43877.78061109674;55722;56966.14550781659;57463.85072298614;58371.70814145902;80940;82230.58884705538;82695.346093079;84073;84078.15921840703;6809.127489940306;7174.964125179341;7243.674034668347;7250.528715633467;7392.8891066635115;9376.624935002523;11507.309561426342;12758.298293593942;13024.153430027018;13086.738265234833;10744.623938162127;11132.721681958015;11144.88855111471;11187.664370068911;11365.374904380338;5527.917081243704;10843.024127828534;10893.074088702231;11083.889161108607;11131.387773672202;11330.546778128783;11392.94303528477;11412.201145919706;11513.30920144794;11547.13396495283;7007.894881576678;7185.461090418135;7384.852302954018;7408.370288525536;7410.592417417094;8950.418222815497;9949.651762188289;11050.06074483678;11294.491747871201;11402.885971140182 05:51:55 INFO - PROCESS | 2004 | |3;mootools.html;1416.815813944187;1461.7355987071182;1676.346224972261;1847.0764617691154;1916.3484415298797;6748.662566871655;7913.406494512906;8164.714235001776;8253;8888.06675299094;8380.49717016978;8687.348448866345;8705.390622656401;8823.911760882405;8858.77853053674;2273.545290941814;2328.906843726249;2330.3707998840305;2330.93007209784;2332.2769941318247;2308.4690521180137;2308.6421604651223;2327.650852372149;2338.9415264618438;2345.413646588353;2303.9078436862587;2310.8844557772127;2320.176337400224;2320.3155069254526;2326.3134227684877;2040.7959204079548;2265.1166045242367;2291.9656205156934;2301.4361481436986;2305.1931823861596;2310.8151347892126;2311.9653205201935;2314.2941402872116;2314.479242170515;2318.9188378406843;8761.56192190388;8795.384323097385;8880.822383552357;8905.109489051043;8916.554172291424;5161.664491808058;5304.893902121975;5347.0909945309395;5347.786088556453;5350.117230656937;3015.3667729776553;3347.7991320520846;3406.097384193191;3424.9143771405666;3516.4549494828343;1057.4924036462542;1063.8723353197665;1065.9093977011964;1069.6630561373142;1089.8256278995402;11496.137789665725;11546.249493782878;11655.650330490098;11666.883331166664;11680.591179308683;4531.886702832456;4570.611498022638;4758.191107511731;4762.404699412574;4766.809327626856;9872.173647875166;10005.099541041196;10020.949895250476;10020.949895250476;10037.949810251048;5284.788608455696;5285.577153827685;5302.946970530323;5304.602154838402;5318.787248510093;4320.65434765218;4482.910341793211;4650.372199753057;4790.8323208688225;4859.076775412731;3814.9809250953567;3847.2690188864026;3935.940960885589;3941.192055628589;3965.0285680008583;1225.2587184753274;1276.495784165268;1277.188984994535;1280.052760956885;1291.6189724031433;769.4652216709334;811.7118422959883;874.3966663002508;903.846346121161;922.3543519536352;5562.9443705563235;5903.704814759245;5987.670678112746;6003.879922401527;6103.42017508336;922.3681777982104;929.953502324881;930.5812384427035;935.462109287149;992.7369247149511;3959.425883246913;3968.206358728266;3969.563348031714;4059.431679564804;4073.0631954650003;10332.483375831178;10718.946405267923;10754.73113172177;10778.461076946121;10781.730456738644;10586.629467968583;10736.946315268373;10746.623868164577;10747.78504429907;10767.300125491818;6125.908111378333;7808.258215469521;8123.147069557729;8262.091169971298;8291;5717.42825717425;5803.767849285981;5889.263842019747;5895.616784908967;5917.881642367042;9942;9950.701478955643;9985.301028928196;10030.097291243823;10102.595896164072;7574.621268936641;8557.801907733046;9436.433813971184;9816.754581135528;10191.439470829175;5789.45000224978;6919.827004324932;6987.091678081817;7014.508984371045;7047.471439641945;8124;8199.508029518249;8218.589070546568;8234.90010047434;8246.505209687439;7311.268873112859;7471.290227428385;7477.40180785525;7510.136334321623;7590.468667193243;7341.375983041501;7358.264173582599;7379.631018449163;7521.473496855387;7556.8488630228185;6938.444924406136;7049.436045116481;7059.047028651066;7062.540934839219;7072.115985501812;4951.430585482715;4995.5004499551205;5077.289179514797;5130.769115389891;5150.97424512875;5042.14283571801;5042.294078828893;5152.536271735412;5165.372907534114;5237.764300606405 05:51:55 INFO - PROCESS | 2004 | |4;prototype.html;300.94131644329354;301.3926937221499;308.2955446804053;312.24125375337934;312.8357612253568;4390.868273951783;5099.974500127494;5292.550133238675;5303.390110137336;5412.296401467814;5095.464976177504;5259.579233661308;5261.552768014723;5286.3392075990505;5298.788048478066;4065.4918135233097;4078.3678529827926;4082.6937979651498;4095.303798354272;4097.754134751909;3727.5154229950067;4021.919561608766;4093.2779701498466;4102.138550904314;4107.753534787922;3991.560928297885;4015.8192881320265;4021.6581590564692;4026.255142798592;4050.129222217223;4018.1516502408926;4055.493063367094;4058.431819545266;4060.817263223162;4063.7199282226006;3500.5099286099967;3510.8946731598094;3512.016635342108;3520.929581408383;3521.841517131735;4870.634702397334;5160.587153027749;5166.328377310963;5193.662411943212;5220.504052115043;4521.84173553924;4578.381918441001;4597.195490789132;4599.885002874921;4610.694652673663;5124.641275110744;5284.124135931727;5562.443755624446;5605.327360716699;5620.213170156181;3334.333133373311;3689.538807649044;3772.4152756322815;3798.3542797724454;3815.351390263662;5324.387695415038;5334.959682861843;5355.651882627656;5926.8959519370865;5942.910856337202;3888.5333759948985;3888.922221555553;3899;3906.7265291429894;3914.5106861642294;3767.3972164453558;3810.142717888453;3881.2237552489614;3900.863469778544;3910.7485604606254;3420.521127042216;4552.565941728345;4559.338895860082;4563.726176429424;4570.423203994616;4661.741329840924;4664.603508701798;5621.213030175779;5682.119271512922;5723.484886360247;1253.7492501499555;1289.529321797556;1299.5191779041816;1321.187469706143;1329.4349901292105;834.4784509681449;849.7790574450687;869.5478351257311;876.5967654878827;893.4237416866085;5172.172452407597;5178.145605975047;5229.790808367698;5254.4220135785035;5294.047071527162;5203.479652034766;5392.56859451243;5657.632253903483;5666.46168613981;5680.630759000652;4092.8772136835346;5036.597072234213;5190.844274671766;5213.296205012351;5315.096433606296;2290.381596968809;2481.677381940336;2545.7836083932702;2546.8217224794084;2575.987120064388;4641.396618439649;4804.183288840835;4893.412790465096;5110.4634013428795;5119.10415677255;4021.055052062763;4520.389747384061;4571.702839315434;4836.46798852126;4847.891167342217;4729.456112547101;4836.7339796310835;4973.18478755259;5003.849884503544;5027.606365703135;4057.776822274685;4163;4329.956700432956;4507.3915021471685;4515.864524064284;3682.7053835693614;4069.4302797608952;4323;4831.492693267156;4834.3804825382485;4172.4993000840095;4736.621070314298;5021.924671129863;5073.797048118034;5077.796888124433;3251.69932027191;3374.71314938233;3397.9830100849335;3405.965940340664;3412.9658703413643;4036.6972477064924;4323.74057556535;4893.926591101065;4900.362952816111;5500.477454641803;5114.514121158484;5130.769115389891;5299.311089558333;5589.441055894378;5593.517717804866;4135.255653982312;4698.647601429838;5009.273655320031;5480.534154596904;5600.523955463831;4414.196984914538;5227.947720522746;5555.527780138734;5560.19377190297;5598.272224610774;4475.865724028285;4716.905661886812;4882.92675609859;5172.405173404956;5693.772249109989;4610.884727881696;5222.529972302511;5502.889942201214;5576.972115139561;5618.123494788583 05:51:55 INFO - PROCESS | 2004 | |5;yui.html;689.5793565924786;703.9014537964689;725.8366867454823;771.4252881603206;789.2738680414019;14336;15122;15165.696686066285;15167.469138580153;15204.467843625474;14362.353694083766;14481.493147739831;14482.85517144831;14511.274436278196;14518.491852785155;650.4731167754135;670.3665036540472;804.7062822069961;817.1215942861418;836.9832603347929;810.841885832263;820.9220124088232;843.3464065349342;846.4836449765638;847.1063028504925;735.3455424672046;763.7097902796929;798.4131663227523;861.1001503428901;890.8574628059512;778.3267473635321;781.9335356494648;839.7529668442359;890.6081324217356;894.0031864471133;631.4790298004119;633.9968300158516;634.3244444666461;656.0552803962279;657.2737125476327;14366.640833979129;14562.344694488773;14572.198529080897;14620.926895365561;14665.973381863274;14319.928400357932;14552.636184095481;14555;14568.562943111723;14652.633684157874;11716.179867409284;11923.582674606434;11927.821082683766;11957.94021029898;11969.401529923556;3279.770416070876;3736.630087512179;3784.6593806557544;3800.4869342638667;3835.463035175078;119734;120553.5750891212;120733;120792.18811717832;124844;11080.671224362959;11238.269512481662;11320;11361.204715669825;11693.415329233505;23128.959196836182;23334.64998025031;23381.7661823383;23403.765962340498;23426;7394.519356241827;7706.460547761603;7782.766517004499;7811.726589569452;7942.205779422012;4225.471816022997;4290.506591741927;4297.548757380492;4310.245707001325;4389.407429996973;3462.272922686214;3575.2491976685187;3603.837827297778;3606.441001644749;3620.0587847159927;669.4577392312243;673.3569441183657;675.864827034595;675.9222689390684;692.0760784352946;565.8245943757448;591.1635036423413;606.4966078155121;615.9106929495198;621.8973869311513;8417.452865563719;9100.317476189311;9103.635854565875;9111.726648200565;9186.356955013085;575.4389470266541;580.3847921203537;611.736953110167;617.5923890232425;624.7313655128247;4281.207976524353;4395.450568678915;4446.73319600825;4484.730916145042;4598.747068911175;104324;157420.42579574286;163271.1836440834;163274.18362908348;163397;143636;144458.83311750332;146298.2685086589;146922.53077469303;150814;62572.687136564935;71801.6409917947;83334;97376;100193.49903250583;9358.578863951003;9893.604255829687;9909.157721593745;10077.244206684381;10189.286749927434;62054.37945620486;62649;63850;64737.02894456681;65886;58752;68698.31301686919;91653.5417322909;92910;95781.08437831343;12841.871581284442;12927.482900683868;13013.609591712264;13124.343782811013;13426.39581218867;14618;14672.413103475741;14784.260786960394;14866.702665946837;15285;13460.192388456724;13590.450870166094;13784.448622055406;13870.861291386957;14248.501302454364;13229.140105893086;13430.731385372042;13614.455421783017;13660.385282662503;13685.726285474433;11409.429528523706;13385.464581416634;13476.326183690971;14058.507952221624;14084.295785210494;11168.66494005181;11329.150313726668;11450.141239407245;11461.713457163638;11910.583129590423;8023.879641805261;9823.21414286841;11498.195126341076;11551.90440627334;11693.239939403911 05:51:55 INFO - PROCESS | 2004 | __end_tp_report 05:51:55 INFO - PROCESS | 2004 | __start_cc_report 05:51:55 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,362 05:51:55 INFO - PROCESS | 2004 | __end_cc_report 05:51:55 INFO - PROCESS | 2004 | __startTimestamp1476190315560__endTimestamp 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | ------- Summary: start ------- 05:51:55 INFO - PROCESS | 2004 | Number of tests: 6 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | [#0] dojo.html Cycles:165 Average:5372.35 Median:5534.50 stddev:654.59 (11.8%) stddev-sans-first:623.65 05:51:55 INFO - PROCESS | 2004 | Values: 2758.2 3113.9 3237.7 3280.6 3302.9 5327.4 5352.7 5378.4 5395.7 5435.6 5336.9 5374.2 5400.9 5419.6 5437.2 4304.7 4905.0 4920.4 5040.8 5051.6 4950.3 5031.2 5078.2 5089.1 5117.4 3713.5 5065.0 5067.4 5080.3 5192.0 5029.7 5039.1 5048.9 5053.9 5072.3 4967.6 4970.8 4973.2 4983.3 4994.4 5157.4 5230.3 5310.2 5397.0 5466.0 5616.3 5781.0 5802.1 5803.2 5858.8 5702.2 5792.1 5839.8 5919.5 5937.0 5516.1 5524.9 5526.1 5559.9 5579.8 6083.9 6100.3 6105.6 6106.1 6125.4 5582.2 5639.9 5705.9 5749.7 5765.3 5773.1 5808.4 5835.0 5847.2 5986.8 5804.7 5836.8 5838.6 5842.3 5868.2 4665.7 5737.5 5841.5 5855.4 5879.0 4687.3 4695.6 4702.4 4717.1 4720.5 3539.5 4198.1 4244.0 4244.8 4289.3 5358.1 5407.4 5409.4 5485.0 5523.2 5841.5 5974.4 5985.5 5991.7 5994.7 5509.2 5529.1 5534.5 5536.9 5541.8 5001.7 5045.0 5077.9 5137.9 5140.9 6209.9 6215.0 6227.8 6234.8 6238.7 5911.5 5931.3 5962.2 5964.9 5972.9 5984.2 6052.8 6139.8 6201.0 6267.9 5762.5 5838.6 5852.8 5858.8 5900.4 4550.8 4967.8 5100.6 5602.4 5968.1 4176.3 4280.8 4972.1 5619.5 5734.9 4621.4 4731.8 5683.1 5685.3 5781.2 4608.7 5573.6 5603.2 5606.2 5611.6 5580.7 5673.2 5681.8 5708.9 5796.0 5471.9 5483.5 5538.1 5588.1 5647.9 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | [#1] ext.html Cycles:180 Average:70814.17 Median:40391.10 stddev:156647.91 (387.8%) stddev-sans-first:156998.35 05:51:55 INFO - PROCESS | 2004 | Values: 483.7 487.2 489.6 517.7 536.3 39503.8 41372.8 41440.2 42694.8 43538.9 36585.6 43294.4 43337.3 43340.0 43403.9 9724.1 9841.0 9861.9 9883.6 9907.2 9647.4 9662.9 9746.9 9777.8 9796.8 9760.7 9816.7 9819.7 9845.4 9873.2 9724.3 9744.0 9768.8 9778.3 9814.8 9631.9 9707.8 9714.2 9741.7 9746.0 39946.8 40116.6 40285.0 40385.6 40396.6 3200.0 3273.9 3418.7 3451.8 3665.6 30715.9 31072.4 31443.2 31888.5 32355.8 3208.5 3253.9 3259.8 3343.8 3355.7 491046.0 499991.0 505253.0 505836.0 509302.0 61117.0 61384.0 61499.4 61616.1 61707.1 62536.7 63884.0 64459.4 64596.7 64836.7 15330.0 15586.4 15598.7 15604.7 15609.8 11807.7 11867.3 11875.5 11901.9 11902.8 15556.5 16354.8 16908.7 17979.7 18932.5 6028.9 6117.4 6393.0 6849.0 7649.7 812.3 884.9 937.3 969.8 1051.8 23177.9 23591.3 24783.8 27912.5 30298.7 1007.2 1078.7 1086.0 1105.8 1121.9 14920.3 15498.8 15548.5 15608.8 15699.9 658307.0 661536.0 666451.7 667149.0 669260.0 55707.0 56036.7 56682.4 56696.4 56850.7 1195.0 1293.0 1299.3 1370.3 1371.1 26357.9 26845.3 29524.7 29672.9 30057.5 48951.0 49195.0 49255.0 49283.0 49318.0 575078.0 575821.0 579027.0 579400.0 580519.0 25900.4 25984.7 26107.7 26347.5 26373.3 45581.5 45941.5 46431.8 46531.1 46896.5 29886.3 31459.8 37685.1 38731.2 40838.8 33031.5 33779.7 36515.6 39015.8 39198.1 37879.8 37963.8 38267.2 38363.2 38590.6 25863.0 25999.9 30292.0 32321.0 32762.0 25275.6 25334.7 25356.4 25417.4 25698.6 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | [#2] jquery.html Cycles:180 Average:32692.82 Median:375.17 stddev:86235.37 (22985.6%) stddev-sans-first:86443.13 05:51:55 INFO - PROCESS | 2004 | Values: 367.7 368.1 373.4 376.9 393.1 14901.5 20316.5 20521.3 20883.3 21105.8 20063.8 20246.7 20451.4 20558.9 20756.6 4834.0 5791.7 5914.4 6035.5 6098.8 5913.7 6033.8 6049.5 6057.6 6058.8 5687.5 5879.3 5914.9 5921.7 5971.4 5840.8 5915.6 5927.5 5955.7 5961.6 5061.0 5113.8 5115.0 5141.8 5150.1 24879.0 25350.7 25394.5 25745.1 25847.4 2284.0 2420.6 2462.3 2509.7 3034.2 14996.0 15830.6 15982.0 16033.4 16278.2 1839.4 1848.4 1985.7 2009.6 2022.2 97257.0 119647.4 122501.2 124134.4 124418.0 11283.9 11518.8 11541.5 11565.7 11737.4 14320.0 14358.9 14362.4 14369.8 14379.8 6703.5 7814.4 7869.7 8021.5 8126.6 7813.7 7923.6 7948.6 8081.3 8103.0 4476.3 4499.8 4500.6 4537.9 4599.0 1464.4 1612.5 1862.1 1872.5 1902.7 856.5 861.6 869.7 895.6 926.6 16306.5 20047.6 21776.1 21824.7 21913.9 760.6 797.3 858.7 873.9 892.6 5884.9 8606.6 10763.7 11066.7 11349.9 428724.0 440725.0 530577.0 534054.0 592194.0 130720.0 132942.3 133387.7 135586.0 135829.3 926.5 951.5 960.6 961.8 967.6 15198.6 18467.8 19565.8 19608.2 19974.4 43877.8 55722.0 56966.1 57463.9 58371.7 80940.0 82230.6 82695.3 84073.0 84078.2 6809.1 7175.0 7243.7 7250.5 7392.9 9376.6 11507.3 12758.3 13024.2 13086.7 10744.6 11132.7 11144.9 11187.7 11365.4 5527.9 10843.0 10893.1 11083.9 11131.4 11330.5 11392.9 11412.2 11513.3 11547.1 7007.9 7185.5 7384.9 7408.4 7410.6 8950.4 9949.7 11050.1 11294.5 11402.9 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | [#3] mootools.html Cycles:180 Average:5629.92 Median:5059.79 stddev:3151.17 (62.3%) stddev-sans-first:3144.11 05:51:55 INFO - PROCESS | 2004 | Values: 1416.8 1461.7 1676.3 1847.1 1916.3 6748.7 7913.4 8164.7 8253.0 8888.1 8380.5 8687.3 8705.4 8823.9 8858.8 2273.5 2328.9 2330.4 2330.9 2332.3 2308.5 2308.6 2327.7 2338.9 2345.4 2303.9 2310.9 2320.2 2320.3 2326.3 2040.8 2265.1 2292.0 2301.4 2305.2 2310.8 2312.0 2314.3 2314.5 2318.9 8761.6 8795.4 8880.8 8905.1 8916.6 5161.7 5304.9 5347.1 5347.8 5350.1 3015.4 3347.8 3406.1 3424.9 3516.5 1057.5 1063.9 1065.9 1069.7 1089.8 11496.1 11546.2 11655.7 11666.9 11680.6 4531.9 4570.6 4758.2 4762.4 4766.8 9872.2 10005.1 10020.9 10020.9 10037.9 5284.8 5285.6 5302.9 5304.6 5318.8 4320.7 4482.9 4650.4 4790.8 4859.1 3815.0 3847.3 3935.9 3941.2 3965.0 1225.3 1276.5 1277.2 1280.1 1291.6 769.5 811.7 874.4 903.8 922.4 5562.9 5903.7 5987.7 6003.9 6103.4 922.4 930.0 930.6 935.5 992.7 3959.4 3968.2 3969.6 4059.4 4073.1 10332.5 10718.9 10754.7 10778.5 10781.7 10586.6 10736.9 10746.6 10747.8 10767.3 6125.9 7808.3 8123.1 8262.1 8291.0 5717.4 5803.8 5889.3 5895.6 5917.9 9942.0 9950.7 9985.3 10030.1 10102.6 7574.6 8557.8 9436.4 9816.8 10191.4 5789.5 6919.8 6987.1 7014.5 7047.5 8124.0 8199.5 8218.6 8234.9 8246.5 7311.3 7471.3 7477.4 7510.1 7590.5 7341.4 7358.3 7379.6 7521.5 7556.8 6938.4 7049.4 7059.0 7062.5 7072.1 4951.4 4995.5 5077.3 5130.8 5151.0 5042.1 5042.3 5152.5 5165.4 5237.8 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | [#4] prototype.html Cycles:180 Average:4286.59 Median:4651.57 stddev:1287.94 (27.7%) stddev-sans-first:1256.33 05:51:55 INFO - PROCESS | 2004 | Values: 300.9 301.4 308.3 312.2 312.8 4390.9 5100.0 5292.6 5303.4 5412.3 5095.5 5259.6 5261.6 5286.3 5298.8 4065.5 4078.4 4082.7 4095.3 4097.8 3727.5 4021.9 4093.3 4102.1 4107.8 3991.6 4015.8 4021.7 4026.3 4050.1 4018.2 4055.5 4058.4 4060.8 4063.7 3500.5 3510.9 3512.0 3520.9 3521.8 4870.6 5160.6 5166.3 5193.7 5220.5 4521.8 4578.4 4597.2 4599.9 4610.7 5124.6 5284.1 5562.4 5605.3 5620.2 3334.3 3689.5 3772.4 3798.4 3815.4 5324.4 5335.0 5355.7 5926.9 5942.9 3888.5 3888.9 3899.0 3906.7 3914.5 3767.4 3810.1 3881.2 3900.9 3910.7 3420.5 4552.6 4559.3 4563.7 4570.4 4661.7 4664.6 5621.2 5682.1 5723.5 1253.7 1289.5 1299.5 1321.2 1329.4 834.5 849.8 869.5 876.6 893.4 5172.2 5178.1 5229.8 5254.4 5294.0 5203.5 5392.6 5657.6 5666.5 5680.6 4092.9 5036.6 5190.8 5213.3 5315.1 2290.4 2481.7 2545.8 2546.8 2576.0 4641.4 4804.2 4893.4 5110.5 5119.1 4021.1 4520.4 4571.7 4836.5 4847.9 4729.5 4836.7 4973.2 5003.8 5027.6 4057.8 4163.0 4330.0 4507.4 4515.9 3682.7 4069.4 4323.0 4831.5 4834.4 4172.5 4736.6 5021.9 5073.8 5077.8 3251.7 3374.7 3398.0 3406.0 3413.0 4036.7 4323.7 4893.9 4900.4 5500.5 5114.5 5130.8 5299.3 5589.4 5593.5 4135.3 4698.6 5009.3 5480.5 5600.5 4414.2 5227.9 5555.5 5560.2 5598.3 4475.9 4716.9 4882.9 5172.4 5693.8 4610.9 5222.5 5502.9 5577.0 5618.1 05:51:55 INFO - PROCESS | 2004 | 05:51:55 INFO - PROCESS | 2004 | [#5] yui.html Cycles:180 Average:24757.32 Median:3613.25 stddev:40412.53 (1118.5%) stddev-sans-first:40485.49 05:51:55 INFO - PROCESS | 2004 | Values: 689.6 703.9 725.8 771.4 789.3 14336.0 15122.0 15165.7 15167.5 15204.5 14362.4 14481.5 14482.9 14511.3 14518.5 650.5 670.4 804.7 817.1 837.0 810.8 820.9 843.3 846.5 847.1 735.3 763.7 798.4 861.1 890.9 778.3 781.9 839.8 890.6 894.0 631.5 634.0 634.3 656.1 657.3 14366.6 14562.3 14572.2 14620.9 14666.0 14319.9 14552.6 14555.0 14568.6 14652.6 11716.2 11923.6 11927.8 11957.9 11969.4 3279.8 3736.6 3784.7 3800.5 3835.5 119734.0 120553.6 120733.0 120792.2 124844.0 11080.7 11238.3 11320.0 11361.2 11693.4 23129.0 23334.6 23381.8 23403.8 23426.0 7394.5 7706.5 7782.8 7811.7 7942.2 4225.5 4290.5 4297.5 4310.2 4389.4 3462.3 3575.2 3603.8 3606.4 3620.1 669.5 673.4 675.9 675.9 692.1 565.8 591.2 606.5 615.9 621.9 8417.5 9100.3 9103.6 9111.7 9186.4 575.4 580.4 611.7 617.6 624.7 4281.2 4395.5 4446.7 4484.7 4598.7 104324.0 157420.4 163271.2 163274.2 163397.0 143636.0 144458.8 146298.3 146922.5 150814.0 62572.7 71801.6 83334.0 97376.0 100193.5 9358.6 9893.6 9909.2 10077.2 10189.3 62054.4 62649.0 63850.0 64737.0 65886.0 58752.0 68698.3 91653.5 92910.0 95781.1 12841.9 12927.5 13013.6 13124.3 13426.4 14618.0 14672.4 14784.3 14866.7 15285.0 13460.2 13590.5 13784.4 13870.9 14248.5 13229.1 13430.7 13614.5 13660.4 13685.7 11409.4 13385.5 13476.3 14058.5 14084.3 11168.7 11329.2 11450.1 11461.7 11910.6 8023.9 9823.2 11498.2 11551.9 11693.2 05:51:55 INFO - PROCESS | 2004 | -------- Summary: end -------- 05:51:55 INFO - PROCESS | 2004 | 05:51:56 INFO - TEST-INFO | 2004: exit 0 05:51:56 INFO - TEST-OK | dromaeo_css | took 1114094ms 05:51:56 INFO - TEST-START | kraken 05:51:56 INFO - operating with platform_type : mac_ 05:51:56 INFO - Initialising browser for kraken test... 05:51:56 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpPLfPCS/profile http://localhost:49395/getInfo.html) 05:51:59 INFO - PROCESS | 2009 | 2016-10-11 05:51:59.029 plugin-container[2011:14072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4637, name = 'com.apple.tsm.portname' 05:51:59 INFO - PROCESS | 2009 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:51:59 INFO - PROCESS | 2009 | 2016-10-11 05:51:59.030 plugin-container[2011:14072] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 05:51:59 INFO - PROCESS | 2009 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:51:59 INFO - PROCESS | 2009 | 2016-10-11 05:51:59.030 plugin-container[2011:14072] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:51:59 INFO - PROCESS | 2009 | __metrics Screen width/height:1600/1200 05:51:59 INFO - PROCESS | 2009 | colorDepth:24 05:51:59 INFO - PROCESS | 2009 | Browser inner width/height: 1024/689 05:51:59 INFO - PROCESS | 2009 | __metrics 05:51:59 ERROR - PROCESS | 2009 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 05:51:59 INFO - TEST-INFO | 2009: exit 0 05:51:59 INFO - Browser initialized. 05:51:59 INFO - Running cycle 1/1 for kraken test... 05:51:59 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpPLfPCS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:02 INFO - PROCESS | 2012 | 2016-10-11 05:52:02.282 plugin-container[2013:14185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 05:52:02 INFO - PROCESS | 2012 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:02 INFO - PROCESS | 2012 | 2016-10-11 05:52:02.282 plugin-container[2013:14185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 05:52:02 INFO - PROCESS | 2012 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:02 INFO - PROCESS | 2012 | 2016-10-11 05:52:02.282 plugin-container[2013:14185] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:52:11 INFO - PROCESS | 2012 | RSS: Main: 239091712 05:52:11 INFO - PROCESS | 2012 | 05:52:15 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:16 INFO - PROCESS | 2012 | RSS: Main: 252731392 05:52:16 INFO - PROCESS | 2012 | 05:52:18 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-dft) 05:52:19 INFO - PROCESS | 2012 | RSS: Main: 261025792 05:52:19 INFO - PROCESS | 2012 | 05:52:22 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-fft) 05:52:23 INFO - PROCESS | 2012 | RSS: Main: 261263360 05:52:23 INFO - PROCESS | 2012 | 05:52:25 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-oscillator) 05:52:25 INFO - PROCESS | 2012 | RSS: Main: 262246400 05:52:25 INFO - PROCESS | 2012 | 05:52:27 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:28 INFO - PROCESS | 2012 | RSS: Main: 263839744 05:52:28 INFO - PROCESS | 2012 | 05:52:31 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49395/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:32 INFO - PROCESS | 2012 | RSS: Main: 264544256 05:52:32 INFO - PROCESS | 2012 | 05:52:34 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49395/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:35 INFO - PROCESS | 2012 | RSS: Main: 264642560 05:52:35 INFO - PROCESS | 2012 | 05:52:38 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49395/tests/kraken/driver.html?testName=json-parse-financial) 05:52:39 INFO - PROCESS | 2012 | RSS: Main: 265146368 05:52:39 INFO - PROCESS | 2012 | 05:52:40 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:41 INFO - PROCESS | 2012 | RSS: Main: 264589312 05:52:41 INFO - PROCESS | 2012 | 05:52:43 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:43 INFO - PROCESS | 2012 | RSS: Main: 264683520 05:52:43 INFO - PROCESS | 2012 | 05:52:45 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:46 INFO - PROCESS | 2012 | RSS: Main: 264716288 05:52:46 INFO - PROCESS | 2012 | 05:52:49 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:50 INFO - PROCESS | 2012 | RSS: Main: 264949760 05:52:50 INFO - PROCESS | 2012 | 05:52:53 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:53 INFO - PROCESS | 2012 | RSS: Main: 265142272 05:52:53 INFO - PROCESS | 2012 | 05:52:55 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49395/tests/kraken/driver.html?testName=ai-astar) 05:52:56 INFO - PROCESS | 2012 | RSS: Main: 266817536 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | __start_tp_report 05:52:56 INFO - PROCESS | 2012 | _x_x_mozilla_page_load 05:52:56 INFO - PROCESS | 2012 | _x_x_mozilla_page_load_details 05:52:56 INFO - PROCESS | 2012 | |i|pagename|runs| 05:52:56 INFO - PROCESS | 2012 | |0;ai-astar;115;121;119;119;120;119;121;121;118;98 05:52:56 INFO - PROCESS | 2012 | |1;audio-beat-detection;150;114;117;154;118;116;119;120;149;116 05:52:56 INFO - PROCESS | 2012 | |2;audio-dft;202;206;229;198;200;195;187;201;207;194 05:52:56 INFO - PROCESS | 2012 | |3;audio-fft;83;49;62;75;78;75;83;88;99;52 05:52:56 INFO - PROCESS | 2012 | |4;audio-oscillator;92;69;87;74;69;72;89;72;72;89 05:52:56 INFO - PROCESS | 2012 | |5;imaging-gaussian-blur;93;105;93;93;137;133;112;89;93;90 05:52:56 INFO - PROCESS | 2012 | |6;imaging-darkroom;102;105;102;101;102;102;114;101;102;137 05:52:56 INFO - PROCESS | 2012 | |7;imaging-desaturate;108;144;92;91;91;90;90;93;91;92 05:52:56 INFO - PROCESS | 2012 | |8;json-parse-financial;56;57;57;59;56;57;58;59;65;78 05:52:56 INFO - PROCESS | 2012 | |9;json-stringify-tinderbox;69;70;75;82;80;76;70;70;70;69 05:52:56 INFO - PROCESS | 2012 | |10;stanford-crypto-aes;90;87;91;89;88;89;87;86;89;87 05:52:56 INFO - PROCESS | 2012 | |11;stanford-crypto-ccm;163;165;159;169;175;159;153;148;182;150 05:52:56 INFO - PROCESS | 2012 | |12;stanford-crypto-pbkdf2;172;173;176;171;174;177;174;175;174;173 05:52:56 INFO - PROCESS | 2012 | |13;stanford-crypto-sha256-iterative;71;79;81;93;91;70;76;90;90;91 05:52:56 INFO - PROCESS | 2012 | __end_tp_report 05:52:56 INFO - PROCESS | 2012 | __start_cc_report 05:52:56 INFO - PROCESS | 2012 | _x_x_mozilla_cycle_collect,946 05:52:56 INFO - PROCESS | 2012 | __end_cc_report 05:52:56 INFO - PROCESS | 2012 | __startTimestamp1476190376043__endTimestamp 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | ------- Summary: start ------- 05:52:56 INFO - PROCESS | 2012 | Number of tests: 14 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#0] ai-astar Cycles:10 Average:117.10 Median:120.50 stddev:6.95 (5.8%) stddev-sans-first:7.33 05:52:56 INFO - PROCESS | 2012 | Values: 115.0 121.0 119.0 119.0 120.0 119.0 121.0 121.0 118.0 98.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:119.50 stddev:16.49 (13.8%) stddev-sans-first:15.30 05:52:56 INFO - PROCESS | 2012 | Values: 150.0 114.0 117.0 154.0 118.0 116.0 119.0 120.0 149.0 116.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#2] audio-dft Cycles:10 Average:201.90 Median:201.50 stddev:11.20 (5.6%) stddev-sans-first:11.88 05:52:56 INFO - PROCESS | 2012 | Values: 202.0 206.0 229.0 198.0 200.0 195.0 187.0 201.0 207.0 194.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#3] audio-fft Cycles:10 Average:74.40 Median:80.50 stddev:15.82 (19.7%) stddev-sans-first:16.47 05:52:56 INFO - PROCESS | 2012 | Values: 83.0 49.0 62.0 75.0 78.0 75.0 83.0 88.0 99.0 52.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:80.50 stddev:9.44 (11.7%) stddev-sans-first:8.66 05:52:56 INFO - PROCESS | 2012 | Values: 92.0 69.0 87.0 74.0 69.0 72.0 89.0 72.0 72.0 89.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#5] imaging-gaussian-blur Cycles:10 Average:103.80 Median:91.50 stddev:17.95 (19.6%) stddev-sans-first:18.61 05:52:56 INFO - PROCESS | 2012 | Values: 93.0 105.0 93.0 93.0 137.0 133.0 112.0 89.0 93.0 90.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#6] imaging-darkroom Cycles:10 Average:106.80 Median:102.00 stddev:11.30 (11.1%) stddev-sans-first:11.85 05:52:56 INFO - PROCESS | 2012 | Values: 102.0 105.0 102.0 101.0 102.0 102.0 114.0 101.0 102.0 137.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#7] imaging-desaturate Cycles:10 Average:98.20 Median:91.00 stddev:16.96 (18.6%) stddev-sans-first:17.61 05:52:56 INFO - PROCESS | 2012 | Values: 108.0 144.0 92.0 91.0 91.0 90.0 90.0 93.0 91.0 92.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.50 stddev:6.78 (11.6%) stddev-sans-first:7.02 05:52:56 INFO - PROCESS | 2012 | Values: 56.0 57.0 57.0 59.0 56.0 57.0 58.0 59.0 65.0 78.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:72.50 stddev:4.84 (6.7%) stddev-sans-first:4.90 05:52:56 INFO - PROCESS | 2012 | Values: 69.0 70.0 75.0 82.0 80.0 76.0 70.0 70.0 70.0 69.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:89.00 stddev:1.57 (1.8%) stddev-sans-first:1.54 05:52:56 INFO - PROCESS | 2012 | Values: 90.0 87.0 91.0 89.0 88.0 89.0 87.0 86.0 89.0 87.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#11] stanford-crypto-ccm Cycles:10 Average:162.30 Median:164.00 stddev:10.88 (6.6%) stddev-sans-first:11.54 05:52:56 INFO - PROCESS | 2012 | Values: 163.0 165.0 159.0 169.0 175.0 159.0 153.0 148.0 182.0 150.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:1.79 (1.0%) stddev-sans-first:1.76 05:52:56 INFO - PROCESS | 2012 | Values: 172.0 173.0 176.0 171.0 174.0 177.0 174.0 175.0 174.0 173.0 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - PROCESS | 2012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.20 Median:90.00 stddev:8.87 (9.9%) stddev-sans-first:8.23 05:52:56 INFO - PROCESS | 2012 | Values: 71.0 79.0 81.0 93.0 91.0 70.0 76.0 90.0 90.0 91.0 05:52:56 INFO - PROCESS | 2012 | -------- Summary: end -------- 05:52:56 INFO - PROCESS | 2012 | 05:52:56 INFO - TEST-INFO | 2012: exit 0 05:52:56 INFO - TEST-OK | kraken | took 60684ms 05:52:56 INFO - SUITE-END | took 1174s 05:52:57 INFO - Completed test suite (00:19:35) 05:52:57 INFO - javascript benchmark 05:52:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7147.359278835289, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2758.2001219646304, 3113.859876305569, 3237.692419220173, 3280.557124788153, 3302.9339413211737, 5327.387350454689, 5352.661834541364, 5378.381486129097, 5395.730213489324, 5435.592330575213, 5336.946630533694, 5374.247605335257, 5400.945990540094, 5419.647722898018, 5437.238786569884, 4304.720193187432, 4905.043516514281, 4920.434150072742, 5040.798368065273, 5051.595872330205, 4950.306957026001, 5031.22016087507, 5078.1874900016, 5089.134847076006, 5117.360329958755, 3713.4615480755274, 5065.012322597095, 5067.391912970449, 5080.288759573663, 5192.0, 5029.698218106925, 5039.118154322979, 5048.899022019539, 5053.9494605054215, 5072.34059572257, 4967.627427942883, 4970.82602108928, 4973.204287314049, 4983.302337672729, 4994.35073440454, 5157.381114266312, 5230.293910322096, 5310.20346947957, 5397.0, 5465.9726701366635, 5616.297962754656, 5780.988327042793, 5802.071668533056, 5803.187553742479, 5858.76564937402, 5702.2301989231755, 5792.131180322943, 5839.7664093436215, 5919.49684276837, 5936.990711579042, 5516.089845175581, 5524.889502209973, 5526.088195447706, 5559.9444005559835, 5579.832605021856, 6083.939160608337, 6100.298465676504, 6105.633661980295, 6106.053561697944, 6125.448709616156, 5582.218489411485, 5639.943600564024, 5705.914411283834, 5749.712514374348, 5765.3369862465515, 5773.134029895466, 5808.419158084158, 5835.037218858925, 5847.210626565445, 5986.790462333797, 5804.651720896675, 5836.795712150054, 5838.620489668158, 5842.269716285465, 5868.207791948118, 4665.650076244296, 5737.540996720252, 5841.503472204825, 5855.355910849803, 5879.0, 4687.343771871872, 4695.577398034194, 4702.36518070063, 4717.056588682209, 4720.504347043511, 3539.486774417695, 4198.1393814268, 4243.957560424418, 4244.830206791756, 4289.335153051282, 5358.062339090644, 5407.378151512627, 5409.43200963901, 5485.040117979338, 5523.226748255248, 5841.532677385799, 5974.4324289192455, 5985.521158307412, 5991.700414979234, 5994.700264986734, 5509.228707980886, 5529.142982837667, 5534.501894829485, 5536.944630553643, 5541.778328866801, 5001.72490513018, 5045.0, 5077.898442031139, 5137.946720922202, 5140.897182056338, 6209.906851397323, 6215.0, 6227.813165605039, 6234.750609975641, 6238.719257633417, 5911.467967882912, 5931.288245410578, 5962.2249107615735, 5964.8807023860145, 5972.940270597239, 5984.16221728967, 6052.757889684363, 6139.84650383744, 6201.0, 6267.874642507216, 5762.510186634016, 5838.591298609226, 5852.7658893643775, 5858.765649373977, 5900.43945825146, 4550.7712917512745, 4967.776450059829, 5100.566451851486, 5602.383737788921, 5968.104784282219, 4176.2691528981695, 4280.822773737247, 4972.0801651694555, 5619.522340600931, 5734.856628584319, 4621.3530105785885, 4731.763411829464, 5683.147527870852, 5685.260916081049, 5781.190633311256, 4608.700434471749, 5573.6098473106495, 5603.187537807076, 5606.187102870143, 5611.607187496836, 5580.665160090408, 5673.234113394639, 5681.829545113653, 5708.857278568069, 5796.0, 5471.945280547303, 5483.533899618577, 5538.113901775697, 5588.105903055654, 5647.943520564741], "value": 5332.04690242588, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.7315290014043, 487.22044728434497, 489.6278828090652, 517.7204309672777, 536.2894165231068, 39503.80248098759, 41372.793136034314, 41440.17119657609, 42694.7865260674, 43538.911527211836, 36585.63414365862, 43294.35058474117, 43337.34993975093, 43340.0, 43403.914902127464, 9724.076212759794, 9841.0, 9861.852072218922, 9883.604655813759, 9907.157891579225, 9647.372920760163, 9662.903370966305, 9746.853797193047, 9777.804443911118, 9796.755081122994, 9760.707178784647, 9816.656417025406, 9819.70540883771, 9845.40927544346, 9873.160781333596, 9724.270679699015, 9743.95128024359, 9768.755781105458, 9778.266630002778, 9814.803703925918, 9631.90368096317, 9707.805843883083, 9714.22286217101, 9741.659041933499, 9745.951270243604, 39946.800265998776, 40116.59591914269, 40284.99287517835, 40385.59614403848, 40396.596034039576, 3199.9520007199912, 3273.9017829465156, 3418.6923176913947, 3451.8446669899663, 3665.5784584772828, 30715.9249426269, 31072.37855242905, 31443.213919651964, 31888.521672174935, 32355.838220808746, 3208.5187221916667, 3253.9349213015844, 3259.7555183361105, 3343.8160901150427, 3355.7147642450423, 491046.0, 499991.0, 505253.0, 505836.0, 509302.0, 61117.0, 61384.0, 61499.38500615026, 61616.075758863655, 61707.074393884126, 62536.687316563126, 63884.0, 64459.355406445335, 64596.677016614616, 64836.67581662061, 15330.0, 15586.376544938303, 15598.688026239412, 15604.68790624204, 15609.765853512206, 11807.701152873176, 11867.347295898808, 11875.524979000917, 11901.940490297493, 11902.761944761056, 15556.533304000897, 16354.754678679828, 16908.661826763397, 17979.650247713085, 18932.526686832665, 6028.8794224116145, 6117.36953110158, 6393.0, 6849.04113424121, 7649.6557654904545, 812.3095368936475, 884.8628462588309, 937.329809186435, 969.7672558585889, 1051.784384201237, 23177.88411057934, 23591.29226123219, 24783.752162478144, 27912.463634818487, 30298.69701303003, 1007.2445665750687, 1078.654830454247, 1085.9791795712006, 1105.8009558279587, 1121.8709848367541, 14920.317729929473, 15498.767518487231, 15548.455804046804, 15608.765868511982, 15699.921500392426, 658307.0, 661536.0, 666451.6677416582, 667149.0, 669260.0, 55707.0, 56036.71981640147, 56682.43317566854, 56696.43303566911, 56850.71574642183, 1194.970125746846, 1292.9612111636666, 1299.259422129377, 1370.3490841850041, 1371.1430356027483, 26357.868210658824, 26845.328866778487, 29524.704752953054, 29672.851635741685, 30057.491376293732, 48951.0, 49195.016099677094, 49255.0, 49283.01433971372, 49318.013639727724, 575078.0, 575821.0, 579027.0, 579400.0, 580519.0, 25900.35249118787, 25984.74015259823, 26107.73892261053, 26347.473050539265, 26373.34066648349, 45581.54418455773, 45941.54058459373, 46431.76784116193, 46531.06937861291, 46896.53103469058, 29886.252843678212, 31459.84270078635, 37685.05787355338, 38731.207108572875, 40838.79580602078, 33031.50452743259, 33779.66220337765, 36515.63484365229, 39015.80492097521, 39198.0965721406, 37879.81060094682, 37963.810180948916, 38267.23465530729, 38363.23273534458, 38590.614093858705, 25863.0, 25999.870000649877, 30292.0, 32321.0, 32762.0342779434, 25275.620865687397, 25334.74665253324, 25356.366090847878, 25417.424081072004, 25698.61452078183], "value": 19599.224371809545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.68195510883083, 368.0632789550595, 373.42865415913656, 376.91330993871424, 393.13118009199667, 14901.478448254313, 20316.492087697814, 20521.281755138574, 20883.269085582007, 21105.788942110576, 20063.799362006375, 20246.69629955552, 20451.386458406236, 20558.89720551399, 20756.584868302623, 4833.9516604834025, 5791.681457519845, 5914.418366240493, 6035.5473339499495, 6098.786542471014, 5913.7338819752995, 6033.758649654031, 6049.455549000589, 6057.606255593372, 6058.818235452944, 5687.459691329317, 5879.294484661847, 5914.940850591482, 5921.73352199152, 5971.37300583439, 5840.795572154954, 5915.645061296336, 5927.496162826165, 5955.672438015908, 5961.612495187821, 5061.013102445025, 5113.795448182068, 5115.028144652504, 5141.794328226866, 5150.124478838607, 24879.0, 25350.746492535207, 25394.492110157695, 25745.098921537843, 25847.353816154748, 2283.9771602284095, 2420.580879986127, 2462.273629279367, 2509.736477669837, 3034.2262723005715, 14996.0, 15830.604234894105, 15982.0, 16033.35866565336, 16278.186090695537, 1839.4113883557268, 1848.4454663600866, 1985.7418535590425, 2009.6483115454737, 2022.2315520102413, 97257.0, 119647.4017629915, 122501.16248256373, 124134.37932810368, 124418.0, 11283.943580282046, 11518.769624607461, 11541.518573506568, 11565.653030409101, 11737.35444550558, 14319.997600167888, 14358.928205359116, 14362.353694083582, 14369.78445323321, 14379.78430323546, 6703.530752847254, 7814.3748500119855, 7869.685212591432, 8021.478603890729, 8126.55303958288, 7813.726519571787, 7923.603819808986, 7948.602569871599, 8081.313088387553, 8103.0, 4476.306172543196, 4499.842505512292, 4500.572445617661, 4537.909241815145, 4599.0, 1464.406915199346, 1612.540425978614, 1862.050354319307, 1872.5225067607946, 1902.73361729358, 856.5160684213399, 861.6381119929645, 869.6912596028445, 895.632790555869, 926.6247169896203, 16306.53241208297, 20047.599048018958, 21776.128954841628, 21824.672629910565, 21913.890430547744, 760.5626764610371, 797.2983774278714, 858.6522458404356, 873.921347078766, 892.6027917576616, 5884.852878678067, 8606.612702428405, 10763.677089687322, 11066.667999960015, 11349.865013498584, 428724.0, 440725.0, 530577.0, 534054.0, 592194.0, 130720.0, 132942.3352883249, 133387.66612333947, 135586.0, 135829.3208533951, 926.4858003807817, 951.5480146930291, 960.596549449233, 961.8220629183623, 967.6322997261136, 15198.620034499227, 18467.81532184661, 19565.80434195697, 19608.215671372986, 19974.400767976986, 43877.78061109674, 55722.0, 56966.14550781659, 57463.85072298614, 58371.70814145902, 80940.0, 82230.58884705538, 82695.346093079, 84073.0, 84078.15921840703, 6809.127489940306, 7174.964125179341, 7243.674034668347, 7250.528715633467, 7392.8891066635115, 9376.624935002523, 11507.309561426342, 12758.298293593942, 13024.153430027018, 13086.738265234833, 10744.623938162127, 11132.721681958015, 11144.88855111471, 11187.664370068911, 11365.374904380338, 5527.917081243704, 10843.024127828534, 10893.074088702231, 11083.889161108607, 11131.387773672202, 11330.546778128783, 11392.94303528477, 11412.201145919706, 11513.30920144794, 11547.13396495283, 7007.894881576678, 7185.461090418135, 7384.852302954018, 7408.370288525536, 7410.592417417094, 8950.418222815497, 9949.651762188289, 11050.06074483678, 11294.491747871201, 11402.885971140182], "value": 9407.93235869364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.815813944187, 1461.7355987071182, 1676.346224972261, 1847.0764617691154, 1916.3484415298797, 6748.662566871655, 7913.406494512906, 8164.714235001776, 8253.0, 8888.06675299094, 8380.49717016978, 8687.348448866345, 8705.390622656401, 8823.911760882405, 8858.77853053674, 2273.545290941814, 2328.906843726249, 2330.3707998840305, 2330.93007209784, 2332.2769941318247, 2308.4690521180137, 2308.6421604651223, 2327.650852372149, 2338.9415264618438, 2345.413646588353, 2303.9078436862587, 2310.8844557772127, 2320.176337400224, 2320.3155069254526, 2326.3134227684877, 2040.7959204079548, 2265.1166045242367, 2291.9656205156934, 2301.4361481436986, 2305.1931823861596, 2310.8151347892126, 2311.9653205201935, 2314.2941402872116, 2314.479242170515, 2318.9188378406843, 8761.56192190388, 8795.384323097385, 8880.822383552357, 8905.109489051043, 8916.554172291424, 5161.664491808058, 5304.893902121975, 5347.0909945309395, 5347.786088556453, 5350.117230656937, 3015.3667729776553, 3347.7991320520846, 3406.097384193191, 3424.9143771405666, 3516.4549494828343, 1057.4924036462542, 1063.8723353197665, 1065.9093977011964, 1069.6630561373142, 1089.8256278995402, 11496.137789665725, 11546.249493782878, 11655.650330490098, 11666.883331166664, 11680.591179308683, 4531.886702832456, 4570.611498022638, 4758.191107511731, 4762.404699412574, 4766.809327626856, 9872.173647875166, 10005.099541041196, 10020.949895250476, 10020.949895250476, 10037.949810251048, 5284.788608455696, 5285.577153827685, 5302.946970530323, 5304.602154838402, 5318.787248510093, 4320.65434765218, 4482.910341793211, 4650.372199753057, 4790.8323208688225, 4859.076775412731, 3814.9809250953567, 3847.2690188864026, 3935.940960885589, 3941.192055628589, 3965.0285680008583, 1225.2587184753274, 1276.495784165268, 1277.188984994535, 1280.052760956885, 1291.6189724031433, 769.4652216709334, 811.7118422959883, 874.3966663002508, 903.846346121161, 922.3543519536352, 5562.9443705563235, 5903.704814759245, 5987.670678112746, 6003.879922401527, 6103.42017508336, 922.3681777982104, 929.953502324881, 930.5812384427035, 935.462109287149, 992.7369247149511, 3959.425883246913, 3968.206358728266, 3969.563348031714, 4059.431679564804, 4073.0631954650003, 10332.483375831178, 10718.946405267923, 10754.73113172177, 10778.461076946121, 10781.730456738644, 10586.629467968583, 10736.946315268373, 10746.623868164577, 10747.78504429907, 10767.300125491818, 6125.908111378333, 7808.258215469521, 8123.147069557729, 8262.091169971298, 8291.0, 5717.42825717425, 5803.767849285981, 5889.263842019747, 5895.616784908967, 5917.881642367042, 9942.0, 9950.701478955643, 9985.301028928196, 10030.097291243823, 10102.595896164072, 7574.621268936641, 8557.801907733046, 9436.433813971184, 9816.754581135528, 10191.439470829175, 5789.45000224978, 6919.827004324932, 6987.091678081817, 7014.508984371045, 7047.471439641945, 8124.0, 8199.508029518249, 8218.589070546568, 8234.90010047434, 8246.505209687439, 7311.268873112859, 7471.290227428385, 7477.40180785525, 7510.136334321623, 7590.468667193243, 7341.375983041501, 7358.264173582599, 7379.631018449163, 7521.473496855387, 7556.8488630228185, 6938.444924406136, 7049.436045116481, 7059.047028651066, 7062.540934839219, 7072.115985501812, 4951.430585482715, 4995.5004499551205, 5077.289179514797, 5130.769115389891, 5150.97424512875, 5042.14283571801, 5042.294078828893, 5152.536271735412, 5165.372907534114, 5237.764300606405], "value": 4530.795548256012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.94131644329354, 301.3926937221499, 308.2955446804053, 312.24125375337934, 312.8357612253568, 4390.868273951783, 5099.974500127494, 5292.550133238675, 5303.390110137336, 5412.296401467814, 5095.464976177504, 5259.579233661308, 5261.552768014723, 5286.3392075990505, 5298.788048478066, 4065.4918135233097, 4078.3678529827926, 4082.6937979651498, 4095.303798354272, 4097.754134751909, 3727.5154229950067, 4021.919561608766, 4093.2779701498466, 4102.138550904314, 4107.753534787922, 3991.560928297885, 4015.8192881320265, 4021.6581590564692, 4026.255142798592, 4050.129222217223, 4018.1516502408926, 4055.493063367094, 4058.431819545266, 4060.817263223162, 4063.7199282226006, 3500.5099286099967, 3510.8946731598094, 3512.016635342108, 3520.929581408383, 3521.841517131735, 4870.634702397334, 5160.587153027749, 5166.328377310963, 5193.662411943212, 5220.504052115043, 4521.84173553924, 4578.381918441001, 4597.195490789132, 4599.885002874921, 4610.694652673663, 5124.641275110744, 5284.124135931727, 5562.443755624446, 5605.327360716699, 5620.213170156181, 3334.333133373311, 3689.538807649044, 3772.4152756322815, 3798.3542797724454, 3815.351390263662, 5324.387695415038, 5334.959682861843, 5355.651882627656, 5926.8959519370865, 5942.910856337202, 3888.5333759948985, 3888.922221555553, 3899.0, 3906.7265291429894, 3914.5106861642294, 3767.3972164453558, 3810.142717888453, 3881.2237552489614, 3900.863469778544, 3910.7485604606254, 3420.521127042216, 4552.565941728345, 4559.338895860082, 4563.726176429424, 4570.423203994616, 4661.741329840924, 4664.603508701798, 5621.213030175779, 5682.119271512922, 5723.484886360247, 1253.7492501499555, 1289.529321797556, 1299.5191779041816, 1321.187469706143, 1329.4349901292105, 834.4784509681449, 849.7790574450687, 869.5478351257311, 876.5967654878827, 893.4237416866085, 5172.172452407597, 5178.145605975047, 5229.790808367698, 5254.4220135785035, 5294.047071527162, 5203.479652034766, 5392.56859451243, 5657.632253903483, 5666.46168613981, 5680.630759000652, 4092.8772136835346, 5036.597072234213, 5190.844274671766, 5213.296205012351, 5315.096433606296, 2290.381596968809, 2481.677381940336, 2545.7836083932702, 2546.8217224794084, 2575.987120064388, 4641.396618439649, 4804.183288840835, 4893.412790465096, 5110.4634013428795, 5119.10415677255, 4021.055052062763, 4520.389747384061, 4571.702839315434, 4836.46798852126, 4847.891167342217, 4729.456112547101, 4836.7339796310835, 4973.18478755259, 5003.849884503544, 5027.606365703135, 4057.776822274685, 4163.0, 4329.956700432956, 4507.3915021471685, 4515.864524064284, 3682.7053835693614, 4069.4302797608952, 4323.0, 4831.492693267156, 4834.3804825382485, 4172.4993000840095, 4736.621070314298, 5021.924671129863, 5073.797048118034, 5077.796888124433, 3251.69932027191, 3374.71314938233, 3397.9830100849335, 3405.965940340664, 3412.9658703413643, 4036.6972477064924, 4323.74057556535, 4893.926591101065, 4900.362952816111, 5500.477454641803, 5114.514121158484, 5130.769115389891, 5299.311089558333, 5589.441055894378, 5593.517717804866, 4135.255653982312, 4698.647601429838, 5009.273655320031, 5480.534154596904, 5600.523955463831, 4414.196984914538, 5227.947720522746, 5555.527780138734, 5560.19377190297, 5598.272224610774, 4475.865724028285, 4716.905661886812, 4882.92675609859, 5172.405173404956, 5693.772249109989, 4610.884727881696, 5222.529972302511, 5502.889942201214, 5576.972115139561, 5618.123494788583], "value": 3884.2219988776856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5793565924786, 703.9014537964689, 725.8366867454823, 771.4252881603206, 789.2738680414019, 14336.0, 15122.0, 15165.696686066285, 15167.469138580153, 15204.467843625474, 14362.353694083766, 14481.493147739831, 14482.85517144831, 14511.274436278196, 14518.491852785155, 650.4731167754135, 670.3665036540472, 804.7062822069961, 817.1215942861418, 836.9832603347929, 810.841885832263, 820.9220124088232, 843.3464065349342, 846.4836449765638, 847.1063028504925, 735.3455424672046, 763.7097902796929, 798.4131663227523, 861.1001503428901, 890.8574628059512, 778.3267473635321, 781.9335356494648, 839.7529668442359, 890.6081324217356, 894.0031864471133, 631.4790298004119, 633.9968300158516, 634.3244444666461, 656.0552803962279, 657.2737125476327, 14366.640833979129, 14562.344694488773, 14572.198529080897, 14620.926895365561, 14665.973381863274, 14319.928400357932, 14552.636184095481, 14555.0, 14568.562943111723, 14652.633684157874, 11716.179867409284, 11923.582674606434, 11927.821082683766, 11957.94021029898, 11969.401529923556, 3279.770416070876, 3736.630087512179, 3784.6593806557544, 3800.4869342638667, 3835.463035175078, 119734.0, 120553.5750891212, 120733.0, 120792.18811717832, 124844.0, 11080.671224362959, 11238.269512481662, 11320.0, 11361.204715669825, 11693.415329233505, 23128.959196836182, 23334.64998025031, 23381.7661823383, 23403.765962340498, 23426.0, 7394.519356241827, 7706.460547761603, 7782.766517004499, 7811.726589569452, 7942.205779422012, 4225.471816022997, 4290.506591741927, 4297.548757380492, 4310.245707001325, 4389.407429996973, 3462.272922686214, 3575.2491976685187, 3603.837827297778, 3606.441001644749, 3620.0587847159927, 669.4577392312243, 673.3569441183657, 675.864827034595, 675.9222689390684, 692.0760784352946, 565.8245943757448, 591.1635036423413, 606.4966078155121, 615.9106929495198, 621.8973869311513, 8417.452865563719, 9100.317476189311, 9103.635854565875, 9111.726648200565, 9186.356955013085, 575.4389470266541, 580.3847921203537, 611.736953110167, 617.5923890232425, 624.7313655128247, 4281.207976524353, 4395.450568678915, 4446.73319600825, 4484.730916145042, 4598.747068911175, 104324.0, 157420.42579574286, 163271.1836440834, 163274.18362908348, 163397.0, 143636.0, 144458.83311750332, 146298.2685086589, 146922.53077469303, 150814.0, 62572.687136564935, 71801.6409917947, 83334.0, 97376.0, 100193.49903250583, 9358.578863951003, 9893.604255829687, 9909.157721593745, 10077.244206684381, 10189.286749927434, 62054.37945620486, 62649.0, 63850.0, 64737.02894456681, 65886.0, 58752.0, 68698.31301686919, 91653.5417322909, 92910.0, 95781.08437831343, 12841.871581284442, 12927.482900683868, 13013.609591712264, 13124.343782811013, 13426.39581218867, 14618.0, 14672.413103475741, 14784.260786960394, 14866.702665946837, 15285.0, 13460.192388456724, 13590.450870166094, 13784.448622055406, 13870.861291386957, 14248.501302454364, 13229.140105893086, 13430.731385372042, 13614.455421783017, 13660.385282662503, 13685.726285474433, 11409.429528523706, 13385.464581416634, 13476.326183690971, 14058.507952221624, 14084.295785210494, 11168.66494005181, 11329.150313726668, 11450.141239407245, 11461.713457163638, 11910.583129590423, 8023.879641805261, 9823.21414286841, 11498.195126341076, 11551.90440627334, 11693.239939403911], "value": 7704.047012108701, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 121.0, 119.0, 119.0, 120.0, 119.0, 121.0, 121.0, 118.0, 98.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 117.0, 154.0, 118.0, 116.0, 119.0, 120.0, 149.0, 116.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 206.0, 229.0, 198.0, 200.0, 195.0, 187.0, 201.0, 207.0, 194.0], "value": 201.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 49.0, 62.0, 75.0, 78.0, 75.0, 83.0, 88.0, 99.0, 52.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 87.0, 74.0, 69.0, 72.0, 89.0, 72.0, 72.0, 89.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 105.0, 93.0, 93.0, 137.0, 133.0, 112.0, 89.0, 93.0, 90.0], "value": 103.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 105.0, 102.0, 101.0, 102.0, 102.0, 114.0, 101.0, 102.0, 137.0], "value": 106.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 144.0, 92.0, 91.0, 91.0, 90.0, 90.0, 93.0, 91.0, 92.0], "value": 98.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 59.0, 56.0, 57.0, 58.0, 59.0, 65.0, 78.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 75.0, 82.0, 80.0, 76.0, 70.0, 70.0, 70.0, 69.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 89.0, 88.0, 89.0, 87.0, 86.0, 89.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 159.0, 169.0, 175.0, 159.0, 153.0, 148.0, 182.0, 150.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 176.0, 171.0, 174.0, 177.0, 174.0, 175.0, 174.0, 173.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 81.0, 93.0, 91.0, 70.0, 76.0, 90.0, 90.0, 91.0], "value": 83.2, "unit": "score"}]}]} 05:52:57 INFO - Return code: 0 05:52:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:57 ERROR - # TBPL SUCCESS # 05:52:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:57 INFO - 2016-10-11 05:52:57.333 screenresolution[2017:14568] starting screenresolution argv=screenresolution get 05:52:57 INFO - 2016-10-11 05:52:57.336 screenresolution[2017:14568] Display 0: 1600x1200x32@60 05:52:57 INFO - 2016-10-11 05:52:57.342 screenresolution[2018:14571] starting screenresolution argv=screenresolution list 05:52:57 INFO - Available Modes on Display 0 05:52:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:57 INFO - Intel Iris: 05:52:57 INFO - Chipset Model: Intel Iris 05:52:57 INFO - Type: GPU 05:52:57 INFO - Bus: Built-In 05:52:57 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:57 INFO - Vendor: Intel (0x8086) 05:52:57 INFO - Device ID: 0x0a2e 05:52:57 INFO - Revision ID: 0x0009 05:52:57 INFO - Displays: 05:52:57 INFO - Display: 05:52:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:57 INFO - Display Serial Number: 1600x1200 60 05:52:57 INFO - Main Display: Yes 05:52:57 INFO - Mirror: Off 05:52:57 INFO - Online: Yes 05:52:57 INFO - Rotation: Supported 05:52:57 INFO - Return code: 0 05:52:57 INFO - Running post-action listener: _resource_record_post_action 05:52:57 INFO - [mozharness: 2016-10-11 12:52:57.584481Z] Finished run-tests step (success) 05:52:57 INFO - Running post-run listener: _resource_record_post_run 05:52:57 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 1528832; Write bytes: 708734976; Read time: 16; Write time: 2084 05:52:57 INFO - TinderboxPrint: CPU usage
54.6% 05:52:57 INFO - TinderboxPrint: I/O read bytes / time
1,528,832 / 16 05:52:57 INFO - TinderboxPrint: I/O write bytes / time
708,734,976 / 2,084 05:52:57 INFO - TinderboxPrint: CPU idle
2,196.1 (45.4%) 05:52:57 INFO - TinderboxPrint: CPU system
987.0 (20.4%) 05:52:57 INFO - TinderboxPrint: CPU user
1,658.7 (34.3%) 05:52:57 INFO - TinderboxPrint: Swap in / out
408,817,664 / 0 05:52:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 403962368; Write bytes: 398960640; Read time: 30870; Write time: 701 05:52:57 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 1475584; Write bytes: 296814592; Read time: 14; Write time: 1319 05:52:58 INFO - Running post-run listener: _upload_blobber_files 05:52:58 INFO - Blob upload gear active. 05:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:58 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 05:52:58 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:58 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:59 INFO - (blobuploader) - INFO - Done attempting. 05:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:00 INFO - (blobuploader) - INFO - Done attempting. 05:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:03 INFO - (blobuploader) - INFO - Done attempting. 05:53:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:03 INFO - Return code: 0 05:53:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0731cfc2ad0b2361c3eb39909f2375f2096d55005714db95a4099be1ee678f12120ed28543aeea82ad47deb0e86b359d44fc3cbae8ac00c7bf8bbe855234d79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b23f395691a865475aa1683eaf238d9e4eb755d7dd282467a39bb8bc46fe583fd40bb55e8d9d1673c25bf9b8774a4073b8a39e838eb032f76150065ab50ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2ba7c654ea87a9910a971205b981323c9ae2faa1093f554eedc3a3fac34661df5a08c5985804dc3f668bfe583d650bb720c8080fc012f3065b677a2356a789e"} 05:53:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:03 INFO - Contents: 05:53:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0731cfc2ad0b2361c3eb39909f2375f2096d55005714db95a4099be1ee678f12120ed28543aeea82ad47deb0e86b359d44fc3cbae8ac00c7bf8bbe855234d79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b23f395691a865475aa1683eaf238d9e4eb755d7dd282467a39bb8bc46fe583fd40bb55e8d9d1673c25bf9b8774a4073b8a39e838eb032f76150065ab50ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2ba7c654ea87a9910a971205b981323c9ae2faa1093f554eedc3a3fac34661df5a08c5985804dc3f668bfe583d650bb720c8080fc012f3065b677a2356a789e"} 05:53:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:03 INFO - Copying logs to upload dir... 05:53:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.951178 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-11 05:53:03.522975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:03.526241) ========= 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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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/Firefox/sha512/a0731cfc2ad0b2361c3eb39909f2375f2096d55005714db95a4099be1ee678f12120ed28543aeea82ad47deb0e86b359d44fc3cbae8ac00c7bf8bbe855234d79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b23f395691a865475aa1683eaf238d9e4eb755d7dd282467a39bb8bc46fe583fd40bb55e8d9d1673c25bf9b8774a4073b8a39e838eb032f76150065ab50ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2ba7c654ea87a9910a971205b981323c9ae2faa1093f554eedc3a3fac34661df5a08c5985804dc3f668bfe583d650bb720c8080fc012f3065b677a2356a789e"} build_url:https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0731cfc2ad0b2361c3eb39909f2375f2096d55005714db95a4099be1ee678f12120ed28543aeea82ad47deb0e86b359d44fc3cbae8ac00c7bf8bbe855234d79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b23f395691a865475aa1683eaf238d9e4eb755d7dd282467a39bb8bc46fe583fd40bb55e8d9d1673c25bf9b8774a4073b8a39e838eb032f76150065ab50ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2ba7c654ea87a9910a971205b981323c9ae2faa1093f554eedc3a3fac34661df5a08c5985804dc3f668bfe583d650bb720c8080fc012f3065b677a2356a789e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:03.558689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:03.559032) ========= 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.pbKIhbq8sW/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.7LmGXC28ZG/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005445 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:03.607659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 05:53:03.607999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 05:53:03.608335) ========= ========= Total master_lag: 0.17 =========