builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0169 starttime: 1470416726.01 results: success (0) buildid: 20160805080032 builduid: 8c4d3f9a03ef4815b821ae11b0617ac5 revision: 009c0f237a44d7882d0da85076c78252da6369b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.009664) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.010147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.010432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.204699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.205086) ========= 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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-08-05 10:05:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2016-08-05 10:05:26 (15.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.473800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.702144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.702455) ========= 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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.028877 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:26.752056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 10:05:26.752422) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 009c0f237a44d7882d0da85076c78252da6369b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 009c0f237a44d7882d0da85076c78252da6369b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ltzHNPwtKl/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.pbWyRDjTtM/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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-08-05 10:05:26,823 truncating revision to first 12 chars 2016-08-05 10:05:26,823 Setting DEBUG logging. 2016-08-05 10:05:26,823 attempt 1/10 2016-08-05 10:05:26,823 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/009c0f237a44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 10:05:27,477 unpacking tar archive at: autoland-009c0f237a44/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933630 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 10:05:27.883877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:27.884178) ========= script_repo_revision: 009c0f237a44d7882d0da85076c78252da6369b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:27.884606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:27.884915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 10:05:27.907562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-05 10:05:27.908095) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ltzHNPwtKl/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.pbWyRDjTtM/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:05:28 INFO - MultiFileLogger online at 20160805 10:05:28 in /builds/slave/test 10:05:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:05:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:28 INFO - {'append_to_log': False, 10:05:28 INFO - 'base_work_dir': '/builds/slave/test', 10:05:28 INFO - 'blob_upload_branch': 'Autoland', 10:05:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:28 INFO - 'branch': 'Autoland', 10:05:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:28 INFO - 'config_files': ('talos/mac_config.py',), 10:05:28 INFO - 'default_actions': ('clobber', 10:05:28 INFO - 'read-buildbot-config', 10:05:28 INFO - 'download-and-extract', 10:05:28 INFO - 'populate-webroot', 10:05:28 INFO - 'create-virtualenv', 10:05:28 INFO - 'install', 10:05:28 INFO - 'run-tests'), 10:05:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:28 INFO - 'download_minidump_stackwalk': True, 10:05:28 INFO - 'download_symbols': 'ondemand', 10:05:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:28 INFO - 'installer_path': 'installer.exe', 10:05:28 INFO - 'log_level': 'info', 10:05:28 INFO - 'log_name': 'talos', 10:05:28 INFO - 'log_to_console': True, 10:05:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:05:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:05:28 INFO - 'opt_config_files': (), 10:05:28 INFO - 'pip_index': False, 10:05:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:28 INFO - 'cmd': ('bash', 10:05:28 INFO - '-c', 10:05:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:28 INFO - 'enabled': True, 10:05:28 INFO - 'halt_on_failure': False, 10:05:28 INFO - 'name': 'check_screen_resolution'},), 10:05:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:28 INFO - 'cmd': ('bash', 10:05:28 INFO - '-c', 10:05:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:28 INFO - 'enabled': True, 10:05:28 INFO - 'halt_on_failure': False, 10:05:28 INFO - 'name': 'check_screen_resolution'},), 10:05:28 INFO - 'run_cmd_checks_enabled': True, 10:05:28 INFO - 'sps_profile': False, 10:05:28 INFO - 'sps_profile_interval': 0, 10:05:28 INFO - 'suite': 'dromaeojs-e10s', 10:05:28 INFO - 'system_bits': '32', 10:05:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:28 INFO - 'title': 't-yosemite-r7-0169', 10:05:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:28 INFO - 'use_talos_json': True, 10:05:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:28 INFO - 'work_dir': 'build'} 10:05:28 INFO - [mozharness: 2016-08-05 17:05:28.128384Z] Running clobber step. 10:05:28 INFO - Running pre-action listener: _resource_record_pre_action 10:05:28 INFO - Running main action method: clobber 10:05:28 INFO - rmtree: /builds/slave/test/build 10:05:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:30 INFO - Running post-action listener: _resource_record_post_action 10:05:30 INFO - [mozharness: 2016-08-05 17:05:30.289862Z] Finished clobber step (success) 10:05:30 INFO - [mozharness: 2016-08-05 17:05:30.290052Z] Running read-buildbot-config step. 10:05:30 INFO - Running pre-action listener: _resource_record_pre_action 10:05:30 INFO - Running main action method: read_buildbot_config 10:05:30 INFO - Using buildbot properties: 10:05:30 INFO - { 10:05:30 INFO - "project": "", 10:05:30 INFO - "product": "firefox", 10:05:30 INFO - "script_repo_revision": "production", 10:05:30 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 10:05:30 INFO - "repository": "", 10:05:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 10:05:30 INFO - "buildid": "20160805080032", 10:05:30 INFO - "pgo_build": "False", 10:05:30 INFO - "basedir": "/builds/slave/test", 10:05:30 INFO - "buildnumber": 105, 10:05:30 INFO - "slavename": "t-yosemite-r7-0169", 10:05:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:05:30 INFO - "platform": "yosemite_r7", 10:05:30 INFO - "scheduler": "tests-autoland-macosx64-talos", 10:05:30 INFO - "branch": "autoland", 10:05:30 INFO - "repo_path": "integration/autoland", 10:05:30 INFO - "revision": "009c0f237a44d7882d0da85076c78252da6369b0", 10:05:30 INFO - "stage_platform": "macosx64", 10:05:30 INFO - "builduid": "8c4d3f9a03ef4815b821ae11b0617ac5", 10:05:30 INFO - "slavebuilddir": "test" 10:05:30 INFO - } 10:05:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:05:30 INFO - Running post-action listener: _resource_record_post_action 10:05:30 INFO - [mozharness: 2016-08-05 17:05:30.295792Z] Finished read-buildbot-config step (success) 10:05:30 INFO - [mozharness: 2016-08-05 17:05:30.296003Z] Running download-and-extract step. 10:05:30 INFO - Running pre-action listener: _resource_record_pre_action 10:05:30 INFO - Running main action method: download_and_extract 10:05:30 INFO - mkdir: /builds/slave/test/build/tests 10:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:30 INFO - trying https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:05:30 INFO - Downloading https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 10:05:31 INFO - Downloaded 1199 bytes. 10:05:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:05:31 INFO - Using the following test package requirements: 10:05:31 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:05:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:05:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:05:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'jsshell-mac.zip'], 10:05:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:05:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:05:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:05:31 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:05:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:05:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:05:31 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:05:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:31 INFO - trying https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:05:31 INFO - Downloading https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:05:32 INFO - Downloaded 16320610 bytes. 10:05:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:05:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:39 INFO - trying https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:05:39 INFO - Downloading https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:05:40 INFO - Downloaded 16320610 bytes. 10:05:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:46 INFO - trying https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:05:46 INFO - Downloading https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:05:47 INFO - Downloaded 14413723 bytes. 10:05:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:48 INFO - trying https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:05:48 INFO - Downloading https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 10:05:51 INFO - Downloaded 111435659 bytes. 10:05:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:05:51 INFO - mkdir: /builds/slave/test/properties 10:05:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:51 INFO - Contents: 10:05:51 INFO - build_url:https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:05:51 INFO - Running post-action listener: _resource_record_post_action 10:05:51 INFO - Running post-action listener: set_extra_try_arguments 10:05:51 INFO - [mozharness: 2016-08-05 17:05:51.812505Z] Finished download-and-extract step (success) 10:05:51 INFO - [mozharness: 2016-08-05 17:05:51.812651Z] Running populate-webroot step. 10:05:51 INFO - Running pre-action listener: _resource_record_pre_action 10:05:51 INFO - Running main action method: populate_webroot 10:05:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:51 INFO - '--tppagecycles', 10:05:51 INFO - '7'], 10:05:51 INFO - 'tests': ['tsvgm']}}, 10:05:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['damp', 'tps']}, 10:05:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'tests': ['damp', 'tps']}, 10:05:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['dromaeo_dom']}, 10:05:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['basic_compositor_video']}, 10:05:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['a11yr', 10:05:51 INFO - 'ts_paint', 10:05:51 INFO - 'tpaint', 10:05:51 INFO - 'sessionrestore', 10:05:51 INFO - 'sessionrestore_no_auto_restore', 10:05:51 INFO - 'tabpaint']}, 10:05:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:51 INFO - 'ts_paint', 10:05:51 INFO - 'tpaint', 10:05:51 INFO - 'sessionrestore', 10:05:51 INFO - 'sessionrestore_no_auto_restore', 10:05:51 INFO - 'tabpaint']}, 10:05:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:51 INFO - 'ts_paint', 10:05:51 INFO - 'tpaint', 10:05:51 INFO - 'sessionrestore', 10:05:51 INFO - 'sessionrestore_no_auto_restore', 10:05:51 INFO - 'tabpaint']}, 10:05:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:51 INFO - 'ts_paint', 10:05:51 INFO - 'tpaint', 10:05:51 INFO - 'sessionrestore', 10:05:51 INFO - 'sessionrestore_no_auto_restore', 10:05:51 INFO - 'tabpaint']}, 10:05:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['a11yr', 10:05:51 INFO - 'ts_paint', 10:05:51 INFO - 'tpaint', 10:05:51 INFO - 'sessionrestore', 10:05:51 INFO - 'sessionrestore_no_auto_restore', 10:05:51 INFO - 'tabpaint']}, 10:05:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['a11yr', 10:05:51 INFO - 'ts_paint', 10:05:51 INFO - 'tpaint', 10:05:51 INFO - 'sessionrestore', 10:05:51 INFO - 'sessionrestore_no_auto_restore', 10:05:51 INFO - 'tabpaint']}, 10:05:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['tsvgx', 10:05:51 INFO - 'tsvgr_opacity', 10:05:51 INFO - 'tart', 10:05:51 INFO - 'tscrollx', 10:05:51 INFO - 'cart']}, 10:05:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:51 INFO - 'tsvgr_opacity', 10:05:51 INFO - 'tart', 10:05:51 INFO - 'tscrollx', 10:05:51 INFO - 'cart']}, 10:05:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'talos_options': ['--disable-e10s'], 10:05:51 INFO - 'tests': ['tp5o']}, 10:05:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'tests': ['tp5o']}, 10:05:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'talos_options': ['--disable-e10s', 10:05:51 INFO - '--xperf_path', 10:05:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:51 INFO - 'tests': ['tp5n']}, 10:05:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:51 INFO - 'talos_options': ['--xperf_path', 10:05:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:51 INFO - 'tests': ['tp5n']}}, 10:05:51 INFO - 'talos.zip': {'path': '', 10:05:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:51 INFO - Running post-action listener: _resource_record_post_action 10:05:51 INFO - [mozharness: 2016-08-05 17:05:51.830984Z] Finished populate-webroot step (success) 10:05:51 INFO - [mozharness: 2016-08-05 17:05:51.831112Z] Running create-virtualenv step. 10:05:51 INFO - Running pre-action listener: _resource_record_pre_action 10:05:51 INFO - Running main action method: create_virtualenv 10:05:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:05:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:51 INFO - Using real prefix '/tools/python27' 10:05:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:55 INFO - Installing pip.................done. 10:05:55 INFO - Return code: 0 10:05:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:55 INFO - 'HOME': '/Users/cltbld', 10:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:55 INFO - 'LOGNAME': 'cltbld', 10:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:55 INFO - 'MOZ_NO_REMOTE': '1', 10:05:55 INFO - 'NO_EM_RESTART': '1', 10:05:55 INFO - 'PAGER': '/bin/cat', 10:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:55 INFO - 'PWD': '/builds/slave/test', 10:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:55 INFO - 'SHELL': '/bin/bash', 10:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:05:55 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:55 INFO - 'USER': 'cltbld', 10:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:55 INFO - 'XPC_FLAGS': '0x0', 10:05:55 INFO - 'XPC_SERVICE_NAME': '0', 10:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:05:55 INFO - Cleaning up... 10:05:55 INFO - Return code: 0 10:05:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:55 INFO - 'HOME': '/Users/cltbld', 10:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:55 INFO - 'LOGNAME': 'cltbld', 10:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:55 INFO - 'MOZ_NO_REMOTE': '1', 10:05:55 INFO - 'NO_EM_RESTART': '1', 10:05:55 INFO - 'PAGER': '/bin/cat', 10:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:55 INFO - 'PWD': '/builds/slave/test', 10:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:55 INFO - 'SHELL': '/bin/bash', 10:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:05:55 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:55 INFO - 'USER': 'cltbld', 10:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:55 INFO - 'XPC_FLAGS': '0x0', 10:05:55 INFO - 'XPC_SERVICE_NAME': '0', 10:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:56 INFO - Downloading/unpacking psutil>=3.1.1 10:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:59 INFO - Installing collected packages: psutil 10:05:59 INFO - Running setup.py install for psutil 10:05:59 INFO - building 'psutil._psutil_osx' extension 10:05:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:06:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:06:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:06:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:06:00 INFO - building 'psutil._psutil_posix' extension 10:06:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:06:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:06:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:06:00 INFO - ^ 10:06:00 INFO - 1 warning generated. 10:06:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:00 INFO - Successfully installed psutil 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:00 INFO - 'HOME': '/Users/cltbld', 10:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:00 INFO - 'LOGNAME': 'cltbld', 10:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:00 INFO - 'MOZ_NO_REMOTE': '1', 10:06:00 INFO - 'NO_EM_RESTART': '1', 10:06:00 INFO - 'PAGER': '/bin/cat', 10:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:00 INFO - 'PWD': '/builds/slave/test', 10:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:00 INFO - 'SHELL': '/bin/bash', 10:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:00 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:00 INFO - 'USER': 'cltbld', 10:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:00 INFO - 'XPC_FLAGS': '0x0', 10:06:00 INFO - 'XPC_SERVICE_NAME': '0', 10:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:03 INFO - Installing collected packages: mozsystemmonitor 10:06:03 INFO - Running setup.py install for mozsystemmonitor 10:06:03 INFO - Successfully installed mozsystemmonitor 10:06:03 INFO - Cleaning up... 10:06:03 INFO - Return code: 0 10:06:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:03 INFO - 'HOME': '/Users/cltbld', 10:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:03 INFO - 'LOGNAME': 'cltbld', 10:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:03 INFO - 'MOZ_NO_REMOTE': '1', 10:06:03 INFO - 'NO_EM_RESTART': '1', 10:06:03 INFO - 'PAGER': '/bin/cat', 10:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:03 INFO - 'PWD': '/builds/slave/test', 10:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:03 INFO - 'SHELL': '/bin/bash', 10:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:03 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:03 INFO - 'USER': 'cltbld', 10:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:03 INFO - 'XPC_FLAGS': '0x0', 10:06:03 INFO - 'XPC_SERVICE_NAME': '0', 10:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:04 INFO - Downloading/unpacking jsonschema==2.5.1 10:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:06 INFO - warning: no files found matching '*.txt' 10:06:06 INFO - no previously-included directories found matching 'build' 10:06:06 INFO - no previously-included directories found matching 'dist' 10:06:06 INFO - no previously-included directories found matching '.git*' 10:06:06 INFO - Installing collected packages: jsonschema, functools32 10:06:06 INFO - Running setup.py install for functools32 10:06:07 INFO - warning: no files found matching '*.txt' 10:06:07 INFO - no previously-included directories found matching 'build' 10:06:07 INFO - no previously-included directories found matching 'dist' 10:06:07 INFO - no previously-included directories found matching '.git*' 10:06:07 INFO - Successfully installed jsonschema functools32 10:06:07 INFO - Cleaning up... 10:06:07 INFO - Return code: 0 10:06:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:07 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:07 INFO - 'HOME': '/Users/cltbld', 10:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:07 INFO - 'LOGNAME': 'cltbld', 10:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:07 INFO - 'MOZ_NO_REMOTE': '1', 10:06:07 INFO - 'NO_EM_RESTART': '1', 10:06:07 INFO - 'PAGER': '/bin/cat', 10:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:07 INFO - 'PWD': '/builds/slave/test', 10:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:07 INFO - 'SHELL': '/bin/bash', 10:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:07 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:07 INFO - 'USER': 'cltbld', 10:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:07 INFO - 'XPC_FLAGS': '0x0', 10:06:07 INFO - 'XPC_SERVICE_NAME': '0', 10:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:07 INFO - Cleaning up... 10:06:07 INFO - Return code: 0 10:06:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:07 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:07 INFO - 'HOME': '/Users/cltbld', 10:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:07 INFO - 'LOGNAME': 'cltbld', 10:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:07 INFO - 'MOZ_NO_REMOTE': '1', 10:06:07 INFO - 'NO_EM_RESTART': '1', 10:06:07 INFO - 'PAGER': '/bin/cat', 10:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:07 INFO - 'PWD': '/builds/slave/test', 10:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:07 INFO - 'SHELL': '/bin/bash', 10:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:07 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:07 INFO - 'USER': 'cltbld', 10:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:07 INFO - 'XPC_FLAGS': '0x0', 10:06:07 INFO - 'XPC_SERVICE_NAME': '0', 10:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - Downloading docopt-0.6.1.tar.gz 10:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:11 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:11 INFO - Running setup.py install for blobuploader 10:06:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:11 INFO - Running setup.py install for requests 10:06:12 INFO - Running setup.py install for docopt 10:06:12 INFO - Successfully installed blobuploader requests docopt 10:06:12 INFO - Cleaning up... 10:06:12 INFO - Return code: 0 10:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:12 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:12 INFO - 'HOME': '/Users/cltbld', 10:06:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:12 INFO - 'LOGNAME': 'cltbld', 10:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:12 INFO - 'MOZ_NO_REMOTE': '1', 10:06:12 INFO - 'NO_EM_RESTART': '1', 10:06:12 INFO - 'PAGER': '/bin/cat', 10:06:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:12 INFO - 'PWD': '/builds/slave/test', 10:06:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:12 INFO - 'SHELL': '/bin/bash', 10:06:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:12 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:12 INFO - 'USER': 'cltbld', 10:06:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:12 INFO - 'XPC_FLAGS': '0x0', 10:06:12 INFO - 'XPC_SERVICE_NAME': '0', 10:06:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-EF1Txh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-eRHhv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ZBBxQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-NyuC5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:12 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-JANVI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-CaedrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-KqI54m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-YNvet4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-VKlOOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-6xYLjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-J58mZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-zl9Z4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-0hrSuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:13 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-l2JGpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-8zkyz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-OvMvLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:14 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-OExTDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:14 INFO - Running setup.py install for manifestparser 10:06:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozcrash 10:06:14 INFO - Running setup.py install for mozdebug 10:06:14 INFO - Running setup.py install for mozdevice 10:06:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:14 INFO - Running setup.py install for mozfile 10:06:15 INFO - Running setup.py install for mozhttpd 10:06:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Running setup.py install for mozinfo 10:06:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Running setup.py install for mozInstall 10:06:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Running setup.py install for mozleak 10:06:15 INFO - Running setup.py install for mozlog 10:06:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Running setup.py install for moznetwork 10:06:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:15 INFO - Running setup.py install for mozprocess 10:06:16 INFO - Running setup.py install for mozprofile 10:06:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:16 INFO - Running setup.py install for mozrunner 10:06:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:16 INFO - Running setup.py install for mozscreenshot 10:06:16 INFO - Running setup.py install for moztest 10:06:16 INFO - Running setup.py install for mozversion 10:06:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:16 INFO - Cleaning up... 10:06:16 INFO - Return code: 0 10:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:16 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:16 INFO - 'HOME': '/Users/cltbld', 10:06:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:16 INFO - 'LOGNAME': 'cltbld', 10:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:16 INFO - 'MOZ_NO_REMOTE': '1', 10:06:16 INFO - 'NO_EM_RESTART': '1', 10:06:16 INFO - 'PAGER': '/bin/cat', 10:06:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:16 INFO - 'PWD': '/builds/slave/test', 10:06:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:16 INFO - 'SHELL': '/bin/bash', 10:06:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:16 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:16 INFO - 'USER': 'cltbld', 10:06:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:16 INFO - 'XPC_FLAGS': '0x0', 10:06:16 INFO - 'XPC_SERVICE_NAME': '0', 10:06:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-D7mRNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-c6LZVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:17 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)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-pxY5SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-qHhRmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-w6Cjib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-lLwmXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Z52FCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-xnwO2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:17 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-73EgIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-4eNzmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-4zQWPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ehFHrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-9r_D3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Yoa_Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:18 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)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-OZUWQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-gSGRj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:18 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)) 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:18 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-KWR0PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:06:18 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)) 10:06:18 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)) 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:21 INFO - Downloading blessings-1.6.tar.gz 10:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:21 INFO - Installing collected packages: blessings 10:06:21 INFO - Running setup.py install for blessings 10:06:21 INFO - Successfully installed blessings 10:06:21 INFO - Cleaning up... 10:06:21 INFO - Return code: 0 10:06:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:22 INFO - Reading from file tmpfile_stdout 10:06:22 INFO - Current package versions: 10:06:22 INFO - blessings == 1.6 10:06:22 INFO - blobuploader == 1.2.4 10:06:22 INFO - docopt == 0.6.1 10:06:22 INFO - functools32 == 3.2.3-2 10:06:22 INFO - jsonschema == 2.5.1 10:06:22 INFO - manifestparser == 1.1 10:06:22 INFO - mozInstall == 1.12 10:06:22 INFO - mozcrash == 0.17 10:06:22 INFO - mozdebug == 0.1 10:06:22 INFO - mozdevice == 0.48 10:06:22 INFO - mozfile == 1.2 10:06:22 INFO - mozhttpd == 0.7 10:06:22 INFO - mozinfo == 0.9 10:06:22 INFO - mozleak == 0.1 10:06:22 INFO - mozlog == 3.3 10:06:22 INFO - moznetwork == 0.27 10:06:22 INFO - mozprocess == 0.23 10:06:22 INFO - mozprofile == 0.28 10:06:22 INFO - mozrunner == 6.12 10:06:22 INFO - mozscreenshot == 0.1 10:06:22 INFO - mozsystemmonitor == 0.3 10:06:22 INFO - moztest == 0.7 10:06:22 INFO - mozversion == 1.4 10:06:22 INFO - psutil == 3.1.1 10:06:22 INFO - requests == 1.2.3 10:06:22 INFO - wsgiref == 0.1.2 10:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:22 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:22 INFO - 'HOME': '/Users/cltbld', 10:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:22 INFO - 'LOGNAME': 'cltbld', 10:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:22 INFO - 'MOZ_NO_REMOTE': '1', 10:06:22 INFO - 'NO_EM_RESTART': '1', 10:06:22 INFO - 'PAGER': '/bin/cat', 10:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:22 INFO - 'PWD': '/builds/slave/test', 10:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:22 INFO - 'SHELL': '/bin/bash', 10:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:22 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:22 INFO - 'USER': 'cltbld', 10:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:22 INFO - 'XPC_FLAGS': '0x0', 10:06:22 INFO - 'XPC_SERVICE_NAME': '0', 10:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:06:22 INFO - Cleaning up... 10:06:22 INFO - Return code: 0 10:06:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:22 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 0x10af1ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afb0618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4b58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, '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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:22 INFO - 'HOME': '/Users/cltbld', 10:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:22 INFO - 'LOGNAME': 'cltbld', 10:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:22 INFO - 'MOZ_NO_REMOTE': '1', 10:06:22 INFO - 'NO_EM_RESTART': '1', 10:06:22 INFO - 'PAGER': '/bin/cat', 10:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:22 INFO - 'PWD': '/builds/slave/test', 10:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:22 INFO - 'SHELL': '/bin/bash', 10:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:22 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:22 INFO - 'USER': 'cltbld', 10:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:22 INFO - 'XPC_FLAGS': '0x0', 10:06:22 INFO - 'XPC_SERVICE_NAME': '0', 10:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:22 INFO - Cleaning up... 10:06:22 INFO - Return code: 0 10:06:22 INFO - Running post-action listener: _resource_record_post_action 10:06:22 INFO - Running post-action listener: _start_resource_monitoring 10:06:22 INFO - Starting resource monitoring. 10:06:22 INFO - [mozharness: 2016-08-05 17:06:22.582546Z] Finished create-virtualenv step (success) 10:06:22 INFO - [mozharness: 2016-08-05 17:06:22.583505Z] Running install step. 10:06:22 INFO - Running pre-action listener: _resource_record_pre_action 10:06:22 INFO - Running main action method: install 10:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:22 INFO - Reading from file tmpfile_stdout 10:06:22 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:22 INFO - Reading from file tmpfile_stdout 10:06:22 INFO - Output received: 10:06:22 INFO - Usage: mozinstall [options] installer 10:06:22 INFO - Options: 10:06:22 INFO - -h, --help show this help message and exit 10:06:22 INFO - -d DEST, --destination=DEST 10:06:22 INFO - Directory to install application into. [default: 10:06:22 INFO - "/builds/slave/test"] 10:06:22 INFO - --app=APP Application being installed. [default: firefox] 10:06:22 INFO - mkdir: /builds/slave/test/build/application 10:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:06:57 INFO - Reading from file tmpfile_stdout 10:06:57 INFO - Output received: 10:06:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:06:57 INFO - Running post-action listener: _resource_record_post_action 10:06:57 INFO - [mozharness: 2016-08-05 17:06:57.117750Z] Finished install step (success) 10:06:57 INFO - [mozharness: 2016-08-05 17:06:57.117922Z] Running run-tests step. 10:06:57 INFO - Running pre-action listener: _resource_record_pre_action 10:06:57 INFO - Running main action method: run_tests 10:06:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:57 INFO - 2016-08-05 10:06:57.132 screenresolution[1646:7645] starting screenresolution argv=screenresolution get 10:06:57 INFO - 2016-08-05 10:06:57.135 screenresolution[1646:7645] Display 0: 1600x1200x32@60 10:06:57 INFO - 2016-08-05 10:06:57.140 screenresolution[1647:7647] starting screenresolution argv=screenresolution list 10:06:57 INFO - Available Modes on Display 0 10:06:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:57 INFO - Intel Iris: 10:06:57 INFO - Chipset Model: Intel Iris 10:06:57 INFO - Type: GPU 10:06:57 INFO - Bus: Built-In 10:06:57 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:57 INFO - Vendor: Intel (0x8086) 10:06:57 INFO - Device ID: 0x0a2e 10:06:57 INFO - Revision ID: 0x0009 10:06:57 INFO - Displays: 10:06:57 INFO - Display: 10:06:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:57 INFO - Display Serial Number: 1600x1200 60 10:06:57 INFO - Main Display: Yes 10:06:57 INFO - Mirror: Off 10:06:57 INFO - Online: Yes 10:06:57 INFO - Rotation: Supported 10:06:57 INFO - Return code: 0 10:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:57 INFO - Python 2.7.3 10:06:57 INFO - Return code: 0 10:06:57 INFO - grabbing minidump binary from tooltool 10:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:57 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 0x10ae7fd30>, '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 0x10abe4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae77b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:06:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:06:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:06:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:57 INFO - Return code: 0 10:06:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:06:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:06:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:06:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ltzHNPwtKl/Render', 10:06:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:57 INFO - 'HOME': '/Users/cltbld', 10:06:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:57 INFO - 'LOGNAME': 'cltbld', 10:06:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:57 INFO - 'MOZ_NO_REMOTE': '1', 10:06:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:57 INFO - 'NO_EM_RESTART': '1', 10:06:57 INFO - 'PAGER': '/bin/cat', 10:06:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:57 INFO - 'PWD': '/builds/slave/test', 10:06:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:57 INFO - 'SHELL': '/bin/bash', 10:06:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pbWyRDjTtM/Listeners', 10:06:57 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 10:06:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:57 INFO - 'USER': 'cltbld', 10:06:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:57 INFO - 'XPC_FLAGS': '0x0', 10:06:57 INFO - 'XPC_SERVICE_NAME': '0', 10:06:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:06:57 INFO - mozversion application_buildid: 20160805080032 10:06:57 INFO - mozversion application_changeset: 009c0f237a44d7882d0da85076c78252da6369b0 10:06:57 INFO - mozversion application_display_name: Nightly 10:06:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:57 INFO - mozversion application_name: Firefox 10:06:57 INFO - mozversion application_remotingname: firefox 10:06:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:06:57 INFO - mozversion application_vendor: Mozilla 10:06:57 INFO - mozversion application_version: 51.0a1 10:06:57 INFO - mozversion platform_buildid: 20160805080032 10:06:57 INFO - mozversion platform_changeset: 009c0f237a44d7882d0da85076c78252da6369b0 10:06:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:06:57 INFO - mozversion platform_version: 51.0a1 10:06:57 INFO - using testdate: 1470416817 10:06:57 INFO - actual date: 1470416817 10:06:57 INFO - starting webserver on 'localhost:49267' 10:06:57 INFO - SUITE-START | Running 2 tests 10:06:57 INFO - TEST-START | dromaeo_css 10:06:57 INFO - operating with platform_type : mac_ 10:06:57 INFO - Initialising browser for dromaeo_css test... 10:06:57 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpnMSYnh/profile http://localhost:49267/getInfo.html) 10:07:00 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 10:07:00 INFO - PROCESS | 1657 | colorDepth:24 10:07:00 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 10:07:00 INFO - PROCESS | 1657 | __metrics 10:07:00 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:07:01 INFO - TEST-INFO | 1657: exit 0 10:07:01 INFO - Browser initialized. 10:07:01 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:01 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpnMSYnh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:13 INFO - PROCESS | 1660 | RSS: Main: 254926848 10:07:13 INFO - PROCESS | 1660 | 10:08:03 INFO - PROCESS | 1660 | 1470416883310 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] 10:10:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 10:10:17 INFO - PROCESS | 1660 | RSS: Main: 269475840 10:10:17 INFO - PROCESS | 1660 | 10:13:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 10:13:20 INFO - PROCESS | 1660 | RSS: Main: 282013696 10:13:20 INFO - PROCESS | 1660 | 10:16:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 10:16:22 INFO - PROCESS | 1660 | RSS: Main: 290390016 10:16:22 INFO - PROCESS | 1660 | 10:19:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 10:19:25 INFO - PROCESS | 1660 | RSS: Main: 288940032 10:19:25 INFO - PROCESS | 1660 | 10:22:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 10:22:28 INFO - PROCESS | 1660 | RSS: Main: 293822464 10:22:28 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 10:25:31 INFO - PROCESS | 1660 | RSS: Main: 294125568 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | __start_tp_report 10:25:31 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 10:25:31 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 10:25:31 INFO - PROCESS | 1660 | |i|pagename|runs| 10:25:31 INFO - PROCESS | 1660 | |0;dojo.html;3321.568196134502;3395.270016946356;3442.3803715331246;3449;3477.6522347765217;5741.45456181662;5749.798757043504;5761;5774;5895.85260368491;4771.9761401192945;5824.417558244173;5833.183354330397;5858.677772722509;5914.935311643902;5227.764750586214;5347.839564813062;5357.946420535804;5413.864653383677;5458.072127738294;5416.91874621881;5449.945500544984;5468.453154684519;5476.890462190754;5518.255035570187;5280.102382594968;5308.973455132699;5327.840164795062;5354.705491197982;5356.1430171172815;3927.9214415711526;5185.7294962733995;5341.278927344836;5344.518993290583;5413.593980451443;5239.292695486099;5239.345081864767;5316.468353164652;5319.680819150824;5362.758675859557;4131.566185550504;5079.746012699387;5758.971205143947;5837.211976383176;5845.123231515264;6188.783392581238;6235.719392627343;6269.780557680459;6296.464800491918;6320.051992201206;6285.465735412496;6316.873662526769;6322.52581056418;6327.905081423783;6329.493640508748;5838.503727183237;5917;5943.108533719977;6001.699915004232;6015.699215039231;6464.482841372679;6481.319461456479;6483.09236706852;6497.155369801895;6498.3826536478955;6064.818055458343;6125.693715314305;6146.078088286793;6149.354317796567;6159.96920015406;6092.145434360276;6099.340048628031;6157.107219453154;6203.7828675996125;6287.2140982377205;6179.196704428486;6184.907226391608;6195.566310358232;6196.039613859859;6205.47253483459;5865.797511510215;6179.876402472015;6236.438720515175;6256.217972753406;6262.248530176408;4547.3406356078185;4918.975405122951;4953.900921981613;4974.0051989602225;4984.40187177541;4442.800073996678;4481.686281960231;4483.170613436525;4486.932696009562;4507.684462087688;5822.7670893163795;5917.940820591739;5923.08192230205;5933.614315069507;5960.0165972614905;5321.175217841241;6117.827404800917;6118.20463339763;6195.907061394083;6271.874562508816;4885.389326334208;4909.337239472626;5946.494547963472;5951.5238780897425;5981.581289309794;4722.504137065559;5540.86147846299;5557.305336832896;5573.860653483695;5575.609707320448;6306.716197771111;6398.232212134573;6430.260520040255;6447.451966582706;6516.185476815398;6168.290646575521;6282.3089460158435;6290.308066112815;6301.6534090625455;6367.458766004941;5062.063518249136;6354.904676429765;6483.157189565515;6500.317466666121;6533.8693226136165;5653.3498647654405;5703.973284808774;6143.235544005126;6156.846078848064;6172.598781079216;6258.624482531062;6266.937330626635;6273.153124328157;6285.685715714105;6292.748290068529;5406.24312596229;6223.91498847891;6245.718942647501;6267.435930766253;6272.278687950944;5119.436861945109;6137.775380989496;6172.876542469216;6204.100405441276;6231.2522497300615;4999.675021123615;6155.507559395327;6167.506599471942;6169.84575385619;6188.938110618837;6203.503719702323;6257.4994000480765;6259.687015649109;6260.843478913063;6280.5289603279025;5991.430814072656;6114.113453549299;6128.350350989301;6135.722664536794;6159.19930409044 10:25:31 INFO - PROCESS | 1660 | |1;ext.html;464.3104989091201;485.2187977356456;505.25727181043874;522.4749127127236;529.4784637132424;30191.094267171993;40979.79510102453;41032;41142.17715645689;41146.99999999996;42194.57805421945;42614.786926065324;42684.71945841622;42706.57293427065;42847.78576107123;9711.22310215183;9902.603895844157;9941.304108712393;9951.253655975795;9970.850437243447;9814.362066465692;9878.506074696272;9935.751606209831;9941.502924853765;9965.252606054539;9883.406995580252;9900.653477128302;9919.950400247988;9941.055599718014;9994.9500252499;8341.165883411672;9872.555734991942;9874.901250987507;9888.95055524725;9954.153896918771;8272.37957153216;9676.806463870753;9807.803843923082;9827;9831.262655300881;40057.39913901294;40354;40439.595604043876;40470;40610.79694601508;2805.2846524136417;3084.784065115443;3148.590683211191;3266.477363621809;3491.354099491602;23996.560206387672;29719.108426747232;29880.85059574688;30727.231819204477;31102.688973110206;3146.9685303146903;3156.384505021522;3162.16202706283;3165.5409965554863;3243.367543329052;398272.0172798293;429822;445136;446648;449740;34169.97490075302;34262.82868585641;34289;34350.65649343524;34404.65595344065;30140;35260.41328140189;35492.46761298583;35533;36146.27707445836;16167;16288;16526.83473165277;16598.419055333005;16654.333826646798;12453;12685.619431417072;12817.807732884014;12826.486940522274;12834.973202143807;19433.22267109328;19469.369311213086;19533.609327813363;19622.60754784925;19676.803231967497;6910.818954532536;7882.369410447151;7893.763187104396;7932.484388514728;7988.520688758693;862.0216054777873;909.4725059465494;1000.9649662261786;1022.0648106982028;1063.197286049028;23882.044718211426;29345.559816602767;29348.97278595239;30937;31479.52780708291;1004.1063453526367;1095.8191898336686;1110.4847520366377;1110.744528758374;1218.9817152742717;12923.612291631267;15878.364865405485;16220.188990550425;16249.187540622921;16337.509874703777;160233;160848.19575902278;161421.89335799628;161913;162500.1874990641;59387;59632;60080.79838403295;60432.093518597256;60591;1338.1903948111253;1358.8641135886332;1368.1996032321006;1388.0699931046022;1393.004002138476;30374.696253037186;30576.388472230876;30642.693573063985;31061.22346941254;31299;52572.73713631407;52734;52752.73623632011;52864.735676321376;53003.20495192498;553421;561175;562546;563338;563932;26134.34664133412;27041.323966900985;27357.45285094247;27665.723342766316;27772.583411248444;49348;49871;50252.748736256086;50445;50511.24233136432;30823.537646934867;34354;40364.19271614493;41234.587654123075;42064.78967605143;39958;40450.797746011085;40505;41272.380914285706;41532.37701434542;38505.6149438502;39573.80213098916;40001.39997900092;40055.39916901191;40130.59869401269;33398.33203335871;35304.29391412106;35976.460353094204;36007;36020.919372418866;25614.359641009123;26130.216093517225;26449.94200231969;26525.734742653098;27063.594046088932 10:25:31 INFO - PROCESS | 1660 | |2;jquery.html;324.7191179629621;382.6460524015286;383.91170030892886;394.924964256791;407.03938704657;15872.523824285261;19600.411987640393;19618.607627847436;20548.38354849355;21154.365369038915;20186.49533761657;20522;21216.8939155304;21556.784432155673;21692.132314707393;5374;5552.111662134039;6052.818415447521;6187;6238.407351301642;4680.508546602592;5152.201408781626;6055.576109672303;6075.149479072933;6181.752729890822;5897.20387747655;6024.7288872000645;6077.361877002917;6084.908726369108;6147.170132032164;5963.642181469126;6017.458428741435;6018.789342372996;6090.908636370458;6131.110988906628;4449.199144154051;5189.273501709764;5280.392754833205;5311.521963023347;5352.090144675414;25694.74305256942;25999.480010399875;26049.088281910233;26313.631773140318;26415;2135.29535253366;2264.3772962435464;2315.791578757903;2390.9163179288817;2412.9517409651885;13173.341332933314;14489.623485768836;15642.921785391114;15862.603434914105;16212.513624591282;1884.9905750471296;1936.3803582853493;1958.7845337012918;1971.221367559806;1999.600079984009;102739;104628;104890.47554762254;105232;105751;8694.739157825275;10507.422091785025;10532;11065.059469944983;11206.887931120747;13518.39167237457;13688.65778355549;13755.587332380044;13762.793558096637;13814.240216787972;8396;8664.781870305615;8698.34762392823;8792.032876383593;8809.42738721981;8128.349732021424;8683.522406267715;8751.64993400257;8758.781030474289;8777.473351598925;5500.339959204841;5737.426257374229;6722.529422940445;6760.18877734675;6837.965810170917;1541.6223025358859;1589.4278059898427;1815.8002619711822;1843.787964384086;1845.280340667141;853.2593509241078;882.1927935938544;888.1518150166576;922.9077092290718;994.6419289055934;21536.246231381825;22107.889460552593;22203.444913877283;22237.888810555844;22296.66555001676;955.5699935029264;957.6169532187181;971.8785151856018;993.3146129170849;1074.8119079161115;9196.75843761097;11084.889151108548;11388;11818.527258909719;11946.940265298617;556111;559679;565732;571595;572017;106279;107721.46139269254;107982.46008769906;110150.44924775485;111946.44026779814;980.1032055669126;1023.6417253961054;1078.0513148429332;1097.7145942055124;1100.6422912553292;15301.6174595636;19375.3218637347;19467.415977520697;19636.803631963496;19645.11596978168;32754;43500.56499435092;44541.777291113336;44602.55397446114;44892.77553612211;58319.08404579669;66945.66527167527;67161;67328.66335668486;67403.65192696216;6962.23415424313;7315.561066336037;8083;8269.338452923872;8331.041930178108;11447.713807154554;12951.740965180832;13162.934185329012;13714.65713357174;13742.312884355542;11328.433578321215;11467.369294688871;11525.193236473366;11803.291802491878;11880.752520985172;11248.325100493996;11340.829887551528;11531.481083351102;11570.76858462843;11706.824397634213;11472.369019703996;11662.416879156179;11936.52253909834;11954.222975506564;12000.939995299968;8026.638801254075;8248.958755206186;8262.091169971418;8318.417710760188;8390.958045209734;8714.564271786512;10994.780104398027;11425.31448113116;11525.193236473366;11567.826482602935 10:25:31 INFO - PROCESS | 1660 | |3;mootools.html;1506.8493150684928;1527.5646440764383;1675.0368538090602;1736.782902137233;1838.6322735452914;7854.764357069297;8173.877391839127;8282.875756863645;8843.469391836494;8880.023197448292;8269.25576698097;8462.323014158852;8558.186972237643;8558.40091193615;8603.956980215105;2301.608726516492;2363.409147713072;2367.3844800351944;2371.1819422299363;2373.5727569037567;2329.3244958961964;2347.565700345433;2365.077619728307;2366.6213405855065;2367.715874095111;2333.894974726133;2355.187460326193;2361.5867223235864;2376.4415362389823;2380.702412198475;2326.6161083421216;2345.9530809383887;2346.577616029114;2347.80043696286;2364.7280562735164;2323.163661082026;2326.0230703104735;2326.651002349661;2341.9297421077395;2344.5310937812337;7364.153122390887;7519.759239725438;8662.220400163953;8669.959604847396;8743.868841967376;4184.267753143218;5218.1129208034345;5285.286486324336;5291.788328466857;5297.12597421425;3400.404929137416;3573.428251479777;3607.783532988029;3631.7276204284785;3639.872604458831;1052.1740433759462;1071.314358810362;1090.6946055104584;1103.9944800276028;1107.2304748200004;11312.717182070513;11354.886451135466;11424.371659558721;11503.827442588368;11544.365059921702;4498.415206023196;4563.429571303587;4756.262779269219;4756.453007904066;4766.380370551806;9860;9985.900140998498;9988.650397236062;9992.500374981222;10007.549660265306;5260.263563101169;5278.736063196825;5280.471952804689;5282.075636763551;5292.603054770908;4343.391925130484;4655.138799322136;4777.498362671939;4804.783784729696;4840.878978025577;3889.9805500972316;3963.980180099081;4004;4036.2936486114813;4112.013116851994;1076.1982323169132;1273.2615083251876;1289.1169548859061;1297.7469393468184;1306.4186437035428;772.6831998880432;869.9391042627082;872.5462759365095;917.5320586500799;932.1051790281406;5590.972045139748;5614.9438505615235;5831.620944638585;5862.853428664317;5953.523718102541;418.80316251361813;432.8398492557774;438.47164167179113;443.5453659998527;443.6229205175575;3736.2153947671295;3825.957235206365;3869.7097717671286;3897.824597893102;3950.170464202492;8638.568071596395;8795.560221988875;10242.231832612584;10317.9484102579;10431.321964072462;10280.691579252634;10508.211884108723;10528.36829790215;10538.262321637565;10544.103751181083;7582.431317651088;7962.084360298524;8049.235322644339;8108.2297181767635;8129.796755081052;5680.289963754531;5844.006518891883;5846.678432686073;5884.4409781072445;5937.614055086406;9296.95351523238;9759.975202603624;9827.852582211415;9848.113669769755;9930.404175749478;7907.84184316322;8254.587270636564;9556.904430955601;9672.322937394314;9930.503474826375;6773.966130169318;7147.178074521288;7314.96342518284;7360.1535823381;7471.701131954878;8073.717419890276;8114.918850811417;8165.550894700848;8242.423030387816;8254.174582541698;6266.248050234001;7292.96353518229;7416.184219735933;7475.551466912003;7545.849083018418;7235.746748863765;7299.9270007301375;7314.378277846443;7317.26827317264;7358.889616655862;6777.186737591521;6804;6888.621125838127;6900.102986611709;6922.688479018557;4838.491958344323;4895.902081958412;4912.066707325596;4920.36035315421;4986.6010719143105;3869.903252418712;4802.159622066055;4894.339264199288;4964.602831773522;4998.525140111684 10:25:31 INFO - PROCESS | 1660 | |4;prototype.html;297.5506984453476;305.1273358195561;311.80200572636375;316.85899774600296;317.60616835124455;5318.46815318468;5557.360903496099;5755.395683453235;5768.682722450264;5828.825135245944;4574.885627859297;5535.6955367454875;5586.340946679931;5637.267155269819;5687.886242275152;3746.66993217408;4288.52826189119;4344;4364.272329793879;4393.978030109845;4199.664026877843;4264.5095813981325;4294.227039132955;4361.716488428257;4362.411074504933;3496.580410350749;3525.048236976015;4029.858954936578;4289.227938970984;4291.957080429187;3626.9844443555717;3833.8658146964863;4205.369194620801;4307.310830267143;4354.194474022316;2945.808522446034;3107.720305172523;3453.620101788801;3723;3746.6815320697774;4757.52516719818;5274.4198138204765;5467.469108649584;5591.552675785927;5604.486788567105;4906.656534042619;4919.237518184651;4922.753862306906;4959.876003099916;4963.454020057827;5474.808381706661;5985.610935289193;5988.97005514974;6063.211782468295;6073;3967.504061992251;3982.721209515335;3988.262171498282;3995.220931918277;4019.517657881073;5268.288781014552;5907.700305932688;6290.591111577733;6314.116023756677;6387.614564280939;3220.8872689455757;3726.7763934164036;3823.8910715892634;3873.845046198177;3897.5250715795673;3614.493970844084;3991.9421353341386;4085.3667681509414;4102.261592913304;4106.856260030884;4237.788110594458;4776.379070720784;4781.737004464788;4809.422869255642;4825.95174048255;4769.499202583748;4844.875055589126;5961.956657584905;5964.224650795369;5977.402259774075;1207.704112492445;1232.6302109367155;1250.1623911978995;1347.1782212850153;1367.8851735835262;675.5473832532117;769.8845173224062;827.557256867573;850.5109562001874;858.965641374338;4027.838886444509;4240.448741663564;4347.34789781529;4642.558956899089;4719;4408.9118217636105;4553.772311384418;4689.6717229793585;5117.083262540316;5165.457626949192;4087.8569250076102;4091.509018917749;4507;4653.488116307203;4688.531146885284;2250.8424410291123;2343.9100818119314;2523.233736384538;2687.6909155446983;2725.146900107946;5277.894442111213;5284.550813180923;5286.938094143287;5326.644214145063;5336.759845806948;4353.673474489426;4538.162044372035;4845.830395936126;5152.943646552448;5297.390800058042;4271.615554600101;5276.657017293864;5329.973350133225;5341.732913354239;5372.489613486712;3990.7605543667473;4408.206522825923;4883.87790305231;5115.363083813144;5115.797787519856;4461.92913700716;4531.750753708578;4580.862574122782;4777.474477807369;5052.444231134646;4537.4328208973875;4710.8351207707565;5291.550218231493;5311.49540793624;5316.601254905975;3144.842757862052;3473.2980839389024;3501.9474707878894;3514.121469632592;3551.100161413631;4247.598292563508;4851;5097.0315640028275;5180.922286165635;5330.760115794721;4963.5780958618925;5135;5553.8333849984565;5993.220881285405;6020.668863212565;5366.248725178556;5708.686022268649;5979.282486101695;5981.863445945431;5991.817078227389;5546.500814926676;5751.482366587027;5754.280714910637;5880.588358814842;5905.527557795452;4761.9047619048115;5034.697918124924;5128.820491282787;5508.338999320107;6085.269767627913;5305.188250227386;5669.42826019605;5708.971455142698;5796.275465566804;5839.211706419579 10:25:31 INFO - PROCESS | 1660 | |5;yui.html;632.3644737039275;656.5174596671445;674.8245456181397;746.6080307838384;813.329003572053;15273;15733.685326293467;15878.285477153542;15931.283092260846;15977.840221597795;14166.291685415714;14239.3592288347;14383.065100768443;14411.567652970427;15432.305546250418;839.6431516605418;844.3667249562828;857.9571021448934;862.8403745307107;868.8392647360226;872.5375550957971;874.2219424712011;874.5015341255487;875.7197696737047;877.4384393987821;731.1116992853682;891.2825175733532;927.4528028463205;932.3054324528202;933.1788026536672;907.6823111910844;908.9727308180732;916.3906002508324;918.9816203675922;919.8344298026352;665.5806841689753;668.151447661472;676.0906580649068;680.7651360280695;681.4276008153125;15262.38950441981;15319.540413787605;15450.5364839055;15550.922245388814;15630.218489075502;13731.794023089662;13740.65648358799;13758.240664726183;13783.793243101361;13882.791758123636;11819.822702659467;12493;13161.210327380291;13245.933770331183;13265.27041012744;4567.223571992769;4594.127115848011;4678.69588476748;4703.341532185496;4742.751215417416;94411.05588944092;99309;106788.46605767;124010;124239;11178.888211117948;11290.661280161608;11344.48949797261;11428.828567571492;11672.241304315363;21391.14435422597;22042.559148817254;22069.889650551646;22097.779022209572;22115.115395384004;8226.177382261845;8330.083690794008;8461.661533538589;8540.359473039547;8560.657573697106;4389.758563279051;4584.289435137559;4593.081383723269;4690.742009189527;4708.223143181405;3647.6899463545365;3761.6614504694708;3771.4908487354405;3786.6970642348547;3788.886333410002;635.8760041791807;670.7289686044918;672.6939242644585;698.3296035805582;700.7337211859563;521.3352974956885;648.8183308673579;677.8373190434261;706.1032488739272;710.2826145592988;9205.079492050741;9401.435913845055;9456.689513467392;9586.233101351874;9694.806103877883;588.6115163991831;647.6373230990661;651.0332156747227;686.6532401137493;723.8443734596982;4621.5378462154185;4712.905741885212;4718.41019872516;4726.125666751594;4806.49531799156;89406;119877.20184197243;158263;159963.20018399833;170858;92245.5387723057;145549;145831.2708436451;146122;147358.26320868326;69664.30335696679;71647.64176179294;117982;122370.38814805869;125402;9743.34600760444;9877.308588398742;9900.752481188028;10015.649452269136;10231.590736370461;45714;50191.745206370135;59598.424094554466;61150.08274875969;61335;91887.54056229677;95086.52456737672;97352.67207631482;97619;98499;11413.372264525531;13413.463461461432;13417.597472075853;13488.73022539524;13936.930315348358;14675.046122002035;14755;15021.549353519413;15188.46840360582;15276.618084547976;14070.577882663127;14190.503332383318;14253;14375.353109109907;14557.490487833298;13781.379837907118;13790.517331893336;13871.098378605358;14111.717765644835;14419.639509012359;10074.748131296776;13706;13742;13794.379252933843;14337;9827.4103553787;11053.454578050469;11219.66341009771;11390.829137562778;11995.040396768063;11155.944220278847;11559.364234967157;11674.649760507198;11820.113491488344;11823.881761182622 10:25:31 INFO - PROCESS | 1660 | __end_tp_report 10:25:31 INFO - PROCESS | 1660 | __start_cc_report 10:25:31 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,410 10:25:31 INFO - PROCESS | 1660 | __end_cc_report 10:25:31 INFO - PROCESS | 1660 | __startTimestamp1470417931878__endTimestamp 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | ------- Summary: start ------- 10:25:31 INFO - PROCESS | 1660 | Number of tests: 6 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5757.64 Median:6001.70 stddev:687.21 (11.5%) stddev-sans-first:662.21 10:25:31 INFO - PROCESS | 1660 | Values: 3321.6 3395.3 3442.4 3449.0 3477.7 5741.5 5749.8 5761.0 5774.0 5895.9 4772.0 5824.4 5833.2 5858.7 5914.9 5227.8 5347.8 5357.9 5413.9 5458.1 5416.9 5449.9 5468.5 5476.9 5518.3 5280.1 5309.0 5327.8 5354.7 5356.1 3927.9 5185.7 5341.3 5344.5 5413.6 5239.3 5239.3 5316.5 5319.7 5362.8 4131.6 5079.7 5759.0 5837.2 5845.1 6188.8 6235.7 6269.8 6296.5 6320.1 6285.5 6316.9 6322.5 6327.9 6329.5 5838.5 5917.0 5943.1 6001.7 6015.7 6464.5 6481.3 6483.1 6497.2 6498.4 6064.8 6125.7 6146.1 6149.4 6160.0 6092.1 6099.3 6157.1 6203.8 6287.2 6179.2 6184.9 6195.6 6196.0 6205.5 5865.8 6179.9 6236.4 6256.2 6262.2 4547.3 4919.0 4953.9 4974.0 4984.4 4442.8 4481.7 4483.2 4486.9 4507.7 5822.8 5917.9 5923.1 5933.6 5960.0 5321.2 6117.8 6118.2 6195.9 6271.9 4885.4 4909.3 5946.5 5951.5 5981.6 4722.5 5540.9 5557.3 5573.9 5575.6 6306.7 6398.2 6430.3 6447.5 6516.2 6168.3 6282.3 6290.3 6301.7 6367.5 5062.1 6354.9 6483.2 6500.3 6533.9 5653.3 5704.0 6143.2 6156.8 6172.6 6258.6 6266.9 6273.2 6285.7 6292.7 5406.2 6223.9 6245.7 6267.4 6272.3 5119.4 6137.8 6172.9 6204.1 6231.3 4999.7 6155.5 6167.5 6169.8 6188.9 6203.5 6257.5 6259.7 6260.8 6280.5 5991.4 6114.1 6128.4 6135.7 6159.2 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:53799.08 Median:37325.95 stddev:112486.92 (301.4%) stddev-sans-first:112731.20 10:25:31 INFO - PROCESS | 1660 | Values: 464.3 485.2 505.3 522.5 529.5 30191.1 40979.8 41032.0 41142.2 41147.0 42194.6 42614.8 42684.7 42706.6 42847.8 9711.2 9902.6 9941.3 9951.3 9970.9 9814.4 9878.5 9935.8 9941.5 9965.3 9883.4 9900.7 9920.0 9941.1 9995.0 8341.2 9872.6 9874.9 9889.0 9954.2 8272.4 9676.8 9807.8 9827.0 9831.3 40057.4 40354.0 40439.6 40470.0 40610.8 2805.3 3084.8 3148.6 3266.5 3491.4 23996.6 29719.1 29880.9 30727.2 31102.7 3147.0 3156.4 3162.2 3165.5 3243.4 398272.0 429822.0 445136.0 446648.0 449740.0 34170.0 34262.8 34289.0 34350.7 34404.7 30140.0 35260.4 35492.5 35533.0 36146.3 16167.0 16288.0 16526.8 16598.4 16654.3 12453.0 12685.6 12817.8 12826.5 12835.0 19433.2 19469.4 19533.6 19622.6 19676.8 6910.8 7882.4 7893.8 7932.5 7988.5 862.0 909.5 1001.0 1022.1 1063.2 23882.0 29345.6 29349.0 30937.0 31479.5 1004.1 1095.8 1110.5 1110.7 1219.0 12923.6 15878.4 16220.2 16249.2 16337.5 160233.0 160848.2 161421.9 161913.0 162500.2 59387.0 59632.0 60080.8 60432.1 60591.0 1338.2 1358.9 1368.2 1388.1 1393.0 30374.7 30576.4 30642.7 31061.2 31299.0 52572.7 52734.0 52752.7 52864.7 53003.2 553421.0 561175.0 562546.0 563338.0 563932.0 26134.3 27041.3 27357.5 27665.7 27772.6 49348.0 49871.0 50252.7 50445.0 50511.2 30823.5 34354.0 40364.2 41234.6 42064.8 39958.0 40450.8 40505.0 41272.4 41532.4 38505.6 39573.8 40001.4 40055.4 40130.6 33398.3 35304.3 35976.5 36007.0 36020.9 25614.4 26130.2 26449.9 26525.7 27063.6 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:32775.43 Median:2401.93 stddev:93607.17 (3897.2%) stddev-sans-first:93838.05 10:25:31 INFO - PROCESS | 1660 | Values: 324.7 382.6 383.9 394.9 407.0 15872.5 19600.4 19618.6 20548.4 21154.4 20186.5 20522.0 21216.9 21556.8 21692.1 5374.0 5552.1 6052.8 6187.0 6238.4 4680.5 5152.2 6055.6 6075.1 6181.8 5897.2 6024.7 6077.4 6084.9 6147.2 5963.6 6017.5 6018.8 6090.9 6131.1 4449.2 5189.3 5280.4 5311.5 5352.1 25694.7 25999.5 26049.1 26313.6 26415.0 2135.3 2264.4 2315.8 2390.9 2413.0 13173.3 14489.6 15642.9 15862.6 16212.5 1885.0 1936.4 1958.8 1971.2 1999.6 102739.0 104628.0 104890.5 105232.0 105751.0 8694.7 10507.4 10532.0 11065.1 11206.9 13518.4 13688.7 13755.6 13762.8 13814.2 8396.0 8664.8 8698.3 8792.0 8809.4 8128.3 8683.5 8751.6 8758.8 8777.5 5500.3 5737.4 6722.5 6760.2 6838.0 1541.6 1589.4 1815.8 1843.8 1845.3 853.3 882.2 888.2 922.9 994.6 21536.2 22107.9 22203.4 22237.9 22296.7 955.6 957.6 971.9 993.3 1074.8 9196.8 11084.9 11388.0 11818.5 11946.9 556111.0 559679.0 565732.0 571595.0 572017.0 106279.0 107721.5 107982.5 110150.4 111946.4 980.1 1023.6 1078.1 1097.7 1100.6 15301.6 19375.3 19467.4 19636.8 19645.1 32754.0 43500.6 44541.8 44602.6 44892.8 58319.1 66945.7 67161.0 67328.7 67403.7 6962.2 7315.6 8083.0 8269.3 8331.0 11447.7 12951.7 13162.9 13714.7 13742.3 11328.4 11467.4 11525.2 11803.3 11880.8 11248.3 11340.8 11531.5 11570.8 11706.8 11472.4 11662.4 11936.5 11954.2 12000.9 8026.6 8249.0 8262.1 8318.4 8391.0 8714.6 10994.8 11425.3 11525.2 11567.8 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5543.06 Median:4916.21 stddev:3081.47 (62.7%) stddev-sans-first:3075.18 10:25:31 INFO - PROCESS | 1660 | Values: 1506.8 1527.6 1675.0 1736.8 1838.6 7854.8 8173.9 8282.9 8843.5 8880.0 8269.3 8462.3 8558.2 8558.4 8604.0 2301.6 2363.4 2367.4 2371.2 2373.6 2329.3 2347.6 2365.1 2366.6 2367.7 2333.9 2355.2 2361.6 2376.4 2380.7 2326.6 2346.0 2346.6 2347.8 2364.7 2323.2 2326.0 2326.7 2341.9 2344.5 7364.2 7519.8 8662.2 8670.0 8743.9 4184.3 5218.1 5285.3 5291.8 5297.1 3400.4 3573.4 3607.8 3631.7 3639.9 1052.2 1071.3 1090.7 1104.0 1107.2 11312.7 11354.9 11424.4 11503.8 11544.4 4498.4 4563.4 4756.3 4756.5 4766.4 9860.0 9985.9 9988.7 9992.5 10007.5 5260.3 5278.7 5280.5 5282.1 5292.6 4343.4 4655.1 4777.5 4804.8 4840.9 3890.0 3964.0 4004.0 4036.3 4112.0 1076.2 1273.3 1289.1 1297.7 1306.4 772.7 869.9 872.5 917.5 932.1 5591.0 5614.9 5831.6 5862.9 5953.5 418.8 432.8 438.5 443.5 443.6 3736.2 3826.0 3869.7 3897.8 3950.2 8638.6 8795.6 10242.2 10317.9 10431.3 10280.7 10508.2 10528.4 10538.3 10544.1 7582.4 7962.1 8049.2 8108.2 8129.8 5680.3 5844.0 5846.7 5884.4 5937.6 9297.0 9760.0 9827.9 9848.1 9930.4 7907.8 8254.6 9556.9 9672.3 9930.5 6774.0 7147.2 7315.0 7360.2 7471.7 8073.7 8114.9 8165.6 8242.4 8254.2 6266.2 7293.0 7416.2 7475.6 7545.8 7235.7 7299.9 7314.4 7317.3 7358.9 6777.2 6804.0 6888.6 6900.1 6922.7 4838.5 4895.9 4912.1 4920.4 4986.6 3869.9 4802.2 4894.3 4964.6 4998.5 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4435.15 Median:4779.61 stddev:1390.17 (29.1%) stddev-sans-first:1358.94 10:25:31 INFO - PROCESS | 1660 | Values: 297.6 305.1 311.8 316.9 317.6 5318.5 5557.4 5755.4 5768.7 5828.8 4574.9 5535.7 5586.3 5637.3 5687.9 3746.7 4288.5 4344.0 4364.3 4394.0 4199.7 4264.5 4294.2 4361.7 4362.4 3496.6 3525.0 4029.9 4289.2 4292.0 3627.0 3833.9 4205.4 4307.3 4354.2 2945.8 3107.7 3453.6 3723.0 3746.7 4757.5 5274.4 5467.5 5591.6 5604.5 4906.7 4919.2 4922.8 4959.9 4963.5 5474.8 5985.6 5989.0 6063.2 6073.0 3967.5 3982.7 3988.3 3995.2 4019.5 5268.3 5907.7 6290.6 6314.1 6387.6 3220.9 3726.8 3823.9 3873.8 3897.5 3614.5 3991.9 4085.4 4102.3 4106.9 4237.8 4776.4 4781.7 4809.4 4826.0 4769.5 4844.9 5962.0 5964.2 5977.4 1207.7 1232.6 1250.2 1347.2 1367.9 675.5 769.9 827.6 850.5 859.0 4027.8 4240.4 4347.3 4642.6 4719.0 4408.9 4553.8 4689.7 5117.1 5165.5 4087.9 4091.5 4507.0 4653.5 4688.5 2250.8 2343.9 2523.2 2687.7 2725.1 5277.9 5284.6 5286.9 5326.6 5336.8 4353.7 4538.2 4845.8 5152.9 5297.4 4271.6 5276.7 5330.0 5341.7 5372.5 3990.8 4408.2 4883.9 5115.4 5115.8 4461.9 4531.8 4580.9 4777.5 5052.4 4537.4 4710.8 5291.6 5311.5 5316.6 3144.8 3473.3 3501.9 3514.1 3551.1 4247.6 4851.0 5097.0 5180.9 5330.8 4963.6 5135.0 5553.8 5993.2 6020.7 5366.2 5708.7 5979.3 5981.9 5991.8 5546.5 5751.5 5754.3 5880.6 5905.5 4761.9 5034.7 5128.8 5508.3 6085.3 5305.2 5669.4 5709.0 5796.3 5839.2 10:25:31 INFO - PROCESS | 1660 | 10:25:31 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:24674.25 Median:4478.49 stddev:39570.38 (883.6%) stddev-sans-first:39640.21 10:25:31 INFO - PROCESS | 1660 | Values: 632.4 656.5 674.8 746.6 813.3 15273.0 15733.7 15878.3 15931.3 15977.8 14166.3 14239.4 14383.1 14411.6 15432.3 839.6 844.4 858.0 862.8 868.8 872.5 874.2 874.5 875.7 877.4 731.1 891.3 927.5 932.3 933.2 907.7 909.0 916.4 919.0 919.8 665.6 668.2 676.1 680.8 681.4 15262.4 15319.5 15450.5 15550.9 15630.2 13731.8 13740.7 13758.2 13783.8 13882.8 11819.8 12493.0 13161.2 13245.9 13265.3 4567.2 4594.1 4678.7 4703.3 4742.8 94411.1 99309.0 106788.5 124010.0 124239.0 11178.9 11290.7 11344.5 11428.8 11672.2 21391.1 22042.6 22069.9 22097.8 22115.1 8226.2 8330.1 8461.7 8540.4 8560.7 4389.8 4584.3 4593.1 4690.7 4708.2 3647.7 3761.7 3771.5 3786.7 3788.9 635.9 670.7 672.7 698.3 700.7 521.3 648.8 677.8 706.1 710.3 9205.1 9401.4 9456.7 9586.2 9694.8 588.6 647.6 651.0 686.7 723.8 4621.5 4712.9 4718.4 4726.1 4806.5 89406.0 119877.2 158263.0 159963.2 170858.0 92245.5 145549.0 145831.3 146122.0 147358.3 69664.3 71647.6 117982.0 122370.4 125402.0 9743.3 9877.3 9900.8 10015.6 10231.6 45714.0 50191.7 59598.4 61150.1 61335.0 91887.5 95086.5 97352.7 97619.0 98499.0 11413.4 13413.5 13417.6 13488.7 13936.9 14675.0 14755.0 15021.5 15188.5 15276.6 14070.6 14190.5 14253.0 14375.4 14557.5 13781.4 13790.5 13871.1 14111.7 14419.6 10074.7 13706.0 13742.0 13794.4 14337.0 9827.4 11053.5 11219.7 11390.8 11995.0 11155.9 11559.4 11674.6 11820.1 11823.9 10:25:31 INFO - PROCESS | 1660 | -------- Summary: end -------- 10:25:31 INFO - PROCESS | 1660 | 10:25:32 INFO - TEST-INFO | 1660: exit 0 10:25:32 INFO - TEST-OK | dromaeo_css | took 1114877ms 10:25:32 INFO - TEST-START | kraken 10:25:32 INFO - operating with platform_type : mac_ 10:25:32 INFO - Initialising browser for kraken test... 10:25:32 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp5Nq5hC/profile http://localhost:49267/getInfo.html) 10:25:35 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 10:25:35 INFO - PROCESS | 1669 | colorDepth:24 10:25:35 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 10:25:35 INFO - PROCESS | 1669 | __metrics 10:25:35 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:25:35 INFO - TEST-INFO | 1669: exit 0 10:25:35 INFO - Browser initialized. 10:25:35 INFO - Running cycle 1/1 for kraken test... 10:25:35 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmp5Nq5hC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:48 INFO - PROCESS | 1671 | RSS: Main: 254984192 10:25:48 INFO - PROCESS | 1671 | 10:25:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:51 INFO - PROCESS | 1671 | RSS: Main: 267718656 10:25:51 INFO - PROCESS | 1671 | 10:25:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 10:25:54 INFO - PROCESS | 1671 | RSS: Main: 276520960 10:25:54 INFO - PROCESS | 1671 | 10:25:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 10:25:59 INFO - PROCESS | 1671 | RSS: Main: 279650304 10:25:59 INFO - PROCESS | 1671 | 10:26:01 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 10:26:02 INFO - PROCESS | 1671 | RSS: Main: 282116096 10:26:02 INFO - PROCESS | 1671 | 10:26:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:04 INFO - PROCESS | 1671 | RSS: Main: 282562560 10:26:04 INFO - PROCESS | 1671 | 10:26:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:08 INFO - PROCESS | 1671 | RSS: Main: 283570176 10:26:08 INFO - PROCESS | 1671 | 10:26:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:11 INFO - PROCESS | 1671 | RSS: Main: 283750400 10:26:11 INFO - PROCESS | 1671 | 10:26:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 10:26:15 INFO - PROCESS | 1671 | RSS: Main: 283844608 10:26:15 INFO - PROCESS | 1671 | 10:26:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:17 INFO - PROCESS | 1671 | RSS: Main: 283500544 10:26:17 INFO - PROCESS | 1671 | 10:26:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:20 INFO - PROCESS | 1671 | RSS: Main: 283078656 10:26:20 INFO - PROCESS | 1671 | 10:26:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:23 INFO - PROCESS | 1671 | RSS: Main: 283324416 10:26:23 INFO - PROCESS | 1671 | 10:26:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:26 INFO - PROCESS | 1671 | RSS: Main: 283582464 10:26:26 INFO - PROCESS | 1671 | 10:26:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:30 INFO - PROCESS | 1671 | RSS: Main: 283561984 10:26:30 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 10:26:32 INFO - PROCESS | 1671 | RSS: Main: 284360704 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | __start_tp_report 10:26:32 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 10:26:32 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 10:26:32 INFO - PROCESS | 1671 | |i|pagename|runs| 10:26:32 INFO - PROCESS | 1671 | |0;ai-astar;105;116;108;116;113;115;113;116;118;113 10:26:32 INFO - PROCESS | 1671 | |1;audio-beat-detection;148;109;129;156;106;138;131;114;159;112 10:26:32 INFO - PROCESS | 1671 | |2;audio-dft;195;207;261;244;273;197;189;277;248;194 10:26:32 INFO - PROCESS | 1671 | |3;audio-fft;60;103;91;169;84;81;82;62;136;84 10:26:32 INFO - PROCESS | 1671 | |4;audio-oscillator;69;71;123;71;69;72;114;70;73;115 10:26:32 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;132;85;88;87;91;85;92;89;89;86 10:26:32 INFO - PROCESS | 1671 | |6;imaging-darkroom;95;97;95;95;109;150;96;96;96;118 10:26:32 INFO - PROCESS | 1671 | |7;imaging-desaturate;100;153;109;92;91;92;94;84;151;151 10:26:32 INFO - PROCESS | 1671 | |8;json-parse-financial;56;57;55;56;55;56;58;62;58;56 10:26:32 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;66;69;68;70;72;104;64;82;105;106 10:26:32 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;86;85;84;87;85;85;87;87;87;87 10:26:32 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;138;139;134;159;155;156;140;137;158;154 10:26:32 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;170;171;192;235;173;169;173;169;175;174 10:26:32 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;70;70;65;68;69;65;71;69;70 10:26:32 INFO - PROCESS | 1671 | __end_tp_report 10:26:32 INFO - PROCESS | 1671 | __start_cc_report 10:26:32 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1058 10:26:32 INFO - PROCESS | 1671 | __end_cc_report 10:26:32 INFO - PROCESS | 1671 | __startTimestamp1470417992290__endTimestamp 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | ------- Summary: start ------- 10:26:32 INFO - PROCESS | 1671 | Number of tests: 14 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.50 stddev:4.00 (3.5%) stddev-sans-first:2.91 10:26:32 INFO - PROCESS | 1671 | Values: 105.0 116.0 108.0 116.0 113.0 115.0 113.0 116.0 118.0 113.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:134.50 stddev:19.73 (14.7%) stddev-sans-first:19.85 10:26:32 INFO - PROCESS | 1671 | Values: 148.0 109.0 129.0 156.0 106.0 138.0 131.0 114.0 159.0 112.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:228.50 Median:246.00 stddev:35.49 (14.4%) stddev-sans-first:35.51 10:26:32 INFO - PROCESS | 1671 | Values: 195.0 207.0 261.0 244.0 273.0 197.0 189.0 277.0 248.0 194.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:95.20 Median:81.50 stddev:33.59 (41.2%) stddev-sans-first:33.13 10:26:32 INFO - PROCESS | 1671 | Values: 60.0 103.0 91.0 169.0 84.0 81.0 82.0 62.0 136.0 84.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:70.50 stddev:22.67 (32.2%) stddev-sans-first:23.32 10:26:32 INFO - PROCESS | 1671 | Values: 69.0 71.0 123.0 71.0 69.0 72.0 114.0 70.0 73.0 115.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:88.50 stddev:14.11 (15.9%) stddev-sans-first:2.50 10:26:32 INFO - PROCESS | 1671 | Values: 132.0 85.0 88.0 87.0 91.0 85.0 92.0 89.0 89.0 86.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:95.50 stddev:17.69 (18.5%) stddev-sans-first:18.41 10:26:32 INFO - PROCESS | 1671 | Values: 95.0 97.0 95.0 95.0 109.0 150.0 96.0 96.0 96.0 118.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:111.70 Median:87.50 stddev:28.33 (32.4%) stddev-sans-first:29.73 10:26:32 INFO - PROCESS | 1671 | Values: 100.0 153.0 109.0 92.0 91.0 92.0 94.0 84.0 151.0 151.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:2.08 (3.7%) stddev-sans-first:2.18 10:26:32 INFO - PROCESS | 1671 | Values: 56.0 57.0 55.0 56.0 55.0 56.0 58.0 62.0 58.0 56.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:80.60 Median:68.50 stddev:17.51 (25.6%) stddev-sans-first:17.75 10:26:32 INFO - PROCESS | 1671 | Values: 66.0 69.0 68.0 70.0 72.0 104.0 64.0 82.0 105.0 106.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:87.00 stddev:1.15 (1.3%) stddev-sans-first:1.22 10:26:32 INFO - PROCESS | 1671 | Values: 86.0 85.0 84.0 87.0 85.0 85.0 87.0 87.0 87.0 87.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:154.50 stddev:10.12 (6.6%) stddev-sans-first:10.20 10:26:32 INFO - PROCESS | 1671 | Values: 138.0 139.0 134.0 159.0 155.0 156.0 140.0 137.0 158.0 154.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:173.50 stddev:20.41 (11.8%) stddev-sans-first:21.32 10:26:32 INFO - PROCESS | 1671 | Values: 170.0 171.0 192.0 235.0 173.0 169.0 173.0 169.0 175.0 174.0 10:26:32 INFO - PROCESS | 1671 | 10:26:32 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.50 stddev:2.07 (3.0%) stddev-sans-first:2.19 10:26:32 INFO - PROCESS | 1671 | Values: 68.0 70.0 70.0 65.0 68.0 69.0 65.0 71.0 69.0 70.0 10:26:32 INFO - PROCESS | 1671 | -------- Summary: end -------- 10:26:32 INFO - PROCESS | 1671 | 10:26:33 INFO - TEST-INFO | 1671: exit 0 10:26:33 INFO - TEST-OK | kraken | took 60525ms 10:26:33 INFO - SUITE-END | took 1175s 10:26:33 INFO - Completed test suite (00:19:35) 10:26:33 INFO - javascript benchmark 10:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.823985111354, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.568196134502, 3395.270016946356, 3442.3803715331246, 3449.0, 3477.6522347765217, 5741.45456181662, 5749.798757043504, 5761.0, 5774.0, 5895.85260368491, 4771.9761401192945, 5824.417558244173, 5833.183354330397, 5858.677772722509, 5914.935311643902, 5227.764750586214, 5347.839564813062, 5357.946420535804, 5413.864653383677, 5458.072127738294, 5416.91874621881, 5449.945500544984, 5468.453154684519, 5476.890462190754, 5518.255035570187, 5280.102382594968, 5308.973455132699, 5327.840164795062, 5354.705491197982, 5356.1430171172815, 3927.9214415711526, 5185.7294962733995, 5341.278927344836, 5344.518993290583, 5413.593980451443, 5239.292695486099, 5239.345081864767, 5316.468353164652, 5319.680819150824, 5362.758675859557, 4131.566185550504, 5079.746012699387, 5758.971205143947, 5837.211976383176, 5845.123231515264, 6188.783392581238, 6235.719392627343, 6269.780557680459, 6296.464800491918, 6320.051992201206, 6285.465735412496, 6316.873662526769, 6322.52581056418, 6327.905081423783, 6329.493640508748, 5838.503727183237, 5917.0, 5943.108533719977, 6001.699915004232, 6015.699215039231, 6464.482841372679, 6481.319461456479, 6483.09236706852, 6497.155369801895, 6498.3826536478955, 6064.818055458343, 6125.693715314305, 6146.078088286793, 6149.354317796567, 6159.96920015406, 6092.145434360276, 6099.340048628031, 6157.107219453154, 6203.7828675996125, 6287.2140982377205, 6179.196704428486, 6184.907226391608, 6195.566310358232, 6196.039613859859, 6205.47253483459, 5865.797511510215, 6179.876402472015, 6236.438720515175, 6256.217972753406, 6262.248530176408, 4547.3406356078185, 4918.975405122951, 4953.900921981613, 4974.0051989602225, 4984.40187177541, 4442.800073996678, 4481.686281960231, 4483.170613436525, 4486.932696009562, 4507.684462087688, 5822.7670893163795, 5917.940820591739, 5923.08192230205, 5933.614315069507, 5960.0165972614905, 5321.175217841241, 6117.827404800917, 6118.20463339763, 6195.907061394083, 6271.874562508816, 4885.389326334208, 4909.337239472626, 5946.494547963472, 5951.5238780897425, 5981.581289309794, 4722.504137065559, 5540.86147846299, 5557.305336832896, 5573.860653483695, 5575.609707320448, 6306.716197771111, 6398.232212134573, 6430.260520040255, 6447.451966582706, 6516.185476815398, 6168.290646575521, 6282.3089460158435, 6290.308066112815, 6301.6534090625455, 6367.458766004941, 5062.063518249136, 6354.904676429765, 6483.157189565515, 6500.317466666121, 6533.8693226136165, 5653.3498647654405, 5703.973284808774, 6143.235544005126, 6156.846078848064, 6172.598781079216, 6258.624482531062, 6266.937330626635, 6273.153124328157, 6285.685715714105, 6292.748290068529, 5406.24312596229, 6223.91498847891, 6245.718942647501, 6267.435930766253, 6272.278687950944, 5119.436861945109, 6137.775380989496, 6172.876542469216, 6204.100405441276, 6231.2522497300615, 4999.675021123615, 6155.507559395327, 6167.506599471942, 6169.84575385619, 6188.938110618837, 6203.503719702323, 6257.4994000480765, 6259.687015649109, 6260.843478913063, 6280.5289603279025, 5991.430814072656, 6114.113453549299, 6128.350350989301, 6135.722664536794, 6159.19930409044], "value": 5717.034568986741, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.3104989091201, 485.2187977356456, 505.25727181043874, 522.4749127127236, 529.4784637132424, 30191.094267171993, 40979.79510102453, 41032.0, 41142.17715645689, 41146.99999999996, 42194.57805421945, 42614.786926065324, 42684.71945841622, 42706.57293427065, 42847.78576107123, 9711.22310215183, 9902.603895844157, 9941.304108712393, 9951.253655975795, 9970.850437243447, 9814.362066465692, 9878.506074696272, 9935.751606209831, 9941.502924853765, 9965.252606054539, 9883.406995580252, 9900.653477128302, 9919.950400247988, 9941.055599718014, 9994.9500252499, 8341.165883411672, 9872.555734991942, 9874.901250987507, 9888.95055524725, 9954.153896918771, 8272.37957153216, 9676.806463870753, 9807.803843923082, 9827.0, 9831.262655300881, 40057.39913901294, 40354.0, 40439.595604043876, 40470.0, 40610.79694601508, 2805.2846524136417, 3084.784065115443, 3148.590683211191, 3266.477363621809, 3491.354099491602, 23996.560206387672, 29719.108426747232, 29880.85059574688, 30727.231819204477, 31102.688973110206, 3146.9685303146903, 3156.384505021522, 3162.16202706283, 3165.5409965554863, 3243.367543329052, 398272.0172798293, 429822.0, 445136.0, 446648.0, 449740.0, 34169.97490075302, 34262.82868585641, 34289.0, 34350.65649343524, 34404.65595344065, 30140.0, 35260.41328140189, 35492.46761298583, 35533.0, 36146.27707445836, 16167.0, 16288.0, 16526.83473165277, 16598.419055333005, 16654.333826646798, 12453.0, 12685.619431417072, 12817.807732884014, 12826.486940522274, 12834.973202143807, 19433.22267109328, 19469.369311213086, 19533.609327813363, 19622.60754784925, 19676.803231967497, 6910.818954532536, 7882.369410447151, 7893.763187104396, 7932.484388514728, 7988.520688758693, 862.0216054777873, 909.4725059465494, 1000.9649662261786, 1022.0648106982028, 1063.197286049028, 23882.044718211426, 29345.559816602767, 29348.97278595239, 30937.0, 31479.52780708291, 1004.1063453526367, 1095.8191898336686, 1110.4847520366377, 1110.744528758374, 1218.9817152742717, 12923.612291631267, 15878.364865405485, 16220.188990550425, 16249.187540622921, 16337.509874703777, 160233.0, 160848.19575902278, 161421.89335799628, 161913.0, 162500.1874990641, 59387.0, 59632.0, 60080.79838403295, 60432.093518597256, 60591.0, 1338.1903948111253, 1358.8641135886332, 1368.1996032321006, 1388.0699931046022, 1393.004002138476, 30374.696253037186, 30576.388472230876, 30642.693573063985, 31061.22346941254, 31299.0, 52572.73713631407, 52734.0, 52752.73623632011, 52864.735676321376, 53003.20495192498, 553421.0, 561175.0, 562546.0, 563338.0, 563932.0, 26134.34664133412, 27041.323966900985, 27357.45285094247, 27665.723342766316, 27772.583411248444, 49348.0, 49871.0, 50252.748736256086, 50445.0, 50511.24233136432, 30823.537646934867, 34354.0, 40364.19271614493, 41234.587654123075, 42064.78967605143, 39958.0, 40450.797746011085, 40505.0, 41272.380914285706, 41532.37701434542, 38505.6149438502, 39573.80213098916, 40001.39997900092, 40055.39916901191, 40130.59869401269, 33398.33203335871, 35304.29391412106, 35976.460353094204, 36007.0, 36020.919372418866, 25614.359641009123, 26130.216093517225, 26449.94200231969, 26525.734742653098, 27063.594046088932], "value": 18724.165723059396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.7191179629621, 382.6460524015286, 383.91170030892886, 394.924964256791, 407.03938704657, 15872.523824285261, 19600.411987640393, 19618.607627847436, 20548.38354849355, 21154.365369038915, 20186.49533761657, 20522.0, 21216.8939155304, 21556.784432155673, 21692.132314707393, 5374.0, 5552.111662134039, 6052.818415447521, 6187.0, 6238.407351301642, 4680.508546602592, 5152.201408781626, 6055.576109672303, 6075.149479072933, 6181.752729890822, 5897.20387747655, 6024.7288872000645, 6077.361877002917, 6084.908726369108, 6147.170132032164, 5963.642181469126, 6017.458428741435, 6018.789342372996, 6090.908636370458, 6131.110988906628, 4449.199144154051, 5189.273501709764, 5280.392754833205, 5311.521963023347, 5352.090144675414, 25694.74305256942, 25999.480010399875, 26049.088281910233, 26313.631773140318, 26415.0, 2135.29535253366, 2264.3772962435464, 2315.791578757903, 2390.9163179288817, 2412.9517409651885, 13173.341332933314, 14489.623485768836, 15642.921785391114, 15862.603434914105, 16212.513624591282, 1884.9905750471296, 1936.3803582853493, 1958.7845337012918, 1971.221367559806, 1999.600079984009, 102739.0, 104628.0, 104890.47554762254, 105232.0, 105751.0, 8694.739157825275, 10507.422091785025, 10532.0, 11065.059469944983, 11206.887931120747, 13518.39167237457, 13688.65778355549, 13755.587332380044, 13762.793558096637, 13814.240216787972, 8396.0, 8664.781870305615, 8698.34762392823, 8792.032876383593, 8809.42738721981, 8128.349732021424, 8683.522406267715, 8751.64993400257, 8758.781030474289, 8777.473351598925, 5500.339959204841, 5737.426257374229, 6722.529422940445, 6760.18877734675, 6837.965810170917, 1541.6223025358859, 1589.4278059898427, 1815.8002619711822, 1843.787964384086, 1845.280340667141, 853.2593509241078, 882.1927935938544, 888.1518150166576, 922.9077092290718, 994.6419289055934, 21536.246231381825, 22107.889460552593, 22203.444913877283, 22237.888810555844, 22296.66555001676, 955.5699935029264, 957.6169532187181, 971.8785151856018, 993.3146129170849, 1074.8119079161115, 9196.75843761097, 11084.889151108548, 11388.0, 11818.527258909719, 11946.940265298617, 556111.0, 559679.0, 565732.0, 571595.0, 572017.0, 106279.0, 107721.46139269254, 107982.46008769906, 110150.44924775485, 111946.44026779814, 980.1032055669126, 1023.6417253961054, 1078.0513148429332, 1097.7145942055124, 1100.6422912553292, 15301.6174595636, 19375.3218637347, 19467.415977520697, 19636.803631963496, 19645.11596978168, 32754.0, 43500.56499435092, 44541.777291113336, 44602.55397446114, 44892.77553612211, 58319.08404579669, 66945.66527167527, 67161.0, 67328.66335668486, 67403.65192696216, 6962.23415424313, 7315.561066336037, 8083.0, 8269.338452923872, 8331.041930178108, 11447.713807154554, 12951.740965180832, 13162.934185329012, 13714.65713357174, 13742.312884355542, 11328.433578321215, 11467.369294688871, 11525.193236473366, 11803.291802491878, 11880.752520985172, 11248.325100493996, 11340.829887551528, 11531.481083351102, 11570.76858462843, 11706.824397634213, 11472.369019703996, 11662.416879156179, 11936.52253909834, 11954.222975506564, 12000.939995299968, 8026.638801254075, 8248.958755206186, 8262.091169971418, 8318.417710760188, 8390.958045209734, 8714.564271786512, 10994.780104398027, 11425.31448113116, 11525.193236473366, 11567.826482602935], "value": 9583.566578295578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.8493150684928, 1527.5646440764383, 1675.0368538090602, 1736.782902137233, 1838.6322735452914, 7854.764357069297, 8173.877391839127, 8282.875756863645, 8843.469391836494, 8880.023197448292, 8269.25576698097, 8462.323014158852, 8558.186972237643, 8558.40091193615, 8603.956980215105, 2301.608726516492, 2363.409147713072, 2367.3844800351944, 2371.1819422299363, 2373.5727569037567, 2329.3244958961964, 2347.565700345433, 2365.077619728307, 2366.6213405855065, 2367.715874095111, 2333.894974726133, 2355.187460326193, 2361.5867223235864, 2376.4415362389823, 2380.702412198475, 2326.6161083421216, 2345.9530809383887, 2346.577616029114, 2347.80043696286, 2364.7280562735164, 2323.163661082026, 2326.0230703104735, 2326.651002349661, 2341.9297421077395, 2344.5310937812337, 7364.153122390887, 7519.759239725438, 8662.220400163953, 8669.959604847396, 8743.868841967376, 4184.267753143218, 5218.1129208034345, 5285.286486324336, 5291.788328466857, 5297.12597421425, 3400.404929137416, 3573.428251479777, 3607.783532988029, 3631.7276204284785, 3639.872604458831, 1052.1740433759462, 1071.314358810362, 1090.6946055104584, 1103.9944800276028, 1107.2304748200004, 11312.717182070513, 11354.886451135466, 11424.371659558721, 11503.827442588368, 11544.365059921702, 4498.415206023196, 4563.429571303587, 4756.262779269219, 4756.453007904066, 4766.380370551806, 9860.0, 9985.900140998498, 9988.650397236062, 9992.500374981222, 10007.549660265306, 5260.263563101169, 5278.736063196825, 5280.471952804689, 5282.075636763551, 5292.603054770908, 4343.391925130484, 4655.138799322136, 4777.498362671939, 4804.783784729696, 4840.878978025577, 3889.9805500972316, 3963.980180099081, 4004.0, 4036.2936486114813, 4112.013116851994, 1076.1982323169132, 1273.2615083251876, 1289.1169548859061, 1297.7469393468184, 1306.4186437035428, 772.6831998880432, 869.9391042627082, 872.5462759365095, 917.5320586500799, 932.1051790281406, 5590.972045139748, 5614.9438505615235, 5831.620944638585, 5862.853428664317, 5953.523718102541, 418.80316251361813, 432.8398492557774, 438.47164167179113, 443.5453659998527, 443.6229205175575, 3736.2153947671295, 3825.957235206365, 3869.7097717671286, 3897.824597893102, 3950.170464202492, 8638.568071596395, 8795.560221988875, 10242.231832612584, 10317.9484102579, 10431.321964072462, 10280.691579252634, 10508.211884108723, 10528.36829790215, 10538.262321637565, 10544.103751181083, 7582.431317651088, 7962.084360298524, 8049.235322644339, 8108.2297181767635, 8129.796755081052, 5680.289963754531, 5844.006518891883, 5846.678432686073, 5884.4409781072445, 5937.614055086406, 9296.95351523238, 9759.975202603624, 9827.852582211415, 9848.113669769755, 9930.404175749478, 7907.84184316322, 8254.587270636564, 9556.904430955601, 9672.322937394314, 9930.503474826375, 6773.966130169318, 7147.178074521288, 7314.96342518284, 7360.1535823381, 7471.701131954878, 8073.717419890276, 8114.918850811417, 8165.550894700848, 8242.423030387816, 8254.174582541698, 6266.248050234001, 7292.96353518229, 7416.184219735933, 7475.551466912003, 7545.849083018418, 7235.746748863765, 7299.9270007301375, 7314.378277846443, 7317.26827317264, 7358.889616655862, 6777.186737591521, 6804.0, 6888.621125838127, 6900.102986611709, 6922.688479018557, 4838.491958344323, 4895.902081958412, 4912.066707325596, 4920.36035315421, 4986.6010719143105, 3869.903252418712, 4802.159622066055, 4894.339264199288, 4964.602831773522, 4998.525140111684], "value": 4407.557606616146, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5506984453476, 305.1273358195561, 311.80200572636375, 316.85899774600296, 317.60616835124455, 5318.46815318468, 5557.360903496099, 5755.395683453235, 5768.682722450264, 5828.825135245944, 4574.885627859297, 5535.6955367454875, 5586.340946679931, 5637.267155269819, 5687.886242275152, 3746.66993217408, 4288.52826189119, 4344.0, 4364.272329793879, 4393.978030109845, 4199.664026877843, 4264.5095813981325, 4294.227039132955, 4361.716488428257, 4362.411074504933, 3496.580410350749, 3525.048236976015, 4029.858954936578, 4289.227938970984, 4291.957080429187, 3626.9844443555717, 3833.8658146964863, 4205.369194620801, 4307.310830267143, 4354.194474022316, 2945.808522446034, 3107.720305172523, 3453.620101788801, 3723.0, 3746.6815320697774, 4757.52516719818, 5274.4198138204765, 5467.469108649584, 5591.552675785927, 5604.486788567105, 4906.656534042619, 4919.237518184651, 4922.753862306906, 4959.876003099916, 4963.454020057827, 5474.808381706661, 5985.610935289193, 5988.97005514974, 6063.211782468295, 6073.0, 3967.504061992251, 3982.721209515335, 3988.262171498282, 3995.220931918277, 4019.517657881073, 5268.288781014552, 5907.700305932688, 6290.591111577733, 6314.116023756677, 6387.614564280939, 3220.8872689455757, 3726.7763934164036, 3823.8910715892634, 3873.845046198177, 3897.5250715795673, 3614.493970844084, 3991.9421353341386, 4085.3667681509414, 4102.261592913304, 4106.856260030884, 4237.788110594458, 4776.379070720784, 4781.737004464788, 4809.422869255642, 4825.95174048255, 4769.499202583748, 4844.875055589126, 5961.956657584905, 5964.224650795369, 5977.402259774075, 1207.704112492445, 1232.6302109367155, 1250.1623911978995, 1347.1782212850153, 1367.8851735835262, 675.5473832532117, 769.8845173224062, 827.557256867573, 850.5109562001874, 858.965641374338, 4027.838886444509, 4240.448741663564, 4347.34789781529, 4642.558956899089, 4719.0, 4408.9118217636105, 4553.772311384418, 4689.6717229793585, 5117.083262540316, 5165.457626949192, 4087.8569250076102, 4091.509018917749, 4507.0, 4653.488116307203, 4688.531146885284, 2250.8424410291123, 2343.9100818119314, 2523.233736384538, 2687.6909155446983, 2725.146900107946, 5277.894442111213, 5284.550813180923, 5286.938094143287, 5326.644214145063, 5336.759845806948, 4353.673474489426, 4538.162044372035, 4845.830395936126, 5152.943646552448, 5297.390800058042, 4271.615554600101, 5276.657017293864, 5329.973350133225, 5341.732913354239, 5372.489613486712, 3990.7605543667473, 4408.206522825923, 4883.87790305231, 5115.363083813144, 5115.797787519856, 4461.92913700716, 4531.750753708578, 4580.862574122782, 4777.474477807369, 5052.444231134646, 4537.4328208973875, 4710.8351207707565, 5291.550218231493, 5311.49540793624, 5316.601254905975, 3144.842757862052, 3473.2980839389024, 3501.9474707878894, 3514.121469632592, 3551.100161413631, 4247.598292563508, 4851.0, 5097.0315640028275, 5180.922286165635, 5330.760115794721, 4963.5780958618925, 5135.0, 5553.8333849984565, 5993.220881285405, 6020.668863212565, 5366.248725178556, 5708.686022268649, 5979.282486101695, 5981.863445945431, 5991.817078227389, 5546.500814926676, 5751.482366587027, 5754.280714910637, 5880.588358814842, 5905.527557795452, 4761.9047619048115, 5034.697918124924, 5128.820491282787, 5508.338999320107, 6085.269767627913, 5305.188250227386, 5669.42826019605, 5708.971455142698, 5796.275465566804, 5839.211706419579], "value": 3990.8858697849973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.3644737039275, 656.5174596671445, 674.8245456181397, 746.6080307838384, 813.329003572053, 15273.0, 15733.685326293467, 15878.285477153542, 15931.283092260846, 15977.840221597795, 14166.291685415714, 14239.3592288347, 14383.065100768443, 14411.567652970427, 15432.305546250418, 839.6431516605418, 844.3667249562828, 857.9571021448934, 862.8403745307107, 868.8392647360226, 872.5375550957971, 874.2219424712011, 874.5015341255487, 875.7197696737047, 877.4384393987821, 731.1116992853682, 891.2825175733532, 927.4528028463205, 932.3054324528202, 933.1788026536672, 907.6823111910844, 908.9727308180732, 916.3906002508324, 918.9816203675922, 919.8344298026352, 665.5806841689753, 668.151447661472, 676.0906580649068, 680.7651360280695, 681.4276008153125, 15262.38950441981, 15319.540413787605, 15450.5364839055, 15550.922245388814, 15630.218489075502, 13731.794023089662, 13740.65648358799, 13758.240664726183, 13783.793243101361, 13882.791758123636, 11819.822702659467, 12493.0, 13161.210327380291, 13245.933770331183, 13265.27041012744, 4567.223571992769, 4594.127115848011, 4678.69588476748, 4703.341532185496, 4742.751215417416, 94411.05588944092, 99309.0, 106788.46605767, 124010.0, 124239.0, 11178.888211117948, 11290.661280161608, 11344.48949797261, 11428.828567571492, 11672.241304315363, 21391.14435422597, 22042.559148817254, 22069.889650551646, 22097.779022209572, 22115.115395384004, 8226.177382261845, 8330.083690794008, 8461.661533538589, 8540.359473039547, 8560.657573697106, 4389.758563279051, 4584.289435137559, 4593.081383723269, 4690.742009189527, 4708.223143181405, 3647.6899463545365, 3761.6614504694708, 3771.4908487354405, 3786.6970642348547, 3788.886333410002, 635.8760041791807, 670.7289686044918, 672.6939242644585, 698.3296035805582, 700.7337211859563, 521.3352974956885, 648.8183308673579, 677.8373190434261, 706.1032488739272, 710.2826145592988, 9205.079492050741, 9401.435913845055, 9456.689513467392, 9586.233101351874, 9694.806103877883, 588.6115163991831, 647.6373230990661, 651.0332156747227, 686.6532401137493, 723.8443734596982, 4621.5378462154185, 4712.905741885212, 4718.41019872516, 4726.125666751594, 4806.49531799156, 89406.0, 119877.20184197243, 158263.0, 159963.20018399833, 170858.0, 92245.5387723057, 145549.0, 145831.2708436451, 146122.0, 147358.26320868326, 69664.30335696679, 71647.64176179294, 117982.0, 122370.38814805869, 125402.0, 9743.34600760444, 9877.308588398742, 9900.752481188028, 10015.649452269136, 10231.590736370461, 45714.0, 50191.745206370135, 59598.424094554466, 61150.08274875969, 61335.0, 91887.54056229677, 95086.52456737672, 97352.67207631482, 97619.0, 98499.0, 11413.372264525531, 13413.463461461432, 13417.597472075853, 13488.73022539524, 13936.930315348358, 14675.046122002035, 14755.0, 15021.549353519413, 15188.46840360582, 15276.618084547976, 14070.577882663127, 14190.503332383318, 14253.0, 14375.353109109907, 14557.490487833298, 13781.379837907118, 13790.517331893336, 13871.098378605358, 14111.717765644835, 14419.639509012359, 10074.748131296776, 13706.0, 13742.0, 13794.379252933843, 14337.0, 9827.4103553787, 11053.454578050469, 11219.66341009771, 11390.829137562778, 11995.040396768063, 11155.944220278847, 11559.364234967157, 11674.649760507198, 11820.113491488344, 11823.881761182622], "value": 7979.1008817444645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 108.0, 116.0, 113.0, 115.0, 113.0, 116.0, 118.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 129.0, 156.0, 106.0, 138.0, 131.0, 114.0, 159.0, 112.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 207.0, 261.0, 244.0, 273.0, 197.0, 189.0, 277.0, 248.0, 194.0], "value": 228.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 103.0, 91.0, 169.0, 84.0, 81.0, 82.0, 62.0, 136.0, 84.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 123.0, 71.0, 69.0, 72.0, 114.0, 70.0, 73.0, 115.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 85.0, 88.0, 87.0, 91.0, 85.0, 92.0, 89.0, 89.0, 86.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 109.0, 150.0, 96.0, 96.0, 96.0, 118.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 153.0, 109.0, 92.0, 91.0, 92.0, 94.0, 84.0, 151.0, 151.0], "value": 111.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 56.0, 55.0, 56.0, 58.0, 62.0, 58.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 70.0, 72.0, 104.0, 64.0, 82.0, 105.0, 106.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 87.0, 85.0, 85.0, 87.0, 87.0, 87.0, 87.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 134.0, 159.0, 155.0, 156.0, 140.0, 137.0, 158.0, 154.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 192.0, 235.0, 173.0, 169.0, 173.0, 169.0, 175.0, 174.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 65.0, 68.0, 69.0, 65.0, 71.0, 69.0, 70.0], "value": 68.5, "unit": "score"}]}]} 10:26:33 INFO - Return code: 0 10:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:33 ERROR - # TBPL SUCCESS # 10:26:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:26:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:26:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:26:33 INFO - 2016-08-05 10:26:33.630 screenresolution[1676:10666] starting screenresolution argv=screenresolution get 10:26:33 INFO - 2016-08-05 10:26:33.633 screenresolution[1676:10666] Display 0: 1600x1200x32@60 10:26:33 INFO - 2016-08-05 10:26:33.639 screenresolution[1677:10669] starting screenresolution argv=screenresolution list 10:26:33 INFO - Available Modes on Display 0 10:26:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:26:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:26:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:26:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:26:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:26:33 INFO - Intel Iris: 10:26:33 INFO - Chipset Model: Intel Iris 10:26:33 INFO - Type: GPU 10:26:33 INFO - Bus: Built-In 10:26:33 INFO - VRAM (Dynamic, Max): 1536 MB 10:26:33 INFO - Vendor: Intel (0x8086) 10:26:33 INFO - Device ID: 0x0a2e 10:26:33 INFO - Revision ID: 0x0009 10:26:33 INFO - Displays: 10:26:33 INFO - Display: 10:26:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:26:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:26:33 INFO - Display Serial Number: 1600x1200 60 10:26:33 INFO - Main Display: Yes 10:26:33 INFO - Mirror: Off 10:26:33 INFO - Online: Yes 10:26:33 INFO - Rotation: Supported 10:26:33 INFO - Return code: 0 10:26:33 INFO - Running post-action listener: _resource_record_post_action 10:26:33 INFO - [mozharness: 2016-08-05 17:26:33.876833Z] Finished run-tests step (success) 10:26:33 INFO - Running post-run listener: _resource_record_post_run 10:26:33 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32627712; Write bytes: 705830400; Read time: 316; Write time: 2106 10:26:33 INFO - TinderboxPrint: CPU usage
54.3% 10:26:33 INFO - TinderboxPrint: I/O read bytes / time
32,627,712 / 316 10:26:33 INFO - TinderboxPrint: I/O write bytes / time
705,830,400 / 2,106 10:26:33 INFO - TinderboxPrint: CPU idle
2,213.8 (45.7%) 10:26:33 INFO - TinderboxPrint: CPU system
976.0 (20.2%) 10:26:33 INFO - TinderboxPrint: CPU user
1,651.9 (34.1%) 10:26:33 INFO - TinderboxPrint: Swap in / out
433,373,184 / 0 10:26:33 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395926016; Write bytes: 389293568; Read time: 29636; Write time: 793 10:26:33 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30686208; Write bytes: 298813440; Read time: 296; Write time: 1273 10:26:34 INFO - Running post-run listener: _upload_blobber_files 10:26:34 INFO - Blob upload gear active. 10:26:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:26:34 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:26:34 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:36 INFO - (blobuploader) - INFO - Done attempting. 10:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:26:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:36 INFO - (blobuploader) - INFO - Done attempting. 10:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:39 INFO - (blobuploader) - INFO - Done attempting. 10:26:39 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:39 INFO - Return code: 0 10:26:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/59829dfc45908356eb5ef330f4567fae8e968361960cbb1a139f1322f6bea7c072d6b6b44601d48848a9fb2ec3a1b0558e1fa84c6112b7cad8594344633eee20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e238e62eaa05c1e5f62a77e50623b18ce4bb5b3cd85e7e735e3cf786ffb432e4680e87bfee7673175634b3070b9a4df0deb1bca2f435055846890b7848143cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/975bc4268dac40d4341ad2293c093325ff8d8d4f56d5682782de8bdd0a69dcf6ccca229e87ca4460849c42de9a59f2eb815ca58452c173ac489d506b5282184c"} 10:26:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:39 INFO - Contents: 10:26:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/59829dfc45908356eb5ef330f4567fae8e968361960cbb1a139f1322f6bea7c072d6b6b44601d48848a9fb2ec3a1b0558e1fa84c6112b7cad8594344633eee20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e238e62eaa05c1e5f62a77e50623b18ce4bb5b3cd85e7e735e3cf786ffb432e4680e87bfee7673175634b3070b9a4df0deb1bca2f435055846890b7848143cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/975bc4268dac40d4341ad2293c093325ff8d8d4f56d5682782de8bdd0a69dcf6ccca229e87ca4460849c42de9a59f2eb815ca58452c173ac489d506b5282184c"} 10:26:39 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:39 INFO - Copying logs to upload dir... 10:26:39 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.352884 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-05 10:26:39.298059) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 10:26:39.305359) ========= 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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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/Autoland/sha512/59829dfc45908356eb5ef330f4567fae8e968361960cbb1a139f1322f6bea7c072d6b6b44601d48848a9fb2ec3a1b0558e1fa84c6112b7cad8594344633eee20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e238e62eaa05c1e5f62a77e50623b18ce4bb5b3cd85e7e735e3cf786ffb432e4680e87bfee7673175634b3070b9a4df0deb1bca2f435055846890b7848143cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/975bc4268dac40d4341ad2293c093325ff8d8d4f56d5682782de8bdd0a69dcf6ccca229e87ca4460849c42de9a59f2eb815ca58452c173ac489d506b5282184c"} build_url:https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010738 build_url: 'https://queue.taskcluster.net/v1/task/c38rjJPrS2SJXfZlhKyuzQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/59829dfc45908356eb5ef330f4567fae8e968361960cbb1a139f1322f6bea7c072d6b6b44601d48848a9fb2ec3a1b0558e1fa84c6112b7cad8594344633eee20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e238e62eaa05c1e5f62a77e50623b18ce4bb5b3cd85e7e735e3cf786ffb432e4680e87bfee7673175634b3070b9a4df0deb1bca2f435055846890b7848143cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/975bc4268dac40d4341ad2293c093325ff8d8d4f56d5682782de8bdd0a69dcf6ccca229e87ca4460849c42de9a59f2eb815ca58452c173ac489d506b5282184c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 10:26:39.337762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:26:39.338147) ========= 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.ltzHNPwtKl/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.pbWyRDjTtM/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/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.005295 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:26:39.387607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 10:26:39.388277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 10:26:39.389172) ========= ========= Total master_lag: 0.34 =========