builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0224 starttime: 1470634378.26 results: success (0) buildid: 20160807203652 builduid: e876ee354a4943b99651582a4d344f4e revision: 1ed87253fdf1d9e8e6c3a5280a4441cebe7bcf06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.262341) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.262828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.263112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.286290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.287250) ========= 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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-07 22:32:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.67M=0.002s 2016-08-07 22:32:58 (7.67 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158433 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.467396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.467757) ========= 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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.020197 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:32:58.516343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 22:32:58.516728) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1ed87253fdf1d9e8e6c3a5280a4441cebe7bcf06 --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 1ed87253fdf1d9e8e6c3a5280a4441cebe7bcf06 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-07 22:32:58,599 truncating revision to first 12 chars 2016-08-07 22:32:58,599 Setting DEBUG logging. 2016-08-07 22:32:58,599 attempt 1/10 2016-08-07 22:32:58,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1ed87253fdf1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 22:33:00,198 unpacking tar archive at: autoland-1ed87253fdf1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.868026 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 22:33:00.406848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 22:33:00.407173) ========= script_repo_revision: 1ed87253fdf1d9e8e6c3a5280a4441cebe7bcf06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 22:33:00.407726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 22:33:00.408038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 22:33:00.427321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-07 22:33:00.427716) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:00 INFO - MultiFileLogger online at 20160807 22:33:00 in /builds/slave/test 22:33:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 22:33:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:33:00 INFO - {'append_to_log': False, 22:33:00 INFO - 'base_work_dir': '/builds/slave/test', 22:33:00 INFO - 'blob_upload_branch': 'Autoland', 22:33:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:33:00 INFO - 'branch': 'Autoland', 22:33:00 INFO - 'buildbot_json_path': 'buildprops.json', 22:33:00 INFO - 'config_files': ('talos/mac_config.py',), 22:33:00 INFO - 'default_actions': ('clobber', 22:33:00 INFO - 'read-buildbot-config', 22:33:00 INFO - 'download-and-extract', 22:33:00 INFO - 'populate-webroot', 22:33:00 INFO - 'create-virtualenv', 22:33:00 INFO - 'install', 22:33:00 INFO - 'run-tests'), 22:33:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:33:00 INFO - 'download_minidump_stackwalk': True, 22:33:00 INFO - 'download_symbols': 'ondemand', 22:33:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:33:00 INFO - 'tooltool.py': '/tools/tooltool.py', 22:33:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:33:00 INFO - '/tools/misc-python/virtualenv.py')}, 22:33:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:33:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:33:00 INFO - 'installer_path': 'installer.exe', 22:33:00 INFO - 'log_level': 'info', 22:33:00 INFO - 'log_name': 'talos', 22:33:00 INFO - 'log_to_console': True, 22:33:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:33:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:33:00 INFO - 'opt_config_files': (), 22:33:00 INFO - 'pip_index': False, 22:33:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:33:00 INFO - 'cmd': ('bash', 22:33:00 INFO - '-c', 22:33:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:33:00 INFO - 'enabled': True, 22:33:00 INFO - 'halt_on_failure': False, 22:33:00 INFO - 'name': 'check_screen_resolution'},), 22:33:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:33:00 INFO - 'cmd': ('bash', 22:33:00 INFO - '-c', 22:33:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:33:00 INFO - 'enabled': True, 22:33:00 INFO - 'halt_on_failure': False, 22:33:00 INFO - 'name': 'check_screen_resolution'},), 22:33:00 INFO - 'run_cmd_checks_enabled': True, 22:33:00 INFO - 'sps_profile': False, 22:33:00 INFO - 'sps_profile_interval': 0, 22:33:00 INFO - 'suite': 'dromaeojs-e10s', 22:33:00 INFO - 'system_bits': '32', 22:33:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:33:00 INFO - 'title': 't-yosemite-r7-0224', 22:33:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:33:00 INFO - 'use_talos_json': True, 22:33:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:33:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:33:00 INFO - 'work_dir': 'build'} 22:33:00 INFO - [mozharness: 2016-08-08 05:33:00.632039Z] Running clobber step. 22:33:00 INFO - Running pre-action listener: _resource_record_pre_action 22:33:00 INFO - Running main action method: clobber 22:33:00 INFO - rmtree: /builds/slave/test/build 22:33:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:33:02 INFO - Running post-action listener: _resource_record_post_action 22:33:02 INFO - [mozharness: 2016-08-08 05:33:02.375533Z] Finished clobber step (success) 22:33:02 INFO - [mozharness: 2016-08-08 05:33:02.375697Z] Running read-buildbot-config step. 22:33:02 INFO - Running pre-action listener: _resource_record_pre_action 22:33:02 INFO - Running main action method: read_buildbot_config 22:33:02 INFO - Using buildbot properties: 22:33:02 INFO - { 22:33:02 INFO - "project": "", 22:33:02 INFO - "product": "firefox", 22:33:02 INFO - "script_repo_revision": "production", 22:33:02 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 22:33:02 INFO - "repository": "", 22:33:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 22:33:02 INFO - "buildid": "20160807203652", 22:33:02 INFO - "pgo_build": "False", 22:33:02 INFO - "basedir": "/builds/slave/test", 22:33:02 INFO - "buildnumber": 81, 22:33:02 INFO - "slavename": "t-yosemite-r7-0224", 22:33:02 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 22:33:02 INFO - "platform": "yosemite_r7", 22:33:02 INFO - "scheduler": "tests-autoland-macosx64-talos", 22:33:02 INFO - "branch": "autoland", 22:33:02 INFO - "repo_path": "integration/autoland", 22:33:02 INFO - "revision": "1ed87253fdf1d9e8e6c3a5280a4441cebe7bcf06", 22:33:02 INFO - "stage_platform": "macosx64", 22:33:02 INFO - "builduid": "e876ee354a4943b99651582a4d344f4e", 22:33:02 INFO - "slavebuilddir": "test" 22:33:02 INFO - } 22:33:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 22:33:02 INFO - Running post-action listener: _resource_record_post_action 22:33:02 INFO - [mozharness: 2016-08-08 05:33:02.379773Z] Finished read-buildbot-config step (success) 22:33:02 INFO - [mozharness: 2016-08-08 05:33:02.379904Z] Running download-and-extract step. 22:33:02 INFO - Running pre-action listener: _resource_record_pre_action 22:33:02 INFO - Running main action method: download_and_extract 22:33:02 INFO - mkdir: /builds/slave/test/build/tests 22:33:02 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')]} 22:33:02 INFO - trying https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 22:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/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 22:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/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 22:33:02 INFO - Downloaded 1199 bytes. 22:33:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 22:33:02 INFO - Using the following test package requirements: 22:33:02 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 22:33:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 22:33:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 22:33:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'jsshell-mac.zip'], 22:33:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 22:33:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 22:33:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 22:33:02 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 22:33:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 22:33:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 22:33:02 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 22:33:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:33:02 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')]} 22:33:02 INFO - trying https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:33:03 INFO - Downloaded 16324174 bytes. 22:33:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:33:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:33:06 INFO - Return code: 0 22:33:06 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 22:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:06 INFO - trying https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:33:06 INFO - Downloading https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 22:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:33:07 INFO - Downloaded 16324174 bytes. 22:33:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:33:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:33:11 INFO - Return code: 0 22:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:11 INFO - trying https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 22:33:11 INFO - Downloading https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 22:33:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:33:12 INFO - Downloaded 14413723 bytes. 22:33:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:33:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:33:12 INFO - Return code: 0 22:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:12 INFO - trying https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:33:12 INFO - Downloading https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 22:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/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 22:33:15 INFO - Downloaded 111942104 bytes. 22:33:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:33:15 INFO - mkdir: /builds/slave/test/properties 22:33:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:33:15 INFO - Writing to file /builds/slave/test/properties/build_url 22:33:15 INFO - Contents: 22:33:15 INFO - build_url:https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 22:33:16 INFO - Running post-action listener: _resource_record_post_action 22:33:16 INFO - Running post-action listener: set_extra_try_arguments 22:33:16 INFO - [mozharness: 2016-08-08 05:33:16.392276Z] Finished download-and-extract step (success) 22:33:16 INFO - [mozharness: 2016-08-08 05:33:16.392422Z] Running populate-webroot step. 22:33:16 INFO - Running pre-action listener: _resource_record_pre_action 22:33:16 INFO - Running main action method: populate_webroot 22:33:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:33:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:33:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:33:16 INFO - '--tppagecycles', 22:33:16 INFO - '7'], 22:33:16 INFO - 'tests': ['tsvgm']}}, 22:33:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:33:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:33:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:33:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:33:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:33:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['damp', 'tps']}, 22:33:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'tests': ['damp', 'tps']}, 22:33:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['dromaeo_dom']}, 22:33:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:33:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['basic_compositor_video']}, 22:33:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:33:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['a11yr', 22:33:16 INFO - 'ts_paint', 22:33:16 INFO - 'tpaint', 22:33:16 INFO - 'sessionrestore', 22:33:16 INFO - 'sessionrestore_no_auto_restore', 22:33:16 INFO - 'tabpaint']}, 22:33:16 INFO - 'other-e10s': {'tests': ['a11yr', 22:33:16 INFO - 'ts_paint', 22:33:16 INFO - 'tpaint', 22:33:16 INFO - 'sessionrestore', 22:33:16 INFO - 'sessionrestore_no_auto_restore', 22:33:16 INFO - 'tabpaint']}, 22:33:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:33:16 INFO - 'ts_paint', 22:33:16 INFO - 'tpaint', 22:33:16 INFO - 'sessionrestore', 22:33:16 INFO - 'sessionrestore_no_auto_restore', 22:33:16 INFO - 'tabpaint']}, 22:33:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:33:16 INFO - 'ts_paint', 22:33:16 INFO - 'tpaint', 22:33:16 INFO - 'sessionrestore', 22:33:16 INFO - 'sessionrestore_no_auto_restore', 22:33:16 INFO - 'tabpaint']}, 22:33:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['a11yr', 22:33:16 INFO - 'ts_paint', 22:33:16 INFO - 'tpaint', 22:33:16 INFO - 'sessionrestore', 22:33:16 INFO - 'sessionrestore_no_auto_restore', 22:33:16 INFO - 'tabpaint']}, 22:33:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['a11yr', 22:33:16 INFO - 'ts_paint', 22:33:16 INFO - 'tpaint', 22:33:16 INFO - 'sessionrestore', 22:33:16 INFO - 'sessionrestore_no_auto_restore', 22:33:16 INFO - 'tabpaint']}, 22:33:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['tsvgx', 22:33:16 INFO - 'tsvgr_opacity', 22:33:16 INFO - 'tart', 22:33:16 INFO - 'tscrollx', 22:33:16 INFO - 'cart']}, 22:33:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:33:16 INFO - 'tsvgr_opacity', 22:33:16 INFO - 'tart', 22:33:16 INFO - 'tscrollx', 22:33:16 INFO - 'cart']}, 22:33:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'talos_options': ['--disable-e10s'], 22:33:16 INFO - 'tests': ['tp5o']}, 22:33:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'tests': ['tp5o']}, 22:33:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'talos_options': ['--disable-e10s', 22:33:16 INFO - '--xperf_path', 22:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:16 INFO - 'tests': ['tp5n']}, 22:33:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:33:16 INFO - 'talos_options': ['--xperf_path', 22:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:33:16 INFO - 'tests': ['tp5n']}}, 22:33:16 INFO - 'talos.zip': {'path': '', 22:33:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:33:16 INFO - Running post-action listener: _resource_record_post_action 22:33:16 INFO - [mozharness: 2016-08-08 05:33:16.410737Z] Finished populate-webroot step (success) 22:33:16 INFO - [mozharness: 2016-08-08 05:33:16.410875Z] Running create-virtualenv step. 22:33:16 INFO - Running pre-action listener: _resource_record_pre_action 22:33:16 INFO - Running main action method: create_virtualenv 22:33:16 INFO - Creating virtualenv /builds/slave/test/build/venv 22:33:16 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 22:33:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:33:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:33:16 INFO - Using real prefix '/tools/python27' 22:33:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:33:17 INFO - Installing distribute.............................................................................................................................................................................................done. 22:33:20 INFO - Installing pip.................done. 22:33:20 INFO - Return code: 0 22:33:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:33:20 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')]} 22:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:20 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')]} 22:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:20 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:20 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 22:33:20 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 22:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:20 INFO - 'HOME': '/Users/cltbld', 22:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:20 INFO - 'LOGNAME': 'cltbld', 22:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:20 INFO - 'MOZ_NO_REMOTE': '1', 22:33:20 INFO - 'NO_EM_RESTART': '1', 22:33:20 INFO - 'PAGER': '/bin/cat', 22:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:20 INFO - 'PWD': '/builds/slave/test', 22:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:20 INFO - 'SHELL': '/bin/bash', 22:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:20 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:20 INFO - 'USER': 'cltbld', 22:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:20 INFO - 'XPC_FLAGS': '0x0', 22:33:20 INFO - 'XPC_SERVICE_NAME': '0', 22:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:20 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 22:33:20 INFO - Cleaning up... 22:33:20 INFO - Return code: 0 22:33:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:33:20 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')]} 22:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:20 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')]} 22:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:20 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:20 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 22:33:20 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 22:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:20 INFO - 'HOME': '/Users/cltbld', 22:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:20 INFO - 'LOGNAME': 'cltbld', 22:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:20 INFO - 'MOZ_NO_REMOTE': '1', 22:33:20 INFO - 'NO_EM_RESTART': '1', 22:33:20 INFO - 'PAGER': '/bin/cat', 22:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:20 INFO - 'PWD': '/builds/slave/test', 22:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:20 INFO - 'SHELL': '/bin/bash', 22:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:20 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:20 INFO - 'USER': 'cltbld', 22:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:20 INFO - 'XPC_FLAGS': '0x0', 22:33:20 INFO - 'XPC_SERVICE_NAME': '0', 22:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:20 INFO - Downloading/unpacking psutil>=3.1.1 22:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:24 INFO - Installing collected packages: psutil 22:33:24 INFO - Running setup.py install for psutil 22:33:24 INFO - building 'psutil._psutil_osx' extension 22:33:24 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 22:33:24 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 22:33:24 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 22:33:24 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 22:33:24 INFO - building 'psutil._psutil_posix' extension 22:33:24 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 22:33:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:33:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:33:24 INFO - ^ 22:33:24 INFO - 1 warning generated. 22:33:24 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 22:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:24 INFO - Successfully installed psutil 22:33:24 INFO - Cleaning up... 22:33:25 INFO - Return code: 0 22:33:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:33:25 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')]} 22:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:25 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')]} 22:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:25 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:25 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 22:33:25 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 22:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:25 INFO - 'HOME': '/Users/cltbld', 22:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:25 INFO - 'LOGNAME': 'cltbld', 22:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:25 INFO - 'MOZ_NO_REMOTE': '1', 22:33:25 INFO - 'NO_EM_RESTART': '1', 22:33:25 INFO - 'PAGER': '/bin/cat', 22:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:25 INFO - 'PWD': '/builds/slave/test', 22:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:25 INFO - 'SHELL': '/bin/bash', 22:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:25 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:25 INFO - 'USER': 'cltbld', 22:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:25 INFO - 'XPC_FLAGS': '0x0', 22:33:25 INFO - 'XPC_SERVICE_NAME': '0', 22:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:33:25 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 22:33:25 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 22:33:25 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 22:33:25 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 22:33:25 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 22:33:25 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 22:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:33:27 INFO - Installing collected packages: mozsystemmonitor 22:33:27 INFO - Running setup.py install for mozsystemmonitor 22:33:27 INFO - Successfully installed mozsystemmonitor 22:33:27 INFO - Cleaning up... 22:33:27 INFO - Return code: 0 22:33:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:33:27 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')]} 22:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:27 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')]} 22:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:27 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:27 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 22:33:27 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 22:33:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:27 INFO - 'HOME': '/Users/cltbld', 22:33:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:27 INFO - 'LOGNAME': 'cltbld', 22:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:27 INFO - 'MOZ_NO_REMOTE': '1', 22:33:27 INFO - 'NO_EM_RESTART': '1', 22:33:27 INFO - 'PAGER': '/bin/cat', 22:33:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:27 INFO - 'PWD': '/builds/slave/test', 22:33:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:27 INFO - 'SHELL': '/bin/bash', 22:33:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:27 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:27 INFO - 'USER': 'cltbld', 22:33:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:27 INFO - 'XPC_FLAGS': '0x0', 22:33:27 INFO - 'XPC_SERVICE_NAME': '0', 22:33:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:28 INFO - Downloading/unpacking jsonschema==2.5.1 22:33:28 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 22:33:28 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 22:33:28 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 22:33:28 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 22:33:28 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 22:33:28 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 22:33:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:33:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:30 INFO - Downloading functools32-3.2.3-2.tar.gz 22:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:33:31 INFO - warning: no files found matching '*.txt' 22:33:31 INFO - no previously-included directories found matching 'build' 22:33:31 INFO - no previously-included directories found matching 'dist' 22:33:31 INFO - no previously-included directories found matching '.git*' 22:33:31 INFO - Installing collected packages: jsonschema, functools32 22:33:31 INFO - Running setup.py install for functools32 22:33:31 INFO - warning: no files found matching '*.txt' 22:33:31 INFO - no previously-included directories found matching 'build' 22:33:31 INFO - no previously-included directories found matching 'dist' 22:33:31 INFO - no previously-included directories found matching '.git*' 22:33:31 INFO - Successfully installed jsonschema functools32 22:33:31 INFO - Cleaning up... 22:33:31 INFO - Return code: 0 22:33:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:31 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:31 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 22:33:31 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 22:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:31 INFO - 'HOME': '/Users/cltbld', 22:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:31 INFO - 'LOGNAME': 'cltbld', 22:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:31 INFO - 'MOZ_NO_REMOTE': '1', 22:33:31 INFO - 'NO_EM_RESTART': '1', 22:33:31 INFO - 'PAGER': '/bin/cat', 22:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:31 INFO - 'PWD': '/builds/slave/test', 22:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:31 INFO - 'SHELL': '/bin/bash', 22:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:31 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:31 INFO - 'USER': 'cltbld', 22:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:31 INFO - 'XPC_FLAGS': '0x0', 22:33:31 INFO - 'XPC_SERVICE_NAME': '0', 22:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:33:31 INFO - Cleaning up... 22:33:31 INFO - Return code: 0 22:33:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:31 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:31 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 22:33:31 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 22:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:31 INFO - 'HOME': '/Users/cltbld', 22:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:31 INFO - 'LOGNAME': 'cltbld', 22:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:31 INFO - 'MOZ_NO_REMOTE': '1', 22:33:31 INFO - 'NO_EM_RESTART': '1', 22:33:31 INFO - 'PAGER': '/bin/cat', 22:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:31 INFO - 'PWD': '/builds/slave/test', 22:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:31 INFO - 'SHELL': '/bin/bash', 22:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:31 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:31 INFO - 'USER': 'cltbld', 22:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:31 INFO - 'XPC_FLAGS': '0x0', 22:33:31 INFO - 'XPC_SERVICE_NAME': '0', 22:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:31 INFO - Downloading/unpacking blobuploader==1.2.4 22:33:31 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 22:33:31 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 22:33:31 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 22:33:31 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 22:33:31 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 22:33:31 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 22:33:34 INFO - Downloading blobuploader-1.2.4.tar.gz 22:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:33:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:33:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:33:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:33:35 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 22:33:35 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 22:33:35 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 22:33:35 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 22:33:35 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 22:33:35 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 22:33:35 INFO - Downloading docopt-0.6.1.tar.gz 22:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:33:35 INFO - Installing collected packages: blobuploader, requests, docopt 22:33:35 INFO - Running setup.py install for blobuploader 22:33:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:33:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:33:35 INFO - Running setup.py install for requests 22:33:36 INFO - Running setup.py install for docopt 22:33:36 INFO - Successfully installed blobuploader requests docopt 22:33:36 INFO - Cleaning up... 22:33:36 INFO - Return code: 0 22:33:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:36 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')]} 22:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:36 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')]} 22:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:36 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:36 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 22:33:36 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 22:33:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:36 INFO - 'HOME': '/Users/cltbld', 22:33:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:36 INFO - 'LOGNAME': 'cltbld', 22:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:36 INFO - 'MOZ_NO_REMOTE': '1', 22:33:36 INFO - 'NO_EM_RESTART': '1', 22:33:36 INFO - 'PAGER': '/bin/cat', 22:33:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:36 INFO - 'PWD': '/builds/slave/test', 22:33:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:36 INFO - 'SHELL': '/bin/bash', 22:33:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:36 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:36 INFO - 'USER': 'cltbld', 22:33:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:36 INFO - 'XPC_FLAGS': '0x0', 22:33:36 INFO - 'XPC_SERVICE_NAME': '0', 22:33:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-huBjVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-pAJGdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-WHorEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Xv_Cx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ksQlIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Qyrwmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-1aNGa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-eXWJ9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-_0su_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-XvMCxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-zlY_3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-U0H5eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:38 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-hGeXsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:38 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ks8wKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:38 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-cHcXyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:38 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-03hyTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:38 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-KfYrLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:33:38 INFO - Running setup.py install for manifestparser 22:33:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:33:38 INFO - Running setup.py install for mozcrash 22:33:38 INFO - Running setup.py install for mozdebug 22:33:38 INFO - Running setup.py install for mozdevice 22:33:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Running setup.py install for mozfile 22:33:39 INFO - Running setup.py install for mozhttpd 22:33:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Running setup.py install for mozinfo 22:33:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Running setup.py install for mozInstall 22:33:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:33:39 INFO - Running setup.py install for mozleak 22:33:39 INFO - Running setup.py install for mozlog 22:33:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:33:40 INFO - Running setup.py install for moznetwork 22:33:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:33:40 INFO - Running setup.py install for mozprocess 22:33:40 INFO - Running setup.py install for mozprofile 22:33:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:33:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:33:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:33:40 INFO - Running setup.py install for mozrunner 22:33:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:33:40 INFO - Running setup.py install for mozscreenshot 22:33:40 INFO - Running setup.py install for moztest 22:33:40 INFO - Running setup.py install for mozversion 22:33:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:33:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:33:41 INFO - Cleaning up... 22:33:41 INFO - Return code: 0 22:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:41 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:41 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 22:33:41 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 22:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:41 INFO - 'HOME': '/Users/cltbld', 22:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:41 INFO - 'LOGNAME': 'cltbld', 22:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:41 INFO - 'MOZ_NO_REMOTE': '1', 22:33:41 INFO - 'NO_EM_RESTART': '1', 22:33:41 INFO - 'PAGER': '/bin/cat', 22:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:41 INFO - 'PWD': '/builds/slave/test', 22:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:41 INFO - 'SHELL': '/bin/bash', 22:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:41 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:41 INFO - 'USER': 'cltbld', 22:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:41 INFO - 'XPC_FLAGS': '0x0', 22:33:41 INFO - 'XPC_SERVICE_NAME': '0', 22:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-4lYOOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:41 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)) 22:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nClIWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:41 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)) 22:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-vqugjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:41 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)) 22:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-9HgI9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-DyU51B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-83nmuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-9h7MYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-qL70X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-qIMGe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-RNbVtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-J8dB_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-xi8YEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-owMUdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:42 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)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-TrOYfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Kgu0LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-L2Lilv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:43 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)) 22:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:43 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Th9R1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:43 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)) 22:33:43 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)) 22:33:43 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)) 22:33:43 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)) 22:33:43 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)) 22:33:43 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)) 22:33:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:33:43 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 22:33:43 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 22:33:43 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 22:33:43 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 22:33:43 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 22:33:43 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 22:33:45 INFO - Downloading blessings-1.6.tar.gz 22:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:33:45 INFO - Installing collected packages: blessings 22:33:45 INFO - Running setup.py install for blessings 22:33:45 INFO - Successfully installed blessings 22:33:45 INFO - Cleaning up... 22:33:46 INFO - Return code: 0 22:33:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:46 INFO - Reading from file tmpfile_stdout 22:33:46 INFO - Current package versions: 22:33:46 INFO - blessings == 1.6 22:33:46 INFO - blobuploader == 1.2.4 22:33:46 INFO - docopt == 0.6.1 22:33:46 INFO - functools32 == 3.2.3-2 22:33:46 INFO - jsonschema == 2.5.1 22:33:46 INFO - manifestparser == 1.1 22:33:46 INFO - mozInstall == 1.12 22:33:46 INFO - mozcrash == 0.17 22:33:46 INFO - mozdebug == 0.1 22:33:46 INFO - mozdevice == 0.48 22:33:46 INFO - mozfile == 1.2 22:33:46 INFO - mozhttpd == 0.7 22:33:46 INFO - mozinfo == 0.9 22:33:46 INFO - mozleak == 0.1 22:33:46 INFO - mozlog == 3.3 22:33:46 INFO - moznetwork == 0.27 22:33:46 INFO - mozprocess == 0.23 22:33:46 INFO - mozprofile == 0.28 22:33:46 INFO - mozrunner == 6.12 22:33:46 INFO - mozscreenshot == 0.1 22:33:46 INFO - mozsystemmonitor == 0.3 22:33:46 INFO - moztest == 0.7 22:33:46 INFO - mozversion == 1.4 22:33:46 INFO - psutil == 3.1.1 22:33:46 INFO - requests == 1.2.3 22:33:46 INFO - wsgiref == 0.1.2 22:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:46 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:46 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 22:33:46 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 22:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:46 INFO - 'HOME': '/Users/cltbld', 22:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:46 INFO - 'LOGNAME': 'cltbld', 22:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:46 INFO - 'MOZ_NO_REMOTE': '1', 22:33:46 INFO - 'NO_EM_RESTART': '1', 22:33:46 INFO - 'PAGER': '/bin/cat', 22:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:46 INFO - 'PWD': '/builds/slave/test', 22:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:46 INFO - 'SHELL': '/bin/bash', 22:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:46 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:46 INFO - 'USER': 'cltbld', 22:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:46 INFO - 'XPC_FLAGS': '0x0', 22:33:46 INFO - 'XPC_SERVICE_NAME': '0', 22:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 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)) 22:33:46 INFO - Cleaning up... 22:33:46 INFO - Return code: 0 22:33:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:46 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 0x10fc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da0ca4820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, '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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 22:33:46 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 22:33:46 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 22:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:46 INFO - 'HOME': '/Users/cltbld', 22:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:46 INFO - 'LOGNAME': 'cltbld', 22:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:46 INFO - 'MOZ_NO_REMOTE': '1', 22:33:46 INFO - 'NO_EM_RESTART': '1', 22:33:46 INFO - 'PAGER': '/bin/cat', 22:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:46 INFO - 'PWD': '/builds/slave/test', 22:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:46 INFO - 'SHELL': '/bin/bash', 22:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:33:46 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:46 INFO - 'USER': 'cltbld', 22:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:46 INFO - 'XPC_FLAGS': '0x0', 22:33:46 INFO - 'XPC_SERVICE_NAME': '0', 22:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:33:46 INFO - Cleaning up... 22:33:46 INFO - Return code: 0 22:33:46 INFO - Running post-action listener: _resource_record_post_action 22:33:46 INFO - Running post-action listener: _start_resource_monitoring 22:33:46 INFO - Starting resource monitoring. 22:33:46 INFO - [mozharness: 2016-08-08 05:33:46.829501Z] Finished create-virtualenv step (success) 22:33:46 INFO - [mozharness: 2016-08-08 05:33:46.830460Z] Running install step. 22:33:46 INFO - Running pre-action listener: _resource_record_pre_action 22:33:46 INFO - Running main action method: install 22:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:47 INFO - Reading from file tmpfile_stdout 22:33:47 INFO - Detecting whether we're running mozinstall >=1.0... 22:33:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:33:47 INFO - Reading from file tmpfile_stdout 22:33:47 INFO - Output received: 22:33:47 INFO - Usage: mozinstall [options] installer 22:33:47 INFO - Options: 22:33:47 INFO - -h, --help show this help message and exit 22:33:47 INFO - -d DEST, --destination=DEST 22:33:47 INFO - Directory to install application into. [default: 22:33:47 INFO - "/builds/slave/test"] 22:33:47 INFO - --app=APP Application being installed. [default: firefox] 22:33:47 INFO - mkdir: /builds/slave/test/build/application 22:33:47 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'] 22:33:47 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 22:34:22 INFO - Reading from file tmpfile_stdout 22:34:22 INFO - Output received: 22:34:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:34:22 INFO - Running post-action listener: _resource_record_post_action 22:34:22 INFO - [mozharness: 2016-08-08 05:34:22.406940Z] Finished install step (success) 22:34:22 INFO - [mozharness: 2016-08-08 05:34:22.407083Z] Running run-tests step. 22:34:22 INFO - Running pre-action listener: _resource_record_pre_action 22:34:22 INFO - Running main action method: run_tests 22:34:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:34:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:34:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:34:22 INFO - 2016-08-07 22:34:22.421 screenresolution[1986:10518] starting screenresolution argv=screenresolution get 22:34:22 INFO - 2016-08-07 22:34:22.424 screenresolution[1986:10518] Display 0: 1600x1200x32@60 22:34:22 INFO - 2016-08-07 22:34:22.430 screenresolution[1987:10520] starting screenresolution argv=screenresolution list 22:34:22 INFO - Available Modes on Display 0 22:34:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:34:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:34:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:34:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:34:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:34:22 INFO - Intel Iris: 22:34:22 INFO - Chipset Model: Intel Iris 22:34:22 INFO - Type: GPU 22:34:22 INFO - Bus: Built-In 22:34:22 INFO - VRAM (Dynamic, Max): 1536 MB 22:34:22 INFO - Vendor: Intel (0x8086) 22:34:22 INFO - Device ID: 0x0a2e 22:34:22 INFO - Revision ID: 0x0009 22:34:22 INFO - Displays: 22:34:22 INFO - Display: 22:34:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:34:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:34:22 INFO - Display Serial Number: 1600x1200 60 22:34:22 INFO - Main Display: Yes 22:34:22 INFO - Mirror: Off 22:34:22 INFO - Online: Yes 22:34:22 INFO - Rotation: Supported 22:34:22 INFO - Return code: 0 22:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:34:22 INFO - Python 2.7.3 22:34:22 INFO - Return code: 0 22:34:22 INFO - grabbing minidump binary from tooltool 22:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:34:22 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 0x10fbd1d30>, '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 0x10f936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:34:22 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 22:34:22 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 22:34:22 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 22:34:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:34:22 INFO - Return code: 0 22:34:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:34:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:34:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:34:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:34:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0224 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:34:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DHYLGJ4p9E/Render', 22:34:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:34:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:34:22 INFO - 'HOME': '/Users/cltbld', 22:34:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:34:22 INFO - 'LOGNAME': 'cltbld', 22:34:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:34:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:34:22 INFO - 'MOZ_NO_REMOTE': '1', 22:34:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:34:22 INFO - 'NO_EM_RESTART': '1', 22:34:22 INFO - 'PAGER': '/bin/cat', 22:34:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:34:22 INFO - 'PWD': '/builds/slave/test', 22:34:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:34:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:34:22 INFO - 'SHELL': '/bin/bash', 22:34:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5Auma9Ymx/Listeners', 22:34:22 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 22:34:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:34:22 INFO - 'USER': 'cltbld', 22:34:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:34:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:34:22 INFO - 'XPC_FLAGS': '0x0', 22:34:22 INFO - 'XPC_SERVICE_NAME': '0', 22:34:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:34:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:34:23 INFO - mozversion application_buildid: 20160807203652 22:34:23 INFO - mozversion application_changeset: 1ed87253fdf1d9e8e6c3a5280a4441cebe7bcf06 22:34:23 INFO - mozversion application_display_name: Nightly 22:34:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:34:23 INFO - mozversion application_name: Firefox 22:34:23 INFO - mozversion application_remotingname: firefox 22:34:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:34:23 INFO - mozversion application_vendor: Mozilla 22:34:23 INFO - mozversion application_version: 51.0a1 22:34:23 INFO - mozversion platform_buildid: 20160807203652 22:34:23 INFO - mozversion platform_changeset: 1ed87253fdf1d9e8e6c3a5280a4441cebe7bcf06 22:34:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:34:23 INFO - mozversion platform_version: 51.0a1 22:34:23 INFO - using testdate: 1470634463 22:34:23 INFO - actual date: 1470634463 22:34:23 INFO - starting webserver on 'localhost:49390' 22:34:23 INFO - SUITE-START | Running 2 tests 22:34:23 INFO - TEST-START | dromaeo_css 22:34:23 INFO - operating with platform_type : mac_ 22:34:23 INFO - Initialising browser for dromaeo_css test... 22:34:23 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmp92KXNh/profile http://localhost:49390/getInfo.html) 22:34:25 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 22:34:25 INFO - PROCESS | 1997 | colorDepth:24 22:34:25 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 22:34:25 INFO - PROCESS | 1997 | __metrics 22:34:26 ERROR - PROCESS | 1997 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:34:26 INFO - TEST-INFO | 1997: exit 0 22:34:26 INFO - Browser initialized. 22:34:26 INFO - Running cycle 1/1 for dromaeo_css test... 22:34:26 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmp92KXNh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:38 INFO - PROCESS | 2000 | RSS: Main: 254791680 22:34:38 INFO - PROCESS | 2000 | 22:35:28 INFO - PROCESS | 2000 | 1470634528385 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] 22:37:41 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49390/tests/dromaeo/cssquery-ext.html) 22:37:42 INFO - PROCESS | 2000 | RSS: Main: 267964416 22:37:42 INFO - PROCESS | 2000 | 22:40:44 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-ext.html (next: http://localhost:49390/tests/dromaeo/cssquery-jquery.html) 22:40:45 INFO - PROCESS | 2000 | RSS: Main: 280481792 22:40:45 INFO - PROCESS | 2000 | 22:43:47 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49390/tests/dromaeo/cssquery-mootools.html) 22:43:47 INFO - PROCESS | 2000 | RSS: Main: 287830016 22:43:47 INFO - PROCESS | 2000 | 22:46:49 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49390/tests/dromaeo/cssquery-prototype.html) 22:46:50 INFO - PROCESS | 2000 | RSS: Main: 288210944 22:46:50 INFO - PROCESS | 2000 | 22:49:52 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49390/tests/dromaeo/cssquery-yui.html) 22:49:53 INFO - PROCESS | 2000 | RSS: Main: 291680256 22:49:53 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49390/tests/dromaeo/cssquery-yui.html (next: http://localhost:49390/tests/dromaeo/cssquery-dojo.html) 22:52:56 INFO - PROCESS | 2000 | RSS: Main: 291893248 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | __start_tp_report 22:52:56 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 22:52:56 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 22:52:56 INFO - PROCESS | 2000 | |i|pagename|runs| 22:52:56 INFO - PROCESS | 2000 | |0;dojo.html;3409.386310464117;3432.536607557979;3459.4637831136165;3465.878694245702;3475.8262086895647;5682.6306290091115;5706.77172913083;5711.8000869969555;5712.143178523218;5819.010768169411;5752.942470575293;5770.971145144268;5786.913196302059;5805.5065319447895;5880.647161170333;5202.0116177926075;5288.101022826109;5314.441983591725;5364.812231571896;5405.378381486121;4505.526919673436;5380.811671591495;5410.864728381803;5425.674459532421;5458.208559758833;5193.376794784613;5256.999999999981;5262.2632831403635;5297.364316282033;5344.973275133639;5285.577153827723;5295.708736019517;5306.09796334624;5323.813666521692;5359.330083739533;5236.947630523684;5276.7889284428575;5279;5309.946900530984;5312.548433383167;4799.232122860326;5537.197106419587;5765.394633563457;5795.594308398414;5827.650340979512;6141.539384546132;6152.907706384408;6192.411720886508;6202.81391558254;6217.68911554425;6206.813795586139;6214;6217.098520714516;6228;6247.094171345175;5710.800121995751;5836.649801011953;5885.764569417261;5924.1113832924975;5925.34821169671;6298.086777417248;6314.778982735674;6314.842128946813;6318.589291696117;6320.462760665303;6129.570930034944;6186;6201.81394558164;6204.255489341308;6207.503399728011;6093.866968088049;6104.76233045773;6138.38839838597;6175.104609831549;6244.750209991549;5234.659747116425;6120.540959428061;6204.255489341218;6213.192285003011;6214.906776398358;4892.779824907888;6188.81433556994;6210.472109870621;6268.153799237045;6273.529485288622;4898.461169271377;4958.454569997298;4978.278149668277;4990.925136122961;4997.375328083989;4486.506484286726;4488.573585509372;4503.932441013388;4514.954850451453;4539.7049191802425;5723.912456633227;5854.7072646367515;5867;5892.528597712173;5897.439743224387;6145.463634091477;6185.536084793658;6196.566240363131;6221;6243.313235544087;4825.3485779419325;5853.209816674779;5867.501262392744;5881.382454842265;5885.970570147122;5477.315335583052;5510.201020851954;5517.4482551745305;5518.061929471999;5535.197396377503;5314.5216930476445;6215.098810672517;6230.470410015108;6237.7193026314835;6326.620402775756;4722.7874745635845;6118.755249789959;6249.375062493714;6261.373862613702;6267.749290028348;6302.464290535356;6321.8735625288155;6329.7151628175925;6340.239171299289;6342.841428964312;6089.512838972783;6131.651934473353;6135.845176233341;6155.4767844731905;6220.191375121386;5206.401263854706;6248.843778905563;6275.152854364603;6278.372162783685;6351.491880649444;6135.761162021872;6203.627782333075;6219.40915613016;6227.003679411272;6250.187475628321;5217.791288348423;5651.180578815966;5990.311114221746;6120.17287048654;6137.877242455036;5550.722463876709;6072.666003369857;6077.179580756541;6115.602485838406;6125.326214116532;6114.7248373822395;6146.200993870947;6167.784127555514;6217.875642487215;6228.906566401417;5910.615809972338;5990.820275391745;5995.2206213192;6034.366391528826;6098.786542470993 22:52:56 INFO - PROCESS | 2000 | |1;ext.html;480.81728943001656;496.54069985263624;519.192655420821;530.5039787798408;549.5630973376166;38740;41471.75584732455;41601.79199104004;41609.7919510402;41721.3741793873;42636.78681606596;42895.14209715812;43179.136417271635;43331.91670208246;44108.558914410845;9372.484513351763;9654.179394751454;9945.801083978353;9950.955149709285;9955.800883982316;8592.914070859273;9798.853017204712;9810.558524866397;9813.852792208123;9826.312158148932;9701;9786.119249267564;9828.410295382264;9831.213502919785;9833.31166818323;9739.805203895918;9787.412755234638;9815.607375704963;9856.457894815781;9879.753006174868;9710.563024663907;9732.805343893153;9747.171490423323;9798.90201097987;9804.215662747034;35596.46605300922;35897;35946;36116.45825312623;36298.81850590756;3123.422166899131;3354.6477619849807;3387.0516255448515;3419.333230020147;3532.311199316134;30857.537136942963;30869.69130308713;31976.680233197603;31991.84004079965;33010.339793204;3203.567518385035;3231.1922019495128;3266.4610339293986;3270.2968861694612;3366.3267346530793;354409;464778;472495;474945.2505474936;485324;60657.69671151616;61826.381736182964;62833.68583157055;63046.684766575876;63101.05348419777;34255.4861677075;35543.82228088895;35558.111047224025;66535.00197497041;66786.99819502712;16951.321947122222;17094.487165385057;17095.48713538596;17101.315947362215;17213.311467541407;12734.745305094031;12920.160189587647;13007.219566825832;13060;13060.542880999119;19085.854848708845;19298.035098245033;19423.979902102572;19703.605927881363;19724.70412943807;8170;8232.300254478316;8332.208440198292;8363.456375335705;8373.581320933929;891.2023738753779;976.4133283414452;985.605757696927;997.2321312589265;1037.5486663301338;29481.410371792444;30630.92791752278;31173;31288.53067203994;31368.529472057937;1004.4626125023077;1022.7085280695115;1042.864427624404;1057.296897563112;1145.1583086431467;15406;15435.30541125652;15444.305006274744;15666.373345066298;15794.526164215093;667925;675598;675925;677484;677662;55416;57028.71485642628;57145;57707;58296.70851645715;1336.7460182565476;1371.3280492558774;1376.0849035391352;1378.9586312410643;1379.5792283353474;26077.348066298495;27721.722782772722;29274.414511710074;29393.412131757672;29399.85300073486;45523.77238113788;45910;46717.36489222861;50697.493025070755;51242.23136652879;271177;277011;281285;282419;283027;26334;26361.472770544864;26501.33746656349;26702.732972670026;26867.462650746485;47252.29121563111;48326.79183020453;48686.0262794735;48779;48877;34837.8258108718;38152.04619884414;39275.607243927196;39794.20411591694;40118.997025074605;38705.806470967465;39019;39842.2031559373;39966.2006759869;40133.598664012985;37002.62997369992;37464.62535374721;37698.2460350786;38185.236295274495;38409.84770456891;34198.82900585481;34600;34632.307353853284;34857.47713784346;35388.292234155684;25496.490070198863;25775;25877;26246.73753262443;26259 22:52:56 INFO - PROCESS | 2000 | |2;jquery.html;370.8590735520502;381.2394273424518;384.3044090196743;395.78231972415165;406.7539138821013;19257.229710811567;21212.939353032365;21307.467313317156;21405.357839264827;22187.223447179353;20337.59324813503;20530.589388212225;21186.364409067715;21402;21708.674369884426;5899.532420652836;6108.297545782248;6133.693315334238;6175.197224360849;6186;4203.579642035787;5734.598578099534;6080.2399700037495;6122.571420000601;6194.535409844257;6672.432843208333;6818.897716534256;6821.045053692487;6829.965850170742;6832.350926661959;4622.237330840408;5014.824481143179;5819.214406055171;5865.384134665884;6884.65576721162;4854.902901941977;5662.37713851476;5699.088145896678;5755.079187330007;5823.039198532237;18582.90708546462;20997.370078897657;25140;25857.482850343076;26061.869690651616;2168.98915505423;2326.755690652491;2948.1597744642672;3001.669816320203;3006.3536339686852;9861.457619830906;9905;10062.547185376676;10095.848562271573;10166.491675416273;1847.6489467001227;1867.4957761404344;1871.5414723392855;1926.0947354743248;1932.4975506368305;110430.44784776105;124890.12664810035;125319;126060;126956;11247.775044499227;11600.419979001017;11607.59373421943;11710.88289117115;11891.583794567148;14474.927625361806;14617.780733288797;14652.340644671016;14743.336549855283;14791.890608204427;8334.62494187763;8462.576871156542;8611.95694021526;8635.827283454295;8650.740477785677;8497.36269779769;8497.702580409656;8530.616122274512;8677.826443471095;8682.088380720059;4188.602082802129;4443.733375997451;4488;4544.353662816245;4586.8165273388695;1673.6359866708838;1691.5855615374312;1798.4604618614364;1817.654935347833;1990.9502262443555;862.5773371048267;902.5712786426395;908.2779190543533;949.188443880486;1043.087298613713;21263.086322231073;21653.458663533536;21756.564868702855;21893.9053047347;21931;877.9946960729928;896.3008853094597;918.1461241045758;968.2157452463528;1022.2792930983638;10494.790104197873;11177.776444471065;11258.831117533244;11551.191416600757;11608.477618507188;571161;571196;576196;614349;626157.6076358858;126470;127143.72856271504;129597;129863.05205421927;130947.34526327498;954.4607296877242;957.7701351675547;976.5703090640095;985.6747273399761;993.2897977945803;18744.250229991194;18877.05614719231;19053.237870485027;19075.236990520225;19124;44294.77852610845;50318.24522632237;51975.74012129915;56417.43582564286;57426.7128664354;69952.30047699458;75732;77187.61406192933;81032;84130.57934710287;7141.571505709674;7396.9260307396235;7621.923780762121;7874.173211812907;8103.392245581487;11538.826917596074;11674.416279186176;11951.521939122686;12881.420336085086;13750.65623359424;11547.191696581494;11562.88437115618;11811.704707382385;11843.644690659294;11915.761684766083;6533.41199292066;11252.774944501229;11452.427378631202;11563.71090722705;11624.593139240085;9268.907310926805;10468.738281543023;11703.473343699725;11716.70708232301;12014.219075760047;7452.515586486861;7591.58246296459;7629.8855517168395;7645.388368930361;7672.194419585863;8669.60986755585;11321.886781132083;11566;11728.94135529317;11823.586174483851 22:52:56 INFO - PROCESS | 2000 | |3;mootools.html;1502.6769244612406;1527.679187370652;1584.2712352317933;1829;1837.9891059917043;7871.370290376771;8388.119247479019;8416;8930.866037009442;8970.102989701034;8498.320134389249;8719.5640217989;8724.912750872505;8733.825323493526;8734.563271836414;2321.791038806511;2361.7402085770636;2364.7398786133513;2366.089055713554;2366.290112966112;2339.6841426407473;2359.587072262356;2380.9285721428387;2383.285014495653;2385.9522809543887;1950.8731932424348;2339.2982105368405;2369.6919400477914;2372.063035101134;2380.4167978845207;2291.679164916913;2350.189184731265;2358.3750306168795;2363.3028256664325;2365.7989070928993;2001.5896741168026;2322.2336628912417;2344.0389440329554;2352.658864464643;2354.4702441950594;8693.347998900044;8785.516796576187;8799.648014079428;8854.822903541894;8868.911310886873;5118.155504341779;5281.471852814726;5285.550728188108;5285.7621407036395;5298.496642818926;3431.7940923544666;3488.197714525648;3621.3662609043313;3634.800085995269;3637.308911306843;1056.9207309451745;1087.5758454202867;1094.162965331514;1097.5335482420019;1112.3159257056932;11352.602658906899;11445.427728613618;11546.36494992775;11564.826527602092;11615.825762613653;4401.537838526909;4567.2464043432465;4611.308303754397;4744.312074749211;4745.027269409763;9718.805623887483;9736.075072868067;9739.172170365457;9750.561224744904;9801.50992450389;5157.63896527247;5157.742112894341;5160.845174644766;5165.199394093846;5176.7411629418375;4333.285007973649;4675.392199014174;4693.95306046942;4807.95192048075;4829.985703002409;3808.5810560838286;3898;3912.823922923418;3943.2310699413338;3992.1017771001875;1088.8094583447864;1268.6257554021586;1284.4990453723055;1292.3150730113055;1293.2176033499786;840.4411066640615;902.1519771414848;912.1471424218245;924.8797656304637;968.4915419404869;4243.978780106141;4832.613390928717;5276.841694749163;5851.561132914963;6034.607750496204;955.6941778630771;991.3159919655415;991.4051569058507;1010.6765834932897;1019.1999280564721;3639.235760490327;3738.9717827597083;3773.3773927301686;4012.779297138627;4029.234445455354;10373.325733827278;10549.261551691308;10694.786104277871;10766.676999690022;10768.192385570957;9946.303758736818;10118.190544756402;10550.788984220426;10666.306690065276;10810.837837432446;8099.230573095547;8106.392020598479;8225.95887020573;8229.629666665014;8256.917430825735;4291.506476755213;5346.304980352529;5431.782728690808;5442.37412697529;5898.908701890164;7970;9631.470269135265;9822;9899.257555683496;9911.306208565331;10092.142167915516;10099.44453055089;10126.189904807745;10166.644167454104;10342.741431464274;6938.444924406136;7373;7495.662695178621;7530;7621.31408173267;8344.165583441607;8431.451955622864;8432.32541396699;8440.66237350499;8453.746387608382;7360.374368178765;7435.665395057127;7517.398608111447;7528.887066694114;7610.162882083077;7248.492605517563;7320.96339518299;7338.816529586803;7449.776506704808;7463.552186868806;6994.496183320611;6994.510384273052;7026.543274687129;7046.612436316052;7063.117110361205;4842.539958703917;4924.064427758714;4998.4501704813165;5057.468965758542;5082.466341034286;4916.336294600326;4919.114559379203;5013.548780609763;5114.539691427789;5144.562712169508 22:52:56 INFO - PROCESS | 2000 | |4;prototype.html;290.17445367928235;306.92940623656557;312.5842629303027;313.54066292880924;315.2261198757052;4495.595396414326;4926.950730492694;5480.671159730419;5644.887102257952;5745.511631511321;4383.6493080553555;4632.559906808856;4843.39457567804;5024;5653.038983372826;3714.6627214202867;3771.9811400943095;3940.566537680853;3953.327934251184;4197.433346498215;3566.8573257069816;3592.425211966086;3985.481887354654;4347.500037495681;4355.889248241694;3073.446779579675;4086.9986853221003;4173.725319700755;4188.623023927846;4212.68404869636;3656.360136976045;3660.9450858237014;3953.406988951666;4253.21315556623;4263.424437700902;3004.248937765559;3342.846717882351;3503.562054743157;3671.706263498914;3673.4857120002953;4955.207166853286;5081.720505372203;5356.1697936819855;5376.91934620981;5415.593830462692;4073.368627862686;4218.177455396199;4682.518265319386;4781.8087276508895;4813.638977076698;5124.975634624302;5434.184872269152;5638.7445021991125;5881.911771323434;5959.318306761931;3821.48409964654;3891.76649401034;3892;3917.6082391760597;3921.607839216084;4819.855404337875;5194.584433245369;5840.766369345221;6169.784057557964;6219;3552.147484603728;4047.919041619151;4059.7564146150735;4061.2080644274674;4062.7765472899273;3799.905002374963;4060.675145988314;4119.434614846399;4139.8965025874595;4151.91696166075;4378.233809083397;4740.478547359857;4808.783604737795;4869.780859861315;4890.731009794496;5978.312494063239;6003.939960600425;6010;6025.367336429699;6076.3316035236085;1317.7496275707585;1356.2405053170257;1375.2848518770384;1392.1507880193074;1394.4591226694558;771.4214339245566;914.5015966298383;936.9203617692573;937.7749340158313;939.9812003759887;4663.930041049387;4828.985912958318;5434.673919564839;5459.2902922619805;5477.67133971955;4937.161581649932;5041.798328066836;5449.891002179934;6063.787767428119;6166.969165154235;4264.808083636244;5175.430702622709;5406.405295417501;5427.3215848019;5439.428859969726;2293.4037150340696;2481.9379515511896;2606.72629373913;2711.7559419652325;2716.709562957619;4716.113554578196;5051.823186188466;5232.581393488512;5264.05213080676;5271.499207575274;4676.392069031004;4917.459079501252;5171.974140129275;5182.663126896739;5248.606354523426;4521.683482156283;5032.572231360376;5105.540501354896;5199.506046925536;5222.772648427616;4176.350341615106;4524.88687782808;4544.88637784058;5058.1947150206715;5086.771095300646;4270.636995855263;4326.437563116775;4458.777061146994;4707.964247865464;5018.548330650259;5117.769700363418;5188.325517682677;5207.140821764518;5229.215617657382;5384.542313903362;2990.5925729787728;3296.0770984124483;3347.681970212826;3507.9473807893414;3549.4498352755363;4667.0398432657685;4918.852434426973;4963.429205641398;5059;5154.520698528403;4627.583517483443;4925.655204135676;4937.23514831681;4966.503349665005;4972.5276098770555;4422.77886105687;4668.85993420198;4907.828226012072;4932.704037757746;4966.925496117633;3975.7813320267664;4240.982164280489;4574.748388838646;4839.797891959221;4842.5157484251295;4106.876793696194;4845.224764037737;4872.4640289567415;4906.803727850989;4918.2376731606655;4653.325267836212;4838.806447742051;4840.903181936271;4844.588210002048;4877.414710234794 22:52:56 INFO - PROCESS | 2000 | |5;yui.html;712.4051417066746;737.4027038099139;750.0024966794165;786.2059320086711;790.3400660448525;15388.07671539707;15784.605384865385;15981;16005.919970400146;16072.758908616366;14528.418863245484;14628;14650.780238296435;14673.633159171026;14682.412703491847;694.6353164588606;841.2807049972278;872.8123453457505;879.9032106468284;884.5533005832045;865.68835219321;868.7784614923186;870.6038752367657;871.3160169267127;871.5293741379647;908.7909780750431;918.6509126531942;923.5659240157115;925.1581061234278;927.1099744245532;892.8437523433406;906.3112034853493;916.9174774270281;921.189353369031;921.8985911549725;654.0255020020184;665.620596260132;686.080651926421;687.4156966578419;688.401091050784;12448;15107.54677359681;15185.468508602256;15292.235388230543;15296.770548441782;14895.106293622417;14903.180325082116;14938.850611493855;15007.099574025593;15056.698866022727;10531.368117912873;11998.640040798702;12168.843959823802;12174.391280435942;12555.937220313932;3849.5957924418094;3871.361225397806;4062.0657248832936;4091.590840915914;4099.344104943225;109509.90490095077;110392.4480377593;110579;110821;114640.99999999917;11459.541618335339;11503.539858405737;11579.652610421701;11583.594574189863;11879.346635935106;23366.415839604146;24300.87849560741;24361.39096522601;24462.877685611456;24485.775711214723;8274.338052955749;8364.539950302791;8396.958015210008;8412.957935210407;8582.485050896967;4015.4980627421573;4438.312061630452;4583.518730533313;4588.701734387254;4599.126166028444;3607.639236076424;3695.297893400299;3728.496652951871;3730.384486559687;3730.9553325069023;560.9691466969274;630.8265227062594;631.8957372033562;650.0314531348257;650.9121268628769;643.6845945486677;648.2447948140458;652.5627829354249;653.9444147247538;665.6339013542532;8043.19568043191;9209.17117459432;9420.62317507292;9439.008904065111;9824.263180261367;629.7418058596045;649.0880313160018;677.3125277842993;678.725116327888;684.2097377528962;4447.466304043535;4471.262241730143;4691.390119284471;4743.454502732161;4793.9041219176115;123034;124157;131272;156181.21909390608;161701;75239;80123;83139.16860831314;122376.38811806063;123008.38495807642;93535.53232233795;100800.48799268017;110163.44918275518;114089;117637;8608.053114157312;9425.01037391064;9749.48882923148;9982.60069597208;10055.899441005497;38982;59277;59368;60454;61629;86958.69561956702;91453;97113;99811.50094249482;101008;13091.345432728516;13233;13316.400761965928;13365.866341336463;13651.79522307186;15193.240337983278;15489;15641.452549160726;15756.448524301595;15790.289436975134;13480;13615.18308901469;13930.512432064828;14000.859991400363;14580.90643201743;11970.880291196976;13873.375698093409;14146.22195779242;14452.421903124177;14563.85436145625;13731.176129432266;13914.51299204523;13927.23400212998;14249.572512824632;14323.069000514934;11141.442927853737;11337.489812958602;11515.769684606094;11531.423428828693;12199.512019519474;9651.420914745138;9855.507224638883;10499.580016799242;10676.306040107369;11653.30080195191 22:52:56 INFO - PROCESS | 2000 | __end_tp_report 22:52:56 INFO - PROCESS | 2000 | __start_cc_report 22:52:56 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,416 22:52:56 INFO - PROCESS | 2000 | __end_cc_report 22:52:56 INFO - PROCESS | 2000 | __startTimestamp1470635576701__endTimestamp 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | ------- Summary: start ------- 22:52:56 INFO - PROCESS | 2000 | Number of tests: 6 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5734.56 Median:5924.11 stddev:632.01 (10.7%) stddev-sans-first:607.06 22:52:56 INFO - PROCESS | 2000 | Values: 3409.4 3432.5 3459.5 3465.9 3475.8 5682.6 5706.8 5711.8 5712.1 5819.0 5752.9 5771.0 5786.9 5805.5 5880.6 5202.0 5288.1 5314.4 5364.8 5405.4 4505.5 5380.8 5410.9 5425.7 5458.2 5193.4 5257.0 5262.3 5297.4 5345.0 5285.6 5295.7 5306.1 5323.8 5359.3 5236.9 5276.8 5279.0 5309.9 5312.5 4799.2 5537.2 5765.4 5795.6 5827.7 6141.5 6152.9 6192.4 6202.8 6217.7 6206.8 6214.0 6217.1 6228.0 6247.1 5710.8 5836.6 5885.8 5924.1 5925.3 6298.1 6314.8 6314.8 6318.6 6320.5 6129.6 6186.0 6201.8 6204.3 6207.5 6093.9 6104.8 6138.4 6175.1 6244.8 5234.7 6120.5 6204.3 6213.2 6214.9 4892.8 6188.8 6210.5 6268.2 6273.5 4898.5 4958.5 4978.3 4990.9 4997.4 4486.5 4488.6 4503.9 4515.0 4539.7 5723.9 5854.7 5867.0 5892.5 5897.4 6145.5 6185.5 6196.6 6221.0 6243.3 4825.3 5853.2 5867.5 5881.4 5886.0 5477.3 5510.2 5517.4 5518.1 5535.2 5314.5 6215.1 6230.5 6237.7 6326.6 4722.8 6118.8 6249.4 6261.4 6267.7 6302.5 6321.9 6329.7 6340.2 6342.8 6089.5 6131.7 6135.8 6155.5 6220.2 5206.4 6248.8 6275.2 6278.4 6351.5 6135.8 6203.6 6219.4 6227.0 6250.2 5217.8 5651.2 5990.3 6120.2 6137.9 5550.7 6072.7 6077.2 6115.6 6125.3 6114.7 6146.2 6167.8 6217.9 6228.9 5910.6 5990.8 5995.2 6034.4 6098.8 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:61514.37 Median:38297.54 stddev:132970.33 (347.2%) stddev-sans-first:133264.38 22:52:56 INFO - PROCESS | 2000 | Values: 480.8 496.5 519.2 530.5 549.6 38740.0 41471.8 41601.8 41609.8 41721.4 42636.8 42895.1 43179.1 43331.9 44108.6 9372.5 9654.2 9945.8 9951.0 9955.8 8592.9 9798.9 9810.6 9813.9 9826.3 9701.0 9786.1 9828.4 9831.2 9833.3 9739.8 9787.4 9815.6 9856.5 9879.8 9710.6 9732.8 9747.2 9798.9 9804.2 35596.5 35897.0 35946.0 36116.5 36298.8 3123.4 3354.6 3387.1 3419.3 3532.3 30857.5 30869.7 31976.7 31991.8 33010.3 3203.6 3231.2 3266.5 3270.3 3366.3 354409.0 464778.0 472495.0 474945.3 485324.0 60657.7 61826.4 62833.7 63046.7 63101.1 34255.5 35543.8 35558.1 66535.0 66787.0 16951.3 17094.5 17095.5 17101.3 17213.3 12734.7 12920.2 13007.2 13060.0 13060.5 19085.9 19298.0 19424.0 19703.6 19724.7 8170.0 8232.3 8332.2 8363.5 8373.6 891.2 976.4 985.6 997.2 1037.5 29481.4 30630.9 31173.0 31288.5 31368.5 1004.5 1022.7 1042.9 1057.3 1145.2 15406.0 15435.3 15444.3 15666.4 15794.5 667925.0 675598.0 675925.0 677484.0 677662.0 55416.0 57028.7 57145.0 57707.0 58296.7 1336.7 1371.3 1376.1 1379.0 1379.6 26077.3 27721.7 29274.4 29393.4 29399.9 45523.8 45910.0 46717.4 50697.5 51242.2 271177.0 277011.0 281285.0 282419.0 283027.0 26334.0 26361.5 26501.3 26702.7 26867.5 47252.3 48326.8 48686.0 48779.0 48877.0 34837.8 38152.0 39275.6 39794.2 40119.0 38705.8 39019.0 39842.2 39966.2 40133.6 37002.6 37464.6 37698.2 38185.2 38409.8 34198.8 34600.0 34632.3 34857.5 35388.3 25496.5 25775.0 25877.0 26246.7 26259.0 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:34984.77 Median:3004.01 stddev:99044.33 (3297.1%) stddev-sans-first:99288.07 22:52:56 INFO - PROCESS | 2000 | Values: 370.9 381.2 384.3 395.8 406.8 19257.2 21212.9 21307.5 21405.4 22187.2 20337.6 20530.6 21186.4 21402.0 21708.7 5899.5 6108.3 6133.7 6175.2 6186.0 4203.6 5734.6 6080.2 6122.6 6194.5 6672.4 6818.9 6821.0 6830.0 6832.4 4622.2 5014.8 5819.2 5865.4 6884.7 4854.9 5662.4 5699.1 5755.1 5823.0 18582.9 20997.4 25140.0 25857.5 26061.9 2169.0 2326.8 2948.2 3001.7 3006.4 9861.5 9905.0 10062.5 10095.8 10166.5 1847.6 1867.5 1871.5 1926.1 1932.5 110430.4 124890.1 125319.0 126060.0 126956.0 11247.8 11600.4 11607.6 11710.9 11891.6 14474.9 14617.8 14652.3 14743.3 14791.9 8334.6 8462.6 8612.0 8635.8 8650.7 8497.4 8497.7 8530.6 8677.8 8682.1 4188.6 4443.7 4488.0 4544.4 4586.8 1673.6 1691.6 1798.5 1817.7 1991.0 862.6 902.6 908.3 949.2 1043.1 21263.1 21653.5 21756.6 21893.9 21931.0 878.0 896.3 918.1 968.2 1022.3 10494.8 11177.8 11258.8 11551.2 11608.5 571161.0 571196.0 576196.0 614349.0 626157.6 126470.0 127143.7 129597.0 129863.1 130947.3 954.5 957.8 976.6 985.7 993.3 18744.3 18877.1 19053.2 19075.2 19124.0 44294.8 50318.2 51975.7 56417.4 57426.7 69952.3 75732.0 77187.6 81032.0 84130.6 7141.6 7396.9 7621.9 7874.2 8103.4 11538.8 11674.4 11951.5 12881.4 13750.7 11547.2 11562.9 11811.7 11843.6 11915.8 6533.4 11252.8 11452.4 11563.7 11624.6 9268.9 10468.7 11703.5 11716.7 12014.2 7452.5 7591.6 7629.9 7645.4 7672.2 8669.6 11321.9 11566.0 11728.9 11823.6 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5634.94 Median:4917.73 stddev:3161.16 (64.3%) stddev-sans-first:3154.77 22:52:56 INFO - PROCESS | 2000 | Values: 1502.7 1527.7 1584.3 1829.0 1838.0 7871.4 8388.1 8416.0 8930.9 8970.1 8498.3 8719.6 8724.9 8733.8 8734.6 2321.8 2361.7 2364.7 2366.1 2366.3 2339.7 2359.6 2380.9 2383.3 2386.0 1950.9 2339.3 2369.7 2372.1 2380.4 2291.7 2350.2 2358.4 2363.3 2365.8 2001.6 2322.2 2344.0 2352.7 2354.5 8693.3 8785.5 8799.6 8854.8 8868.9 5118.2 5281.5 5285.6 5285.8 5298.5 3431.8 3488.2 3621.4 3634.8 3637.3 1056.9 1087.6 1094.2 1097.5 1112.3 11352.6 11445.4 11546.4 11564.8 11615.8 4401.5 4567.2 4611.3 4744.3 4745.0 9718.8 9736.1 9739.2 9750.6 9801.5 5157.6 5157.7 5160.8 5165.2 5176.7 4333.3 4675.4 4694.0 4808.0 4830.0 3808.6 3898.0 3912.8 3943.2 3992.1 1088.8 1268.6 1284.5 1292.3 1293.2 840.4 902.2 912.1 924.9 968.5 4244.0 4832.6 5276.8 5851.6 6034.6 955.7 991.3 991.4 1010.7 1019.2 3639.2 3739.0 3773.4 4012.8 4029.2 10373.3 10549.3 10694.8 10766.7 10768.2 9946.3 10118.2 10550.8 10666.3 10810.8 8099.2 8106.4 8226.0 8229.6 8256.9 4291.5 5346.3 5431.8 5442.4 5898.9 7970.0 9631.5 9822.0 9899.3 9911.3 10092.1 10099.4 10126.2 10166.6 10342.7 6938.4 7373.0 7495.7 7530.0 7621.3 8344.2 8431.5 8432.3 8440.7 8453.7 7360.4 7435.7 7517.4 7528.9 7610.2 7248.5 7321.0 7338.8 7449.8 7463.6 6994.5 6994.5 7026.5 7046.6 7063.1 4842.5 4924.1 4998.5 5057.5 5082.5 4916.3 4919.1 5013.5 5114.5 5144.6 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:4323.87 Median:4811.21 stddev:1300.79 (27.0%) stddev-sans-first:1268.72 22:52:56 INFO - PROCESS | 2000 | Values: 290.2 306.9 312.6 313.5 315.2 4495.6 4927.0 5480.7 5644.9 5745.5 4383.6 4632.6 4843.4 5024.0 5653.0 3714.7 3772.0 3940.6 3953.3 4197.4 3566.9 3592.4 3985.5 4347.5 4355.9 3073.4 4087.0 4173.7 4188.6 4212.7 3656.4 3660.9 3953.4 4253.2 4263.4 3004.2 3342.8 3503.6 3671.7 3673.5 4955.2 5081.7 5356.2 5376.9 5415.6 4073.4 4218.2 4682.5 4781.8 4813.6 5125.0 5434.2 5638.7 5881.9 5959.3 3821.5 3891.8 3892.0 3917.6 3921.6 4819.9 5194.6 5840.8 6169.8 6219.0 3552.1 4047.9 4059.8 4061.2 4062.8 3799.9 4060.7 4119.4 4139.9 4151.9 4378.2 4740.5 4808.8 4869.8 4890.7 5978.3 6003.9 6010.0 6025.4 6076.3 1317.7 1356.2 1375.3 1392.2 1394.5 771.4 914.5 936.9 937.8 940.0 4663.9 4829.0 5434.7 5459.3 5477.7 4937.2 5041.8 5449.9 6063.8 6167.0 4264.8 5175.4 5406.4 5427.3 5439.4 2293.4 2481.9 2606.7 2711.8 2716.7 4716.1 5051.8 5232.6 5264.1 5271.5 4676.4 4917.5 5172.0 5182.7 5248.6 4521.7 5032.6 5105.5 5199.5 5222.8 4176.4 4524.9 4544.9 5058.2 5086.8 4270.6 4326.4 4458.8 4708.0 5018.5 5117.8 5188.3 5207.1 5229.2 5384.5 2990.6 3296.1 3347.7 3507.9 3549.4 4667.0 4918.9 4963.4 5059.0 5154.5 4627.6 4925.7 4937.2 4966.5 4972.5 4422.8 4668.9 4907.8 4932.7 4966.9 3975.8 4241.0 4574.7 4839.8 4842.5 4106.9 4845.2 4872.5 4906.8 4918.2 4653.3 4838.8 4840.9 4844.6 4877.4 22:52:56 INFO - PROCESS | 2000 | 22:52:56 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:23805.11 Median:3790.28 stddev:36872.80 (972.8%) stddev-sans-first:36935.47 22:52:56 INFO - PROCESS | 2000 | Values: 712.4 737.4 750.0 786.2 790.3 15388.1 15784.6 15981.0 16005.9 16072.8 14528.4 14628.0 14650.8 14673.6 14682.4 694.6 841.3 872.8 879.9 884.6 865.7 868.8 870.6 871.3 871.5 908.8 918.7 923.6 925.2 927.1 892.8 906.3 916.9 921.2 921.9 654.0 665.6 686.1 687.4 688.4 12448.0 15107.5 15185.5 15292.2 15296.8 14895.1 14903.2 14938.9 15007.1 15056.7 10531.4 11998.6 12168.8 12174.4 12555.9 3849.6 3871.4 4062.1 4091.6 4099.3 109509.9 110392.4 110579.0 110821.0 114641.0 11459.5 11503.5 11579.7 11583.6 11879.3 23366.4 24300.9 24361.4 24462.9 24485.8 8274.3 8364.5 8397.0 8413.0 8582.5 4015.5 4438.3 4583.5 4588.7 4599.1 3607.6 3695.3 3728.5 3730.4 3731.0 561.0 630.8 631.9 650.0 650.9 643.7 648.2 652.6 653.9 665.6 8043.2 9209.2 9420.6 9439.0 9824.3 629.7 649.1 677.3 678.7 684.2 4447.5 4471.3 4691.4 4743.5 4793.9 123034.0 124157.0 131272.0 156181.2 161701.0 75239.0 80123.0 83139.2 122376.4 123008.4 93535.5 100800.5 110163.4 114089.0 117637.0 8608.1 9425.0 9749.5 9982.6 10055.9 38982.0 59277.0 59368.0 60454.0 61629.0 86958.7 91453.0 97113.0 99811.5 101008.0 13091.3 13233.0 13316.4 13365.9 13651.8 15193.2 15489.0 15641.5 15756.4 15790.3 13480.0 13615.2 13930.5 14000.9 14580.9 11970.9 13873.4 14146.2 14452.4 14563.9 13731.2 13914.5 13927.2 14249.6 14323.1 11141.4 11337.5 11515.8 11531.4 12199.5 9651.4 9855.5 10499.6 10676.3 11653.3 22:52:56 INFO - PROCESS | 2000 | -------- Summary: end -------- 22:52:56 INFO - PROCESS | 2000 | 22:52:57 INFO - TEST-INFO | 2000: exit 0 22:52:57 INFO - TEST-OK | dromaeo_css | took 1114331ms 22:52:57 INFO - TEST-START | kraken 22:52:57 INFO - operating with platform_type : mac_ 22:52:57 INFO - Initialising browser for kraken test... 22:52:57 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpbjiwpg/profile http://localhost:49390/getInfo.html) 22:53:00 INFO - PROCESS | 2006 | __metrics Screen width/height:1600/1200 22:53:00 INFO - PROCESS | 2006 | colorDepth:24 22:53:00 INFO - PROCESS | 2006 | Browser inner width/height: 1024/689 22:53:00 INFO - PROCESS | 2006 | __metrics 22:53:00 ERROR - PROCESS | 2006 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:53:01 INFO - TEST-INFO | 2006: exit 0 22:53:01 INFO - Browser initialized. 22:53:01 INFO - Running cycle 1/1 for kraken test... 22:53:01 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpbjiwpg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:53:12 INFO - PROCESS | 2008 | RSS: Main: 254603264 22:53:12 INFO - PROCESS | 2008 | 22:53:15 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-beat-detection) 22:53:16 INFO - PROCESS | 2008 | RSS: Main: 267415552 22:53:16 INFO - PROCESS | 2008 | 22:53:18 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-dft) 22:53:19 INFO - PROCESS | 2008 | RSS: Main: 276045824 22:53:19 INFO - PROCESS | 2008 | 22:53:23 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-fft) 22:53:23 INFO - PROCESS | 2008 | RSS: Main: 278642688 22:53:23 INFO - PROCESS | 2008 | 22:53:25 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49390/tests/kraken/driver.html?testName=audio-oscillator) 22:53:26 INFO - PROCESS | 2008 | RSS: Main: 280436736 22:53:26 INFO - PROCESS | 2008 | 22:53:28 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:53:29 INFO - PROCESS | 2008 | RSS: Main: 280612864 22:53:29 INFO - PROCESS | 2008 | 22:53:32 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49390/tests/kraken/driver.html?testName=imaging-darkroom) 22:53:32 INFO - PROCESS | 2008 | RSS: Main: 282755072 22:53:32 INFO - PROCESS | 2008 | 22:53:35 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49390/tests/kraken/driver.html?testName=imaging-desaturate) 22:53:36 INFO - PROCESS | 2008 | RSS: Main: 282443776 22:53:36 INFO - PROCESS | 2008 | 22:53:39 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49390/tests/kraken/driver.html?testName=json-parse-financial) 22:53:40 INFO - PROCESS | 2008 | RSS: Main: 283115520 22:53:40 INFO - PROCESS | 2008 | 22:53:42 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:53:42 INFO - PROCESS | 2008 | RSS: Main: 282808320 22:53:42 INFO - PROCESS | 2008 | 22:53:44 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:53:45 INFO - PROCESS | 2008 | RSS: Main: 282234880 22:53:45 INFO - PROCESS | 2008 | 22:53:47 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:53:48 INFO - PROCESS | 2008 | RSS: Main: 282525696 22:53:48 INFO - PROCESS | 2008 | 22:53:51 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:53:51 INFO - PROCESS | 2008 | RSS: Main: 282370048 22:53:51 INFO - PROCESS | 2008 | 22:53:54 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:53:55 INFO - PROCESS | 2008 | RSS: Main: 282980352 22:53:55 INFO - PROCESS | 2008 | 22:53:56 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49390/tests/kraken/driver.html?testName=ai-astar) 22:53:57 INFO - PROCESS | 2008 | RSS: Main: 283738112 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | __start_tp_report 22:53:57 INFO - PROCESS | 2008 | _x_x_mozilla_page_load 22:53:57 INFO - PROCESS | 2008 | _x_x_mozilla_page_load_details 22:53:57 INFO - PROCESS | 2008 | |i|pagename|runs| 22:53:57 INFO - PROCESS | 2008 | |0;ai-astar;105;117;108;116;119;117;112;114;116;113 22:53:57 INFO - PROCESS | 2008 | |1;audio-beat-detection;140;106;128;157;109;127;128;107;155;110 22:53:57 INFO - PROCESS | 2008 | |2;audio-dft;199;195;198;209;208;281;278;200;227;280 22:53:57 INFO - PROCESS | 2008 | |3;audio-fft;70;92;88;145;53;50;74;88;123;78 22:53:57 INFO - PROCESS | 2008 | |4;audio-oscillator;70;72;133;79;101;113;117;72;80;137 22:53:57 INFO - PROCESS | 2008 | |5;imaging-gaussian-blur;92;77;120;83;126;131;92;88;93;126 22:53:57 INFO - PROCESS | 2008 | |6;imaging-darkroom;134;96;109;153;95;128;98;119;120;97 22:53:57 INFO - PROCESS | 2008 | |7;imaging-desaturate;90;104;91;109;150;150;94;93;138;148 22:53:57 INFO - PROCESS | 2008 | |8;json-parse-financial;56;56;68;85;85;83;55;58;56;56 22:53:57 INFO - PROCESS | 2008 | |9;json-stringify-tinderbox;67;70;74;72;77;74;69;69;86;102 22:53:57 INFO - PROCESS | 2008 | |10;stanford-crypto-aes;85;84;85;86;85;83;91;84;88;87 22:53:57 INFO - PROCESS | 2008 | |11;stanford-crypto-ccm;151;159;145;137;140;141;156;141;164;155 22:53:57 INFO - PROCESS | 2008 | |12;stanford-crypto-pbkdf2;168;166;167;165;170;167;198;200;165;167 22:53:57 INFO - PROCESS | 2008 | |13;stanford-crypto-sha256-iterative;66;65;66;71;82;90;83;86;85;88 22:53:57 INFO - PROCESS | 2008 | __end_tp_report 22:53:57 INFO - PROCESS | 2008 | __start_cc_report 22:53:57 INFO - PROCESS | 2008 | _x_x_mozilla_cycle_collect,1054 22:53:57 INFO - PROCESS | 2008 | __end_cc_report 22:53:57 INFO - PROCESS | 2008 | __startTimestamp1470635637234__endTimestamp 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | ------- Summary: start ------- 22:53:57 INFO - PROCESS | 2008 | Number of tests: 14 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#0] ai-astar Cycles:10 Average:113.70 Median:116.00 stddev:4.37 (3.8%) stddev-sans-first:3.32 22:53:57 INFO - PROCESS | 2008 | Values: 105.0 117.0 108.0 116.0 119.0 117.0 112.0 114.0 116.0 113.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:128.00 stddev:19.17 (15.0%) stddev-sans-first:19.72 22:53:57 INFO - PROCESS | 2008 | Values: 140.0 106.0 128.0 157.0 109.0 127.0 128.0 107.0 155.0 110.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#2] audio-dft Cycles:10 Average:227.50 Median:218.00 stddev:37.10 (17.0%) stddev-sans-first:37.89 22:53:57 INFO - PROCESS | 2008 | Values: 199.0 195.0 198.0 209.0 208.0 281.0 278.0 200.0 227.0 280.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#3] audio-fft Cycles:10 Average:86.10 Median:76.00 stddev:29.33 (38.6%) stddev-sans-first:30.53 22:53:57 INFO - PROCESS | 2008 | Values: 70.0 92.0 88.0 145.0 53.0 50.0 74.0 88.0 123.0 78.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:71.00 stddev:26.16 (36.8%) stddev-sans-first:25.80 22:53:57 INFO - PROCESS | 2008 | Values: 70.0 72.0 133.0 79.0 101.0 113.0 117.0 72.0 80.0 137.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#5] imaging-gaussian-blur Cycles:10 Average:102.80 Median:85.50 stddev:20.48 (23.9%) stddev-sans-first:21.34 22:53:57 INFO - PROCESS | 2008 | Values: 92.0 77.0 120.0 83.0 126.0 131.0 92.0 88.0 93.0 126.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:124.00 stddev:19.51 (15.7%) stddev-sans-first:19.43 22:53:57 INFO - PROCESS | 2008 | Values: 134.0 96.0 109.0 153.0 95.0 128.0 98.0 119.0 120.0 97.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#7] imaging-desaturate Cycles:10 Average:116.70 Median:120.00 stddev:26.50 (22.1%) stddev-sans-first:26.29 22:53:57 INFO - PROCESS | 2008 | Values: 90.0 104.0 91.0 109.0 150.0 150.0 94.0 93.0 138.0 148.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:63.00 stddev:13.33 (21.2%) stddev-sans-first:13.66 22:53:57 INFO - PROCESS | 2008 | Values: 56.0 56.0 68.0 85.0 85.0 83.0 55.0 58.0 56.0 56.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#9] json-stringify-tinderbox Cycles:10 Average:76.00 Median:73.00 stddev:10.62 (14.6%) stddev-sans-first:10.76 22:53:57 INFO - PROCESS | 2008 | Values: 67.0 70.0 74.0 72.0 77.0 74.0 69.0 69.0 86.0 102.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.35 (2.7%) stddev-sans-first:2.47 22:53:57 INFO - PROCESS | 2008 | Values: 85.0 84.0 85.0 86.0 85.0 83.0 91.0 84.0 88.0 87.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:153.00 stddev:9.33 (6.1%) stddev-sans-first:9.86 22:53:57 INFO - PROCESS | 2008 | Values: 151.0 159.0 145.0 137.0 140.0 141.0 156.0 141.0 164.0 155.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:167.50 stddev:13.63 (8.1%) stddev-sans-first:14.32 22:53:57 INFO - PROCESS | 2008 | Values: 168.0 166.0 167.0 165.0 170.0 167.0 198.0 200.0 165.0 167.0 22:53:57 INFO - PROCESS | 2008 | 22:53:57 INFO - PROCESS | 2008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:84.00 stddev:10.02 (11.9%) stddev-sans-first:9.61 22:53:57 INFO - PROCESS | 2008 | Values: 66.0 65.0 66.0 71.0 82.0 90.0 83.0 86.0 85.0 88.0 22:53:57 INFO - PROCESS | 2008 | -------- Summary: end -------- 22:53:57 INFO - PROCESS | 2008 | 22:53:58 INFO - TEST-INFO | 2008: exit 0 22:53:58 INFO - TEST-OK | kraken | took 60724ms 22:53:58 INFO - SUITE-END | took 1175s 22:53:58 INFO - Completed test suite (00:19:35) 22:53:58 INFO - javascript benchmark 22:53:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7293.789105738595, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3409.386310464117, 3432.536607557979, 3459.4637831136165, 3465.878694245702, 3475.8262086895647, 5682.6306290091115, 5706.77172913083, 5711.8000869969555, 5712.143178523218, 5819.010768169411, 5752.942470575293, 5770.971145144268, 5786.913196302059, 5805.5065319447895, 5880.647161170333, 5202.0116177926075, 5288.101022826109, 5314.441983591725, 5364.812231571896, 5405.378381486121, 4505.526919673436, 5380.811671591495, 5410.864728381803, 5425.674459532421, 5458.208559758833, 5193.376794784613, 5256.999999999981, 5262.2632831403635, 5297.364316282033, 5344.973275133639, 5285.577153827723, 5295.708736019517, 5306.09796334624, 5323.813666521692, 5359.330083739533, 5236.947630523684, 5276.7889284428575, 5279.0, 5309.946900530984, 5312.548433383167, 4799.232122860326, 5537.197106419587, 5765.394633563457, 5795.594308398414, 5827.650340979512, 6141.539384546132, 6152.907706384408, 6192.411720886508, 6202.81391558254, 6217.68911554425, 6206.813795586139, 6214.0, 6217.098520714516, 6228.0, 6247.094171345175, 5710.800121995751, 5836.649801011953, 5885.764569417261, 5924.1113832924975, 5925.34821169671, 6298.086777417248, 6314.778982735674, 6314.842128946813, 6318.589291696117, 6320.462760665303, 6129.570930034944, 6186.0, 6201.81394558164, 6204.255489341308, 6207.503399728011, 6093.866968088049, 6104.76233045773, 6138.38839838597, 6175.104609831549, 6244.750209991549, 5234.659747116425, 6120.540959428061, 6204.255489341218, 6213.192285003011, 6214.906776398358, 4892.779824907888, 6188.81433556994, 6210.472109870621, 6268.153799237045, 6273.529485288622, 4898.461169271377, 4958.454569997298, 4978.278149668277, 4990.925136122961, 4997.375328083989, 4486.506484286726, 4488.573585509372, 4503.932441013388, 4514.954850451453, 4539.7049191802425, 5723.912456633227, 5854.7072646367515, 5867.0, 5892.528597712173, 5897.439743224387, 6145.463634091477, 6185.536084793658, 6196.566240363131, 6221.0, 6243.313235544087, 4825.3485779419325, 5853.209816674779, 5867.501262392744, 5881.382454842265, 5885.970570147122, 5477.315335583052, 5510.201020851954, 5517.4482551745305, 5518.061929471999, 5535.197396377503, 5314.5216930476445, 6215.098810672517, 6230.470410015108, 6237.7193026314835, 6326.620402775756, 4722.7874745635845, 6118.755249789959, 6249.375062493714, 6261.373862613702, 6267.749290028348, 6302.464290535356, 6321.8735625288155, 6329.7151628175925, 6340.239171299289, 6342.841428964312, 6089.512838972783, 6131.651934473353, 6135.845176233341, 6155.4767844731905, 6220.191375121386, 5206.401263854706, 6248.843778905563, 6275.152854364603, 6278.372162783685, 6351.491880649444, 6135.761162021872, 6203.627782333075, 6219.40915613016, 6227.003679411272, 6250.187475628321, 5217.791288348423, 5651.180578815966, 5990.311114221746, 6120.17287048654, 6137.877242455036, 5550.722463876709, 6072.666003369857, 6077.179580756541, 6115.602485838406, 6125.326214116532, 6114.7248373822395, 6146.200993870947, 6167.784127555514, 6217.875642487215, 6228.906566401417, 5910.615809972338, 5990.820275391745, 5995.2206213192, 6034.366391528826, 6098.786542470993], "value": 5698.906679273692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.81728943001656, 496.54069985263624, 519.192655420821, 530.5039787798408, 549.5630973376166, 38740.0, 41471.75584732455, 41601.79199104004, 41609.7919510402, 41721.3741793873, 42636.78681606596, 42895.14209715812, 43179.136417271635, 43331.91670208246, 44108.558914410845, 9372.484513351763, 9654.179394751454, 9945.801083978353, 9950.955149709285, 9955.800883982316, 8592.914070859273, 9798.853017204712, 9810.558524866397, 9813.852792208123, 9826.312158148932, 9701.0, 9786.119249267564, 9828.410295382264, 9831.213502919785, 9833.31166818323, 9739.805203895918, 9787.412755234638, 9815.607375704963, 9856.457894815781, 9879.753006174868, 9710.563024663907, 9732.805343893153, 9747.171490423323, 9798.90201097987, 9804.215662747034, 35596.46605300922, 35897.0, 35946.0, 36116.45825312623, 36298.81850590756, 3123.422166899131, 3354.6477619849807, 3387.0516255448515, 3419.333230020147, 3532.311199316134, 30857.537136942963, 30869.69130308713, 31976.680233197603, 31991.84004079965, 33010.339793204, 3203.567518385035, 3231.1922019495128, 3266.4610339293986, 3270.2968861694612, 3366.3267346530793, 354409.0, 464778.0, 472495.0, 474945.2505474936, 485324.0, 60657.69671151616, 61826.381736182964, 62833.68583157055, 63046.684766575876, 63101.05348419777, 34255.4861677075, 35543.82228088895, 35558.111047224025, 66535.00197497041, 66786.99819502712, 16951.321947122222, 17094.487165385057, 17095.48713538596, 17101.315947362215, 17213.311467541407, 12734.745305094031, 12920.160189587647, 13007.219566825832, 13060.0, 13060.542880999119, 19085.854848708845, 19298.035098245033, 19423.979902102572, 19703.605927881363, 19724.70412943807, 8170.0, 8232.300254478316, 8332.208440198292, 8363.456375335705, 8373.581320933929, 891.2023738753779, 976.4133283414452, 985.605757696927, 997.2321312589265, 1037.5486663301338, 29481.410371792444, 30630.92791752278, 31173.0, 31288.53067203994, 31368.529472057937, 1004.4626125023077, 1022.7085280695115, 1042.864427624404, 1057.296897563112, 1145.1583086431467, 15406.0, 15435.30541125652, 15444.305006274744, 15666.373345066298, 15794.526164215093, 667925.0, 675598.0, 675925.0, 677484.0, 677662.0, 55416.0, 57028.71485642628, 57145.0, 57707.0, 58296.70851645715, 1336.7460182565476, 1371.3280492558774, 1376.0849035391352, 1378.9586312410643, 1379.5792283353474, 26077.348066298495, 27721.722782772722, 29274.414511710074, 29393.412131757672, 29399.85300073486, 45523.77238113788, 45910.0, 46717.36489222861, 50697.493025070755, 51242.23136652879, 271177.0, 277011.0, 281285.0, 282419.0, 283027.0, 26334.0, 26361.472770544864, 26501.33746656349, 26702.732972670026, 26867.462650746485, 47252.29121563111, 48326.79183020453, 48686.0262794735, 48779.0, 48877.0, 34837.8258108718, 38152.04619884414, 39275.607243927196, 39794.20411591694, 40118.997025074605, 38705.806470967465, 39019.0, 39842.2031559373, 39966.2006759869, 40133.598664012985, 37002.62997369992, 37464.62535374721, 37698.2460350786, 38185.236295274495, 38409.84770456891, 34198.82900585481, 34600.0, 34632.307353853284, 34857.47713784346, 35388.292234155684, 25496.490070198863, 25775.0, 25877.0, 26246.73753262443, 26259.0], "value": 19576.26649006076, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8590735520502, 381.2394273424518, 384.3044090196743, 395.78231972415165, 406.7539138821013, 19257.229710811567, 21212.939353032365, 21307.467313317156, 21405.357839264827, 22187.223447179353, 20337.59324813503, 20530.589388212225, 21186.364409067715, 21402.0, 21708.674369884426, 5899.532420652836, 6108.297545782248, 6133.693315334238, 6175.197224360849, 6186.0, 4203.579642035787, 5734.598578099534, 6080.2399700037495, 6122.571420000601, 6194.535409844257, 6672.432843208333, 6818.897716534256, 6821.045053692487, 6829.965850170742, 6832.350926661959, 4622.237330840408, 5014.824481143179, 5819.214406055171, 5865.384134665884, 6884.65576721162, 4854.902901941977, 5662.37713851476, 5699.088145896678, 5755.079187330007, 5823.039198532237, 18582.90708546462, 20997.370078897657, 25140.0, 25857.482850343076, 26061.869690651616, 2168.98915505423, 2326.755690652491, 2948.1597744642672, 3001.669816320203, 3006.3536339686852, 9861.457619830906, 9905.0, 10062.547185376676, 10095.848562271573, 10166.491675416273, 1847.6489467001227, 1867.4957761404344, 1871.5414723392855, 1926.0947354743248, 1932.4975506368305, 110430.44784776105, 124890.12664810035, 125319.0, 126060.0, 126956.0, 11247.775044499227, 11600.419979001017, 11607.59373421943, 11710.88289117115, 11891.583794567148, 14474.927625361806, 14617.780733288797, 14652.340644671016, 14743.336549855283, 14791.890608204427, 8334.62494187763, 8462.576871156542, 8611.95694021526, 8635.827283454295, 8650.740477785677, 8497.36269779769, 8497.702580409656, 8530.616122274512, 8677.826443471095, 8682.088380720059, 4188.602082802129, 4443.733375997451, 4488.0, 4544.353662816245, 4586.8165273388695, 1673.6359866708838, 1691.5855615374312, 1798.4604618614364, 1817.654935347833, 1990.9502262443555, 862.5773371048267, 902.5712786426395, 908.2779190543533, 949.188443880486, 1043.087298613713, 21263.086322231073, 21653.458663533536, 21756.564868702855, 21893.9053047347, 21931.0, 877.9946960729928, 896.3008853094597, 918.1461241045758, 968.2157452463528, 1022.2792930983638, 10494.790104197873, 11177.776444471065, 11258.831117533244, 11551.191416600757, 11608.477618507188, 571161.0, 571196.0, 576196.0, 614349.0, 626157.6076358858, 126470.0, 127143.72856271504, 129597.0, 129863.05205421927, 130947.34526327498, 954.4607296877242, 957.7701351675547, 976.5703090640095, 985.6747273399761, 993.2897977945803, 18744.250229991194, 18877.05614719231, 19053.237870485027, 19075.236990520225, 19124.0, 44294.77852610845, 50318.24522632237, 51975.74012129915, 56417.43582564286, 57426.7128664354, 69952.30047699458, 75732.0, 77187.61406192933, 81032.0, 84130.57934710287, 7141.571505709674, 7396.9260307396235, 7621.923780762121, 7874.173211812907, 8103.392245581487, 11538.826917596074, 11674.416279186176, 11951.521939122686, 12881.420336085086, 13750.65623359424, 11547.191696581494, 11562.88437115618, 11811.704707382385, 11843.644690659294, 11915.761684766083, 6533.41199292066, 11252.774944501229, 11452.427378631202, 11563.71090722705, 11624.593139240085, 9268.907310926805, 10468.738281543023, 11703.473343699725, 11716.70708232301, 12014.219075760047, 7452.515586486861, 7591.58246296459, 7629.8855517168395, 7645.388368930361, 7672.194419585863, 8669.60986755585, 11321.886781132083, 11566.0, 11728.94135529317, 11823.586174483851], "value": 9611.334487508533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.6769244612406, 1527.679187370652, 1584.2712352317933, 1829.0, 1837.9891059917043, 7871.370290376771, 8388.119247479019, 8416.0, 8930.866037009442, 8970.102989701034, 8498.320134389249, 8719.5640217989, 8724.912750872505, 8733.825323493526, 8734.563271836414, 2321.791038806511, 2361.7402085770636, 2364.7398786133513, 2366.089055713554, 2366.290112966112, 2339.6841426407473, 2359.587072262356, 2380.9285721428387, 2383.285014495653, 2385.9522809543887, 1950.8731932424348, 2339.2982105368405, 2369.6919400477914, 2372.063035101134, 2380.4167978845207, 2291.679164916913, 2350.189184731265, 2358.3750306168795, 2363.3028256664325, 2365.7989070928993, 2001.5896741168026, 2322.2336628912417, 2344.0389440329554, 2352.658864464643, 2354.4702441950594, 8693.347998900044, 8785.516796576187, 8799.648014079428, 8854.822903541894, 8868.911310886873, 5118.155504341779, 5281.471852814726, 5285.550728188108, 5285.7621407036395, 5298.496642818926, 3431.7940923544666, 3488.197714525648, 3621.3662609043313, 3634.800085995269, 3637.308911306843, 1056.9207309451745, 1087.5758454202867, 1094.162965331514, 1097.5335482420019, 1112.3159257056932, 11352.602658906899, 11445.427728613618, 11546.36494992775, 11564.826527602092, 11615.825762613653, 4401.537838526909, 4567.2464043432465, 4611.308303754397, 4744.312074749211, 4745.027269409763, 9718.805623887483, 9736.075072868067, 9739.172170365457, 9750.561224744904, 9801.50992450389, 5157.63896527247, 5157.742112894341, 5160.845174644766, 5165.199394093846, 5176.7411629418375, 4333.285007973649, 4675.392199014174, 4693.95306046942, 4807.95192048075, 4829.985703002409, 3808.5810560838286, 3898.0, 3912.823922923418, 3943.2310699413338, 3992.1017771001875, 1088.8094583447864, 1268.6257554021586, 1284.4990453723055, 1292.3150730113055, 1293.2176033499786, 840.4411066640615, 902.1519771414848, 912.1471424218245, 924.8797656304637, 968.4915419404869, 4243.978780106141, 4832.613390928717, 5276.841694749163, 5851.561132914963, 6034.607750496204, 955.6941778630771, 991.3159919655415, 991.4051569058507, 1010.6765834932897, 1019.1999280564721, 3639.235760490327, 3738.9717827597083, 3773.3773927301686, 4012.779297138627, 4029.234445455354, 10373.325733827278, 10549.261551691308, 10694.786104277871, 10766.676999690022, 10768.192385570957, 9946.303758736818, 10118.190544756402, 10550.788984220426, 10666.306690065276, 10810.837837432446, 8099.230573095547, 8106.392020598479, 8225.95887020573, 8229.629666665014, 8256.917430825735, 4291.506476755213, 5346.304980352529, 5431.782728690808, 5442.37412697529, 5898.908701890164, 7970.0, 9631.470269135265, 9822.0, 9899.257555683496, 9911.306208565331, 10092.142167915516, 10099.44453055089, 10126.189904807745, 10166.644167454104, 10342.741431464274, 6938.444924406136, 7373.0, 7495.662695178621, 7530.0, 7621.31408173267, 8344.165583441607, 8431.451955622864, 8432.32541396699, 8440.66237350499, 8453.746387608382, 7360.374368178765, 7435.665395057127, 7517.398608111447, 7528.887066694114, 7610.162882083077, 7248.492605517563, 7320.96339518299, 7338.816529586803, 7449.776506704808, 7463.552186868806, 6994.496183320611, 6994.510384273052, 7026.543274687129, 7046.612436316052, 7063.117110361205, 4842.539958703917, 4924.064427758714, 4998.4501704813165, 5057.468965758542, 5082.466341034286, 4916.336294600326, 4919.114559379203, 5013.548780609763, 5114.539691427789, 5144.562712169508], "value": 4542.564407080198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.17445367928235, 306.92940623656557, 312.5842629303027, 313.54066292880924, 315.2261198757052, 4495.595396414326, 4926.950730492694, 5480.671159730419, 5644.887102257952, 5745.511631511321, 4383.6493080553555, 4632.559906808856, 4843.39457567804, 5024.0, 5653.038983372826, 3714.6627214202867, 3771.9811400943095, 3940.566537680853, 3953.327934251184, 4197.433346498215, 3566.8573257069816, 3592.425211966086, 3985.481887354654, 4347.500037495681, 4355.889248241694, 3073.446779579675, 4086.9986853221003, 4173.725319700755, 4188.623023927846, 4212.68404869636, 3656.360136976045, 3660.9450858237014, 3953.406988951666, 4253.21315556623, 4263.424437700902, 3004.248937765559, 3342.846717882351, 3503.562054743157, 3671.706263498914, 3673.4857120002953, 4955.207166853286, 5081.720505372203, 5356.1697936819855, 5376.91934620981, 5415.593830462692, 4073.368627862686, 4218.177455396199, 4682.518265319386, 4781.8087276508895, 4813.638977076698, 5124.975634624302, 5434.184872269152, 5638.7445021991125, 5881.911771323434, 5959.318306761931, 3821.48409964654, 3891.76649401034, 3892.0, 3917.6082391760597, 3921.607839216084, 4819.855404337875, 5194.584433245369, 5840.766369345221, 6169.784057557964, 6219.0, 3552.147484603728, 4047.919041619151, 4059.7564146150735, 4061.2080644274674, 4062.7765472899273, 3799.905002374963, 4060.675145988314, 4119.434614846399, 4139.8965025874595, 4151.91696166075, 4378.233809083397, 4740.478547359857, 4808.783604737795, 4869.780859861315, 4890.731009794496, 5978.312494063239, 6003.939960600425, 6010.0, 6025.367336429699, 6076.3316035236085, 1317.7496275707585, 1356.2405053170257, 1375.2848518770384, 1392.1507880193074, 1394.4591226694558, 771.4214339245566, 914.5015966298383, 936.9203617692573, 937.7749340158313, 939.9812003759887, 4663.930041049387, 4828.985912958318, 5434.673919564839, 5459.2902922619805, 5477.67133971955, 4937.161581649932, 5041.798328066836, 5449.891002179934, 6063.787767428119, 6166.969165154235, 4264.808083636244, 5175.430702622709, 5406.405295417501, 5427.3215848019, 5439.428859969726, 2293.4037150340696, 2481.9379515511896, 2606.72629373913, 2711.7559419652325, 2716.709562957619, 4716.113554578196, 5051.823186188466, 5232.581393488512, 5264.05213080676, 5271.499207575274, 4676.392069031004, 4917.459079501252, 5171.974140129275, 5182.663126896739, 5248.606354523426, 4521.683482156283, 5032.572231360376, 5105.540501354896, 5199.506046925536, 5222.772648427616, 4176.350341615106, 4524.88687782808, 4544.88637784058, 5058.1947150206715, 5086.771095300646, 4270.636995855263, 4326.437563116775, 4458.777061146994, 4707.964247865464, 5018.548330650259, 5117.769700363418, 5188.325517682677, 5207.140821764518, 5229.215617657382, 5384.542313903362, 2990.5925729787728, 3296.0770984124483, 3347.681970212826, 3507.9473807893414, 3549.4498352755363, 4667.0398432657685, 4918.852434426973, 4963.429205641398, 5059.0, 5154.520698528403, 4627.583517483443, 4925.655204135676, 4937.23514831681, 4966.503349665005, 4972.5276098770555, 4422.77886105687, 4668.85993420198, 4907.828226012072, 4932.704037757746, 4966.925496117633, 3975.7813320267664, 4240.982164280489, 4574.748388838646, 4839.797891959221, 4842.5157484251295, 4106.876793696194, 4845.224764037737, 4872.4640289567415, 4906.803727850989, 4918.2376731606655, 4653.325267836212, 4838.806447742051, 4840.903181936271, 4844.588210002048, 4877.414710234794], "value": 3922.5139734506783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.4051417066746, 737.4027038099139, 750.0024966794165, 786.2059320086711, 790.3400660448525, 15388.07671539707, 15784.605384865385, 15981.0, 16005.919970400146, 16072.758908616366, 14528.418863245484, 14628.0, 14650.780238296435, 14673.633159171026, 14682.412703491847, 694.6353164588606, 841.2807049972278, 872.8123453457505, 879.9032106468284, 884.5533005832045, 865.68835219321, 868.7784614923186, 870.6038752367657, 871.3160169267127, 871.5293741379647, 908.7909780750431, 918.6509126531942, 923.5659240157115, 925.1581061234278, 927.1099744245532, 892.8437523433406, 906.3112034853493, 916.9174774270281, 921.189353369031, 921.8985911549725, 654.0255020020184, 665.620596260132, 686.080651926421, 687.4156966578419, 688.401091050784, 12448.0, 15107.54677359681, 15185.468508602256, 15292.235388230543, 15296.770548441782, 14895.106293622417, 14903.180325082116, 14938.850611493855, 15007.099574025593, 15056.698866022727, 10531.368117912873, 11998.640040798702, 12168.843959823802, 12174.391280435942, 12555.937220313932, 3849.5957924418094, 3871.361225397806, 4062.0657248832936, 4091.590840915914, 4099.344104943225, 109509.90490095077, 110392.4480377593, 110579.0, 110821.0, 114640.99999999917, 11459.541618335339, 11503.539858405737, 11579.652610421701, 11583.594574189863, 11879.346635935106, 23366.415839604146, 24300.87849560741, 24361.39096522601, 24462.877685611456, 24485.775711214723, 8274.338052955749, 8364.539950302791, 8396.958015210008, 8412.957935210407, 8582.485050896967, 4015.4980627421573, 4438.312061630452, 4583.518730533313, 4588.701734387254, 4599.126166028444, 3607.639236076424, 3695.297893400299, 3728.496652951871, 3730.384486559687, 3730.9553325069023, 560.9691466969274, 630.8265227062594, 631.8957372033562, 650.0314531348257, 650.9121268628769, 643.6845945486677, 648.2447948140458, 652.5627829354249, 653.9444147247538, 665.6339013542532, 8043.19568043191, 9209.17117459432, 9420.62317507292, 9439.008904065111, 9824.263180261367, 629.7418058596045, 649.0880313160018, 677.3125277842993, 678.725116327888, 684.2097377528962, 4447.466304043535, 4471.262241730143, 4691.390119284471, 4743.454502732161, 4793.9041219176115, 123034.0, 124157.0, 131272.0, 156181.21909390608, 161701.0, 75239.0, 80123.0, 83139.16860831314, 122376.38811806063, 123008.38495807642, 93535.53232233795, 100800.48799268017, 110163.44918275518, 114089.0, 117637.0, 8608.053114157312, 9425.01037391064, 9749.48882923148, 9982.60069597208, 10055.899441005497, 38982.0, 59277.0, 59368.0, 60454.0, 61629.0, 86958.69561956702, 91453.0, 97113.0, 99811.50094249482, 101008.0, 13091.345432728516, 13233.0, 13316.400761965928, 13365.866341336463, 13651.79522307186, 15193.240337983278, 15489.0, 15641.452549160726, 15756.448524301595, 15790.289436975134, 13480.0, 13615.18308901469, 13930.512432064828, 14000.859991400363, 14580.90643201743, 11970.880291196976, 13873.375698093409, 14146.22195779242, 14452.421903124177, 14563.85436145625, 13731.176129432266, 13914.51299204523, 13927.23400212998, 14249.572512824632, 14323.069000514934, 11141.442927853737, 11337.489812958602, 11515.769684606094, 11531.423428828693, 12199.512019519474, 9651.420914745138, 9855.507224638883, 10499.580016799242, 10676.306040107369, 11653.30080195191], "value": 7879.538223800493, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 108.0, 116.0, 119.0, 117.0, 112.0, 114.0, 116.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 106.0, 128.0, 157.0, 109.0, 127.0, 128.0, 107.0, 155.0, 110.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 195.0, 198.0, 209.0, 208.0, 281.0, 278.0, 200.0, 227.0, 280.0], "value": 227.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 92.0, 88.0, 145.0, 53.0, 50.0, 74.0, 88.0, 123.0, 78.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 133.0, 79.0, 101.0, 113.0, 117.0, 72.0, 80.0, 137.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 77.0, 120.0, 83.0, 126.0, 131.0, 92.0, 88.0, 93.0, 126.0], "value": 102.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 96.0, 109.0, 153.0, 95.0, 128.0, 98.0, 119.0, 120.0, 97.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 104.0, 91.0, 109.0, 150.0, 150.0, 94.0, 93.0, 138.0, 148.0], "value": 116.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 68.0, 85.0, 85.0, 83.0, 55.0, 58.0, 56.0, 56.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 74.0, 72.0, 77.0, 74.0, 69.0, 69.0, 86.0, 102.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 86.0, 85.0, 83.0, 91.0, 84.0, 88.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 159.0, 145.0, 137.0, 140.0, 141.0, 156.0, 141.0, 164.0, 155.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 167.0, 165.0, 170.0, 167.0, 198.0, 200.0, 165.0, 167.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 71.0, 82.0, 90.0, 83.0, 86.0, 85.0, 88.0], "value": 78.2, "unit": "score"}]}]} 22:53:58 INFO - Return code: 0 22:53:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:53:58 ERROR - # TBPL SUCCESS # 22:53:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:53:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:53:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:53:58 INFO - 2016-08-07 22:53:58.550 screenresolution[2013:13088] starting screenresolution argv=screenresolution get 22:53:58 INFO - 2016-08-07 22:53:58.552 screenresolution[2013:13088] Display 0: 1600x1200x32@60 22:53:58 INFO - 2016-08-07 22:53:58.558 screenresolution[2014:13091] starting screenresolution argv=screenresolution list 22:53:58 INFO - Available Modes on Display 0 22:53:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:53:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:53:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:53:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:53:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:53:58 INFO - Intel Iris: 22:53:58 INFO - Chipset Model: Intel Iris 22:53:58 INFO - Type: GPU 22:53:58 INFO - Bus: Built-In 22:53:58 INFO - VRAM (Dynamic, Max): 1536 MB 22:53:58 INFO - Vendor: Intel (0x8086) 22:53:58 INFO - Device ID: 0x0a2e 22:53:58 INFO - Revision ID: 0x0009 22:53:58 INFO - Displays: 22:53:58 INFO - Display: 22:53:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:53:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:53:58 INFO - Display Serial Number: 1600x1200 60 22:53:58 INFO - Main Display: Yes 22:53:58 INFO - Mirror: Off 22:53:58 INFO - Online: Yes 22:53:58 INFO - Rotation: Supported 22:53:58 INFO - Return code: 0 22:53:58 INFO - Running post-action listener: _resource_record_post_action 22:53:58 INFO - [mozharness: 2016-08-08 05:53:58.792598Z] Finished run-tests step (success) 22:53:58 INFO - Running post-run listener: _resource_record_post_run 22:53:58 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 307200; Write bytes: 705728000; Read time: 8; Write time: 1930 22:53:58 INFO - TinderboxPrint: CPU usage
54.5% 22:53:58 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 8 22:53:58 INFO - TinderboxPrint: I/O write bytes / time
705,728,000 / 1,930 22:53:58 INFO - TinderboxPrint: CPU idle
2,206.4 (45.5%) 22:53:58 INFO - TinderboxPrint: CPU system
980.2 (20.2%) 22:53:58 INFO - TinderboxPrint: CPU user
1,659.0 (34.2%) 22:53:58 INFO - TinderboxPrint: Swap in / out
407,396,352 / 0 22:53:58 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 396268032; Write bytes: 391501312; Read time: 29955; Write time: 767 22:53:58 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 303104; Write bytes: 294361088; Read time: 7; Write time: 1112 22:53:59 INFO - Running post-run listener: _upload_blobber_files 22:53:59 INFO - Blob upload gear active. 22:53:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:53:59 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 22:53:59 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'] 22:53:59 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 22:53:59 INFO - (blobuploader) - INFO - Open directory for files ... 22:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:00 INFO - (blobuploader) - INFO - Done attempting. 22:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:01 INFO - (blobuploader) - INFO - Done attempting. 22:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:54:03 INFO - (blobuploader) - INFO - Done attempting. 22:54:03 INFO - (blobuploader) - INFO - Iteration through files over. 22:54:03 INFO - Return code: 0 22:54:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:54:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:54:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd294ce6c7fbb6725a6336f5dc71fa98f5f60aedb3abc785a678cc09f3be9f8b7e85c9b266e3938e362d04f488cf3c4e251c508550dedab6d5e7dadae9636614", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd9c0b1b188955de853327bc8222d7b24ba8da59fd268f1f9be313f7cd338e15e41b53000a44c70e33e44e6e06d090f8e2d9cfe993ee51f8d154942dc47a882", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/39ae588023b89343fdd38c4bd7eef7b43f8e3a128fabec986a501d7db1199087a9af77ea0f749973e5c3277cc06e15214d707ed6d10d2173359d388edd3bbd2b"} 22:54:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:54:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:54:03 INFO - Contents: 22:54:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd294ce6c7fbb6725a6336f5dc71fa98f5f60aedb3abc785a678cc09f3be9f8b7e85c9b266e3938e362d04f488cf3c4e251c508550dedab6d5e7dadae9636614", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd9c0b1b188955de853327bc8222d7b24ba8da59fd268f1f9be313f7cd338e15e41b53000a44c70e33e44e6e06d090f8e2d9cfe993ee51f8d154942dc47a882", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/39ae588023b89343fdd38c4bd7eef7b43f8e3a128fabec986a501d7db1199087a9af77ea0f749973e5c3277cc06e15214d707ed6d10d2173359d388edd3bbd2b"} 22:54:03 INFO - Running post-run listener: copy_logs_to_upload_dir 22:54:03 INFO - Copying logs to upload dir... 22:54:03 INFO - mkdir: /builds/slave/test/build/upload/logs 22:54:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.305870 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-07 22:54:03.773764) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 22:54:03.776965) ========= 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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd294ce6c7fbb6725a6336f5dc71fa98f5f60aedb3abc785a678cc09f3be9f8b7e85c9b266e3938e362d04f488cf3c4e251c508550dedab6d5e7dadae9636614", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd9c0b1b188955de853327bc8222d7b24ba8da59fd268f1f9be313f7cd338e15e41b53000a44c70e33e44e6e06d090f8e2d9cfe993ee51f8d154942dc47a882", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/39ae588023b89343fdd38c4bd7eef7b43f8e3a128fabec986a501d7db1199087a9af77ea0f749973e5c3277cc06e15214d707ed6d10d2173359d388edd3bbd2b"} build_url:https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/IsE2cVcURt-C8TdkTTX1Hw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd294ce6c7fbb6725a6336f5dc71fa98f5f60aedb3abc785a678cc09f3be9f8b7e85c9b266e3938e362d04f488cf3c4e251c508550dedab6d5e7dadae9636614", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd9c0b1b188955de853327bc8222d7b24ba8da59fd268f1f9be313f7cd338e15e41b53000a44c70e33e44e6e06d090f8e2d9cfe993ee51f8d154942dc47a882", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/39ae588023b89343fdd38c4bd7eef7b43f8e3a128fabec986a501d7db1199087a9af77ea0f749973e5c3277cc06e15214d707ed6d10d2173359d388edd3bbd2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 22:54:03.810378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:54:03.810759) ========= 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.DHYLGJ4p9E/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.j5Auma9Ymx/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 22:54:03.859693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 22:54:03.860003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 22:54:03.860350) ========= ========= Total master_lag: 0.18 =========