builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0392 starttime: 1473737772.44 results: success (0) buildid: 20160912185107 builduid: 9591c8f7dde44d93ad0e8f95a12e71e4 revision: e2707a19e5cb19c2158cc341029422b5d9f80ef7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:12.437106) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:12.437591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:12.437887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:12.492228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:12.492476) ========= 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.HzmLlXlji8/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.qH4AsmCPHI/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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-09-12 20:36:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 92.6M=0s 2016-09-12 20:36:12 (92.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.454537 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:12.977190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:12.977459) ========= 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.HzmLlXlji8/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.qH4AsmCPHI/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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.025914 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:13.027981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 20:36:13.028719) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e2707a19e5cb19c2158cc341029422b5d9f80ef7 --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 e2707a19e5cb19c2158cc341029422b5d9f80ef7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HzmLlXlji8/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.qH4AsmCPHI/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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-09-12 20:36:13,113 truncating revision to first 12 chars 2016-09-12 20:36:13,114 Setting DEBUG logging. 2016-09-12 20:36:13,114 attempt 1/10 2016-09-12 20:36:13,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e2707a19e5cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-12 20:36:14,422 unpacking tar archive at: autoland-e2707a19e5cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.584883 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 20:36:14.641261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:14.641739) ========= script_repo_revision: e2707a19e5cb19c2158cc341029422b5d9f80ef7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:14.642547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:14.643366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 20:36:14.667058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-12 20:36:14.667739) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.HzmLlXlji8/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.qH4AsmCPHI/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:14 INFO - MultiFileLogger online at 20160912 20:36:14 in /builds/slave/test 20:36:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:36:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:36:14 INFO - {'append_to_log': False, 20:36:14 INFO - 'base_work_dir': '/builds/slave/test', 20:36:14 INFO - 'blob_upload_branch': 'Autoland', 20:36:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:36:14 INFO - 'branch': 'Autoland', 20:36:14 INFO - 'buildbot_json_path': 'buildprops.json', 20:36:14 INFO - 'config_files': ('talos/mac_config.py',), 20:36:14 INFO - 'default_actions': ('clobber', 20:36:14 INFO - 'read-buildbot-config', 20:36:14 INFO - 'download-and-extract', 20:36:14 INFO - 'populate-webroot', 20:36:14 INFO - 'create-virtualenv', 20:36:14 INFO - 'install', 20:36:14 INFO - 'run-tests'), 20:36:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:36:14 INFO - 'download_minidump_stackwalk': True, 20:36:14 INFO - 'download_symbols': 'ondemand', 20:36:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:36:14 INFO - 'tooltool.py': '/tools/tooltool.py', 20:36:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:36:14 INFO - '/tools/misc-python/virtualenv.py')}, 20:36:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:36:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:36:14 INFO - 'installer_path': 'installer.exe', 20:36:14 INFO - 'log_level': 'info', 20:36:14 INFO - 'log_name': 'talos', 20:36:14 INFO - 'log_to_console': True, 20:36:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:36:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:36:14 INFO - 'opt_config_files': (), 20:36:14 INFO - 'pip_index': False, 20:36:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:36:14 INFO - 'cmd': ('bash', 20:36:14 INFO - '-c', 20:36:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:36:14 INFO - 'enabled': True, 20:36:14 INFO - 'halt_on_failure': False, 20:36:14 INFO - 'name': 'check_screen_resolution'},), 20:36:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:36:14 INFO - 'cmd': ('bash', 20:36:14 INFO - '-c', 20:36:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:36:14 INFO - 'enabled': True, 20:36:14 INFO - 'halt_on_failure': False, 20:36:14 INFO - 'name': 'check_screen_resolution'},), 20:36:14 INFO - 'run_cmd_checks_enabled': True, 20:36:14 INFO - 'sps_profile': False, 20:36:14 INFO - 'sps_profile_interval': 0, 20:36:14 INFO - 'suite': 'dromaeojs', 20:36:14 INFO - 'system_bits': '32', 20:36:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:36:14 INFO - 'title': 't-yosemite-r7-0392', 20:36:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:36:14 INFO - 'use_talos_json': True, 20:36:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:36:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:36:14 INFO - 'work_dir': 'build'} 20:36:14 INFO - [mozharness: 2016-09-13 03:36:14.868191Z] Running clobber step. 20:36:14 INFO - Running pre-action listener: _resource_record_pre_action 20:36:14 INFO - Running main action method: clobber 20:36:14 INFO - rmtree: /builds/slave/test/build 20:36:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:36:16 INFO - Running post-action listener: _resource_record_post_action 20:36:16 INFO - [mozharness: 2016-09-13 03:36:16.922591Z] Finished clobber step (success) 20:36:16 INFO - [mozharness: 2016-09-13 03:36:16.922789Z] Running read-buildbot-config step. 20:36:16 INFO - Running pre-action listener: _resource_record_pre_action 20:36:16 INFO - Running main action method: read_buildbot_config 20:36:16 INFO - Using buildbot properties: 20:36:16 INFO - { 20:36:16 INFO - "project": "", 20:36:16 INFO - "product": "firefox", 20:36:16 INFO - "script_repo_revision": "production", 20:36:16 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 20:36:16 INFO - "repository": "", 20:36:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 20:36:16 INFO - "buildid": "20160912185107", 20:36:16 INFO - "pgo_build": "False", 20:36:16 INFO - "basedir": "/builds/slave/test", 20:36:16 INFO - "buildnumber": 164, 20:36:16 INFO - "slavename": "t-yosemite-r7-0392", 20:36:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:36:16 INFO - "platform": "yosemite_r7", 20:36:16 INFO - "scheduler": "tests-autoland-macosx64-talos", 20:36:16 INFO - "branch": "autoland", 20:36:16 INFO - "repo_path": "integration/autoland", 20:36:16 INFO - "revision": "e2707a19e5cb19c2158cc341029422b5d9f80ef7", 20:36:16 INFO - "stage_platform": "macosx64", 20:36:16 INFO - "builduid": "9591c8f7dde44d93ad0e8f95a12e71e4", 20:36:16 INFO - "slavebuilddir": "test" 20:36:16 INFO - } 20:36:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 20:36:16 INFO - Running post-action listener: _resource_record_post_action 20:36:16 INFO - [mozharness: 2016-09-13 03:36:16.926069Z] Finished read-buildbot-config step (success) 20:36:16 INFO - [mozharness: 2016-09-13 03:36:16.926176Z] Running download-and-extract step. 20:36:16 INFO - Running pre-action listener: _resource_record_pre_action 20:36:16 INFO - Running main action method: download_and_extract 20:36:16 INFO - mkdir: /builds/slave/test/build/tests 20:36: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')]} 20:36:16 INFO - trying https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 20:36:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/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 20:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/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 20:36:17 INFO - Downloaded 1199 bytes. 20:36:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:36:17 INFO - Using the following test package requirements: 20:36:17 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:36:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 20:36:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 20:36:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'jsshell-mac.zip'], 20:36:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 20:36:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:36:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 20:36:17 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 20:36:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 20:36:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:36:17 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 20:36:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:36:18 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:36:25 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 20:36:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:36:25 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:36:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:36:33 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:36:33 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')]} 20:36:33 INFO - trying https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:36:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 20:36:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/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 20:36:36 INFO - Downloaded 111393150 bytes. 20:36:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:36:36 INFO - mkdir: /builds/slave/test/properties 20:36:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:36:36 INFO - Writing to file /builds/slave/test/properties/build_url 20:36:36 INFO - Contents: 20:36:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:36:37 INFO - Running post-action listener: _resource_record_post_action 20:36:37 INFO - Running post-action listener: set_extra_try_arguments 20:36:37 INFO - [mozharness: 2016-09-13 03:36:37.163210Z] Finished download-and-extract step (success) 20:36:37 INFO - [mozharness: 2016-09-13 03:36:37.163345Z] Running populate-webroot step. 20:36:37 INFO - Running pre-action listener: _resource_record_pre_action 20:36:37 INFO - Running main action method: populate_webroot 20:36:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:36:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:36:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:36:37 INFO - '--tppagecycles', 20:36:37 INFO - '7'], 20:36:37 INFO - 'tests': ['tsvgm']}}, 20:36:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:36:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:36:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:36:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:36:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['damp', 'tps']}, 20:36:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'tests': ['damp', 'tps']}, 20:36:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['dromaeo_dom']}, 20:36:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:36:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['basic_compositor_video']}, 20:36:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:36:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['a11yr', 20:36:37 INFO - 'ts_paint', 20:36:37 INFO - 'tpaint', 20:36:37 INFO - 'sessionrestore', 20:36:37 INFO - 'sessionrestore_no_auto_restore', 20:36:37 INFO - 'tabpaint']}, 20:36:37 INFO - 'other-e10s': {'tests': ['a11yr', 20:36:37 INFO - 'ts_paint', 20:36:37 INFO - 'tpaint', 20:36:37 INFO - 'sessionrestore', 20:36:37 INFO - 'sessionrestore_no_auto_restore', 20:36:37 INFO - 'tabpaint']}, 20:36:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:36:37 INFO - 'ts_paint', 20:36:37 INFO - 'tpaint', 20:36:37 INFO - 'sessionrestore', 20:36:37 INFO - 'sessionrestore_no_auto_restore', 20:36:37 INFO - 'tabpaint']}, 20:36:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:36:37 INFO - 'ts_paint', 20:36:37 INFO - 'tpaint', 20:36:37 INFO - 'sessionrestore', 20:36:37 INFO - 'sessionrestore_no_auto_restore', 20:36:37 INFO - 'tabpaint']}, 20:36:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['a11yr', 20:36:37 INFO - 'ts_paint', 20:36:37 INFO - 'tpaint', 20:36:37 INFO - 'sessionrestore', 20:36:37 INFO - 'sessionrestore_no_auto_restore', 20:36:37 INFO - 'tabpaint']}, 20:36:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['a11yr', 20:36:37 INFO - 'ts_paint', 20:36:37 INFO - 'tpaint', 20:36:37 INFO - 'sessionrestore', 20:36:37 INFO - 'sessionrestore_no_auto_restore', 20:36:37 INFO - 'tabpaint']}, 20:36:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['tsvgx', 20:36:37 INFO - 'tsvgr_opacity', 20:36:37 INFO - 'tart', 20:36:37 INFO - 'tscrollx', 20:36:37 INFO - 'cart']}, 20:36:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:36:37 INFO - 'tsvgr_opacity', 20:36:37 INFO - 'tart', 20:36:37 INFO - 'tscrollx', 20:36:37 INFO - 'cart']}, 20:36:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'talos_options': ['--disable-e10s'], 20:36:37 INFO - 'tests': ['tp5o']}, 20:36:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'tests': ['tp5o']}, 20:36:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'talos_options': ['--disable-e10s', 20:36:37 INFO - '--xperf_path', 20:36:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:37 INFO - 'tests': ['tp5n']}, 20:36:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:37 INFO - 'talos_options': ['--xperf_path', 20:36:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:37 INFO - 'tests': ['tp5n']}}, 20:36:37 INFO - 'talos.zip': {'path': '', 20:36:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:36:37 INFO - Running post-action listener: _resource_record_post_action 20:36:37 INFO - [mozharness: 2016-09-13 03:36:37.182151Z] Finished populate-webroot step (success) 20:36:37 INFO - [mozharness: 2016-09-13 03:36:37.182283Z] Running create-virtualenv step. 20:36:37 INFO - Running pre-action listener: _resource_record_pre_action 20:36:37 INFO - Running main action method: create_virtualenv 20:36:37 INFO - Creating virtualenv /builds/slave/test/build/venv 20:36:37 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 20:36:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:36:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:36:37 INFO - Using real prefix '/tools/python27' 20:36:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:36:38 INFO - Installing distribute.............................................................................................................................................................................................done. 20:36:40 INFO - Installing pip.................done. 20:36:40 INFO - Return code: 0 20:36:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:40 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:40 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 20:36:40 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 20:36:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:36:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:40 INFO - 'HOME': '/Users/cltbld', 20:36:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:40 INFO - 'LOGNAME': 'cltbld', 20:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:40 INFO - 'MOZ_NO_REMOTE': '1', 20:36:40 INFO - 'NO_EM_RESTART': '1', 20:36:40 INFO - 'PAGER': '/bin/cat', 20:36:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:40 INFO - 'PWD': '/builds/slave/test', 20:36:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:40 INFO - 'SHELL': '/bin/bash', 20:36:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:36:40 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:36:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:40 INFO - 'USER': 'cltbld', 20:36:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:40 INFO - 'XPC_FLAGS': '0x0', 20:36:40 INFO - 'XPC_SERVICE_NAME': '0', 20:36:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:41 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 20:36:41 INFO - Cleaning up... 20:36:41 INFO - Return code: 0 20:36:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:36:41 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')]} 20:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:41 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')]} 20:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:41 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:41 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 20:36:41 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 20:36:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:36:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:41 INFO - 'HOME': '/Users/cltbld', 20:36:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:41 INFO - 'LOGNAME': 'cltbld', 20:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:41 INFO - 'MOZ_NO_REMOTE': '1', 20:36:41 INFO - 'NO_EM_RESTART': '1', 20:36:41 INFO - 'PAGER': '/bin/cat', 20:36:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:41 INFO - 'PWD': '/builds/slave/test', 20:36:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:41 INFO - 'SHELL': '/bin/bash', 20:36:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:36:41 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:36:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:41 INFO - 'USER': 'cltbld', 20:36:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:41 INFO - 'XPC_FLAGS': '0x0', 20:36:41 INFO - 'XPC_SERVICE_NAME': '0', 20:36:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:41 INFO - Downloading/unpacking psutil>=3.1.1 20:36:41 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 20:36:41 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 20:36:41 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 20:36:41 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 20:36:41 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 20:36:41 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 20:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:36:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:44 INFO - Installing collected packages: psutil 20:36:44 INFO - Running setup.py install for psutil 20:36:44 INFO - building 'psutil._psutil_osx' extension 20:36:44 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 20:36:45 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 20:36:45 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 20:36:45 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 20:36:45 INFO - building 'psutil._psutil_posix' extension 20:36:45 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 20:36:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:36:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:36:45 INFO - ^ 20:36:45 INFO - 1 warning generated. 20:36:45 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 20:36:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:45 INFO - Successfully installed psutil 20:36:45 INFO - Cleaning up... 20:36:45 INFO - Return code: 0 20:36:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:36:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:36:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:45 INFO - 'HOME': '/Users/cltbld', 20:36:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:45 INFO - 'LOGNAME': 'cltbld', 20:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:45 INFO - 'MOZ_NO_REMOTE': '1', 20:36:45 INFO - 'NO_EM_RESTART': '1', 20:36:45 INFO - 'PAGER': '/bin/cat', 20:36:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:45 INFO - 'PWD': '/builds/slave/test', 20:36:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:45 INFO - 'SHELL': '/bin/bash', 20:36:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:36:45 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:36:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:45 INFO - 'USER': 'cltbld', 20:36:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:45 INFO - 'XPC_FLAGS': '0x0', 20:36:45 INFO - 'XPC_SERVICE_NAME': '0', 20:36:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:36:48 INFO - Installing collected packages: mozsystemmonitor 20:36:48 INFO - Running setup.py install for mozsystemmonitor 20:36:48 INFO - Successfully installed mozsystemmonitor 20:36:48 INFO - Cleaning up... 20:36:48 INFO - Return code: 0 20:36:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:48 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:48 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 20:36:48 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 20:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:48 INFO - 'HOME': '/Users/cltbld', 20:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:48 INFO - 'LOGNAME': 'cltbld', 20:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:48 INFO - 'MOZ_NO_REMOTE': '1', 20:36:48 INFO - 'NO_EM_RESTART': '1', 20:36:48 INFO - 'PAGER': '/bin/cat', 20:36:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:48 INFO - 'PWD': '/builds/slave/test', 20:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:48 INFO - 'SHELL': '/bin/bash', 20:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:36:48 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:48 INFO - 'USER': 'cltbld', 20:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:48 INFO - 'XPC_FLAGS': '0x0', 20:36:48 INFO - 'XPC_SERVICE_NAME': '0', 20:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:48 INFO - Downloading/unpacking jsonschema==2.5.1 20:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:36:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:36:51 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 20:36:51 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 20:36:51 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 20:36:51 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 20:36:51 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 20:36:51 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 20:36:51 INFO - Downloading functools32-3.2.3-2.tar.gz 20:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:36:51 INFO - warning: no files found matching '*.txt' 20:36:51 INFO - no previously-included directories found matching 'build' 20:36:51 INFO - no previously-included directories found matching 'dist' 20:36:51 INFO - no previously-included directories found matching '.git*' 20:36:51 INFO - Installing collected packages: jsonschema, functools32 20:36:51 INFO - Running setup.py install for functools32 20:36:52 INFO - warning: no files found matching '*.txt' 20:36:52 INFO - no previously-included directories found matching 'build' 20:36:52 INFO - no previously-included directories found matching 'dist' 20:36:52 INFO - no previously-included directories found matching '.git*' 20:36:52 INFO - Successfully installed jsonschema functools32 20:36:52 INFO - Cleaning up... 20:36:52 INFO - Return code: 0 20:36:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:36:52 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')]} 20:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:52 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')]} 20:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:52 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:52 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 20:36:52 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 20:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:52 INFO - 'HOME': '/Users/cltbld', 20:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:52 INFO - 'LOGNAME': 'cltbld', 20:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:52 INFO - 'MOZ_NO_REMOTE': '1', 20:36:52 INFO - 'NO_EM_RESTART': '1', 20:36:52 INFO - 'PAGER': '/bin/cat', 20:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:52 INFO - 'PWD': '/builds/slave/test', 20:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:52 INFO - 'SHELL': '/bin/bash', 20:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:36:52 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:52 INFO - 'USER': 'cltbld', 20:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:52 INFO - 'XPC_FLAGS': '0x0', 20:36:52 INFO - 'XPC_SERVICE_NAME': '0', 20:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:36:52 INFO - Cleaning up... 20:36:52 INFO - Return code: 0 20:36:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:36:52 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')]} 20:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:52 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')]} 20:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:52 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:52 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 20:36:52 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 20:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:52 INFO - 'HOME': '/Users/cltbld', 20:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:52 INFO - 'LOGNAME': 'cltbld', 20:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:52 INFO - 'MOZ_NO_REMOTE': '1', 20:36:52 INFO - 'NO_EM_RESTART': '1', 20:36:52 INFO - 'PAGER': '/bin/cat', 20:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:52 INFO - 'PWD': '/builds/slave/test', 20:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:52 INFO - 'SHELL': '/bin/bash', 20:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:36:52 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:52 INFO - 'USER': 'cltbld', 20:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:52 INFO - 'XPC_FLAGS': '0x0', 20:36:52 INFO - 'XPC_SERVICE_NAME': '0', 20:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:55 INFO - Downloading blobuploader-1.2.4.tar.gz 20:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:36:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:36:55 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 20:36:55 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 20:36:55 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 20:36:55 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 20:36:55 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 20:36:55 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 20:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:36:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:36:55 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 20:36:55 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 20:36:55 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 20:36:55 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 20:36:55 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 20:36:55 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 20:36:56 INFO - Downloading docopt-0.6.1.tar.gz 20:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:36:56 INFO - Installing collected packages: blobuploader, requests, docopt 20:36:56 INFO - Running setup.py install for blobuploader 20:36:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:36:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:36:56 INFO - Running setup.py install for requests 20:36:57 INFO - Running setup.py install for docopt 20:36:57 INFO - Successfully installed blobuploader requests docopt 20:36:57 INFO - Cleaning up... 20:36:57 INFO - Return code: 0 20:36:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:57 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:36:57 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 20:36:57 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 20:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:57 INFO - 'HOME': '/Users/cltbld', 20:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:57 INFO - 'LOGNAME': 'cltbld', 20:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:57 INFO - 'MOZ_NO_REMOTE': '1', 20:36:57 INFO - 'NO_EM_RESTART': '1', 20:36:57 INFO - 'PAGER': '/bin/cat', 20:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:57 INFO - 'PWD': '/builds/slave/test', 20:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:57 INFO - 'SHELL': '/bin/bash', 20:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:36:57 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:57 INFO - 'USER': 'cltbld', 20:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:57 INFO - 'XPC_FLAGS': '0x0', 20:36:57 INFO - 'XPC_SERVICE_NAME': '0', 20:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:36:57 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-iiq4Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:36:57 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-STbqeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:36:57 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-REl6H5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:36:57 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-KWJVAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:36:57 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-CENvqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-G_6Qdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-JqhUfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-cgHqqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-WdEz7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-oH47u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-_f2C_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-gDRLib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-xKwTCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:36:58 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-7c2SGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:59 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-AgMg1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:36:59 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-hTcZ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:36:59 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-YgShvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:36:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:36:59 INFO - Running setup.py install for manifestparser 20:36:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:36:59 INFO - Running setup.py install for mozcrash 20:36:59 INFO - Running setup.py install for mozdebug 20:36:59 INFO - Running setup.py install for mozdevice 20:36:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:36:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:36:59 INFO - Running setup.py install for mozfile 20:37:00 INFO - Running setup.py install for mozhttpd 20:37:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Running setup.py install for mozinfo 20:37:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Running setup.py install for mozInstall 20:37:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Running setup.py install for mozleak 20:37:00 INFO - Running setup.py install for mozlog 20:37:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Running setup.py install for moznetwork 20:37:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:37:00 INFO - Running setup.py install for mozprocess 20:37:01 INFO - Running setup.py install for mozprofile 20:37:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:37:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:37:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:37:01 INFO - Running setup.py install for mozrunner 20:37:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:37:01 INFO - Running setup.py install for mozscreenshot 20:37:01 INFO - Running setup.py install for moztest 20:37:01 INFO - Running setup.py install for mozversion 20:37:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:37:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:37:01 INFO - Cleaning up... 20:37:01 INFO - Return code: 0 20:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:01 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:37:01 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 20:37:01 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 20:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:01 INFO - 'HOME': '/Users/cltbld', 20:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:01 INFO - 'LOGNAME': 'cltbld', 20:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:01 INFO - 'MOZ_NO_REMOTE': '1', 20:37:01 INFO - 'NO_EM_RESTART': '1', 20:37:01 INFO - 'PAGER': '/bin/cat', 20:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:01 INFO - 'PWD': '/builds/slave/test', 20:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:01 INFO - 'SHELL': '/bin/bash', 20:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:37:01 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:01 INFO - 'USER': 'cltbld', 20:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:01 INFO - 'XPC_FLAGS': '0x0', 20:37:01 INFO - 'XPC_SERVICE_NAME': '0', 20:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-zfqq3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:37:02 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)) 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-vCQ38S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:37:02 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)) 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-ezSMG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:37:02 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)) 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-kuAZ9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:37:02 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)) 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-C85VyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:37:02 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)) 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-NuXTLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:37:02 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)) 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-jN2Yya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:37:02 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)) 20:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:37:02 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-n3NPcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-CMuuvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-kjGa3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-RjLl5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-GLrH1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-DtxkDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-Mj1Z7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-PypsLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-9jPLrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:37:03 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)) 20:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:37:03 INFO - Running setup.py (path:/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/pip-GSYA0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:37:04 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)) 20:37:04 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)) 20:37:04 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)) 20:37:04 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)) 20:37:04 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)) 20:37:04 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)) 20:37:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:37: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 20:37: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 20:37: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 20:37: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 20:37: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 20:37: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 20:37:06 INFO - Downloading blessings-1.6.tar.gz 20:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:37:06 INFO - Installing collected packages: blessings 20:37:06 INFO - Running setup.py install for blessings 20:37:06 INFO - Successfully installed blessings 20:37:06 INFO - Cleaning up... 20:37:06 INFO - Return code: 0 20:37:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:37:07 INFO - Reading from file tmpfile_stdout 20:37:07 INFO - Current package versions: 20:37:07 INFO - blessings == 1.6 20:37:07 INFO - blobuploader == 1.2.4 20:37:07 INFO - docopt == 0.6.1 20:37:07 INFO - functools32 == 3.2.3-2 20:37:07 INFO - jsonschema == 2.5.1 20:37:07 INFO - manifestparser == 1.1 20:37:07 INFO - mozInstall == 1.12 20:37:07 INFO - mozcrash == 0.17 20:37:07 INFO - mozdebug == 0.1 20:37:07 INFO - mozdevice == 0.48 20:37:07 INFO - mozfile == 1.2 20:37:07 INFO - mozhttpd == 0.7 20:37:07 INFO - mozinfo == 0.9 20:37:07 INFO - mozleak == 0.1 20:37:07 INFO - mozlog == 3.3 20:37:07 INFO - moznetwork == 0.27 20:37:07 INFO - mozprocess == 0.23 20:37:07 INFO - mozprofile == 0.28 20:37:07 INFO - mozrunner == 6.12 20:37:07 INFO - mozscreenshot == 0.1 20:37:07 INFO - mozsystemmonitor == 0.3 20:37:07 INFO - moztest == 0.7 20:37:07 INFO - mozversion == 1.4 20:37:07 INFO - psutil == 3.1.1 20:37:07 INFO - requests == 1.2.3 20:37:07 INFO - wsgiref == 0.1.2 20:37:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:37: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')]} 20:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37: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')]} 20:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37:07 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 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:37:07 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 20:37:07 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 20:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:07 INFO - 'HOME': '/Users/cltbld', 20:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:07 INFO - 'LOGNAME': 'cltbld', 20:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:07 INFO - 'MOZ_NO_REMOTE': '1', 20:37:07 INFO - 'NO_EM_RESTART': '1', 20:37:07 INFO - 'PAGER': '/bin/cat', 20:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:07 INFO - 'PWD': '/builds/slave/test', 20:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:07 INFO - 'SHELL': '/bin/bash', 20:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:37:07 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:07 INFO - 'USER': 'cltbld', 20:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:07 INFO - 'XPC_FLAGS': '0x0', 20:37:07 INFO - 'XPC_SERVICE_NAME': '0', 20:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 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)) 20:37:07 INFO - Cleaning up... 20:37:07 INFO - Return code: 0 20:37:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:37: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')]} 20:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37: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')]} 20:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105c2e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd892dbbfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, '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.HzmLlXlji8/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.qH4AsmCPHI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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 20:37: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', 'jsonschema'] in /builds/slave/test/build 20:37: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 jsonschema 20:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:07 INFO - 'HOME': '/Users/cltbld', 20:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:07 INFO - 'LOGNAME': 'cltbld', 20:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:07 INFO - 'MOZ_NO_REMOTE': '1', 20:37:07 INFO - 'NO_EM_RESTART': '1', 20:37:07 INFO - 'PAGER': '/bin/cat', 20:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:07 INFO - 'PWD': '/builds/slave/test', 20:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:07 INFO - 'SHELL': '/bin/bash', 20:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:37:07 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:07 INFO - 'USER': 'cltbld', 20:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:07 INFO - 'XPC_FLAGS': '0x0', 20:37:07 INFO - 'XPC_SERVICE_NAME': '0', 20:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:37:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:37:07 INFO - Cleaning up... 20:37:07 INFO - Return code: 0 20:37:07 INFO - Running post-action listener: _resource_record_post_action 20:37:07 INFO - Running post-action listener: _start_resource_monitoring 20:37:07 INFO - Starting resource monitoring. 20:37:07 INFO - [mozharness: 2016-09-13 03:37:07.681025Z] Finished create-virtualenv step (success) 20:37:07 INFO - [mozharness: 2016-09-13 03:37:07.682093Z] Running install step. 20:37:07 INFO - Running pre-action listener: _resource_record_pre_action 20:37:07 INFO - Running main action method: install 20:37:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:37:07 INFO - Reading from file tmpfile_stdout 20:37:07 INFO - Detecting whether we're running mozinstall >=1.0... 20:37:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:37:08 INFO - Reading from file tmpfile_stdout 20:37:08 INFO - Output received: 20:37:08 INFO - Usage: mozinstall [options] installer 20:37:08 INFO - Options: 20:37:08 INFO - -h, --help show this help message and exit 20:37:08 INFO - -d DEST, --destination=DEST 20:37:08 INFO - Directory to install application into. [default: 20:37:08 INFO - "/builds/slave/test"] 20:37:08 INFO - --app=APP Application being installed. [default: firefox] 20:37:08 INFO - mkdir: /builds/slave/test/build/application 20:37:08 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'] 20:37:08 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 20:37:42 INFO - Reading from file tmpfile_stdout 20:37:42 INFO - Output received: 20:37:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:37:42 INFO - Running post-action listener: _resource_record_post_action 20:37:42 INFO - [mozharness: 2016-09-13 03:37:42.027175Z] Finished install step (success) 20:37:42 INFO - [mozharness: 2016-09-13 03:37:42.027294Z] Running run-tests step. 20:37:42 INFO - Running pre-action listener: _resource_record_pre_action 20:37:42 INFO - Running main action method: run_tests 20:37:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:37:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:37:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:37:42 INFO - 2016-09-12 20:37:42.042 screenresolution[1660:9135] starting screenresolution argv=screenresolution get 20:37:42 INFO - 2016-09-12 20:37:42.047 screenresolution[1660:9135] Display 0: 1600x1200x32@60 20:37:42 INFO - 2016-09-12 20:37:42.053 screenresolution[1661:9146] starting screenresolution argv=screenresolution list 20:37:42 INFO - Available Modes on Display 0 20:37:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:37:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:37:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:37:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:37:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:37:42 INFO - Intel Iris: 20:37:42 INFO - Chipset Model: Intel Iris 20:37:42 INFO - Type: GPU 20:37:42 INFO - Bus: Built-In 20:37:42 INFO - VRAM (Dynamic, Max): 1536 MB 20:37:42 INFO - Vendor: Intel (0x8086) 20:37:42 INFO - Device ID: 0x0a2e 20:37:42 INFO - Revision ID: 0x0009 20:37:42 INFO - Displays: 20:37:42 INFO - Display: 20:37:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:37:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:37:42 INFO - Display Serial Number: 1600x1200 60 20:37:42 INFO - Main Display: Yes 20:37:42 INFO - Mirror: Off 20:37:42 INFO - Online: Yes 20:37:42 INFO - Rotation: Supported 20:37:42 INFO - Return code: 0 20:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:37:42 INFO - Python 2.7.3 20:37:42 INFO - Return code: 0 20:37:42 INFO - grabbing minidump binary from tooltool 20:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:37:42 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 0x105a42d30>, '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 0x105868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:37:42 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 20:37:42 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 20:37:42 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 20:37:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:37:42 INFO - Return code: 0 20:37:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:37:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:37:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:37:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:37:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0392 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzmLlXlji8/Render', 20:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:42 INFO - 'HOME': '/Users/cltbld', 20:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:42 INFO - 'LOGNAME': 'cltbld', 20:37:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:37:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:42 INFO - 'MOZ_NO_REMOTE': '1', 20:37:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:37:42 INFO - 'NO_EM_RESTART': '1', 20:37:42 INFO - 'PAGER': '/bin/cat', 20:37:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:42 INFO - 'PWD': '/builds/slave/test', 20:37:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:42 INFO - 'SHELL': '/bin/bash', 20:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qH4AsmCPHI/Listeners', 20:37:42 INFO - 'TMPDIR': '/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/', 20:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:42 INFO - 'USER': 'cltbld', 20:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:42 INFO - 'XPC_FLAGS': '0x0', 20:37:42 INFO - 'XPC_SERVICE_NAME': '0', 20:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:37:42 INFO - mozversion application_buildid: 20160912185107 20:37:42 INFO - mozversion application_changeset: e2707a19e5cb19c2158cc341029422b5d9f80ef7 20:37:42 INFO - mozversion application_display_name: Nightly 20:37:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:37:42 INFO - mozversion application_name: Firefox 20:37:42 INFO - mozversion application_remotingname: firefox 20:37:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:37:42 INFO - mozversion application_vendor: Mozilla 20:37:42 INFO - mozversion application_version: 51.0a1 20:37:42 INFO - mozversion platform_buildid: 20160912185107 20:37:42 INFO - mozversion platform_changeset: e2707a19e5cb19c2158cc341029422b5d9f80ef7 20:37:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:37:42 INFO - mozversion platform_version: 51.0a1 20:37:42 INFO - using testdate: 1473737862 20:37:42 INFO - actual date: 1473737862 20:37:42 INFO - starting webserver on 'localhost:49276' 20:37:42 INFO - SUITE-START | Running 2 tests 20:37:42 INFO - TEST-START | dromaeo_css 20:37:42 INFO - operating with platform_type : mac_ 20:37:42 INFO - Initialising browser for dromaeo_css test... 20:37:42 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmpRMbY7Y/profile http://localhost:49276/getInfo.html) 20:37:45 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 20:37:45 INFO - PROCESS | 1671 | colorDepth:24 20:37:45 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 20:37:45 INFO - PROCESS | 1671 | __metrics 20:37:45 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:37:45 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:37:45 INFO - TEST-INFO | 1671: exit 0 20:37:45 INFO - Browser initialized. 20:37:45 INFO - Running cycle 1/1 for dromaeo_css test... 20:37:45 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmpRMbY7Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:58 INFO - PROCESS | 1674 | RSS: Main: 234016768 20:37:58 INFO - PROCESS | 1674 | 20:38:49 INFO - PROCESS | 1674 | 1473737929577 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] 20:41:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 20:41:03 INFO - PROCESS | 1674 | RSS: Main: 391503872 20:41:03 INFO - PROCESS | 1674 | 20:44:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 20:44:06 INFO - PROCESS | 1674 | RSS: Main: 375922688 20:44:06 INFO - PROCESS | 1674 | 20:47:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 20:47:09 INFO - PROCESS | 1674 | RSS: Main: 366616576 20:47:09 INFO - PROCESS | 1674 | 20:50:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 20:50:12 INFO - PROCESS | 1674 | RSS: Main: 353722368 20:50:12 INFO - PROCESS | 1674 | 20:53:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 20:53:16 INFO - PROCESS | 1674 | RSS: Main: 326946816 20:53:16 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 20:56:20 INFO - PROCESS | 1674 | RSS: Main: 479260672 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | __start_tp_report 20:56:20 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 20:56:20 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 20:56:20 INFO - PROCESS | 1674 | |i|pagename|runs| 20:56:20 INFO - PROCESS | 1674 | |0;dojo.html;3367.3770352484785;3389.203537168765;3416.5387672664183;3450.706689931356;3473;4756.904861902764;5765.6828874411995;5849.385814489481;5887.293524777027;5917.911231331528;5845.123231515264;5874.383189765077;5875.412458754123;5885.205497257869;5887.3229578598475;5260.342457192842;5298.576113910878;5298.761555729982;5351.57187425007;5367.597430192751;4242.406063151161;5312.389075256337;5416.972915135419;5427.43011983742;5427.810026649068;4495;5239.79040838366;5353.866153346158;5354;5413.106837371829;5416.2417261583605;5426.077566813651;5449.809256676037;5453.427390124019;5484.341878974508;5206.505381988705;5242.711650859202;5255.421903590602;5371.650842695251;5374.167004114369;5738.196652468658;5812.011957967114;5826.300843898717;5863.882722345572;5868.09044598088;6295;6347.619142851444;6354.3963323484195;6354.7458101675875;6357;6230.906536401958;6246.812595622138;6299.055141728777;6330.68346582669;6370.362963703639;5932.169496270569;5936.198613187207;5942.762289508458;6007.699615019232;6059.27288725347;6346.524010699216;6353.936460635427;6356.968215158895;6361.840953976188;6367.968160159262;5182.585393168538;6136.23297087864;6220.564560480723;6235.438810507076;6290.21372328459;5785.247917770663;5824.94175058244;6243.750249989949;6261.311255761862;6333.809985700436;6325.683715814191;6332.746690132435;6332.905006424908;6344.714487848058;6350;6301.842453938688;6325.262268184792;6347.682615869188;6374.394432528902;6376.107344971708;4960.900781984412;4991.700497970133;4994.275830004629;5032;5052.57053150479;4524;4537.591616754508;4547.8180872764715;4560.4527456704745;4582.266837306015;5809.506191973645;5867.970660146757;5871.882562348729;5880.676562789087;5884.676342801187;6243;6266.749330026839;6290.559660823698;6312.968435157794;6331.683415829282;4943.703377797272;5433.157860531624;5672.716364181774;5826.6795326256615;5860.619059761102;5424.918626220609;5448.83653490396;5455.236266922634;5509.779608815683;5558.833235002957;6352.968235158794;6354.3010268870385;6356.427921486996;6364.554481186273;6369.808905732835;6305.5901366411035;6350.364963503613;6352.777652782131;6358.586691865014;6359.300476947625;6279.748810047547;6289.433950944254;6314.1160237565855;6319.115323854756;6327.715252813542;6123.418275263843;6183.134361189527;6212.627242365473;6217.533684973736;6231.3145553988115;6228.4705800005695;6252.562320637512;6259.937400625936;6264.812055638338;6269.96865015672;5993.507941620928;6109.20580324555;6117.9187529241;6133.785317514044;6143.262808463013;6160.568760186744;6185.103160041859;6186.443220110212;6186.752529898754;6262;6120.538559592075;6123.173371594778;6128.472568454306;6137.723802428812;6138.324784273637;6217.4715149212825;6238.875222495434;6239.251289845248;6242.875142497215;6251.187345645037;5955.434233747787;5984.820455386345;6010.7295171716505;6023.518118550418;6095.603785753912 20:56:20 INFO - PROCESS | 1674 | |1;ext.html;470.96467764917617;521.6218241774714;521.9817306394277;547.5263896729331;554.8807006493604;29123.56314655279;30375.392492150142;31508.53406125327;39924;40966.79516602413;42577.57422425775;42898;42982.35526467098;42985.925351866215;43056.78471607646;9488.240940724725;9616.951915240448;9632.47021413822;9652.517374131301;9674.951625241863;9735.853962190573;9860.309778315484;9860.852087218698;9863.210943124568;9881.752956176082;9840.950795246014;9881.851772223423;9894.30739848211;9914;9915.058069483424;9817.6072957082;9855.226059309321;9861;9871.210303175729;9884.061014203638;9758;9861.309708320421;9865.309428340019;9868.555914983843;9886.357386769838;39743.40384894229;40084.39873401872;40114.197716045805;40146;40186.19627607431;3312.188513814107;3326.567546219;3327.5008748687646;3378.5101160331615;3419.589649242107;30001.699983000326;30515;30537.23656908573;30846.383072338427;31052.0684379469;3137.1059248114407;3219.114743445548;3244.7404207663567;3266.3304022675293;3266.8203248821305;462644.9999999966;464716;466780.6660966707;467096;467319;58355.70822145862;58646;58813.70593147007;58818.7059064702;58834.70582647059;33901;34729.82635086859;60135.69932150399;60152.39847601556;60232.39767602268;15755.212239387985;16103.838961610469;16143.838561614233;16150.515484535483;16158.676826463405;12274.079444041732;12379.133460657667;12387.885090341913;12391.62825115248;12409.131360804837;15160.545183644508;16182.595435114215;17434.389796357067;18583.911539461296;18612.720809187875;7087.468439867031;7652.69389224436;7701.845963080819;7714.729984450517;7760.9223907761325;866.787637028932;913.6756451459769;1025.6717850287985;1051.169576034924;1088.8965548272902;29761.553576696366;29887;30549.38901221963;30647.540286895714;30746.077617671504;902.8058967322057;1029.7334278837072;1038.6883934819675;1050.1598721023151;1112.8553288072499;14941.551753447415;15473.767893481607;15750.684986300439;15814.424494537152;15931.920340398225;593345;710062;711667.4416627884;711815;712656;57644.71177644085;58112.41887581155;58126.4187358121;58138;58210;1229.569650622275;1249.9625011249677;1314.185205172799;1339.189790176929;1364.7611667958067;29905.551416728333;30458;31079.0676279712;31772.364552708354;32030.878919237715;55811.88376232371;56420;56522.43477565336;56533;56548;633018;639413;639661;641117;641288;34608.82695586506;35610;35759.28481430409;41874.58125418707;41974.74075777731;46306.53693463157;46400.591943765285;47727.80680483016;47912.8439220229;47921.281180783015;35923.79105029808;37648;38517.42223866588;38670.033249169;38795.03012424712;30998.22504437407;37261.4410783833;37880.05299867525;38590.42114368343;39221.41167882541;37603.623963760016;37965.166270071655;38785.4182187273;38797;40261.39607905942;30754;33792.01848016545;34464;34539.48190777191;34543.65456345505;25425.237242882744;25477.74522254754;25485.49029019372;25968;25985 20:56:20 INFO - PROCESS | 1674 | |2;jquery.html;342.89541689784636;358.7291594845891;363.5637235317618;370.2927408649479;391.2917619109412;14660.486882959098;14916.477923272687;15749.763753543692;16528.504144875642;20582.588348233025;17917.7312340315;20544.280950166747;20967.16131354744;20985.47536311593;21254.362369128914;5827.912581311273;6145.723442445078;6148.907766383508;6148.985417406145;6151.8769624607485;4207.221663992156;4420.734755914656;5974.611650242742;6034.155218269446;6039.369370270025;4305.24658184818;4382.408374869399;6518.608883466984;6828.453723702117;6846.691898864563;6470.514711396617;6622.072909792633;6679.33206679333;6859.965700171492;6905.343992320747;5762.654240745527;5764.423557644202;5765.481106700375;5777.335606405233;5787.450192231773;24479.51040979188;24870.37824054413;25170.496590068095;25172;25374;1984.1369004483097;2157.4067131538795;2181.5636872625537;2267.5691618592414;2369.751176126499;14734.33695483695;14837.10977341363;15139.394424223017;16150.273237704332;16266.430674926321;1818.336307247845;1866.598681283517;1872.4382685194523;1880.454668146236;1943.6987266973501;119581;121028.39485802515;121980.39009804983;122370;122471.38764306121;9254.953725231466;9809.264305176997;10359.482025898826;10806.51370688321;10997.230193886511;13480.719331663673;13500.729985400434;13531.120477168952;13538.729225415436;13556.661083472993;8136.837263254702;8402.28580570646;8421.031581368099;8539.914600854036;8557.229849313591;8387.832243355098;8395.034571024411;8415.95792021036;8541.231289184003;8595.226429621363;5328.333958255218;6442.162518872517;6510.78302161542;6540.444062254666;6702.09521714572;1540.5378386484233;1549.3105568022122;1645.798567046063;1731.3507434711983;1809.5657042310015;735.2463724682136;830.1242189490146;847.7499137754377;916.6929078758557;924.2513564013171;21233.469163271042;21408;22252.888735556542;22343.553128937656;22466;904.1184844776421;908.3323757038571;932.6083045121065;936.7704912296531;953.4327075390132;10440.738981525523;10917.672469825919;11313.83029254562;11390.867511434257;11394.658160255205;597433;605845;610635;623319.8834005801;623862;120936;124740;143468;146810.53189468183;149959;999.8450240212778;1006.2553710254359;1024.4672770159475;1024.6925922223304;1027.1525991057408;15974;18116.91298522093;19185.61628767445;19268.4219473416;19323.51691207731;43562.782186088865;53166.73416632892;57114.28757130773;57306.713466432404;59548;70811;79382.4123517538;85667.57166214129;86420;88604;7850.097238817609;7910.7231246906085;7977.282044616012;8154.469959452616;8208.958955205186;10405.47972601382;12611.621651350475;12761.808572871229;12837.293948832903;13018.2839943804;10903.34579925207;11250.437478126225;11311.321320720783;11410;11412.600558980395;10125;10817.783644326912;11186.161037922351;11440.771184576428;11451.656450306504;11038.668839934815;11132.276402033842;11397.886021140013;11424.600138995096;11583.305001699924;8077.676892924453;8094.757157285291;8147.59262036884;8186.590670466334;8193.180681931759;9174.357794954556;11311.547538098714;11325.263857849213;11330.394009377724;11353.716157096138 20:56:20 INFO - PROCESS | 1674 | |3;mootools.html;1521.8173819141705;1540.2452798128918;1725.9741103883443;1764.453019563936;1898.838598719108;6659.63372014539;8157.980252468441;8358.414910956228;8875.91124088759;8904.198622124008;7942.880856787153;8486.915130848705;8710.477371357723;8712.346574006942;8838.602262898168;1964.2241314680693;2323.279783267184;2349.9765002349927;2351.071326825903;2351.8824058797077;2312.491251924574;2341.95316093678;2372.2764556810166;2373.4778348763243;2375.8812059397046;2080;2157.255746767363;2159.255057005331;2236.519148383097;2350.764923507653;2324.7442781294044;2362.4566349739657;2364.148906393697;2365.810735141193;2365.976340236593;2256.7404748453973;2306.3888069661552;2306.746257911628;2309.872956987365;2316.4787922717423;8682.479051256945;8749.256313213384;8756.124387561193;8758.649654013832;8773.912260877374;5236.502532259429;5303.443138470444;5363.06146424378;5365.436629153961;5374.005808925362;3480.077779388464;3515.3145136698354;3688.5758137814228;3697.352963231424;3703.370427027412;1068.9198310126772;1069.4813015687384;1074.2275245844341;1089.6513115802945;1096.6052221200362;9603.663871764524;11311.547538098548;11332.886671133265;11522.596709115141;11543.53825846965;4559.566841150086;4587.839425620087;4767.547083027107;4776.450708168536;4784.378030855966;9895.158911492459;9919;9927;9935.565786382238;9974.102330790263;5327.147656374961;5329.147336426153;5332.706701131475;5344.599155063386;5360.973195133999;4669.836555720602;4815.494373090775;4887.706737595756;4888.071266459361;4890.559849613552;3726.9627303727157;3764.8305826237884;3803.1633040730994;3837.808109594509;3847.634474724897;1173.7124404520946;1182.8994535464583;1184.1769969870857;1185.3065956415421;1190.874958129384;617.7992152550439;760.1638197982176;772.6947855597008;800.8038030682403;835.5571547079936;5637.943620563824;5832.912506312408;5977.432143946318;6101.359357267512;6343.5876668016435;771.7568965775763;837.4221786966973;909.1999040844147;916.225789208118;938.3384713776771;3841.2893614681375;3905.824237909301;3978.542467616261;4032.737872038308;4054.3715724062818;10416.166706663449;10796.190285728602;10843.67468975932;10854.620088296871;10859;10724.356538607708;10810.189235807346;10815.297005694605;10823.025927666547;10824.621138260281;8011.719589814328;8157.714479993172;8164.5917704115745;8167.469114507538;8168.836623267502;5344.866378340417;5441.020616289106;5701.686407247641;5867.295924488918;5942;9910;9940.403575785476;9954.950225248827;9962.750931226487;9998.400095994264;9819.410835349901;10010.949945250519;10126.797464050826;10238.436885971343;10246.180305575386;6728.394444500019;6961.860762784615;7015.6842942066705;7025.578465292099;7027.718891244497;8132.6746930122135;8155.551444670363;8161.551114688749;8162.428629995843;8166.918330816616;7132.179799323144;7253.1296244448895;7274.599897005503;7414.036175297177;7588.241175882367;6076.817695469143;7110.1112360954885;7240.203577606564;7376.483646144933;7436.851262974602;6819.18169819605;6825.761098361533;6853.862922741617;6910.654467276717;6918.792436226921;4960.454350021422;5000.974995125001;5025.321581586439;5030.446650868328;5090.7709153088945;4497.280435130363;4880.1215781159735;4969.006198760335;5065.504801686824;5185.507376799198 20:56:20 INFO - PROCESS | 1674 | |4;prototype.html;275.4807188449772;285.2739777266856;306.41627699232953;309.39358856640985;310.6691373687025;4181.393697913801;4313.374560688699;5338.652987555806;5378.623496355257;5381.650192737469;4665.603423708989;5162.7978969337755;5263.236830659552;5274.4725527447235;5292.311999440068;4004.8986528704695;4038.5163124678256;4052.594740525946;4053;4068.247374235761;3042.923926901823;3582.6417358264093;4065.349544072949;4081.632653061224;4087.4890638670167;3791.2986097571898;3880.6701430378453;3966.6826653867765;4000.7599544027307;4043.575424580421;3990.4413382126527;4011.4183443400543;4032.5362583303004;4038.959610403888;4052.2444737578435;2902.75181671881;3500.9824950875336;3526.4710293456187;3526.9118272043147;3531.346700860349;3990.4213888985932;4814.725986329295;4818.602884966125;4886.218205087169;5157.252198431244;3750.887473375803;4023.75857448554;4581.221192397301;4610.700304480198;4610.815567377301;4432.822687092513;5283.418823929364;5364.953834002371;5365.409804921455;5543.639663421905;3108.6269647642202;3231;3367.8380958569255;3451.6548345165534;3730.1420673245034;5194.013137503862;5390.434004429557;5514.91727624086;5821.767129314822;5883.676397798119;3493.7903725776537;3656.5063716398477;3716.442533619979;3833.4666133546802;3877.2827027000094;3893.8637147699696;3894.357431023849;3906.140649057203;3908.6286802753693;3931.4495970564144;4119.423280740699;4297.05464797744;4362.8691139265875;4537;4584.977075114603;4566.543345665407;5102.260172275;5251.00692605219;5513.531349835309;5620.4707881453505;1164.3246916788241;1290.2065229883742;1313.5139998200536;1314.9013823963242;1325.1982550556968;717.2970488920887;789.8657228271207;807.4670717326536;811.7727036429809;813.3371302388534;3862.478565393636;4004.4593979812353;4280.91438171241;4321.703488953364;4333.696641235083;4208.591959332243;4481.834722972051;4744.335792988984;4753.881152971134;4783.928241076386;3644.7084233261276;3832.7125465590193;4248.553901840324;4259.190753756776;4287.7641729705165;2343.7773411525877;2509.447921457313;2770.5290100682932;2867.068202834087;3035.848207589612;5434.64674796137;5844.94155058444;5881.5588830837005;5905.291365036223;5914;4565.726056436624;5457.345118585795;5575.776968921279;5765.808992582875;5972.701364931736;5852.502537284378;5868.559858010581;5873.2658417697785;5873.618214816109;5885.47030767233;5682.318121825408;5700.315962084576;5720.856978575569;5723.599348045764;5731.684757338387;5201.063808514504;5256.395514515727;5554.50009499147;5600.411956744483;5646.075977195809;4519.932201016922;5787.971060144672;5833.679147646751;5851.33764137325;5866;3677.7609455385314;3689.6125906779403;3754.981225093857;3808.8095595220684;3821.9235615288094;4405.977970110129;5092.923606145985;5290.994711004897;5470.398256191736;5721.971390143022;5218.608604354765;5399.811006614907;5584.246126772834;5592.384837667934;5624.381318055092;4960.900781984412;5631.605787594993;5645.899049685272;5653.0993614405925;5778.682172480554;5266.815661451831;5573.442655734394;5625.915611265917;5652.88694226105;5653.360525447574;4405.31717583775;5325.520703136736;5657.830265092054;5670.901766346478;5725.255716756795;5091.287219789307;5537.224788529528;5554.666719996813;5558.055130627722;5595.356533998643 20:56:20 INFO - PROCESS | 1674 | |5;yui.html;666.2937286476332;669.8760729265085;705.8952738963521;732.6410059071053;754.8226166850791;15191.848081519182;16503.669926601462;16533.25600347984;16543.669126617475;16900.746488802677;16316.102614356205;16491.257893394795;16663.91668041658;16689.332426702917;16771.580710482245;838.8070743728931;863.9891327147253;865.8917635295588;867.1935100356666;868.68727258187;691.7405972760215;718.310421994883;850.4854562989395;862.1809281182901;881.5195718333491;908.5094049213417;908.7455512456522;913.2328843771231;923.0584803500426;932.2914584915445;892.1836519584572;893.3478560650697;896.4666023715879;897.8428774964356;898.2993265253114;543.4483998741241;565.3131445293988;665.4210836572165;677.3565113142485;683.3166833166833;15438.5368438947;15571.221438928009;15571.766423503657;15600.531984040497;15607;14067.507637232648;14309.499167529086;14379.496717614938;14387.928060359736;14428.422863085463;12088.33514156721;13051.80422293657;13261.602151935458;13564.593062208149;13725.176489410567;4369.497507786614;4616.953830461686;4735.479097299294;4815.22956326986;4856.68431551948;129404.3529782345;130784;131117;132596.33701831428;134182;11042.668719938414;11247.381394023243;11260.211785174959;11287.774244515063;11632.53469861196;22482.437939051328;22494.66258006131;22532.662010069864;22572.774272257397;23109.422264443187;7197.208307086216;7567.7513210319685;7995.600219988977;8027.93531291013;8064.274215320649;4284.978575107105;4306.41863348444;4322.178786030644;4331.631811296075;4471.575200355961;3452.5856897172;3579.6062433132333;3582.964170358263;3584.354816133121;3591.730620203495;634.708034304216;638.2181827261568;649.3084864619166;654.7282877605741;655.636121952321;491.91391506486224;588.3293045927646;592.2981267198384;596.2397942623104;604.782278379783;7753.883691744515;8538.658453661785;9197.494137822485;9339.547709323073;9793.299007536638;510.45126489023704;557.7211394302849;573.068763259703;631.9399657032575;642.6112202117652;4318.654507639381;4574.954569962288;4665.930011049837;4666;4674.883127921761;96173;101272;138133;143697;148470;42536.14927701429;85627.57186214029;108255.8348833019;120122.79877201116;121162;96470.51764741272;104679.4766026165;107557.46221268844;109258;112453.6942143401;7763.961180194063;9442.48066356357;10057.396556206651;10079.748006299607;10117.747056323356;60704.69647651733;62561;62902.23263944036;64563;64996.02505962509;81647;88114;89521;90522.96893981444;91103.08896911211;13418.93290533541;13477.663058423226;13607.863921361055;13628.727425451634;13805.24071176095;14868.851311486747;15051.6989660204;15060.924695376452;15156.924215378853;15183.544493665207;12919;12956;13074;13113.606591802261;13574.04981651275;11318;13814.861851381358;14379.352929118424;14380.28098595087;14654.194019328614;13358.799618005933;13481.2585307809;13711.382987765774;13738.725225495235;14017.369218384993;10617.432750780607;10813.243072984815;11364.602238921598;11701.88298117042;11876.940615297213;9821;11312.455318134605;11623.18637695387;11645;11910.642680719593 20:56:20 INFO - PROCESS | 1674 | __end_tp_report 20:56:20 INFO - PROCESS | 1674 | __start_cc_report 20:56:20 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1386 20:56:20 INFO - PROCESS | 1674 | __end_cc_report 20:56:20 INFO - PROCESS | 1674 | __startTimestamp1473738980407__endTimestamp 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | ------- Summary: start ------- 20:56:20 INFO - PROCESS | 1674 | Number of tests: 6 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5811.09 Median:6059.27 stddev:654.18 (10.8%) stddev-sans-first:627.47 20:56:20 INFO - PROCESS | 1674 | Values: 3367.4 3389.2 3416.5 3450.7 3473.0 4756.9 5765.7 5849.4 5887.3 5917.9 5845.1 5874.4 5875.4 5885.2 5887.3 5260.3 5298.6 5298.8 5351.6 5367.6 4242.4 5312.4 5417.0 5427.4 5427.8 4495.0 5239.8 5353.9 5354.0 5413.1 5416.2 5426.1 5449.8 5453.4 5484.3 5206.5 5242.7 5255.4 5371.7 5374.2 5738.2 5812.0 5826.3 5863.9 5868.1 6295.0 6347.6 6354.4 6354.7 6357.0 6230.9 6246.8 6299.1 6330.7 6370.4 5932.2 5936.2 5942.8 6007.7 6059.3 6346.5 6353.9 6357.0 6361.8 6368.0 5182.6 6136.2 6220.6 6235.4 6290.2 5785.2 5824.9 6243.8 6261.3 6333.8 6325.7 6332.7 6332.9 6344.7 6350.0 6301.8 6325.3 6347.7 6374.4 6376.1 4960.9 4991.7 4994.3 5032.0 5052.6 4524.0 4537.6 4547.8 4560.5 4582.3 5809.5 5868.0 5871.9 5880.7 5884.7 6243.0 6266.7 6290.6 6313.0 6331.7 4943.7 5433.2 5672.7 5826.7 5860.6 5424.9 5448.8 5455.2 5509.8 5558.8 6353.0 6354.3 6356.4 6364.6 6369.8 6305.6 6350.4 6352.8 6358.6 6359.3 6279.7 6289.4 6314.1 6319.1 6327.7 6123.4 6183.1 6212.6 6217.5 6231.3 6228.5 6252.6 6259.9 6264.8 6270.0 5993.5 6109.2 6117.9 6133.8 6143.3 6160.6 6185.1 6186.4 6186.8 6262.0 6120.5 6123.2 6128.5 6137.7 6138.3 6217.5 6238.9 6239.3 6242.9 6251.2 5955.4 5984.8 6010.7 6023.5 6095.6 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:72524.96 Median:40004.20 stddev:162263.12 (405.6%) stddev-sans-first:162628.13 20:56:20 INFO - PROCESS | 1674 | Values: 471.0 521.6 522.0 547.5 554.9 29123.6 30375.4 31508.5 39924.0 40966.8 42577.6 42898.0 42982.4 42985.9 43056.8 9488.2 9617.0 9632.5 9652.5 9675.0 9735.9 9860.3 9860.9 9863.2 9881.8 9841.0 9881.9 9894.3 9914.0 9915.1 9817.6 9855.2 9861.0 9871.2 9884.1 9758.0 9861.3 9865.3 9868.6 9886.4 39743.4 40084.4 40114.2 40146.0 40186.2 3312.2 3326.6 3327.5 3378.5 3419.6 30001.7 30515.0 30537.2 30846.4 31052.1 3137.1 3219.1 3244.7 3266.3 3266.8 462645.0 464716.0 466780.7 467096.0 467319.0 58355.7 58646.0 58813.7 58818.7 58834.7 33901.0 34729.8 60135.7 60152.4 60232.4 15755.2 16103.8 16143.8 16150.5 16158.7 12274.1 12379.1 12387.9 12391.6 12409.1 15160.5 16182.6 17434.4 18583.9 18612.7 7087.5 7652.7 7701.8 7714.7 7760.9 866.8 913.7 1025.7 1051.2 1088.9 29761.6 29887.0 30549.4 30647.5 30746.1 902.8 1029.7 1038.7 1050.2 1112.9 14941.6 15473.8 15750.7 15814.4 15931.9 593345.0 710062.0 711667.4 711815.0 712656.0 57644.7 58112.4 58126.4 58138.0 58210.0 1229.6 1250.0 1314.2 1339.2 1364.8 29905.6 30458.0 31079.1 31772.4 32030.9 55811.9 56420.0 56522.4 56533.0 56548.0 633018.0 639413.0 639661.0 641117.0 641288.0 34608.8 35610.0 35759.3 41874.6 41974.7 46306.5 46400.6 47727.8 47912.8 47921.3 35923.8 37648.0 38517.4 38670.0 38795.0 30998.2 37261.4 37880.1 38590.4 39221.4 37603.6 37965.2 38785.4 38797.0 40261.4 30754.0 33792.0 34464.0 34539.5 34543.7 25425.2 25477.7 25485.5 25968.0 25985.0 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35953.97 Median:13424.63 stddev:102456.17 (763.2%) stddev-sans-first:102708.69 20:56:20 INFO - PROCESS | 1674 | Values: 342.9 358.7 363.6 370.3 391.3 14660.5 14916.5 15749.8 16528.5 20582.6 17917.7 20544.3 20967.2 20985.5 21254.4 5827.9 6145.7 6148.9 6149.0 6151.9 4207.2 4420.7 5974.6 6034.2 6039.4 4305.2 4382.4 6518.6 6828.5 6846.7 6470.5 6622.1 6679.3 6860.0 6905.3 5762.7 5764.4 5765.5 5777.3 5787.5 24479.5 24870.4 25170.5 25172.0 25374.0 1984.1 2157.4 2181.6 2267.6 2369.8 14734.3 14837.1 15139.4 16150.3 16266.4 1818.3 1866.6 1872.4 1880.5 1943.7 119581.0 121028.4 121980.4 122370.0 122471.4 9255.0 9809.3 10359.5 10806.5 10997.2 13480.7 13500.7 13531.1 13538.7 13556.7 8136.8 8402.3 8421.0 8539.9 8557.2 8387.8 8395.0 8416.0 8541.2 8595.2 5328.3 6442.2 6510.8 6540.4 6702.1 1540.5 1549.3 1645.8 1731.4 1809.6 735.2 830.1 847.7 916.7 924.3 21233.5 21408.0 22252.9 22343.6 22466.0 904.1 908.3 932.6 936.8 953.4 10440.7 10917.7 11313.8 11390.9 11394.7 597433.0 605845.0 610635.0 623319.9 623862.0 120936.0 124740.0 143468.0 146810.5 149959.0 999.8 1006.3 1024.5 1024.7 1027.2 15974.0 18116.9 19185.6 19268.4 19323.5 43562.8 53166.7 57114.3 57306.7 59548.0 70811.0 79382.4 85667.6 86420.0 88604.0 7850.1 7910.7 7977.3 8154.5 8209.0 10405.5 12611.6 12761.8 12837.3 13018.3 10903.3 11250.4 11311.3 11410.0 11412.6 10125.0 10817.8 11186.2 11440.8 11451.7 11038.7 11132.3 11397.9 11424.6 11583.3 8077.7 8094.8 8147.6 8186.6 8193.2 9174.4 11311.5 11325.3 11330.4 11353.7 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5632.18 Median:5078.14 stddev:3161.81 (62.3%) stddev-sans-first:3155.59 20:56:20 INFO - PROCESS | 1674 | Values: 1521.8 1540.2 1726.0 1764.5 1898.8 6659.6 8158.0 8358.4 8875.9 8904.2 7942.9 8486.9 8710.5 8712.3 8838.6 1964.2 2323.3 2350.0 2351.1 2351.9 2312.5 2342.0 2372.3 2373.5 2375.9 2080.0 2157.3 2159.3 2236.5 2350.8 2324.7 2362.5 2364.1 2365.8 2366.0 2256.7 2306.4 2306.7 2309.9 2316.5 8682.5 8749.3 8756.1 8758.6 8773.9 5236.5 5303.4 5363.1 5365.4 5374.0 3480.1 3515.3 3688.6 3697.4 3703.4 1068.9 1069.5 1074.2 1089.7 1096.6 9603.7 11311.5 11332.9 11522.6 11543.5 4559.6 4587.8 4767.5 4776.5 4784.4 9895.2 9919.0 9927.0 9935.6 9974.1 5327.1 5329.1 5332.7 5344.6 5361.0 4669.8 4815.5 4887.7 4888.1 4890.6 3727.0 3764.8 3803.2 3837.8 3847.6 1173.7 1182.9 1184.2 1185.3 1190.9 617.8 760.2 772.7 800.8 835.6 5637.9 5832.9 5977.4 6101.4 6343.6 771.8 837.4 909.2 916.2 938.3 3841.3 3905.8 3978.5 4032.7 4054.4 10416.2 10796.2 10843.7 10854.6 10859.0 10724.4 10810.2 10815.3 10823.0 10824.6 8011.7 8157.7 8164.6 8167.5 8168.8 5344.9 5441.0 5701.7 5867.3 5942.0 9910.0 9940.4 9955.0 9962.8 9998.4 9819.4 10010.9 10126.8 10238.4 10246.2 6728.4 6961.9 7015.7 7025.6 7027.7 8132.7 8155.6 8161.6 8162.4 8166.9 7132.2 7253.1 7274.6 7414.0 7588.2 6076.8 7110.1 7240.2 7376.5 7436.9 6819.2 6825.8 6853.9 6910.7 6918.8 4960.5 5001.0 5025.3 5030.4 5090.8 4497.3 4880.1 4969.0 5065.5 5185.5 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:4381.11 Median:4638.21 stddev:1388.14 (29.9%) stddev-sans-first:1357.40 20:56:20 INFO - PROCESS | 1674 | Values: 275.5 285.3 306.4 309.4 310.7 4181.4 4313.4 5338.7 5378.6 5381.7 4665.6 5162.8 5263.2 5274.5 5292.3 4004.9 4038.5 4052.6 4053.0 4068.2 3042.9 3582.6 4065.3 4081.6 4087.5 3791.3 3880.7 3966.7 4000.8 4043.6 3990.4 4011.4 4032.5 4039.0 4052.2 2902.8 3501.0 3526.5 3526.9 3531.3 3990.4 4814.7 4818.6 4886.2 5157.3 3750.9 4023.8 4581.2 4610.7 4610.8 4432.8 5283.4 5365.0 5365.4 5543.6 3108.6 3231.0 3367.8 3451.7 3730.1 5194.0 5390.4 5514.9 5821.8 5883.7 3493.8 3656.5 3716.4 3833.5 3877.3 3893.9 3894.4 3906.1 3908.6 3931.4 4119.4 4297.1 4362.9 4537.0 4585.0 4566.5 5102.3 5251.0 5513.5 5620.5 1164.3 1290.2 1313.5 1314.9 1325.2 717.3 789.9 807.5 811.8 813.3 3862.5 4004.5 4280.9 4321.7 4333.7 4208.6 4481.8 4744.3 4753.9 4783.9 3644.7 3832.7 4248.6 4259.2 4287.8 2343.8 2509.4 2770.5 2867.1 3035.8 5434.6 5844.9 5881.6 5905.3 5914.0 4565.7 5457.3 5575.8 5765.8 5972.7 5852.5 5868.6 5873.3 5873.6 5885.5 5682.3 5700.3 5720.9 5723.6 5731.7 5201.1 5256.4 5554.5 5600.4 5646.1 4519.9 5788.0 5833.7 5851.3 5866.0 3677.8 3689.6 3755.0 3808.8 3821.9 4406.0 5092.9 5291.0 5470.4 5722.0 5218.6 5399.8 5584.2 5592.4 5624.4 4960.9 5631.6 5645.9 5653.1 5778.7 5266.8 5573.4 5625.9 5652.9 5653.4 4405.3 5325.5 5657.8 5670.9 5725.3 5091.3 5537.2 5554.7 5558.1 5595.4 20:56:20 INFO - PROCESS | 1674 | 20:56:20 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:23934.14 Median:3583.66 stddev:37125.00 (1036.0%) stddev-sans-first:37188.04 20:56:20 INFO - PROCESS | 1674 | Values: 666.3 669.9 705.9 732.6 754.8 15191.8 16503.7 16533.3 16543.7 16900.7 16316.1 16491.3 16663.9 16689.3 16771.6 838.8 864.0 865.9 867.2 868.7 691.7 718.3 850.5 862.2 881.5 908.5 908.7 913.2 923.1 932.3 892.2 893.3 896.5 897.8 898.3 543.4 565.3 665.4 677.4 683.3 15438.5 15571.2 15571.8 15600.5 15607.0 14067.5 14309.5 14379.5 14387.9 14428.4 12088.3 13051.8 13261.6 13564.6 13725.2 4369.5 4617.0 4735.5 4815.2 4856.7 129404.4 130784.0 131117.0 132596.3 134182.0 11042.7 11247.4 11260.2 11287.8 11632.5 22482.4 22494.7 22532.7 22572.8 23109.4 7197.2 7567.8 7995.6 8027.9 8064.3 4285.0 4306.4 4322.2 4331.6 4471.6 3452.6 3579.6 3583.0 3584.4 3591.7 634.7 638.2 649.3 654.7 655.6 491.9 588.3 592.3 596.2 604.8 7753.9 8538.7 9197.5 9339.5 9793.3 510.5 557.7 573.1 631.9 642.6 4318.7 4575.0 4665.9 4666.0 4674.9 96173.0 101272.0 138133.0 143697.0 148470.0 42536.1 85627.6 108255.8 120122.8 121162.0 96470.5 104679.5 107557.5 109258.0 112453.7 7764.0 9442.5 10057.4 10079.7 10117.7 60704.7 62561.0 62902.2 64563.0 64996.0 81647.0 88114.0 89521.0 90523.0 91103.1 13418.9 13477.7 13607.9 13628.7 13805.2 14868.9 15051.7 15060.9 15156.9 15183.5 12919.0 12956.0 13074.0 13113.6 13574.0 11318.0 13814.9 14379.4 14380.3 14654.2 13358.8 13481.3 13711.4 13738.7 14017.4 10617.4 10813.2 11364.6 11701.9 11876.9 9821.0 11312.5 11623.2 11645.0 11910.6 20:56:20 INFO - PROCESS | 1674 | -------- Summary: end -------- 20:56:20 INFO - PROCESS | 1674 | 20:56:21 INFO - TEST-INFO | 1674: exit 0 20:56:21 INFO - TEST-OK | dromaeo_css | took 1118409ms 20:56:21 INFO - TEST-START | kraken 20:56:21 INFO - operating with platform_type : mac_ 20:56:21 INFO - Initialising browser for kraken test... 20:56:21 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmpm5RWoO/profile http://localhost:49276/getInfo.html) 20:56:23 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 20:56:23 INFO - PROCESS | 1681 | colorDepth:24 20:56:23 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 20:56:23 INFO - PROCESS | 1681 | __metrics 20:56:23 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:56:23 INFO - PROCESS | 1681 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:56:23 INFO - TEST-INFO | 1681: exit 0 20:56:23 INFO - Browser initialized. 20:56:23 INFO - Running cycle 1/1 for kraken test... 20:56:23 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/T/tmpm5RWoO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:56:35 INFO - PROCESS | 1682 | RSS: Main: 233897984 20:56:35 INFO - PROCESS | 1682 | 20:56:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 20:56:39 INFO - PROCESS | 1682 | RSS: Main: 292532224 20:56:39 INFO - PROCESS | 1682 | 20:56:42 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 20:56:42 INFO - PROCESS | 1682 | RSS: Main: 289652736 20:56:42 INFO - PROCESS | 1682 | 20:56:46 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 20:56:47 INFO - PROCESS | 1682 | RSS: Main: 374923264 20:56:47 INFO - PROCESS | 1682 | 20:56:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 20:56:49 INFO - PROCESS | 1682 | RSS: Main: 278319104 20:56:49 INFO - PROCESS | 1682 | 20:56:51 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:56:52 INFO - PROCESS | 1682 | RSS: Main: 282210304 20:56:52 INFO - PROCESS | 1682 | 20:56:55 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 20:56:55 INFO - PROCESS | 1682 | RSS: Main: 321708032 20:56:55 INFO - PROCESS | 1682 | 20:56:58 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 20:56:59 INFO - PROCESS | 1682 | RSS: Main: 322838528 20:56:59 INFO - PROCESS | 1682 | 20:57:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 20:57:02 INFO - PROCESS | 1682 | RSS: Main: 322990080 20:57:02 INFO - PROCESS | 1682 | 20:57:04 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:57:04 INFO - PROCESS | 1682 | RSS: Main: 298926080 20:57:04 INFO - PROCESS | 1682 | 20:57:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:57:07 INFO - PROCESS | 1682 | RSS: Main: 303017984 20:57:07 INFO - PROCESS | 1682 | 20:57:09 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:57:10 INFO - PROCESS | 1682 | RSS: Main: 306233344 20:57:10 INFO - PROCESS | 1682 | 20:57:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:57:13 INFO - PROCESS | 1682 | RSS: Main: 319516672 20:57:13 INFO - PROCESS | 1682 | 20:57:17 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:57:17 INFO - PROCESS | 1682 | RSS: Main: 315609088 20:57:17 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 20:57:19 INFO - PROCESS | 1682 | RSS: Main: 358776832 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | __start_tp_report 20:57:19 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 20:57:19 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 20:57:19 INFO - PROCESS | 1682 | |i|pagename|runs| 20:57:19 INFO - PROCESS | 1682 | |0;ai-astar;112;112;117;115;158;145;113;113;112;124 20:57:19 INFO - PROCESS | 1682 | |1;audio-beat-detection;143;109;134;165;107;130;130;117;200;109 20:57:19 INFO - PROCESS | 1682 | |2;audio-dft;182;183;184;184;184;183;182;183;181;186 20:57:19 INFO - PROCESS | 1682 | |3;audio-fft;73;81;79;162;66;73;78;93;162;57 20:57:19 INFO - PROCESS | 1682 | |4;audio-oscillator;83;84;134;72;74;83;113;68;70;110 20:57:19 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;87;86;89;87;88;84;89;85;88;85 20:57:19 INFO - PROCESS | 1682 | |6;imaging-darkroom;93;94;94;94;93;94;94;93;94;93 20:57:19 INFO - PROCESS | 1682 | |7;imaging-desaturate;85;90;85;86;85;83;84;84;84;80 20:57:19 INFO - PROCESS | 1682 | |8;json-parse-financial;54;55;55;54;53;53;55;54;53;52 20:57:19 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;64;65;65;68;72;75;68;70;70;71 20:57:19 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;86;88;85;85;87;85;87;97;110;108 20:57:19 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;143;149;151;144;140;135;133;135;166;144 20:57:19 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;171;233;202;171;169;178;169;170;164;233 20:57:19 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;67;81;76;78;68;67;68;67;68;67 20:57:19 INFO - PROCESS | 1682 | __end_tp_report 20:57:19 INFO - PROCESS | 1682 | __start_cc_report 20:57:19 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,2024 20:57:19 INFO - PROCESS | 1682 | __end_cc_report 20:57:19 INFO - PROCESS | 1682 | __startTimestamp1473739039731__endTimestamp 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | ------- Summary: start ------- 20:57:19 INFO - PROCESS | 1682 | Number of tests: 14 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:122.10 Median:116.00 stddev:16.21 (14.0%) stddev-sans-first:16.78 20:57:19 INFO - PROCESS | 1682 | Values: 112.0 112.0 117.0 115.0 158.0 145.0 113.0 113.0 112.0 124.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:132.00 stddev:29.24 (22.2%) stddev-sans-first:30.85 20:57:19 INFO - PROCESS | 1682 | Values: 143.0 109.0 134.0 165.0 107.0 130.0 130.0 117.0 200.0 109.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.40 (0.8%) stddev-sans-first:1.41 20:57:19 INFO - PROCESS | 1682 | Values: 182.0 183.0 184.0 184.0 184.0 183.0 182.0 183.0 181.0 186.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.50 stddev:37.87 (50.2%) stddev-sans-first:39.51 20:57:19 INFO - PROCESS | 1682 | Values: 73.0 81.0 79.0 162.0 66.0 73.0 78.0 93.0 162.0 57.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:73.00 stddev:22.25 (30.5%) stddev-sans-first:23.49 20:57:19 INFO - PROCESS | 1682 | Values: 83.0 84.0 134.0 72.0 74.0 83.0 113.0 68.0 70.0 110.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.75 (2.0%) stddev-sans-first:1.86 20:57:19 INFO - PROCESS | 1682 | Values: 87.0 86.0 89.0 87.0 88.0 84.0 89.0 85.0 88.0 85.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:57:19 INFO - PROCESS | 1682 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 94.0 93.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:2.50 (2.9%) stddev-sans-first:2.65 20:57:19 INFO - PROCESS | 1682 | Values: 85.0 90.0 85.0 86.0 85.0 83.0 84.0 84.0 84.0 80.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 20:57:19 INFO - PROCESS | 1682 | Values: 54.0 55.0 55.0 54.0 53.0 53.0 55.0 54.0 53.0 52.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:70.00 stddev:3.49 (5.0%) stddev-sans-first:3.24 20:57:19 INFO - PROCESS | 1682 | Values: 64.0 65.0 65.0 68.0 72.0 75.0 68.0 70.0 70.0 71.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:86.50 stddev:9.74 (11.3%) stddev-sans-first:10.10 20:57:19 INFO - PROCESS | 1682 | Values: 86.0 88.0 85.0 85.0 87.0 85.0 87.0 97.0 110.0 108.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:144.00 stddev:9.76 (6.8%) stddev-sans-first:10.35 20:57:19 INFO - PROCESS | 1682 | Values: 143.0 149.0 151.0 144.0 140.0 135.0 133.0 135.0 166.0 144.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.00 Median:174.50 stddev:26.89 (15.4%) stddev-sans-first:27.96 20:57:19 INFO - PROCESS | 1682 | Values: 171.0 233.0 202.0 171.0 169.0 178.0 169.0 170.0 164.0 233.0 20:57:19 INFO - PROCESS | 1682 | 20:57:19 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:68.00 stddev:5.42 (8.0%) stddev-sans-first:5.58 20:57:19 INFO - PROCESS | 1682 | Values: 67.0 81.0 76.0 78.0 68.0 67.0 68.0 67.0 68.0 67.0 20:57:19 INFO - PROCESS | 1682 | -------- Summary: end -------- 20:57:19 INFO - PROCESS | 1682 | 20:57:20 INFO - TEST-INFO | 1682: exit 0 20:57:20 INFO - TEST-OK | kraken | took 59626ms 20:57:20 INFO - SUITE-END | took 1178s 20:57:20 INFO - Completed test suite (00:19:38) 20:57:20 INFO - javascript benchmark 20:57:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.3770352484785, 3389.203537168765, 3416.5387672664183, 3450.706689931356, 3473.0, 4756.904861902764, 5765.6828874411995, 5849.385814489481, 5887.293524777027, 5917.911231331528, 5845.123231515264, 5874.383189765077, 5875.412458754123, 5885.205497257869, 5887.3229578598475, 5260.342457192842, 5298.576113910878, 5298.761555729982, 5351.57187425007, 5367.597430192751, 4242.406063151161, 5312.389075256337, 5416.972915135419, 5427.43011983742, 5427.810026649068, 4495.0, 5239.79040838366, 5353.866153346158, 5354.0, 5413.106837371829, 5416.2417261583605, 5426.077566813651, 5449.809256676037, 5453.427390124019, 5484.341878974508, 5206.505381988705, 5242.711650859202, 5255.421903590602, 5371.650842695251, 5374.167004114369, 5738.196652468658, 5812.011957967114, 5826.300843898717, 5863.882722345572, 5868.09044598088, 6295.0, 6347.619142851444, 6354.3963323484195, 6354.7458101675875, 6357.0, 6230.906536401958, 6246.812595622138, 6299.055141728777, 6330.68346582669, 6370.362963703639, 5932.169496270569, 5936.198613187207, 5942.762289508458, 6007.699615019232, 6059.27288725347, 6346.524010699216, 6353.936460635427, 6356.968215158895, 6361.840953976188, 6367.968160159262, 5182.585393168538, 6136.23297087864, 6220.564560480723, 6235.438810507076, 6290.21372328459, 5785.247917770663, 5824.94175058244, 6243.750249989949, 6261.311255761862, 6333.809985700436, 6325.683715814191, 6332.746690132435, 6332.905006424908, 6344.714487848058, 6350.0, 6301.842453938688, 6325.262268184792, 6347.682615869188, 6374.394432528902, 6376.107344971708, 4960.900781984412, 4991.700497970133, 4994.275830004629, 5032.0, 5052.57053150479, 4524.0, 4537.591616754508, 4547.8180872764715, 4560.4527456704745, 4582.266837306015, 5809.506191973645, 5867.970660146757, 5871.882562348729, 5880.676562789087, 5884.676342801187, 6243.0, 6266.749330026839, 6290.559660823698, 6312.968435157794, 6331.683415829282, 4943.703377797272, 5433.157860531624, 5672.716364181774, 5826.6795326256615, 5860.619059761102, 5424.918626220609, 5448.83653490396, 5455.236266922634, 5509.779608815683, 5558.833235002957, 6352.968235158794, 6354.3010268870385, 6356.427921486996, 6364.554481186273, 6369.808905732835, 6305.5901366411035, 6350.364963503613, 6352.777652782131, 6358.586691865014, 6359.300476947625, 6279.748810047547, 6289.433950944254, 6314.1160237565855, 6319.115323854756, 6327.715252813542, 6123.418275263843, 6183.134361189527, 6212.627242365473, 6217.533684973736, 6231.3145553988115, 6228.4705800005695, 6252.562320637512, 6259.937400625936, 6264.812055638338, 6269.96865015672, 5993.507941620928, 6109.20580324555, 6117.9187529241, 6133.785317514044, 6143.262808463013, 6160.568760186744, 6185.103160041859, 6186.443220110212, 6186.752529898754, 6262.0, 6120.538559592075, 6123.173371594778, 6128.472568454306, 6137.723802428812, 6138.324784273637, 6217.4715149212825, 6238.875222495434, 6239.251289845248, 6242.875142497215, 6251.187345645037, 5955.434233747787, 5984.820455386345, 6010.7295171716505, 6023.518118550418, 6095.603785753912], "value": 5770.289578018355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.96467764917617, 521.6218241774714, 521.9817306394277, 547.5263896729331, 554.8807006493604, 29123.56314655279, 30375.392492150142, 31508.53406125327, 39924.0, 40966.79516602413, 42577.57422425775, 42898.0, 42982.35526467098, 42985.925351866215, 43056.78471607646, 9488.240940724725, 9616.951915240448, 9632.47021413822, 9652.517374131301, 9674.951625241863, 9735.853962190573, 9860.309778315484, 9860.852087218698, 9863.210943124568, 9881.752956176082, 9840.950795246014, 9881.851772223423, 9894.30739848211, 9914.0, 9915.058069483424, 9817.6072957082, 9855.226059309321, 9861.0, 9871.210303175729, 9884.061014203638, 9758.0, 9861.309708320421, 9865.309428340019, 9868.555914983843, 9886.357386769838, 39743.40384894229, 40084.39873401872, 40114.197716045805, 40146.0, 40186.19627607431, 3312.188513814107, 3326.567546219, 3327.5008748687646, 3378.5101160331615, 3419.589649242107, 30001.699983000326, 30515.0, 30537.23656908573, 30846.383072338427, 31052.0684379469, 3137.1059248114407, 3219.114743445548, 3244.7404207663567, 3266.3304022675293, 3266.8203248821305, 462644.9999999966, 464716.0, 466780.6660966707, 467096.0, 467319.0, 58355.70822145862, 58646.0, 58813.70593147007, 58818.7059064702, 58834.70582647059, 33901.0, 34729.82635086859, 60135.69932150399, 60152.39847601556, 60232.39767602268, 15755.212239387985, 16103.838961610469, 16143.838561614233, 16150.515484535483, 16158.676826463405, 12274.079444041732, 12379.133460657667, 12387.885090341913, 12391.62825115248, 12409.131360804837, 15160.545183644508, 16182.595435114215, 17434.389796357067, 18583.911539461296, 18612.720809187875, 7087.468439867031, 7652.69389224436, 7701.845963080819, 7714.729984450517, 7760.9223907761325, 866.787637028932, 913.6756451459769, 1025.6717850287985, 1051.169576034924, 1088.8965548272902, 29761.553576696366, 29887.0, 30549.38901221963, 30647.540286895714, 30746.077617671504, 902.8058967322057, 1029.7334278837072, 1038.6883934819675, 1050.1598721023151, 1112.8553288072499, 14941.551753447415, 15473.767893481607, 15750.684986300439, 15814.424494537152, 15931.920340398225, 593345.0, 710062.0, 711667.4416627884, 711815.0, 712656.0, 57644.71177644085, 58112.41887581155, 58126.4187358121, 58138.0, 58210.0, 1229.569650622275, 1249.9625011249677, 1314.185205172799, 1339.189790176929, 1364.7611667958067, 29905.551416728333, 30458.0, 31079.0676279712, 31772.364552708354, 32030.878919237715, 55811.88376232371, 56420.0, 56522.43477565336, 56533.0, 56548.0, 633018.0, 639413.0, 639661.0, 641117.0, 641288.0, 34608.82695586506, 35610.0, 35759.28481430409, 41874.58125418707, 41974.74075777731, 46306.53693463157, 46400.591943765285, 47727.80680483016, 47912.8439220229, 47921.281180783015, 35923.79105029808, 37648.0, 38517.42223866588, 38670.033249169, 38795.03012424712, 30998.22504437407, 37261.4410783833, 37880.05299867525, 38590.42114368343, 39221.41167882541, 37603.623963760016, 37965.166270071655, 38785.4182187273, 38797.0, 40261.39607905942, 30754.0, 33792.01848016545, 34464.0, 34539.48190777191, 34543.65456345505, 25425.237242882744, 25477.74522254754, 25485.49029019372, 25968.0, 25985.0], "value": 20060.6770156212, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.89541689784636, 358.7291594845891, 363.5637235317618, 370.2927408649479, 391.2917619109412, 14660.486882959098, 14916.477923272687, 15749.763753543692, 16528.504144875642, 20582.588348233025, 17917.7312340315, 20544.280950166747, 20967.16131354744, 20985.47536311593, 21254.362369128914, 5827.912581311273, 6145.723442445078, 6148.907766383508, 6148.985417406145, 6151.8769624607485, 4207.221663992156, 4420.734755914656, 5974.611650242742, 6034.155218269446, 6039.369370270025, 4305.24658184818, 4382.408374869399, 6518.608883466984, 6828.453723702117, 6846.691898864563, 6470.514711396617, 6622.072909792633, 6679.33206679333, 6859.965700171492, 6905.343992320747, 5762.654240745527, 5764.423557644202, 5765.481106700375, 5777.335606405233, 5787.450192231773, 24479.51040979188, 24870.37824054413, 25170.496590068095, 25172.0, 25374.0, 1984.1369004483097, 2157.4067131538795, 2181.5636872625537, 2267.5691618592414, 2369.751176126499, 14734.33695483695, 14837.10977341363, 15139.394424223017, 16150.273237704332, 16266.430674926321, 1818.336307247845, 1866.598681283517, 1872.4382685194523, 1880.454668146236, 1943.6987266973501, 119581.0, 121028.39485802515, 121980.39009804983, 122370.0, 122471.38764306121, 9254.953725231466, 9809.264305176997, 10359.482025898826, 10806.51370688321, 10997.230193886511, 13480.719331663673, 13500.729985400434, 13531.120477168952, 13538.729225415436, 13556.661083472993, 8136.837263254702, 8402.28580570646, 8421.031581368099, 8539.914600854036, 8557.229849313591, 8387.832243355098, 8395.034571024411, 8415.95792021036, 8541.231289184003, 8595.226429621363, 5328.333958255218, 6442.162518872517, 6510.78302161542, 6540.444062254666, 6702.09521714572, 1540.5378386484233, 1549.3105568022122, 1645.798567046063, 1731.3507434711983, 1809.5657042310015, 735.2463724682136, 830.1242189490146, 847.7499137754377, 916.6929078758557, 924.2513564013171, 21233.469163271042, 21408.0, 22252.888735556542, 22343.553128937656, 22466.0, 904.1184844776421, 908.3323757038571, 932.6083045121065, 936.7704912296531, 953.4327075390132, 10440.738981525523, 10917.672469825919, 11313.83029254562, 11390.867511434257, 11394.658160255205, 597433.0, 605845.0, 610635.0, 623319.8834005801, 623862.0, 120936.0, 124740.0, 143468.0, 146810.53189468183, 149959.0, 999.8450240212778, 1006.2553710254359, 1024.4672770159475, 1024.6925922223304, 1027.1525991057408, 15974.0, 18116.91298522093, 19185.61628767445, 19268.4219473416, 19323.51691207731, 43562.782186088865, 53166.73416632892, 57114.28757130773, 57306.713466432404, 59548.0, 70811.0, 79382.4123517538, 85667.57166214129, 86420.0, 88604.0, 7850.097238817609, 7910.7231246906085, 7977.282044616012, 8154.469959452616, 8208.958955205186, 10405.47972601382, 12611.621651350475, 12761.808572871229, 12837.293948832903, 13018.2839943804, 10903.34579925207, 11250.437478126225, 11311.321320720783, 11410.0, 11412.600558980395, 10125.0, 10817.783644326912, 11186.161037922351, 11440.771184576428, 11451.656450306504, 11038.668839934815, 11132.276402033842, 11397.886021140013, 11424.600138995096, 11583.305001699924, 8077.676892924453, 8094.757157285291, 8147.59262036884, 8186.590670466334, 8193.180681931759, 9174.357794954556, 11311.547538098714, 11325.263857849213, 11330.394009377724, 11353.716157096138], "value": 9664.364966256784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.8173819141705, 1540.2452798128918, 1725.9741103883443, 1764.453019563936, 1898.838598719108, 6659.63372014539, 8157.980252468441, 8358.414910956228, 8875.91124088759, 8904.198622124008, 7942.880856787153, 8486.915130848705, 8710.477371357723, 8712.346574006942, 8838.602262898168, 1964.2241314680693, 2323.279783267184, 2349.9765002349927, 2351.071326825903, 2351.8824058797077, 2312.491251924574, 2341.95316093678, 2372.2764556810166, 2373.4778348763243, 2375.8812059397046, 2080.0, 2157.255746767363, 2159.255057005331, 2236.519148383097, 2350.764923507653, 2324.7442781294044, 2362.4566349739657, 2364.148906393697, 2365.810735141193, 2365.976340236593, 2256.7404748453973, 2306.3888069661552, 2306.746257911628, 2309.872956987365, 2316.4787922717423, 8682.479051256945, 8749.256313213384, 8756.124387561193, 8758.649654013832, 8773.912260877374, 5236.502532259429, 5303.443138470444, 5363.06146424378, 5365.436629153961, 5374.005808925362, 3480.077779388464, 3515.3145136698354, 3688.5758137814228, 3697.352963231424, 3703.370427027412, 1068.9198310126772, 1069.4813015687384, 1074.2275245844341, 1089.6513115802945, 1096.6052221200362, 9603.663871764524, 11311.547538098548, 11332.886671133265, 11522.596709115141, 11543.53825846965, 4559.566841150086, 4587.839425620087, 4767.547083027107, 4776.450708168536, 4784.378030855966, 9895.158911492459, 9919.0, 9927.0, 9935.565786382238, 9974.102330790263, 5327.147656374961, 5329.147336426153, 5332.706701131475, 5344.599155063386, 5360.973195133999, 4669.836555720602, 4815.494373090775, 4887.706737595756, 4888.071266459361, 4890.559849613552, 3726.9627303727157, 3764.8305826237884, 3803.1633040730994, 3837.808109594509, 3847.634474724897, 1173.7124404520946, 1182.8994535464583, 1184.1769969870857, 1185.3065956415421, 1190.874958129384, 617.7992152550439, 760.1638197982176, 772.6947855597008, 800.8038030682403, 835.5571547079936, 5637.943620563824, 5832.912506312408, 5977.432143946318, 6101.359357267512, 6343.5876668016435, 771.7568965775763, 837.4221786966973, 909.1999040844147, 916.225789208118, 938.3384713776771, 3841.2893614681375, 3905.824237909301, 3978.542467616261, 4032.737872038308, 4054.3715724062818, 10416.166706663449, 10796.190285728602, 10843.67468975932, 10854.620088296871, 10859.0, 10724.356538607708, 10810.189235807346, 10815.297005694605, 10823.025927666547, 10824.621138260281, 8011.719589814328, 8157.714479993172, 8164.5917704115745, 8167.469114507538, 8168.836623267502, 5344.866378340417, 5441.020616289106, 5701.686407247641, 5867.295924488918, 5942.0, 9910.0, 9940.403575785476, 9954.950225248827, 9962.750931226487, 9998.400095994264, 9819.410835349901, 10010.949945250519, 10126.797464050826, 10238.436885971343, 10246.180305575386, 6728.394444500019, 6961.860762784615, 7015.6842942066705, 7025.578465292099, 7027.718891244497, 8132.6746930122135, 8155.551444670363, 8161.551114688749, 8162.428629995843, 8166.918330816616, 7132.179799323144, 7253.1296244448895, 7274.599897005503, 7414.036175297177, 7588.241175882367, 6076.817695469143, 7110.1112360954885, 7240.203577606564, 7376.483646144933, 7436.851262974602, 6819.18169819605, 6825.761098361533, 6853.862922741617, 6910.654467276717, 6918.792436226921, 4960.454350021422, 5000.974995125001, 5025.321581586439, 5030.446650868328, 5090.7709153088945, 4497.280435130363, 4880.1215781159735, 4969.006198760335, 5065.504801686824, 5185.507376799198], "value": 4505.7457805750655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.4807188449772, 285.2739777266856, 306.41627699232953, 309.39358856640985, 310.6691373687025, 4181.393697913801, 4313.374560688699, 5338.652987555806, 5378.623496355257, 5381.650192737469, 4665.603423708989, 5162.7978969337755, 5263.236830659552, 5274.4725527447235, 5292.311999440068, 4004.8986528704695, 4038.5163124678256, 4052.594740525946, 4053.0, 4068.247374235761, 3042.923926901823, 3582.6417358264093, 4065.349544072949, 4081.632653061224, 4087.4890638670167, 3791.2986097571898, 3880.6701430378453, 3966.6826653867765, 4000.7599544027307, 4043.575424580421, 3990.4413382126527, 4011.4183443400543, 4032.5362583303004, 4038.959610403888, 4052.2444737578435, 2902.75181671881, 3500.9824950875336, 3526.4710293456187, 3526.9118272043147, 3531.346700860349, 3990.4213888985932, 4814.725986329295, 4818.602884966125, 4886.218205087169, 5157.252198431244, 3750.887473375803, 4023.75857448554, 4581.221192397301, 4610.700304480198, 4610.815567377301, 4432.822687092513, 5283.418823929364, 5364.953834002371, 5365.409804921455, 5543.639663421905, 3108.6269647642202, 3231.0, 3367.8380958569255, 3451.6548345165534, 3730.1420673245034, 5194.013137503862, 5390.434004429557, 5514.91727624086, 5821.767129314822, 5883.676397798119, 3493.7903725776537, 3656.5063716398477, 3716.442533619979, 3833.4666133546802, 3877.2827027000094, 3893.8637147699696, 3894.357431023849, 3906.140649057203, 3908.6286802753693, 3931.4495970564144, 4119.423280740699, 4297.05464797744, 4362.8691139265875, 4537.0, 4584.977075114603, 4566.543345665407, 5102.260172275, 5251.00692605219, 5513.531349835309, 5620.4707881453505, 1164.3246916788241, 1290.2065229883742, 1313.5139998200536, 1314.9013823963242, 1325.1982550556968, 717.2970488920887, 789.8657228271207, 807.4670717326536, 811.7727036429809, 813.3371302388534, 3862.478565393636, 4004.4593979812353, 4280.91438171241, 4321.703488953364, 4333.696641235083, 4208.591959332243, 4481.834722972051, 4744.335792988984, 4753.881152971134, 4783.928241076386, 3644.7084233261276, 3832.7125465590193, 4248.553901840324, 4259.190753756776, 4287.7641729705165, 2343.7773411525877, 2509.447921457313, 2770.5290100682932, 2867.068202834087, 3035.848207589612, 5434.64674796137, 5844.94155058444, 5881.5588830837005, 5905.291365036223, 5914.0, 4565.726056436624, 5457.345118585795, 5575.776968921279, 5765.808992582875, 5972.701364931736, 5852.502537284378, 5868.559858010581, 5873.2658417697785, 5873.618214816109, 5885.47030767233, 5682.318121825408, 5700.315962084576, 5720.856978575569, 5723.599348045764, 5731.684757338387, 5201.063808514504, 5256.395514515727, 5554.50009499147, 5600.411956744483, 5646.075977195809, 4519.932201016922, 5787.971060144672, 5833.679147646751, 5851.33764137325, 5866.0, 3677.7609455385314, 3689.6125906779403, 3754.981225093857, 3808.8095595220684, 3821.9235615288094, 4405.977970110129, 5092.923606145985, 5290.994711004897, 5470.398256191736, 5721.971390143022, 5218.608604354765, 5399.811006614907, 5584.246126772834, 5592.384837667934, 5624.381318055092, 4960.900781984412, 5631.605787594993, 5645.899049685272, 5653.0993614405925, 5778.682172480554, 5266.815661451831, 5573.442655734394, 5625.915611265917, 5652.88694226105, 5653.360525447574, 4405.31717583775, 5325.520703136736, 5657.830265092054, 5670.901766346478, 5725.255716756795, 5091.287219789307, 5537.224788529528, 5554.666719996813, 5558.055130627722, 5595.356533998643], "value": 3937.9090731752017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.2937286476332, 669.8760729265085, 705.8952738963521, 732.6410059071053, 754.8226166850791, 15191.848081519182, 16503.669926601462, 16533.25600347984, 16543.669126617475, 16900.746488802677, 16316.102614356205, 16491.257893394795, 16663.91668041658, 16689.332426702917, 16771.580710482245, 838.8070743728931, 863.9891327147253, 865.8917635295588, 867.1935100356666, 868.68727258187, 691.7405972760215, 718.310421994883, 850.4854562989395, 862.1809281182901, 881.5195718333491, 908.5094049213417, 908.7455512456522, 913.2328843771231, 923.0584803500426, 932.2914584915445, 892.1836519584572, 893.3478560650697, 896.4666023715879, 897.8428774964356, 898.2993265253114, 543.4483998741241, 565.3131445293988, 665.4210836572165, 677.3565113142485, 683.3166833166833, 15438.5368438947, 15571.221438928009, 15571.766423503657, 15600.531984040497, 15607.0, 14067.507637232648, 14309.499167529086, 14379.496717614938, 14387.928060359736, 14428.422863085463, 12088.33514156721, 13051.80422293657, 13261.602151935458, 13564.593062208149, 13725.176489410567, 4369.497507786614, 4616.953830461686, 4735.479097299294, 4815.22956326986, 4856.68431551948, 129404.3529782345, 130784.0, 131117.0, 132596.33701831428, 134182.0, 11042.668719938414, 11247.381394023243, 11260.211785174959, 11287.774244515063, 11632.53469861196, 22482.437939051328, 22494.66258006131, 22532.662010069864, 22572.774272257397, 23109.422264443187, 7197.208307086216, 7567.7513210319685, 7995.600219988977, 8027.93531291013, 8064.274215320649, 4284.978575107105, 4306.41863348444, 4322.178786030644, 4331.631811296075, 4471.575200355961, 3452.5856897172, 3579.6062433132333, 3582.964170358263, 3584.354816133121, 3591.730620203495, 634.708034304216, 638.2181827261568, 649.3084864619166, 654.7282877605741, 655.636121952321, 491.91391506486224, 588.3293045927646, 592.2981267198384, 596.2397942623104, 604.782278379783, 7753.883691744515, 8538.658453661785, 9197.494137822485, 9339.547709323073, 9793.299007536638, 510.45126489023704, 557.7211394302849, 573.068763259703, 631.9399657032575, 642.6112202117652, 4318.654507639381, 4574.954569962288, 4665.930011049837, 4666.0, 4674.883127921761, 96173.0, 101272.0, 138133.0, 143697.0, 148470.0, 42536.14927701429, 85627.57186214029, 108255.8348833019, 120122.79877201116, 121162.0, 96470.51764741272, 104679.4766026165, 107557.46221268844, 109258.0, 112453.6942143401, 7763.961180194063, 9442.48066356357, 10057.396556206651, 10079.748006299607, 10117.747056323356, 60704.69647651733, 62561.0, 62902.23263944036, 64563.0, 64996.02505962509, 81647.0, 88114.0, 89521.0, 90522.96893981444, 91103.08896911211, 13418.93290533541, 13477.663058423226, 13607.863921361055, 13628.727425451634, 13805.24071176095, 14868.851311486747, 15051.6989660204, 15060.924695376452, 15156.924215378853, 15183.544493665207, 12919.0, 12956.0, 13074.0, 13113.606591802261, 13574.04981651275, 11318.0, 13814.861851381358, 14379.352929118424, 14380.28098595087, 14654.194019328614, 13358.799618005933, 13481.2585307809, 13711.382987765774, 13738.725225495235, 14017.369218384993, 10617.432750780607, 10813.243072984815, 11364.602238921598, 11701.88298117042, 11876.940615297213, 9821.0, 11312.455318134605, 11623.18637695387, 11645.0, 11910.642680719593], "value": 7822.240436612239, "unit": "score"}], "name": "dromaeo_css", "value": 7331.420146393331, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 117.0, 115.0, 158.0, 145.0, 113.0, 113.0, 112.0, 124.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 134.0, 165.0, 107.0, 130.0, 130.0, 117.0, 200.0, 109.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 184.0, 184.0, 183.0, 182.0, 183.0, 181.0, 186.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 79.0, 162.0, 66.0, 73.0, 78.0, 93.0, 162.0, 57.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 134.0, 72.0, 74.0, 83.0, 113.0, 68.0, 70.0, 110.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 87.0, 88.0, 84.0, 89.0, 85.0, 88.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 85.0, 86.0, 85.0, 83.0, 84.0, 84.0, 84.0, 80.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 53.0, 53.0, 55.0, 54.0, 53.0, 52.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 68.0, 72.0, 75.0, 68.0, 70.0, 70.0, 71.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 85.0, 85.0, 87.0, 85.0, 87.0, 97.0, 110.0, 108.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 149.0, 151.0, 144.0, 140.0, 135.0, 133.0, 135.0, 166.0, 144.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 233.0, 202.0, 171.0, 169.0, 178.0, 169.0, 170.0, 164.0, 233.0], "value": 186.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 76.0, 78.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1501.3, "alertThreshold": 2.0}]} 20:57:20 INFO - Return code: 0 20:57:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:57:21 INFO - # TBPL SUCCESS # 20:57:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:57:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:57:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:57:21 INFO - 2016-09-12 20:57:21.079 screenresolution[1686:11518] starting screenresolution argv=screenresolution get 20:57:21 INFO - 2016-09-12 20:57:21.081 screenresolution[1686:11518] Display 0: 1600x1200x32@60 20:57:21 INFO - 2016-09-12 20:57:21.087 screenresolution[1687:11521] starting screenresolution argv=screenresolution list 20:57:21 INFO - Available Modes on Display 0 20:57:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:57:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:57:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:57:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:57:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:57:21 INFO - Intel Iris: 20:57:21 INFO - Chipset Model: Intel Iris 20:57:21 INFO - Type: GPU 20:57:21 INFO - Bus: Built-In 20:57:21 INFO - VRAM (Dynamic, Max): 1536 MB 20:57:21 INFO - Vendor: Intel (0x8086) 20:57:21 INFO - Device ID: 0x0a2e 20:57:21 INFO - Revision ID: 0x0009 20:57:21 INFO - Displays: 20:57:21 INFO - Display: 20:57:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:57:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:57:21 INFO - Display Serial Number: 1600x1200 60 20:57:21 INFO - Main Display: Yes 20:57:21 INFO - Mirror: Off 20:57:21 INFO - Online: Yes 20:57:21 INFO - Rotation: Supported 20:57:21 INFO - Return code: 0 20:57:21 INFO - Running post-action listener: _resource_record_post_action 20:57:21 INFO - [mozharness: 2016-09-13 03:57:21.324224Z] Finished run-tests step (success) 20:57:21 INFO - Running post-run listener: _resource_record_post_run 20:57:21 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31869952; Write bytes: 706128896; Read time: 197; Write time: 1986 20:57:21 INFO - TinderboxPrint: CPU usage
53.6% 20:57:21 INFO - TinderboxPrint: I/O read bytes / time
31,869,952 / 197 20:57:21 INFO - TinderboxPrint: I/O write bytes / time
706,128,896 / 1,986 20:57:21 INFO - TinderboxPrint: CPU idle
2,252.1 (46.4%) 20:57:21 INFO - TinderboxPrint: CPU system
974.0 (20.1%) 20:57:21 INFO - TinderboxPrint: CPU user
1,627.6 (33.5%) 20:57:21 INFO - TinderboxPrint: Swap in / out
433,561,600 / 0 20:57:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399624704; Write bytes: 393565696; Read time: 29502; Write time: 851 20:57:21 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29805568; Write bytes: 297690624; Read time: 179; Write time: 1094 20:57:21 INFO - Running post-run listener: _upload_blobber_files 20:57:21 INFO - Blob upload gear active. 20:57:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:57:21 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 20:57:21 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'] 20:57:21 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 20:57:22 INFO - (blobuploader) - INFO - Open directory for files ... 20:57:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:57:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:57:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:57:23 INFO - (blobuploader) - INFO - Done attempting. 20:57:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:57:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:57:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:57:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:57:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:57:24 INFO - (blobuploader) - INFO - Done attempting. 20:57:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:57:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:57:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:57:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:57:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:57:27 INFO - (blobuploader) - INFO - Done attempting. 20:57:27 INFO - (blobuploader) - INFO - Iteration through files over. 20:57:27 INFO - Return code: 0 20:57:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:57:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:57:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea66f87fb3d3f902303b1e03b88e718b9087c4794a4b4ba24e05a84f0f4e396638ce3055b279b7737428debfd712812b082d2ec96f846c627dcb2bfc8274e4a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/33d0d1559e76568657c2dded0bc416c6566cd9974eeaa73086baf9d424cfc975e84796e2332555f6fb07edebbe05a9b2fd5b6036b6a3a3378f2ea70f6fa0fd03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63f20badbf63573330dec0147472fb8b48debb46bfca44fec7cc97faf9c2ec3ae2b91c7fa0fbf62ddcd5c0961562f399d3c4f6b01d2cf09a88f40185103318d9"} 20:57:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:57:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:57:27 INFO - Contents: 20:57:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea66f87fb3d3f902303b1e03b88e718b9087c4794a4b4ba24e05a84f0f4e396638ce3055b279b7737428debfd712812b082d2ec96f846c627dcb2bfc8274e4a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/33d0d1559e76568657c2dded0bc416c6566cd9974eeaa73086baf9d424cfc975e84796e2332555f6fb07edebbe05a9b2fd5b6036b6a3a3378f2ea70f6fa0fd03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63f20badbf63573330dec0147472fb8b48debb46bfca44fec7cc97faf9c2ec3ae2b91c7fa0fbf62ddcd5c0961562f399d3c4f6b01d2cf09a88f40185103318d9"} 20:57:27 INFO - Running post-run listener: copy_logs_to_upload_dir 20:57:27 INFO - Copying logs to upload dir... 20:57:27 INFO - mkdir: /builds/slave/test/build/upload/logs 20:57:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.683574 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-12 20:57:27.395963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 20:57:27.399445) ========= 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.HzmLlXlji8/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.qH4AsmCPHI/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea66f87fb3d3f902303b1e03b88e718b9087c4794a4b4ba24e05a84f0f4e396638ce3055b279b7737428debfd712812b082d2ec96f846c627dcb2bfc8274e4a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/33d0d1559e76568657c2dded0bc416c6566cd9974eeaa73086baf9d424cfc975e84796e2332555f6fb07edebbe05a9b2fd5b6036b6a3a3378f2ea70f6fa0fd03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63f20badbf63573330dec0147472fb8b48debb46bfca44fec7cc97faf9c2ec3ae2b91c7fa0fbf62ddcd5c0961562f399d3c4f6b01d2cf09a88f40185103318d9"} build_url:https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010764 build_url: 'https://queue.taskcluster.net/v1/task/Vw72ZVaiSE2JbQHCQ_owNg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea66f87fb3d3f902303b1e03b88e718b9087c4794a4b4ba24e05a84f0f4e396638ce3055b279b7737428debfd712812b082d2ec96f846c627dcb2bfc8274e4a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/33d0d1559e76568657c2dded0bc416c6566cd9974eeaa73086baf9d424cfc975e84796e2332555f6fb07edebbe05a9b2fd5b6036b6a3a3378f2ea70f6fa0fd03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/63f20badbf63573330dec0147472fb8b48debb46bfca44fec7cc97faf9c2ec3ae2b91c7fa0fbf62ddcd5c0961562f399d3c4f6b01d2cf09a88f40185103318d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 20:57:27.433102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:57:27.433474) ========= 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.HzmLlXlji8/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.qH4AsmCPHI/Listeners TMPDIR=/var/folders/fc/wl7qkldn1hvdmlv4c38wrjkc00000w/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.005078 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 20:57:27.482072) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 20:57:27.482424) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 20:57:27.482802) ========= ========= Total master_lag: 0.19 =========