builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0191 starttime: 1475276677.73 results: success (0) buildid: 20160930130919 builduid: 651f021ee29b45ef8f10ca89bd9f40a7 revision: 38c9ddd81b65f9141b1471266fc3d71ebc4e47c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:37.729324) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:37.729889) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:37.730303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:37.754273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:37.754812) ========= 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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-30 16:04:37-- 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% 13.8M=0.001s 2016-09-30 16:04:38 (13.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.844606 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:38.651630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:38.652029) ========= 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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.021079 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:38.709036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 16:04:38.709437) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 38c9ddd81b65f9141b1471266fc3d71ebc4e47c9 --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 38c9ddd81b65f9141b1471266fc3d71ebc4e47c9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6sUsPzLlMy/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.uRg6HEwu2T/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-30 16:04:38,786 truncating revision to first 12 chars 2016-09-30 16:04:38,786 Setting DEBUG logging. 2016-09-30 16:04:38,786 attempt 1/10 2016-09-30 16:04:38,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/38c9ddd81b65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 16:04:40,033 unpacking tar archive at: autoland-38c9ddd81b65/testing/mozharness/ program finished with exit code 0 elapsedTime=1.512217 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 16:04:40.474307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:40.474684) ========= script_repo_revision: 38c9ddd81b65f9141b1471266fc3d71ebc4e47c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:40.475217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:40.475528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 16:04:41.205573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-30 16:04:41.208276) ========= /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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:04:41 INFO - MultiFileLogger online at 20160930 16:04:41 in /builds/slave/test 16:04:41 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 16:04:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:04:41 INFO - {'append_to_log': False, 16:04:41 INFO - 'base_work_dir': '/builds/slave/test', 16:04:41 INFO - 'blob_upload_branch': 'Autoland', 16:04:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:04:41 INFO - 'branch': 'Autoland', 16:04:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:04:41 INFO - 'config_files': ('talos/mac_config.py',), 16:04:41 INFO - 'default_actions': ('clobber', 16:04:41 INFO - 'read-buildbot-config', 16:04:41 INFO - 'download-and-extract', 16:04:41 INFO - 'populate-webroot', 16:04:41 INFO - 'create-virtualenv', 16:04:41 INFO - 'install', 16:04:41 INFO - 'run-tests'), 16:04:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:04:41 INFO - 'download_minidump_stackwalk': True, 16:04:41 INFO - 'download_symbols': 'ondemand', 16:04:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:04:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:04:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:04:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:04:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:04:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:04:41 INFO - 'installer_path': 'installer.exe', 16:04:41 INFO - 'log_level': 'info', 16:04:41 INFO - 'log_name': 'talos', 16:04:41 INFO - 'log_to_console': True, 16:04:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:04:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:04:41 INFO - 'opt_config_files': (), 16:04:41 INFO - 'pip_index': False, 16:04:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:04:41 INFO - 'cmd': ('bash', 16:04:41 INFO - '-c', 16:04:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:04:41 INFO - 'enabled': True, 16:04:41 INFO - 'halt_on_failure': False, 16:04:41 INFO - 'name': 'check_screen_resolution'},), 16:04:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:04:41 INFO - 'cmd': ('bash', 16:04:41 INFO - '-c', 16:04:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:04:41 INFO - 'enabled': True, 16:04:41 INFO - 'halt_on_failure': False, 16:04:41 INFO - 'name': 'check_screen_resolution'},), 16:04:41 INFO - 'run_cmd_checks_enabled': True, 16:04:41 INFO - 'sps_profile': False, 16:04:41 INFO - 'sps_profile_interval': 0, 16:04:41 INFO - 'suite': 'dromaeojs-e10s', 16:04:41 INFO - 'system_bits': '32', 16:04:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:04:41 INFO - 'title': 't-yosemite-r7-0191', 16:04:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:04:41 INFO - 'use_talos_json': True, 16:04:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:04:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:04:41 INFO - 'work_dir': 'build'} 16:04:41 INFO - [mozharness: 2016-09-30 23:04:41.419218Z] Running clobber step. 16:04:41 INFO - Running pre-action listener: _resource_record_pre_action 16:04:41 INFO - Running main action method: clobber 16:04:41 INFO - rmtree: /builds/slave/test/build 16:04:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:04:43 INFO - Running post-action listener: _resource_record_post_action 16:04:43 INFO - [mozharness: 2016-09-30 23:04:43.188514Z] Finished clobber step (success) 16:04:43 INFO - [mozharness: 2016-09-30 23:04:43.188729Z] Running read-buildbot-config step. 16:04:43 INFO - Running pre-action listener: _resource_record_pre_action 16:04:43 INFO - Running main action method: read_buildbot_config 16:04:43 INFO - Using buildbot properties: 16:04:43 INFO - { 16:04:43 INFO - "project": "", 16:04:43 INFO - "product": "firefox", 16:04:43 INFO - "script_repo_revision": "production", 16:04:43 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:04:43 INFO - "repository": "", 16:04:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:04:43 INFO - "buildid": "20160930130919", 16:04:43 INFO - "pgo_build": "False", 16:04:43 INFO - "basedir": "/builds/slave/test", 16:04:43 INFO - "buildnumber": 181, 16:04:43 INFO - "slavename": "t-yosemite-r7-0191", 16:04:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:04:43 INFO - "platform": "yosemite_r7", 16:04:43 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 16:04:43 INFO - "branch": "autoland", 16:04:43 INFO - "repo_path": "integration/autoland", 16:04:43 INFO - "revision": "38c9ddd81b65f9141b1471266fc3d71ebc4e47c9", 16:04:43 INFO - "stage_platform": "macosx64", 16:04:43 INFO - "builduid": "651f021ee29b45ef8f10ca89bd9f40a7", 16:04:43 INFO - "slavebuilddir": "test" 16:04:43 INFO - } 16:04:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:04:43 INFO - Running post-action listener: _resource_record_post_action 16:04:43 INFO - [mozharness: 2016-09-30 23:04:43.194046Z] Finished read-buildbot-config step (success) 16:04:43 INFO - [mozharness: 2016-09-30 23:04:43.194255Z] Running download-and-extract step. 16:04:43 INFO - Running pre-action listener: _resource_record_pre_action 16:04:43 INFO - Running main action method: download_and_extract 16:04:43 INFO - mkdir: /builds/slave/test/build/tests 16:04:43 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')]} 16:04:43 INFO - trying https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:04:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 16:04:44 INFO - Downloaded 1199 bytes. 16:04:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:04:44 INFO - Using the following test package requirements: 16:04:44 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:04:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:04:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:04:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'jsshell-mac.zip'], 16:04:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:04:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:04:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:04:44 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:04:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:04:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:04:44 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:04:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:04:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:04:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:04:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:04:45 INFO - Http code: 200 16:04:45 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 16:04:45 INFO - x-amz-cf-id: ZmpGLGDTJWuwDnwzQGoKCp4IxlU0oVgSXQ2_9PvgZ1KVa1BuXQELxA== 16:04:45 INFO - x-amz-version-id: eMbAqf7W8lfm36Rk8KUGZVL43P4eP7Ps 16:04:45 INFO - Expected file size: 16473489 16:04:45 INFO - Obtained file size: 16473489 16:04:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:04:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:04:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:04:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:04:52 INFO - Http code: 200 16:04:52 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 16:04:52 INFO - x-amz-cf-id: yX_oL3LuWMw0zk9HCeEYfR1s6unij-NlR4WZAKkkodS9fcfE88uwuQ== 16:04:52 INFO - x-amz-version-id: eMbAqf7W8lfm36Rk8KUGZVL43P4eP7Ps 16:04:53 INFO - Expected file size: 16473489 16:04:53 INFO - Obtained file size: 16473489 16:04:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:04:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:04:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:05:00 INFO - Http code: 200 16:05:00 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 16:05:00 INFO - x-amz-cf-id: YHdjBQXSo_Mgy7QysyRQgBNz1VdqxNOil0Az30Xsc4z2SkZIgWhzjg== 16:05:00 INFO - x-amz-version-id: Cjcvk_Eg.Cp8SSSCHpZIoGOFDYnBWQpI 16:05:01 INFO - Expected file size: 14408522 16:05:01 INFO - Obtained file size: 14408522 16:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:01 INFO - trying https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:05:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 16:05:04 INFO - Downloaded 111778052 bytes. 16:05:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:05:04 INFO - mkdir: /builds/slave/test/properties 16:05:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:04 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:04 INFO - Contents: 16:05:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:05:05 INFO - Running post-action listener: _resource_record_post_action 16:05:05 INFO - Running post-action listener: set_extra_try_arguments 16:05:05 INFO - [mozharness: 2016-09-30 23:05:05.014392Z] Finished download-and-extract step (success) 16:05:05 INFO - [mozharness: 2016-09-30 23:05:05.014513Z] Running populate-webroot step. 16:05:05 INFO - Running pre-action listener: _resource_record_pre_action 16:05:05 INFO - Running main action method: populate_webroot 16:05:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:05:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:05:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:05:05 INFO - '--tppagecycles', 16:05:05 INFO - '7'], 16:05:05 INFO - 'tests': ['tsvgm']}}, 16:05:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:05:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:05:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['damp', 'tps']}, 16:05:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'tests': ['damp', 'tps']}, 16:05:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['dromaeo_dom']}, 16:05:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['basic_compositor_video']}, 16:05:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:05:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['a11yr', 16:05:05 INFO - 'ts_paint', 16:05:05 INFO - 'tpaint', 16:05:05 INFO - 'sessionrestore', 16:05:05 INFO - 'sessionrestore_no_auto_restore', 16:05:05 INFO - 'tabpaint']}, 16:05:05 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:05 INFO - 'ts_paint', 16:05:05 INFO - 'tpaint', 16:05:05 INFO - 'sessionrestore', 16:05:05 INFO - 'sessionrestore_no_auto_restore', 16:05:05 INFO - 'tabpaint']}, 16:05:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:05:05 INFO - 'ts_paint', 16:05:05 INFO - 'tpaint', 16:05:05 INFO - 'sessionrestore', 16:05:05 INFO - 'sessionrestore_no_auto_restore', 16:05:05 INFO - 'tabpaint']}, 16:05:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:05:05 INFO - 'ts_paint', 16:05:05 INFO - 'tpaint', 16:05:05 INFO - 'sessionrestore', 16:05:05 INFO - 'sessionrestore_no_auto_restore', 16:05:05 INFO - 'tabpaint']}, 16:05:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['a11yr', 16:05:05 INFO - 'ts_paint', 16:05:05 INFO - 'tpaint', 16:05:05 INFO - 'sessionrestore', 16:05:05 INFO - 'sessionrestore_no_auto_restore', 16:05:05 INFO - 'tabpaint']}, 16:05:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['a11yr', 16:05:05 INFO - 'ts_paint', 16:05:05 INFO - 'tpaint', 16:05:05 INFO - 'sessionrestore', 16:05:05 INFO - 'sessionrestore_no_auto_restore', 16:05:05 INFO - 'tabpaint']}, 16:05:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['tsvgx', 16:05:05 INFO - 'tsvgr_opacity', 16:05:05 INFO - 'tart', 16:05:05 INFO - 'tscrollx', 16:05:05 INFO - 'cart']}, 16:05:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:05 INFO - 'tsvgr_opacity', 16:05:05 INFO - 'tart', 16:05:05 INFO - 'tscrollx', 16:05:05 INFO - 'cart']}, 16:05:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'talos_options': ['--disable-e10s'], 16:05:05 INFO - 'tests': ['tp5o']}, 16:05:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'tests': ['tp5o']}, 16:05:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'talos_options': ['--disable-e10s', 16:05:05 INFO - '--xperf_path', 16:05:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:05 INFO - 'tests': ['tp5n']}, 16:05:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:05 INFO - 'talos_options': ['--xperf_path', 16:05:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:05 INFO - 'tests': ['tp5n']}}, 16:05:05 INFO - 'talos.zip': {'path': '', 16:05:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:05:05 INFO - Running post-action listener: _resource_record_post_action 16:05:05 INFO - [mozharness: 2016-09-30 23:05:05.033153Z] Finished populate-webroot step (success) 16:05:05 INFO - [mozharness: 2016-09-30 23:05:05.033268Z] Running create-virtualenv step. 16:05:05 INFO - Running pre-action listener: _resource_record_pre_action 16:05:05 INFO - Running main action method: create_virtualenv 16:05:05 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:05 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 16:05:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:05:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:05 INFO - Using real prefix '/tools/python27' 16:05:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:05 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:08 INFO - Installing pip.................done. 16:05:08 INFO - Return code: 0 16:05:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:05:08 INFO - Reading from file tmpfile_stdout 16:05:08 INFO - Output received: 16:05:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:05:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:05:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:08 INFO - 'HOME': '/Users/cltbld', 16:05:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:08 INFO - 'LOGNAME': 'cltbld', 16:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:08 INFO - 'MOZ_NO_REMOTE': '1', 16:05:08 INFO - 'NO_EM_RESTART': '1', 16:05:08 INFO - 'PAGER': '/bin/cat', 16:05:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:08 INFO - 'PWD': '/builds/slave/test', 16:05:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:08 INFO - 'SHELL': '/bin/bash', 16:05:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:08 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:08 INFO - 'USER': 'cltbld', 16:05:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:08 INFO - 'XPC_FLAGS': '0x0', 16:05:08 INFO - 'XPC_SERVICE_NAME': '0', 16:05:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:09 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 16:05:09 INFO - Cleaning up... 16:05:09 INFO - Return code: 0 16:05:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:09 INFO - 'HOME': '/Users/cltbld', 16:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:09 INFO - 'LOGNAME': 'cltbld', 16:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:09 INFO - 'MOZ_NO_REMOTE': '1', 16:05:09 INFO - 'NO_EM_RESTART': '1', 16:05:09 INFO - 'PAGER': '/bin/cat', 16:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:09 INFO - 'PWD': '/builds/slave/test', 16:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:09 INFO - 'SHELL': '/bin/bash', 16:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:09 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:09 INFO - 'USER': 'cltbld', 16:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:09 INFO - 'XPC_FLAGS': '0x0', 16:05:09 INFO - 'XPC_SERVICE_NAME': '0', 16:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:09 INFO - Downloading/unpacking psutil>=3.1.1 16:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:05:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:13 INFO - Installing collected packages: psutil 16:05:13 INFO - Running setup.py install for psutil 16:05:13 INFO - building 'psutil._psutil_osx' extension 16:05:13 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 16:05:13 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 16:05:13 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 16:05:13 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 16:05:13 INFO - building 'psutil._psutil_posix' extension 16:05:13 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 16:05:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:05:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:05:14 INFO - ^ 16:05:14 INFO - 1 warning generated. 16:05:14 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 16:05:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:14 INFO - Successfully installed psutil 16:05:14 INFO - Cleaning up... 16:05:14 INFO - Return code: 0 16:05:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:14 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 16:05:14 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 16:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:14 INFO - 'HOME': '/Users/cltbld', 16:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:14 INFO - 'LOGNAME': 'cltbld', 16:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:14 INFO - 'MOZ_NO_REMOTE': '1', 16:05:14 INFO - 'NO_EM_RESTART': '1', 16:05:14 INFO - 'PAGER': '/bin/cat', 16:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:14 INFO - 'PWD': '/builds/slave/test', 16:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:14 INFO - 'SHELL': '/bin/bash', 16:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:14 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:14 INFO - 'USER': 'cltbld', 16:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:14 INFO - 'XPC_FLAGS': '0x0', 16:05:14 INFO - 'XPC_SERVICE_NAME': '0', 16:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:05:14 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 16:05:14 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 16:05:14 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 16:05:14 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 16:05:14 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 16:05:14 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 16:05:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:05:17 INFO - Installing collected packages: mozsystemmonitor 16:05:17 INFO - Running setup.py install for mozsystemmonitor 16:05:17 INFO - Successfully installed mozsystemmonitor 16:05:17 INFO - Cleaning up... 16:05:17 INFO - Return code: 0 16:05:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:05:17 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')]} 16:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:17 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')]} 16:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:17 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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:17 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 16:05:17 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 16:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:17 INFO - 'HOME': '/Users/cltbld', 16:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:17 INFO - 'LOGNAME': 'cltbld', 16:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:17 INFO - 'MOZ_NO_REMOTE': '1', 16:05:17 INFO - 'NO_EM_RESTART': '1', 16:05:17 INFO - 'PAGER': '/bin/cat', 16:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:17 INFO - 'PWD': '/builds/slave/test', 16:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:17 INFO - 'SHELL': '/bin/bash', 16:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:17 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:17 INFO - 'USER': 'cltbld', 16:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:17 INFO - 'XPC_FLAGS': '0x0', 16:05:17 INFO - 'XPC_SERVICE_NAME': '0', 16:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:17 INFO - Downloading/unpacking jsonschema==2.5.1 16:05:17 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 16:05:17 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 16:05:17 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 16:05:17 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 16:05:17 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 16:05:17 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 16:05:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05: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 16:05:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:05:20 INFO - warning: no files found matching '*.txt' 16:05:20 INFO - no previously-included directories found matching 'build' 16:05:20 INFO - no previously-included directories found matching 'dist' 16:05:20 INFO - no previously-included directories found matching '.git*' 16:05:20 INFO - Installing collected packages: jsonschema, functools32 16:05:20 INFO - Running setup.py install for functools32 16:05:20 INFO - warning: no files found matching '*.txt' 16:05:20 INFO - no previously-included directories found matching 'build' 16:05:20 INFO - no previously-included directories found matching 'dist' 16:05:20 INFO - no previously-included directories found matching '.git*' 16:05:20 INFO - Successfully installed jsonschema functools32 16:05:20 INFO - Cleaning up... 16:05:20 INFO - Return code: 0 16:05:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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', '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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:05: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 functools32==3.2.3-2 16:05:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:20 INFO - 'HOME': '/Users/cltbld', 16:05:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:20 INFO - 'LOGNAME': 'cltbld', 16:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:20 INFO - 'MOZ_NO_REMOTE': '1', 16:05:20 INFO - 'NO_EM_RESTART': '1', 16:05:20 INFO - 'PAGER': '/bin/cat', 16:05:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:20 INFO - 'PWD': '/builds/slave/test', 16:05:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:20 INFO - 'SHELL': '/bin/bash', 16:05:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:20 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:20 INFO - 'USER': 'cltbld', 16:05:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:20 INFO - 'XPC_FLAGS': '0x0', 16:05:20 INFO - 'XPC_SERVICE_NAME': '0', 16:05:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:05:21 INFO - Cleaning up... 16:05:21 INFO - Return code: 0 16:05:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:21 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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:21 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 16:05:21 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 16:05:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:21 INFO - 'HOME': '/Users/cltbld', 16:05:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:21 INFO - 'LOGNAME': 'cltbld', 16:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:21 INFO - 'MOZ_NO_REMOTE': '1', 16:05:21 INFO - 'NO_EM_RESTART': '1', 16:05:21 INFO - 'PAGER': '/bin/cat', 16:05:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:21 INFO - 'PWD': '/builds/slave/test', 16:05:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:21 INFO - 'SHELL': '/bin/bash', 16:05:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:21 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:21 INFO - 'USER': 'cltbld', 16:05:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:21 INFO - 'XPC_FLAGS': '0x0', 16:05:21 INFO - 'XPC_SERVICE_NAME': '0', 16:05:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:21 INFO - Downloading/unpacking blobuploader==1.2.4 16:05:21 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 16:05:21 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 16:05:21 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 16:05:21 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 16:05:21 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 16:05:21 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 16:05:23 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:23 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 16:05:23 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 16:05:23 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 16:05:23 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 16:05:23 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 16:05:23 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 16:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:24 INFO - Downloading docopt-0.6.1.tar.gz 16:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:25 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:25 INFO - Running setup.py install for blobuploader 16:05:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:25 INFO - Running setup.py install for requests 16:05:25 INFO - Running setup.py install for docopt 16:05:25 INFO - Successfully installed blobuploader requests docopt 16:05:25 INFO - Cleaning up... 16:05:25 INFO - Return code: 0 16:05:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:25 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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:25 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 16:05:25 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 16:05:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:25 INFO - 'HOME': '/Users/cltbld', 16:05:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:25 INFO - 'LOGNAME': 'cltbld', 16:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:25 INFO - 'MOZ_NO_REMOTE': '1', 16:05:25 INFO - 'NO_EM_RESTART': '1', 16:05:25 INFO - 'PAGER': '/bin/cat', 16:05:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:25 INFO - 'PWD': '/builds/slave/test', 16:05:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:25 INFO - 'SHELL': '/bin/bash', 16:05:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:25 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:25 INFO - 'USER': 'cltbld', 16:05:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:25 INFO - 'XPC_FLAGS': '0x0', 16:05:25 INFO - 'XPC_SERVICE_NAME': '0', 16:05:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hCB_kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-nOVtYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1Ic6B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bO70Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-21ZONs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-p8AamS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-QfM824-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-uejMEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-V_RMKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Fq5doO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-0QaiP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-S2wZTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-64Dtax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-PgcKLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-B5R3Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-3pS3EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1b8Qkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:27 INFO - Running setup.py install for manifestparser 16:05:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Running setup.py install for mozcrash 16:05:28 INFO - Running setup.py install for mozdebug 16:05:28 INFO - Running setup.py install for mozdevice 16:05:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Running setup.py install for mozfile 16:05:28 INFO - Running setup.py install for mozhttpd 16:05:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:05:28 INFO - Running setup.py install for mozinfo 16:05:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozInstall 16:05:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozleak 16:05:29 INFO - Running setup.py install for mozlog 16:05:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for moznetwork 16:05:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozprocess 16:05:29 INFO - Running setup.py install for mozprofile 16:05:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:05:29 INFO - Running setup.py install for mozrunner 16:05:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:05:30 INFO - Running setup.py install for mozscreenshot 16:05:30 INFO - Running setup.py install for moztest 16:05:30 INFO - Running setup.py install for mozversion 16:05:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:05:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:05:30 INFO - Cleaning up... 16:05:30 INFO - Return code: 0 16:05:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:30 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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:30 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 16:05:30 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 16:05:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:30 INFO - 'HOME': '/Users/cltbld', 16:05:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:30 INFO - 'LOGNAME': 'cltbld', 16:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:30 INFO - 'MOZ_NO_REMOTE': '1', 16:05:30 INFO - 'NO_EM_RESTART': '1', 16:05:30 INFO - 'PAGER': '/bin/cat', 16:05:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:30 INFO - 'PWD': '/builds/slave/test', 16:05:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:30 INFO - 'SHELL': '/bin/bash', 16:05:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:30 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:30 INFO - 'USER': 'cltbld', 16:05:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:30 INFO - 'XPC_FLAGS': '0x0', 16:05:30 INFO - 'XPC_SERVICE_NAME': '0', 16:05:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-82AQVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:30 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)) 16:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:30 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-fulPDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-9I8J4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-OgvShe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8N8yOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-La4G8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-T9oF5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-u6189X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-eTx81A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-PLAbHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:31 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-pLCcVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:31 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)) 16:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-J2RxBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:32 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)) 16:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-TNr1FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:32 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)) 16:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yVu3g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:32 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)) 16:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-f3KGLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:32 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)) 16:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-oM6gxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:32 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)) 16:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-f3Zdf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:32 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)) 16:05:32 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)) 16:05:32 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)) 16:05:32 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)) 16:05:32 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)) 16:05:32 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)) 16:05:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:32 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 16:05:32 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 16:05:32 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 16:05:32 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 16:05:32 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 16:05:32 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 16:05:35 INFO - Downloading blessings-1.6.tar.gz 16:05:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:05:35 INFO - Installing collected packages: blessings 16:05:35 INFO - Running setup.py install for blessings 16:05:35 INFO - Successfully installed blessings 16:05:35 INFO - Cleaning up... 16:05:35 INFO - Return code: 0 16:05:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:35 INFO - Reading from file tmpfile_stdout 16:05:35 INFO - Current package versions: 16:05:35 INFO - blessings == 1.6 16:05:35 INFO - blobuploader == 1.2.4 16:05:35 INFO - docopt == 0.6.1 16:05:35 INFO - functools32 == 3.2.3-2 16:05:35 INFO - jsonschema == 2.5.1 16:05:35 INFO - manifestparser == 1.1 16:05:35 INFO - mozInstall == 1.12 16:05:35 INFO - mozcrash == 0.17 16:05:35 INFO - mozdebug == 0.1 16:05:35 INFO - mozdevice == 0.48 16:05:35 INFO - mozfile == 1.2 16:05:35 INFO - mozhttpd == 0.7 16:05:35 INFO - mozinfo == 0.9 16:05:35 INFO - mozleak == 0.1 16:05:35 INFO - mozlog == 3.4 16:05:35 INFO - moznetwork == 0.27 16:05:35 INFO - mozprocess == 0.23 16:05:35 INFO - mozprofile == 0.28 16:05:35 INFO - mozrunner == 6.12 16:05:35 INFO - mozscreenshot == 0.1 16:05:35 INFO - mozsystemmonitor == 0.3 16:05:35 INFO - moztest == 0.7 16:05:35 INFO - mozversion == 1.4 16:05:35 INFO - psutil == 3.1.1 16:05:35 INFO - requests == 1.2.3 16:05:35 INFO - wsgiref == 0.1.2 16:05:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:35 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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:35 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 16:05:35 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 16:05:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:35 INFO - 'HOME': '/Users/cltbld', 16:05:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:35 INFO - 'LOGNAME': 'cltbld', 16:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:35 INFO - 'MOZ_NO_REMOTE': '1', 16:05:35 INFO - 'NO_EM_RESTART': '1', 16:05:35 INFO - 'PAGER': '/bin/cat', 16:05:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:35 INFO - 'PWD': '/builds/slave/test', 16:05:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:35 INFO - 'SHELL': '/bin/bash', 16:05:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:35 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:35 INFO - 'USER': 'cltbld', 16:05:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:35 INFO - 'XPC_FLAGS': '0x0', 16:05:35 INFO - 'XPC_SERVICE_NAME': '0', 16:05:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 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)) 16:05:36 INFO - Cleaning up... 16:05:36 INFO - Return code: 0 16:05:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:05: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')]} 16:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05: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')]} 16:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:36 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 0x108cc8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c3e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4056f310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, '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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 16:05:36 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 16:05:36 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 16:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:36 INFO - 'HOME': '/Users/cltbld', 16:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:36 INFO - 'LOGNAME': 'cltbld', 16:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:36 INFO - 'MOZ_NO_REMOTE': '1', 16:05:36 INFO - 'NO_EM_RESTART': '1', 16:05:36 INFO - 'PAGER': '/bin/cat', 16:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:36 INFO - 'PWD': '/builds/slave/test', 16:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:36 INFO - 'SHELL': '/bin/bash', 16:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:05:36 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:36 INFO - 'USER': 'cltbld', 16:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:36 INFO - 'XPC_FLAGS': '0x0', 16:05:36 INFO - 'XPC_SERVICE_NAME': '0', 16:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:05:36 INFO - Cleaning up... 16:05:36 INFO - Return code: 0 16:05:36 INFO - Running post-action listener: _resource_record_post_action 16:05:36 INFO - Running post-action listener: _start_resource_monitoring 16:05:36 INFO - Starting resource monitoring. 16:05:36 INFO - [mozharness: 2016-09-30 23:05:36.316614Z] Finished create-virtualenv step (success) 16:05:36 INFO - [mozharness: 2016-09-30 23:05:36.317650Z] Running install step. 16:05:36 INFO - Running pre-action listener: _resource_record_pre_action 16:05:36 INFO - Running main action method: install 16:05:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:36 INFO - Reading from file tmpfile_stdout 16:05:36 INFO - Detecting whether we're running mozinstall >=1.0... 16:05:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:05:36 INFO - Reading from file tmpfile_stdout 16:05:36 INFO - Output received: 16:05:36 INFO - Usage: mozinstall [options] installer 16:05:36 INFO - Options: 16:05:36 INFO - -h, --help show this help message and exit 16:05:36 INFO - -d DEST, --destination=DEST 16:05:36 INFO - Directory to install application into. [default: 16:05:36 INFO - "/builds/slave/test"] 16:05:36 INFO - --app=APP Application being installed. [default: firefox] 16:05:36 INFO - mkdir: /builds/slave/test/build/application 16:05:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:06:11 INFO - Reading from file tmpfile_stdout 16:06:11 INFO - Output received: 16:06:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:06:11 INFO - Running post-action listener: _resource_record_post_action 16:06:11 INFO - [mozharness: 2016-09-30 23:06:11.182165Z] Finished install step (success) 16:06:11 INFO - [mozharness: 2016-09-30 23:06:11.182328Z] Running run-tests step. 16:06:11 INFO - Running pre-action listener: _resource_record_pre_action 16:06:11 INFO - Running main action method: run_tests 16:06:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:06:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:06:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:06:11 INFO - 2016-09-30 16:06:11.197 screenresolution[1997:11427] starting screenresolution argv=screenresolution get 16:06:11 INFO - 2016-09-30 16:06:11.199 screenresolution[1997:11427] Display 0: 1600x1200x32@60 16:06:11 INFO - 2016-09-30 16:06:11.205 screenresolution[1998:11429] starting screenresolution argv=screenresolution list 16:06:11 INFO - Available Modes on Display 0 16:06:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:06:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:06:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:06:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:06:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:06:11 INFO - Intel Iris: 16:06:11 INFO - Chipset Model: Intel Iris 16:06:11 INFO - Type: GPU 16:06:11 INFO - Bus: Built-In 16:06:11 INFO - VRAM (Dynamic, Max): 1536 MB 16:06:11 INFO - Vendor: Intel (0x8086) 16:06:11 INFO - Device ID: 0x0a2e 16:06:11 INFO - Revision ID: 0x0009 16:06:11 INFO - Displays: 16:06:11 INFO - Display: 16:06:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:06:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:06:11 INFO - Display Serial Number: 1600x1200 60 16:06:11 INFO - Main Display: Yes 16:06:11 INFO - Mirror: Off 16:06:11 INFO - Online: Yes 16:06:11 INFO - Rotation: Supported 16:06:11 INFO - Return code: 0 16:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:06:11 INFO - Python 2.7.3 16:06:11 INFO - Return code: 0 16:06:11 INFO - grabbing minidump binary from tooltool 16:06: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')]} 16:06:11 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 0x108adcd30>, '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 0x108902db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ad4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:06:11 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 16:06:11 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 16:06:11 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 16:06:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:06:11 INFO - Return code: 0 16:06:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:06:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:06:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:06:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:06:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:06:11 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/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 16:06:11 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/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 16:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6sUsPzLlMy/Render', 16:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:11 INFO - 'HOME': '/Users/cltbld', 16:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:11 INFO - 'LOGNAME': 'cltbld', 16:06:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:11 INFO - 'MOZ_NO_REMOTE': '1', 16:06:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:11 INFO - 'NO_EM_RESTART': '1', 16:06:11 INFO - 'PAGER': '/bin/cat', 16:06:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:11 INFO - 'PWD': '/builds/slave/test', 16:06:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:11 INFO - 'SHELL': '/bin/bash', 16:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uRg6HEwu2T/Listeners', 16:06:11 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 16:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:11 INFO - 'USER': 'cltbld', 16:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:11 INFO - 'XPC_FLAGS': '0x0', 16:06:11 INFO - 'XPC_SERVICE_NAME': '0', 16:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:11 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/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 16:06:11 INFO - mozversion application_buildid: 20160930130919 16:06:11 INFO - mozversion application_changeset: 38c9ddd81b65f9141b1471266fc3d71ebc4e47c9 16:06:11 INFO - mozversion application_display_name: Nightly 16:06:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:06:11 INFO - mozversion application_name: Firefox 16:06:11 INFO - mozversion application_remotingname: firefox 16:06:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:06:11 INFO - mozversion application_vendor: Mozilla 16:06:11 INFO - mozversion application_version: 52.0a1 16:06:11 INFO - mozversion platform_buildid: 20160930130919 16:06:11 INFO - mozversion platform_changeset: 38c9ddd81b65f9141b1471266fc3d71ebc4e47c9 16:06:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:06:11 INFO - mozversion platform_version: 52.0a1 16:06:11 INFO - using testdate: 1475276771 16:06:11 INFO - actual date: 1475276771 16:06:11 INFO - starting webserver on 'localhost:49400' 16:06:11 INFO - SUITE-START | Running 2 tests 16:06:11 INFO - TEST-START | dromaeo_css 16:06:11 INFO - operating with platform_type : mac_ 16:06:11 INFO - Initialising browser for dromaeo_css test... 16:06:11 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmppMfeWA/profile http://localhost:49400/getInfo.html) 16:06:14 INFO - PROCESS | 2008 | 2016-09-30 16:06:14.469 plugin-container[2010:11589] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954b, name = 'com.apple.tsm.portname' 16:06:14 INFO - PROCESS | 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:06:14 INFO - PROCESS | 2008 | 2016-09-30 16:06:14.472 plugin-container[2010:11589] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 16:06:14 INFO - PROCESS | 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:06:14 INFO - PROCESS | 2008 | 2016-09-30 16:06:14.472 plugin-container[2010:11589] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:06:14 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 16:06:14 INFO - PROCESS | 2008 | colorDepth:24 16:06:14 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 16:06:14 INFO - PROCESS | 2008 | __metrics 16:06:14 ERROR - PROCESS | 2008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 16:06:15 INFO - TEST-INFO | 2008: exit 0 16:06:15 INFO - Browser initialized. 16:06:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:15 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmppMfeWA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:17 INFO - PROCESS | 2011 | 2016-09-30 16:06:17.971 plugin-container[2012:11705] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c27, name = 'com.apple.tsm.portname' 16:06:17 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:06:17 INFO - PROCESS | 2011 | 2016-09-30 16:06:17.973 plugin-container[2012:11705] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 16:06:17 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:06:17 INFO - PROCESS | 2011 | 2016-09-30 16:06:17.973 plugin-container[2012:11705] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:06:27 INFO - PROCESS | 2011 | RSS: Main: 240242688 16:06:27 INFO - PROCESS | 2011 | 16:07:17 INFO - PROCESS | 2011 | 1475276837185 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] 16:09:29 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49400/tests/dromaeo/cssquery-ext.html) 16:09:30 INFO - PROCESS | 2011 | RSS: Main: 257822720 16:09:30 INFO - PROCESS | 2011 | 16:12:32 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-ext.html (next: http://localhost:49400/tests/dromaeo/cssquery-jquery.html) 16:12:33 INFO - PROCESS | 2011 | RSS: Main: 265801728 16:12:33 INFO - PROCESS | 2011 | 16:15:35 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49400/tests/dromaeo/cssquery-mootools.html) 16:15:35 INFO - PROCESS | 2011 | RSS: Main: 272039936 16:15:35 INFO - PROCESS | 2011 | 16:18:37 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49400/tests/dromaeo/cssquery-prototype.html) 16:18:38 INFO - PROCESS | 2011 | RSS: Main: 271785984 16:18:38 INFO - PROCESS | 2011 | 16:21:41 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49400/tests/dromaeo/cssquery-yui.html) 16:21:41 INFO - PROCESS | 2011 | RSS: Main: 276967424 16:21:41 INFO - PROCESS | 2011 | 16:24:44 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-yui.html (next: http://localhost:49400/tests/dromaeo/cssquery-dojo.html) 16:24:45 INFO - PROCESS | 2011 | RSS: Main: 280559616 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | __start_tp_report 16:24:45 INFO - PROCESS | 2011 | _x_x_mozilla_page_load 16:24:45 INFO - PROCESS | 2011 | _x_x_mozilla_page_load_details 16:24:45 INFO - PROCESS | 2011 | |i|pagename|runs| 16:24:45 INFO - PROCESS | 2011 | |0;dojo.html;3303.8678452861886;3316.436205845006;3363.7813542119743;3369.578802649669;3390;4687.8359257426;5550.972245138773;5655.57583181262;5698.059820129673;5707.457791509811;4515.638748900088;5528.439037793816;5637.408072152426;5689.288838895138;5709.71451427428;4956.826511072104;4973.378327709036;5003.574696150831;5059.316992206061;5089.083964886319;5044.545990860822;5054.747262636872;5169.3279873616375;5190.584753219752;5244.895102097956;4954.2568614707725;5047.242913562958;5065.898682026375;5218.269442278084;5244.737763111848;5142.820001299974;5164.767585458663;5169.793208271664;5177.689338639656;5178.326817513699;5093.847184584469;5117.616178786606;5150;5152.742362881879;5165.940982098661;5435.076037073707;5475.6440831345835;5566.081596536607;5586.581006424493;5631.0708733059;4950.18321976877;5461.69960652164;6133.6319820810895;6166.290876549209;6175.382461753834;4449.687342234049;4598.241290187115;6066.120412540201;6177.783777567808;6217.409346112112;5553.861153471155;5645.604807663506;5723.341815691166;5839.00736874728;5870.9412905870395;5295.020421222086;5645.181448689917;5731.627444216113;5899.410058994066;6124.197855633957;5439.510444059974;6031.095335699592;6031.24609423822;6036.034234522455;6046.455818976313;6013.128096425994;6106.6336019838955;6127.908081378783;6141.815745527552;6154.630722156685;6025;6092.878142437126;6150.477209437248;6153.7230824613;6212.689365531795;6155.784547540815;6190.164327815687;6194.938050619527;6200.503959683215;6202.658853763086;3735.9726075329504;4809.615230781599;4927.704337739747;4941.703497790072;4943.505649435099;4345.847895323648;4377.627901628333;4387.3857659927635;4482.596566309048;4524.343970124313;5778.768849245983;5858.091995740667;5880.235569375954;5882.617629854046;5891.823245302648;6200.348963358872;6235.251769787564;6249.937500624936;6262.499000079983;6272.5922815016875;5621.156826476062;5666.914996275059;5753.050746626844;5781.971090144522;5826.941730582725;4610.838620648261;5380.192971054373;5412.323459567554;5423.29497165366;5423.566114710814;6284.183056202756;6313.873722525524;6320.051992201114;6338.904916426257;6342.841428964312;6094.169091873587;6105.175801266772;6118.253719382578;6131.877362452815;6214.285357183981;6239.302245970246;6280.371962803683;6288.119663247057;6293.213348331458;6298.71655775482;5957.940420595912;6059.484943779652;6084.361142080018;6141.8464538385115;6150.354212807591;6095.6197031535285;6099.340048627855;6112.5946701277735;6132.386102851662;6229.1590635265475;6066.545009124245;6067.908981365372;6076.1493390924425;6084.8783024340155;6123.540734445023;6050.939490605214;6070.484008859296;6072.666003369857;6075.908861366995;6081.239845019372;4621.560951709582;4924.8276310328965;5447.863803404946;5572.693501857437;5925.851853703692;6096.6476373754385;6106.399996025681;6107.3708791890585;6121.300552271563;6124.441964285778;4920.360353154067;5978.3423823378525;6005.558665920061;6038.788642397495;6039.245094363205 16:24:45 INFO - PROCESS | 2011 | |1;ext.html;474.5634016704631;475.91195628808674;480.93266942628014;516.7080599461302;540.6431755041673;34680.826595867045;39647.80176099123;41417;41588;41616.37575436371;42293.57706422935;42795.57204427955;42807.571924280746;42894.571054289445;42947.570524294824;9779.315447918649;9805.705828825112;9963.701088967342;9983.800323993515;9997;9897.257705672067;9932.801343973117;10000.799984000316;10002.449865257408;10028.59885604575;9992.350497217694;10039.598416063349;10042.598296068149;10044.347117437379;10068.546915388824;9948.552315145836;9986.300958932878;10000.549975251131;10004.349717268427;10017.198624110126;9771.071748183911;9798.26513011527;9810.411375317504;9889.554970026365;9914;40505;40550.78347649575;40607.593924060675;40695.59304406948;40806.59193408058;3149.889753858627;3293.6212335581235;3469.2367679110557;3515.6132825389186;4033.5361433434946;30820.851877917932;31406.842965785254;31912.521312180335;33150.17124571881;33251.83374083138;3024.5916801231774;3226.56441380413;3336.9332613347838;3358.630550639428;3431.24512607226;431932;514091;516294;520109;520632.3968380134;62026.379736202965;63308;63538.09385718436;63631.36368636254;63703.04445433322;33366.332673346886;34137.487937680955;63684.68157659182;66870;67248.66375668091;15916.840831591768;16057.197140142945;16312.67374652524;16444.506664800076;16503.6699266014;12285.447154878051;12554.372281385895;12580.496780128875;12657.493700251887;12658.177218480769;18762.906185468986;19065.332713355245;19077;19087.90456047711;19102.71345929812;6456.967715161488;7749.380049596019;7868.881966770503;7897.842043159105;7955.920440795518;827.6192951242375;901.9729408117767;1043.0925095167254;1065.94606452513;1084.6312253833735;28984.855075724907;30166.94415695484;30599;30619.540706889413;30668.846655767025;1020.6682828080903;1055.4036969112426;1063.4363787192801;1064.7338165458636;1106.5186643809807;14691.85308146905;14793.92603036978;15172.924135379253;15514.224288785515;15518.689626207413;612736;656533;656815;657025;657955;42215.944601384595;50866;57621.13568296479;57764.42235577675;58403.4159658398;1345.9125156864773;1355.6746380868717;1398.1960372785688;1400.824896887889;1406.9366878490493;24376.87811560931;29356.266093347836;29430.558541621464;29567.408651827274;30076.84961575178;50055;50681.746591266805;50776;50906.49093509166;51010.489895100574;622872;625596;627539;628502;629752.8512357592;26153.215403537924;26338.604920926584;26385.472290554466;26722.931082756473;27014.32464188411;45966.770166148955;47212;47611.52388476071;47699.28451073306;47846.043079138915;38977;39144.21711565696;39469.60530394659;40217.39673904835;40478.595214047484;38726.22547549089;38935.415968759924;39340.60659393484;39381.01547461336;40495.392569110896;38051.23897522089;38732.41901371425;39276.410853837784;39351.6226932056;40822.38766418447;28129;30361.24096897595;30699.846500767355;34906.30187396289;35409.46885796663;25874.870625646752;25963;26032.08887688922;26428.20715378465;26523.33691657724 16:24:45 INFO - PROCESS | 2011 | |2;jquery.html;363.963603639636;370.75900664568013;374.28511542952947;375.4124794696301;404.830041180987;18750.655748352503;20281.188752449885;20368.083436245368;20936;21109.788902110973;19461;19918.004099794987;20114.79885201151;20183.09176087076;20303.59392812143;5543.750531226085;5932.495737862276;6023.36754640763;6111.938880611181;6152.077188421727;5138.332016837806;6032.27612686476;6154.138420621117;6158.56890017699;6171.938280617203;4853.441854186761;5174.016936782018;5320.308359913206;5899.380565040673;5986.132010858423;5885.117232415129;5942.97028514859;5998.040313549833;5999.370066143036;6065.848353791169;4421.53573874745;5172.818951336722;5207.270982062514;5280.894382112375;5281.313429254211;19367.612647747108;24408.511829763484;24428.26715198547;24537.38656533583;24727.505449891083;1847.4489618647106;2286.5769832581027;2418.6130219165025;2447.192426499251;3136.870726538444;14441;15015.774763378558;15205.01167424114;15445.922770386076;15643.395293800462;1842.5209445544256;1861.8882867027887;1874.1191639929211;1892.2147308866804;1968.3406058970263;110460;111882;112485.43757281161;114548;114556;9010.63957441708;11253.49359278818;11394.829077563843;11483.42582870853;11598.18812683121;14183.71632567343;14191.78712319316;14211.928940355232;14219.217943013233;14254.429822807178;7880.566568838769;7997.280244777998;7998.920010799934;8019.51882887017;8352.958235208907;8071.394645401619;8195.95902020486;8197.426180167451;8370.707025254087;8373.120822313569;4407.2507673695545;4439.311906654474;4509.6843220974215;4588.587027167571;4599.425071866017;1894.621075784821;1937.651222779913;1941.65050290949;1943.3586916317581;1948.1687214018777;785.1707548615851;847.5296210603051;887.9378443508892;888.9111088891059;973.1582181413027;19499.512512187026;20363;20505.2823151192;20530.17879284842;20571.691424628643;841.3353450773942;923.5223642172605;928.1646518133599;977.8386566216636;992.533509250651;9723.124918757347;10222.539985700512;10546.998035186645;10786.298890572089;10791.190660700478;495664;498929;501098;542723;578606;53284.73357633265;77618;91986;126744.0988385175;137934;946;971.7570607348305;1003.1824063388315;1008.9344192627456;1010.5301035018605;19030.42908712741;19377.224911003403;19468.026598669727;19490.415287541397;19496;42523.78738106413;53385.19922201248;54602.45397546133;54689.25762794849;55695.72152139214;61660.07509887266;66612.666936665;68735.31264687289;74680.17137515139;78448.25431109883;7028.262032486719;7893.921060789548;8009.199080091944;8078.192180781874;8301.045379781403;9201.401908875901;11800.114991375509;12986.545470908473;13070.934645326712;13405.262710551013;9092.81793366858;10115.848262275924;10319.122874555747;10861;11457.713557161138;8709.782255443664;9702.660406885725;11182.552697892319;11183.384913829817;11200.439978000904;11100.722481938015;11232.269902456641;11350.659480215276;11584.826227606423;11732.354720490455;6817.727290908507;8113.7565873023905;8329.416940814328;8407.033191182847;8526.658933642584;7943.721969731263;9540.33217674784;11128.499217535393;11335.489902954221;11485.942570287096 16:24:45 INFO - PROCESS | 2011 | |3;mootools.html;1436.1957303909808;1508.0122519749561;1601.959951001224;1670.5573023148868;1848.926042958281;7802.96098519508;8035.357171426286;8302;9059.13938175874;9112.817743645122;8453.239208471236;8768.824623507526;8780.165884240987;8900;8931.883514560679;2344.1443872986324;2389.23544465771;2390.9760902391013;2393.9521209575796;2401.435662619283;2344.8475849069755;2371.5494056129364;2386.4391867911027;2392;2393.9760602393926;2364.207990323244;2373.6558199061124;2375.2517956843626;2381.559411508868;2381.6903802505735;2322.059565875823;2328.604137296664;2340.789328960393;2354.9646755298686;2360.1621424394434;2328.988355058214;2339.5554844579474;2348.941276468085;2350.9294721158394;2363.2201373546686;8918.464892106495;8951.149640784115;8996.77508062297;9013.684521041732;9020.594073266719;5169.457206993249;5321.255024296602;5361.088614935431;5371.597130215249;5373.274607927958;3605.080704420356;3646.981765091184;3653.12325041988;3704.2591481703766;3712.6472985066375;1050.2858056521563;1087.1791797193148;1087.249797639634;1093.3986307530906;1100.6918062942389;11617.361045142514;11788.351640659761;11807.232529885616;11897.464614092387;11924.403779811062;3737.8691745788765;4571.611413029863;4764.4282686077895;4790.281457781361;4798.5441383068555;9993.250506211918;10047.24645651579;10052.69841904744;10053.396796192252;10089.747756306004;5249.212618107238;5301.443348448434;5323.334583177103;5324.988252232063;5328.280682107943;4273.465816772903;4410.735355878657;4690.929636055462;4836.685615434985;4839.806407743651;3866.864659736952;3875.6899448044087;4005.7997100144876;4028.798560071985;4037.454943582579;1255.3095797311441;1274.1781550899618;1275.483429211171;1282.602393258093;1283.8266833977293;900.8873890763655;903.6837107012493;910.6630546697631;949.4540639132526;952.1675257090129;5751.338596061507;5944;5976.133460648181;6129.570930034944;6154.323024467305;417.538619825095;434.5806296923484;435.1514546634013;437.28722182841767;440.63207221970015;3247.2206670399405;3898.590647981978;3939.074317535377;4032.9596704032583;4086.713930024929;8683;10473.266871318934;10785.514651840685;10870.728231794268;10954;10617.84073238902;10664.200184986157;10738.516766745515;10778.676639700821;10898.72753181161;8147.348212143014;8182.1817818217705;8303.95848020756;8329.250367466957;8366.121557236524;4375.912481750283;5867.20792692981;5873.618214816023;5953.226080609493;5989.951758442342;9967.551460184453;10018.198544116307;10055.798884022424;10075.496225188564;10109.39343639384;9391.060893910555;9589.808203835744;10344.586216551555;10374.22193335518;10419.531121099417;6811.114555107804;7033.648317583998;7206;7464.141623713343;7556.1310449299035;8107.83784324322;8498.405111642373;8509.191626795444;8509.276711479593;8510.574471276288;7143.285671432815;7347.118345798538;7520.623968801648;7552.6223688816435;7598.620068996639;7247.891281630885;7340.669669864976;7356.521826081287;7471.589062601609;7476.140243871807;6908.171019477695;6915.723371065101;6988.231294557696;7007.404370628554;7007.754728584475;4667.369905062773;4888.997755460051;4936.185529387611;5078.923816142835;5099.184130539096;4961.627877909099;4994.126027945168;5087.567556757569;5128.538431541179;5192.3769147702515 16:24:45 INFO - PROCESS | 2011 | |4;prototype.html;262.7477621483376;288.4188360453685;305.94798884189686;308.6080677539524;309.0758631691244;5376.462353764621;5413.53984911283;5560.944390556093;5619.80330688426;5766.1260090470605;4756.382829837855;5004.599632029438;5453.618246722721;5612.494875461208;5631.380548139711;3444.448888177892;3737.897320290507;4010.7994600270017;4243.766592837393;4275.242468607747;4106.486689163855;4260.254455470295;4272.359146128075;4286.207051695431;4297;3871.3031654302213;4127.277726397883;4176.60322269384;4191.476065491814;4250.553691862357;3601.0637234319265;3657.5428071490933;3790.3177428062936;3946.677862915912;4154.729942553724;3070.37482952075;3173.3177366866003;3546.29074185164;3573.8213089345427;3587.802670853102;4100.5899410059055;4559.886002849922;4563.224251877189;4876.756162191911;5394.946050539484;3844.673202777767;4770.260609605517;4775;4777.80888764449;4825.445073816521;4882.780274887603;5189.896202075975;5255.76349064293;5336.252924590561;5372.952274306512;3606.6753992140834;3920.7847566125333;3921.686265098785;3922.2155568886337;3933.252681990413;5823.82528524145;6048.5463590230465;6063.969680151615;6134.9079763803575;6162.96918515409;3479.338925604178;3768.2275133597545;3941.5365396627108;3951.3677811550015;3970.8808735737975;3772.3775577030033;3798.7654012446064;3996.980769903656;4021.6782657387926;4040.070783719761;3819.064329239299;4609.400777898852;4749.548792864673;4758.833440829623;4778.904421911612;5147.9189370231925;5378.2739330189925;5778.393268706725;5937.168796368512;5964.254468191476;1349.50068474665;1374.7695812248182;1377.435251546861;1381.5648070857649;1382.6612479942278;776.3517462918526;791.8676292901207;822.7696245051395;836.6946064686346;840.6637345061902;3690.630936906288;4088.0801819590947;4600.861974140781;4623.606993405599;4799.832005879777;4926.48271931442;4985.277134815431;5143.897122057613;5190.532852043334;5190.584753219733;3747.628554684769;4216.566367435025;4377.854851122926;4680.742559159211;4744.861233304051;2584.8966041358135;2660.5344064788583;2671.305460580263;2673.0109859352165;2706.526357887362;4515.525869783691;4662.59876163776;4665.906681866411;4742.881427964328;4843.6367272454;4690.366800481959;4878.243792257364;4976.825811096594;5052.225646763846;5210;4650.302454631832;4712.670113092119;4891.877703057452;4948.412401009239;5295.073362161606;4708.8574698512775;5064.41759197697;5078.987599796267;5129.666571672829;5154.329937108152;4579.35888975537;5046.946597308723;5059.128122594517;5084.745762711776;5313.574914006947;5429.837104886859;5623.775048997994;5972.283326000907;6145.692715364304;6392.360763923571;3687.1703866630864;3993.960060399359;4005.8798236052967;4020.8994775130855;4039.5152581690386;5504.366997795305;6180.845478862884;6223.751049957951;6235.594686345373;6251.906221406592;5827.79602713903;5853.648781072979;5920.555958303231;5949.405059494189;5972.790952316648;5642.683347239283;5963.926493231086;5970.940290597038;5990.221271234712;6002.819915402545;4451.732896026248;4506.481754598263;5432.886258317115;5563.805266815642;5837.737301821513;5932.79235226765;5980.34216236205;5980.43185897339;5980.461758441587;5992.382056844541;5310.7875684973715;5852.648841069549;5887.293524777054;5920.171176035273;5930.843485520282 16:24:45 INFO - PROCESS | 2011 | |5;yui.html;694.7290556682894;699.3041923286329;711.9323664251898;748.6556184155288;795.793093795613;13308.667283317898;14116.858831411682;15227.923860380697;16278;16663.58341041473;12029.939850300758;14955.925220373883;14959;14991.550253492385;15007.774883376758;557.8326502049389;643.1574637225226;814.37293284171;825.455199568285;852.0414533649645;715.9534630249043;839.1859895900966;858.1418581418582;864.9697260595881;866.3069544364515;909.1590278991906;910.8178364327127;914.8216097860919;917.9862302065441;918.8851393575803;872.3762509805456;904;907.3648446087765;908.3278374003223;909.8771665825161;655.1057806094694;677.6205325017957;682.3415404134984;684.9452043836482;685.1504134872722;15130.54608361751;15138.394464221417;15142.16718080505;15190.088594684354;15232;14646.560603181815;14735.631609209748;14756;14837.703245935021;14871.100135473587;9593.328467007312;10780.622678206304;11327;12004.339761313124;12077.93961030198;3843.327417701891;3865.536135663738;3998.3602623580377;4001.7198796084285;4014.2573623879384;119499.40250298692;120552;122036.38981805035;124498.75501244962;125941.37029314887;10243.84634230487;11131.552898123193;11185.384803835866;11325.433728313552;11397.145214108808;23785.048598055884;23790;23801.880990594935;23843.523129537312;23844.64233036506;7082.468814838908;7781.844363112819;7927.801804954807;7990.403118986353;8099.392545558989;4391.538888416734;4499.1451624191295;4552.203364411214;4590.150822097922;4634.397528321297;3583.8387272572795;3612.5303710517464;3681.9631803682155;3688;3706;643.8873197190472;650.4991156809231;655.6426747422666;673.2829536543566;673.4376795375819;556.9415211402826;601.2604496469368;611.6849822341409;613.8987067133872;676.9424598909147;8891.288696904232;9373.343865929319;9455.763605909908;9469.195118415011;9475.336726429085;552.4227182594199;565.1635579342513;611.3122736920964;613.8802933427938;675.4900050461968;4360.215161270939;4616.261398176276;4648.628109751279;4697.6711630185555;4802.975985120122;127005;147108;152430;153153;155682;115725.4213728926;125145;131183;131377;132958;113465.59603212083;113635;113797.72404551863;114841.4257928705;116888;8436.45163064399;8589.269912057294;8796.296296296154;9025.368224224503;9164.175224229584;48594;53816.92366152733;55979.44020559742;61215.38784612097;61539.692301538205;71731;71798.1280748785;85758;100497.9850604483;103023;9871;10595.398512751348;10809.540712004093;11492.712682183012;11534.250273732181;10075.697729068139;11886.16796824214;11989.700257493632;12055.879441205476;12506.499740010298;11906;11996.400179990791;12039.398030098286;12271;12408.62774116778;9655.903440965782;10398.480075996322;12062.45718942632;12176.147669663038;12469.875301247233;11495.310281383145;11779.823302650295;11780.352080635646;11795.646130616095;11975.820362694392;8159.755207343789;8810.823783524422;10085.848712269175;10324.873649247424;10497.16022718196;8912.598933047899;9218.078192180996;10022.398656080659;10177;10253.179745620184 16:24:45 INFO - PROCESS | 2011 | __end_tp_report 16:24:45 INFO - PROCESS | 2011 | __start_cc_report 16:24:45 INFO - PROCESS | 2011 | _x_x_mozilla_cycle_collect,365 16:24:45 INFO - PROCESS | 2011 | __end_cc_report 16:24:45 INFO - PROCESS | 2011 | __startTimestamp1475277885041__endTimestamp 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | ------- Summary: start ------- 16:24:45 INFO - PROCESS | 2011 | Number of tests: 6 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | [#0] dojo.html Cycles:165 Average:5603.01 Median:5839.01 stddev:677.58 (11.6%) stddev-sans-first:655.22 16:24:45 INFO - PROCESS | 2011 | Values: 3303.9 3316.4 3363.8 3369.6 3390.0 4687.8 5551.0 5655.6 5698.1 5707.5 4515.6 5528.4 5637.4 5689.3 5709.7 4956.8 4973.4 5003.6 5059.3 5089.1 5044.5 5054.7 5169.3 5190.6 5244.9 4954.3 5047.2 5065.9 5218.3 5244.7 5142.8 5164.8 5169.8 5177.7 5178.3 5093.8 5117.6 5150.0 5152.7 5165.9 5435.1 5475.6 5566.1 5586.6 5631.1 4950.2 5461.7 6133.6 6166.3 6175.4 4449.7 4598.2 6066.1 6177.8 6217.4 5553.9 5645.6 5723.3 5839.0 5870.9 5295.0 5645.2 5731.6 5899.4 6124.2 5439.5 6031.1 6031.2 6036.0 6046.5 6013.1 6106.6 6127.9 6141.8 6154.6 6025.0 6092.9 6150.5 6153.7 6212.7 6155.8 6190.2 6194.9 6200.5 6202.7 3736.0 4809.6 4927.7 4941.7 4943.5 4345.8 4377.6 4387.4 4482.6 4524.3 5778.8 5858.1 5880.2 5882.6 5891.8 6200.3 6235.3 6249.9 6262.5 6272.6 5621.2 5666.9 5753.1 5782.0 5826.9 4610.8 5380.2 5412.3 5423.3 5423.6 6284.2 6313.9 6320.1 6338.9 6342.8 6094.2 6105.2 6118.3 6131.9 6214.3 6239.3 6280.4 6288.1 6293.2 6298.7 5957.9 6059.5 6084.4 6141.8 6150.4 6095.6 6099.3 6112.6 6132.4 6229.2 6066.5 6067.9 6076.1 6084.9 6123.5 6050.9 6070.5 6072.7 6075.9 6081.2 4621.6 4924.8 5447.9 5572.7 5925.9 6096.6 6106.4 6107.4 6121.3 6124.4 4920.4 5978.3 6005.6 6038.8 6039.2 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | [#1] ext.html Cycles:180 Average:71977.76 Median:39210.31 stddev:159432.91 (406.6%) stddev-sans-first:159789.77 16:24:45 INFO - PROCESS | 2011 | Values: 474.6 475.9 480.9 516.7 540.6 34680.8 39647.8 41417.0 41588.0 41616.4 42293.6 42795.6 42807.6 42894.6 42947.6 9779.3 9805.7 9963.7 9983.8 9997.0 9897.3 9932.8 10000.8 10002.4 10028.6 9992.4 10039.6 10042.6 10044.3 10068.5 9948.6 9986.3 10000.5 10004.3 10017.2 9771.1 9798.3 9810.4 9889.6 9914.0 40505.0 40550.8 40607.6 40695.6 40806.6 3149.9 3293.6 3469.2 3515.6 4033.5 30820.9 31406.8 31912.5 33150.2 33251.8 3024.6 3226.6 3336.9 3358.6 3431.2 431932.0 514091.0 516294.0 520109.0 520632.4 62026.4 63308.0 63538.1 63631.4 63703.0 33366.3 34137.5 63684.7 66870.0 67248.7 15916.8 16057.2 16312.7 16444.5 16503.7 12285.4 12554.4 12580.5 12657.5 12658.2 18762.9 19065.3 19077.0 19087.9 19102.7 6457.0 7749.4 7868.9 7897.8 7955.9 827.6 902.0 1043.1 1065.9 1084.6 28984.9 30166.9 30599.0 30619.5 30668.8 1020.7 1055.4 1063.4 1064.7 1106.5 14691.9 14793.9 15172.9 15514.2 15518.7 612736.0 656533.0 656815.0 657025.0 657955.0 42215.9 50866.0 57621.1 57764.4 58403.4 1345.9 1355.7 1398.2 1400.8 1406.9 24376.9 29356.3 29430.6 29567.4 30076.8 50055.0 50681.7 50776.0 50906.5 51010.5 622872.0 625596.0 627539.0 628502.0 629752.9 26153.2 26338.6 26385.5 26722.9 27014.3 45966.8 47212.0 47611.5 47699.3 47846.0 38977.0 39144.2 39469.6 40217.4 40478.6 38726.2 38935.4 39340.6 39381.0 40495.4 38051.2 38732.4 39276.4 39351.6 40822.4 28129.0 30361.2 30699.8 34906.3 35409.5 25874.9 25963.0 26032.1 26428.2 26523.3 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | [#2] jquery.html Cycles:180 Average:31642.54 Median:390.12 stddev:87442.70 (22414.2%) stddev-sans-first:87656.46 16:24:45 INFO - PROCESS | 2011 | Values: 364.0 370.8 374.3 375.4 404.8 18750.7 20281.2 20368.1 20936.0 21109.8 19461.0 19918.0 20114.8 20183.1 20303.6 5543.8 5932.5 6023.4 6111.9 6152.1 5138.3 6032.3 6154.1 6158.6 6171.9 4853.4 5174.0 5320.3 5899.4 5986.1 5885.1 5943.0 5998.0 5999.4 6065.8 4421.5 5172.8 5207.3 5280.9 5281.3 19367.6 24408.5 24428.3 24537.4 24727.5 1847.4 2286.6 2418.6 2447.2 3136.9 14441.0 15015.8 15205.0 15445.9 15643.4 1842.5 1861.9 1874.1 1892.2 1968.3 110460.0 111882.0 112485.4 114548.0 114556.0 9010.6 11253.5 11394.8 11483.4 11598.2 14183.7 14191.8 14211.9 14219.2 14254.4 7880.6 7997.3 7998.9 8019.5 8353.0 8071.4 8196.0 8197.4 8370.7 8373.1 4407.3 4439.3 4509.7 4588.6 4599.4 1894.6 1937.7 1941.7 1943.4 1948.2 785.2 847.5 887.9 888.9 973.2 19499.5 20363.0 20505.3 20530.2 20571.7 841.3 923.5 928.2 977.8 992.5 9723.1 10222.5 10547.0 10786.3 10791.2 495664.0 498929.0 501098.0 542723.0 578606.0 53284.7 77618.0 91986.0 126744.1 137934.0 946.0 971.8 1003.2 1008.9 1010.5 19030.4 19377.2 19468.0 19490.4 19496.0 42523.8 53385.2 54602.5 54689.3 55695.7 61660.1 66612.7 68735.3 74680.2 78448.3 7028.3 7893.9 8009.2 8078.2 8301.0 9201.4 11800.1 12986.5 13070.9 13405.3 9092.8 10115.8 10319.1 10861.0 11457.7 8709.8 9702.7 11182.6 11183.4 11200.4 11100.7 11232.3 11350.7 11584.8 11732.4 6817.7 8113.8 8329.4 8407.0 8526.7 7943.7 9540.3 11128.5 11335.5 11485.9 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | [#3] mootools.html Cycles:180 Average:5691.87 Median:4679.15 stddev:3227.18 (69.0%) stddev-sans-first:3220.39 16:24:45 INFO - PROCESS | 2011 | Values: 1436.2 1508.0 1602.0 1670.6 1848.9 7803.0 8035.4 8302.0 9059.1 9112.8 8453.2 8768.8 8780.2 8900.0 8931.9 2344.1 2389.2 2391.0 2394.0 2401.4 2344.8 2371.5 2386.4 2392.0 2394.0 2364.2 2373.7 2375.3 2381.6 2381.7 2322.1 2328.6 2340.8 2355.0 2360.2 2329.0 2339.6 2348.9 2350.9 2363.2 8918.5 8951.1 8996.8 9013.7 9020.6 5169.5 5321.3 5361.1 5371.6 5373.3 3605.1 3647.0 3653.1 3704.3 3712.6 1050.3 1087.2 1087.2 1093.4 1100.7 11617.4 11788.4 11807.2 11897.5 11924.4 3737.9 4571.6 4764.4 4790.3 4798.5 9993.3 10047.2 10052.7 10053.4 10089.7 5249.2 5301.4 5323.3 5325.0 5328.3 4273.5 4410.7 4690.9 4836.7 4839.8 3866.9 3875.7 4005.8 4028.8 4037.5 1255.3 1274.2 1275.5 1282.6 1283.8 900.9 903.7 910.7 949.5 952.2 5751.3 5944.0 5976.1 6129.6 6154.3 417.5 434.6 435.2 437.3 440.6 3247.2 3898.6 3939.1 4033.0 4086.7 8683.0 10473.3 10785.5 10870.7 10954.0 10617.8 10664.2 10738.5 10778.7 10898.7 8147.3 8182.2 8304.0 8329.3 8366.1 4375.9 5867.2 5873.6 5953.2 5990.0 9967.6 10018.2 10055.8 10075.5 10109.4 9391.1 9589.8 10344.6 10374.2 10419.5 6811.1 7033.6 7206.0 7464.1 7556.1 8107.8 8498.4 8509.2 8509.3 8510.6 7143.3 7347.1 7520.6 7552.6 7598.6 7247.9 7340.7 7356.5 7471.6 7476.1 6908.2 6915.7 6988.2 7007.4 7007.8 4667.4 4889.0 4936.2 5078.9 5099.2 4961.6 4994.1 5087.6 5128.5 5192.4 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | [#4] prototype.html Cycles:180 Average:4470.05 Median:4776.40 stddev:1400.92 (29.3%) stddev-sans-first:1368.80 16:24:45 INFO - PROCESS | 2011 | Values: 262.7 288.4 305.9 308.6 309.1 5376.5 5413.5 5560.9 5619.8 5766.1 4756.4 5004.6 5453.6 5612.5 5631.4 3444.4 3737.9 4010.8 4243.8 4275.2 4106.5 4260.3 4272.4 4286.2 4297.0 3871.3 4127.3 4176.6 4191.5 4250.6 3601.1 3657.5 3790.3 3946.7 4154.7 3070.4 3173.3 3546.3 3573.8 3587.8 4100.6 4559.9 4563.2 4876.8 5394.9 3844.7 4770.3 4775.0 4777.8 4825.4 4882.8 5189.9 5255.8 5336.3 5373.0 3606.7 3920.8 3921.7 3922.2 3933.3 5823.8 6048.5 6064.0 6134.9 6163.0 3479.3 3768.2 3941.5 3951.4 3970.9 3772.4 3798.8 3997.0 4021.7 4040.1 3819.1 4609.4 4749.5 4758.8 4778.9 5147.9 5378.3 5778.4 5937.2 5964.3 1349.5 1374.8 1377.4 1381.6 1382.7 776.4 791.9 822.8 836.7 840.7 3690.6 4088.1 4600.9 4623.6 4799.8 4926.5 4985.3 5143.9 5190.5 5190.6 3747.6 4216.6 4377.9 4680.7 4744.9 2584.9 2660.5 2671.3 2673.0 2706.5 4515.5 4662.6 4665.9 4742.9 4843.6 4690.4 4878.2 4976.8 5052.2 5210.0 4650.3 4712.7 4891.9 4948.4 5295.1 4708.9 5064.4 5079.0 5129.7 5154.3 4579.4 5046.9 5059.1 5084.7 5313.6 5429.8 5623.8 5972.3 6145.7 6392.4 3687.2 3994.0 4005.9 4020.9 4039.5 5504.4 6180.8 6223.8 6235.6 6251.9 5827.8 5853.6 5920.6 5949.4 5972.8 5642.7 5963.9 5970.9 5990.2 6002.8 4451.7 4506.5 5432.9 5563.8 5837.7 5932.8 5980.3 5980.4 5980.5 5992.4 5310.8 5852.6 5887.3 5920.2 5930.8 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | [#5] yui.html Cycles:180 Average:24613.26 Median:3854.43 stddev:40258.32 (1044.5%) stddev-sans-first:40331.20 16:24:45 INFO - PROCESS | 2011 | Values: 694.7 699.3 711.9 748.7 795.8 13308.7 14116.9 15227.9 16278.0 16663.6 12029.9 14955.9 14959.0 14991.6 15007.8 557.8 643.2 814.4 825.5 852.0 716.0 839.2 858.1 865.0 866.3 909.2 910.8 914.8 918.0 918.9 872.4 904.0 907.4 908.3 909.9 655.1 677.6 682.3 684.9 685.2 15130.5 15138.4 15142.2 15190.1 15232.0 14646.6 14735.6 14756.0 14837.7 14871.1 9593.3 10780.6 11327.0 12004.3 12077.9 3843.3 3865.5 3998.4 4001.7 4014.3 119499.4 120552.0 122036.4 124498.8 125941.4 10243.8 11131.6 11185.4 11325.4 11397.1 23785.0 23790.0 23801.9 23843.5 23844.6 7082.5 7781.8 7927.8 7990.4 8099.4 4391.5 4499.1 4552.2 4590.2 4634.4 3583.8 3612.5 3682.0 3688.0 3706.0 643.9 650.5 655.6 673.3 673.4 556.9 601.3 611.7 613.9 676.9 8891.3 9373.3 9455.8 9469.2 9475.3 552.4 565.2 611.3 613.9 675.5 4360.2 4616.3 4648.6 4697.7 4803.0 127005.0 147108.0 152430.0 153153.0 155682.0 115725.4 125145.0 131183.0 131377.0 132958.0 113465.6 113635.0 113797.7 114841.4 116888.0 8436.5 8589.3 8796.3 9025.4 9164.2 48594.0 53816.9 55979.4 61215.4 61539.7 71731.0 71798.1 85758.0 100498.0 103023.0 9871.0 10595.4 10809.5 11492.7 11534.3 10075.7 11886.2 11989.7 12055.9 12506.5 11906.0 11996.4 12039.4 12271.0 12408.6 9655.9 10398.5 12062.5 12176.1 12469.9 11495.3 11779.8 11780.4 11795.6 11975.8 8159.8 8810.8 10085.8 10324.9 10497.2 8912.6 9218.1 10022.4 10177.0 10253.2 16:24:45 INFO - PROCESS | 2011 | -------- Summary: end -------- 16:24:45 INFO - PROCESS | 2011 | 16:24:45 INFO - PROCESS | 2011 | [Parent 2011] WARNING: pipe error: Socket is not connected: file /builds/slave/autoland-m64-00000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 687 16:24:45 INFO - TEST-INFO | 2011: exit 0 16:24:45 INFO - TEST-OK | dromaeo_css | took 1114041ms 16:24:45 INFO - TEST-START | kraken 16:24:45 INFO - operating with platform_type : mac_ 16:24:45 INFO - Initialising browser for kraken test... 16:24:45 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp9UBQvm/profile http://localhost:49400/getInfo.html) 16:24:48 INFO - PROCESS | 2016 | 2016-09-30 16:24:48.751 plugin-container[2017:13705] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.tsm.portname' 16:24:48 INFO - PROCESS | 2016 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:24:48 INFO - PROCESS | 2016 | 2016-09-30 16:24:48.753 plugin-container[2017:13705] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 16:24:48 INFO - PROCESS | 2016 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:24:48 INFO - PROCESS | 2016 | 2016-09-30 16:24:48.754 plugin-container[2017:13705] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:24:48 INFO - PROCESS | 2016 | __metrics Screen width/height:1600/1200 16:24:48 INFO - PROCESS | 2016 | colorDepth:24 16:24:48 INFO - PROCESS | 2016 | Browser inner width/height: 1024/689 16:24:48 INFO - PROCESS | 2016 | __metrics 16:24:48 ERROR - PROCESS | 2016 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 16:24:49 INFO - TEST-INFO | 2016: exit 0 16:24:49 INFO - Browser initialized. 16:24:49 INFO - Running cycle 1/1 for kraken test... 16:24:49 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp9UBQvm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:52 INFO - PROCESS | 2018 | 2016-09-30 16:24:52.207 plugin-container[2019:13818] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.tsm.portname' 16:24:52 INFO - PROCESS | 2018 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:24:52 INFO - PROCESS | 2018 | 2016-09-30 16:24:52.210 plugin-container[2019:13818] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 16:24:52 INFO - PROCESS | 2018 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:24:52 INFO - PROCESS | 2018 | 2016-09-30 16:24:52.210 plugin-container[2019:13818] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:25:01 INFO - PROCESS | 2018 | RSS: Main: 240037888 16:25:01 INFO - PROCESS | 2018 | 16:25:05 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:06 INFO - PROCESS | 2018 | RSS: Main: 253919232 16:25:06 INFO - PROCESS | 2018 | 16:25:08 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-dft) 16:25:09 INFO - PROCESS | 2018 | RSS: Main: 261365760 16:25:09 INFO - PROCESS | 2018 | 16:25:12 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-fft) 16:25:13 INFO - PROCESS | 2018 | RSS: Main: 262197248 16:25:13 INFO - PROCESS | 2018 | 16:25:15 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-oscillator) 16:25:15 INFO - PROCESS | 2018 | RSS: Main: 263372800 16:25:15 INFO - PROCESS | 2018 | 16:25:17 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:18 INFO - PROCESS | 2018 | RSS: Main: 263811072 16:25:18 INFO - PROCESS | 2018 | 16:25:21 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:21 INFO - PROCESS | 2018 | RSS: Main: 265240576 16:25:21 INFO - PROCESS | 2018 | 16:25:24 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:25 INFO - PROCESS | 2018 | RSS: Main: 265273344 16:25:25 INFO - PROCESS | 2018 | 16:25:28 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49400/tests/kraken/driver.html?testName=json-parse-financial) 16:25:28 INFO - PROCESS | 2018 | RSS: Main: 265547776 16:25:28 INFO - PROCESS | 2018 | 16:25:30 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:31 INFO - PROCESS | 2018 | RSS: Main: 265310208 16:25:31 INFO - PROCESS | 2018 | 16:25:33 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:33 INFO - PROCESS | 2018 | RSS: Main: 265379840 16:25:33 INFO - PROCESS | 2018 | 16:25:36 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:37 INFO - PROCESS | 2018 | RSS: Main: 265818112 16:25:37 INFO - PROCESS | 2018 | 16:25:39 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:40 INFO - PROCESS | 2018 | RSS: Main: 265592832 16:25:40 INFO - PROCESS | 2018 | 16:25:43 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:25:44 INFO - PROCESS | 2018 | RSS: Main: 265768960 16:25:44 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49400/tests/kraken/driver.html?testName=ai-astar) 16:25:46 INFO - PROCESS | 2018 | RSS: Main: 267259904 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | __start_tp_report 16:25:46 INFO - PROCESS | 2018 | _x_x_mozilla_page_load 16:25:46 INFO - PROCESS | 2018 | _x_x_mozilla_page_load_details 16:25:46 INFO - PROCESS | 2018 | |i|pagename|runs| 16:25:46 INFO - PROCESS | 2018 | |0;ai-astar;113;118;119;119;123;178;118;118;118;117 16:25:46 INFO - PROCESS | 2018 | |1;audio-beat-detection;150;117;114;153;118;118;115;119;186;119 16:25:46 INFO - PROCESS | 2018 | |2;audio-dft;202;238;201;198;198;199;198;196;219;194 16:25:46 INFO - PROCESS | 2018 | |3;audio-fft;84;58;58;84;60;60;61;60;78;60 16:25:46 INFO - PROCESS | 2018 | |4;audio-oscillator;92;71;86;96;97;71;86;69;69;83 16:25:46 INFO - PROCESS | 2018 | |5;imaging-gaussian-blur;87;87;88;86;89;85;89;92;88;88 16:25:46 INFO - PROCESS | 2018 | |6;imaging-darkroom;150;99;99;100;99;100;98;102;99;100 16:25:46 INFO - PROCESS | 2018 | |7;imaging-desaturate;130;93;92;91;118;149;111;90;90;92 16:25:46 INFO - PROCESS | 2018 | |8;json-parse-financial;74;65;58;56;52;46;67;89;90;79 16:25:46 INFO - PROCESS | 2018 | |9;json-stringify-tinderbox;74;81;104;121;111;75;69;104;102;83 16:25:46 INFO - PROCESS | 2018 | |10;stanford-crypto-aes;86;85;94;109;115;101;85;87;90;98 16:25:46 INFO - PROCESS | 2018 | |11;stanford-crypto-ccm;150;152;133;155;137;157;170;171;189;150 16:25:46 INFO - PROCESS | 2018 | |12;stanford-crypto-pbkdf2;206;240;187;174;173;201;237;171;170;170 16:25:46 INFO - PROCESS | 2018 | |13;stanford-crypto-sha256-iterative;69;70;72;68;72;75;75;93;89;91 16:25:46 INFO - PROCESS | 2018 | __end_tp_report 16:25:46 INFO - PROCESS | 2018 | __start_cc_report 16:25:46 INFO - PROCESS | 2018 | _x_x_mozilla_cycle_collect,919 16:25:46 INFO - PROCESS | 2018 | __end_cc_report 16:25:46 INFO - PROCESS | 2018 | __startTimestamp1475277946367__endTimestamp 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | ------- Summary: start ------- 16:25:46 INFO - PROCESS | 2018 | Number of tests: 14 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#0] ai-astar Cycles:10 Average:124.10 Median:118.50 stddev:19.09 (16.1%) stddev-sans-first:19.82 16:25:46 INFO - PROCESS | 2018 | Values: 113.0 118.0 119.0 119.0 123.0 178.0 118.0 118.0 118.0 117.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:119.00 stddev:24.12 (20.3%) stddev-sans-first:24.58 16:25:46 INFO - PROCESS | 2018 | Values: 150.0 117.0 114.0 153.0 118.0 118.0 115.0 119.0 186.0 119.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#2] audio-dft Cycles:10 Average:204.30 Median:200.00 stddev:13.70 (6.9%) stddev-sans-first:14.51 16:25:46 INFO - PROCESS | 2018 | Values: 202.0 238.0 201.0 198.0 198.0 199.0 198.0 196.0 219.0 194.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:11.00 (18.2%) stddev-sans-first:9.62 16:25:46 INFO - PROCESS | 2018 | Values: 84.0 58.0 58.0 84.0 60.0 60.0 61.0 60.0 78.0 60.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:86.00 stddev:11.22 (13.1%) stddev-sans-first:11.31 16:25:46 INFO - PROCESS | 2018 | Values: 92.0 71.0 86.0 96.0 97.0 71.0 86.0 69.0 69.0 83.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:1.91 (2.2%) stddev-sans-first:2.00 16:25:46 INFO - PROCESS | 2018 | Values: 87.0 87.0 88.0 86.0 89.0 85.0 89.0 92.0 88.0 88.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:98.50 stddev:15.99 (16.2%) stddev-sans-first:1.13 16:25:46 INFO - PROCESS | 2018 | Values: 150.0 99.0 99.0 100.0 99.0 100.0 98.0 102.0 99.0 100.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:90.50 stddev:20.79 (23.0%) stddev-sans-first:20.09 16:25:46 INFO - PROCESS | 2018 | Values: 130.0 93.0 92.0 91.0 118.0 149.0 111.0 90.0 90.0 92.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:70.50 stddev:15.18 (21.5%) stddev-sans-first:15.93 16:25:46 INFO - PROCESS | 2018 | Values: 74.0 65.0 58.0 56.0 52.0 46.0 67.0 89.0 90.0 79.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#9] json-stringify-tinderbox Cycles:10 Average:92.40 Median:71.50 stddev:18.05 (25.2%) stddev-sans-first:17.88 16:25:46 INFO - PROCESS | 2018 | Values: 74.0 81.0 104.0 121.0 111.0 75.0 69.0 104.0 102.0 83.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#10] stanford-crypto-aes Cycles:10 Average:95.00 Median:86.50 stddev:10.60 (12.3%) stddev-sans-first:10.74 16:25:46 INFO - PROCESS | 2018 | Values: 86.0 85.0 94.0 109.0 115.0 101.0 85.0 87.0 90.0 98.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:156.00 stddev:16.63 (10.7%) stddev-sans-first:17.47 16:25:46 INFO - PROCESS | 2018 | Values: 150.0 152.0 133.0 155.0 137.0 157.0 170.0 171.0 189.0 150.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.90 Median:194.00 stddev:27.32 (14.1%) stddev-sans-first:28.56 16:25:46 INFO - PROCESS | 2018 | Values: 206.0 240.0 187.0 174.0 173.0 201.0 237.0 171.0 170.0 170.0 16:25:46 INFO - PROCESS | 2018 | 16:25:46 INFO - PROCESS | 2018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:75.00 stddev:9.70 (12.9%) stddev-sans-first:9.80 16:25:46 INFO - PROCESS | 2018 | Values: 69.0 70.0 72.0 68.0 72.0 75.0 75.0 93.0 89.0 91.0 16:25:46 INFO - PROCESS | 2018 | -------- Summary: end -------- 16:25:46 INFO - PROCESS | 2018 | 16:25:47 INFO - TEST-INFO | 2018: exit 0 16:25:47 INFO - TEST-OK | kraken | took 61390ms 16:25:47 INFO - SUITE-END | took 1175s 16:25:47 INFO - Completed test suite (00:19:35) 16:25:47 INFO - javascript benchmark 16:25:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7228.807166288517, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.8678452861886, 3316.436205845006, 3363.7813542119743, 3369.578802649669, 3390.0, 4687.8359257426, 5550.972245138773, 5655.57583181262, 5698.059820129673, 5707.457791509811, 4515.638748900088, 5528.439037793816, 5637.408072152426, 5689.288838895138, 5709.71451427428, 4956.826511072104, 4973.378327709036, 5003.574696150831, 5059.316992206061, 5089.083964886319, 5044.545990860822, 5054.747262636872, 5169.3279873616375, 5190.584753219752, 5244.895102097956, 4954.2568614707725, 5047.242913562958, 5065.898682026375, 5218.269442278084, 5244.737763111848, 5142.820001299974, 5164.767585458663, 5169.793208271664, 5177.689338639656, 5178.326817513699, 5093.847184584469, 5117.616178786606, 5150.0, 5152.742362881879, 5165.940982098661, 5435.076037073707, 5475.6440831345835, 5566.081596536607, 5586.581006424493, 5631.0708733059, 4950.18321976877, 5461.69960652164, 6133.6319820810895, 6166.290876549209, 6175.382461753834, 4449.687342234049, 4598.241290187115, 6066.120412540201, 6177.783777567808, 6217.409346112112, 5553.861153471155, 5645.604807663506, 5723.341815691166, 5839.00736874728, 5870.9412905870395, 5295.020421222086, 5645.181448689917, 5731.627444216113, 5899.410058994066, 6124.197855633957, 5439.510444059974, 6031.095335699592, 6031.24609423822, 6036.034234522455, 6046.455818976313, 6013.128096425994, 6106.6336019838955, 6127.908081378783, 6141.815745527552, 6154.630722156685, 6025.0, 6092.878142437126, 6150.477209437248, 6153.7230824613, 6212.689365531795, 6155.784547540815, 6190.164327815687, 6194.938050619527, 6200.503959683215, 6202.658853763086, 3735.9726075329504, 4809.615230781599, 4927.704337739747, 4941.703497790072, 4943.505649435099, 4345.847895323648, 4377.627901628333, 4387.3857659927635, 4482.596566309048, 4524.343970124313, 5778.768849245983, 5858.091995740667, 5880.235569375954, 5882.617629854046, 5891.823245302648, 6200.348963358872, 6235.251769787564, 6249.937500624936, 6262.499000079983, 6272.5922815016875, 5621.156826476062, 5666.914996275059, 5753.050746626844, 5781.971090144522, 5826.941730582725, 4610.838620648261, 5380.192971054373, 5412.323459567554, 5423.29497165366, 5423.566114710814, 6284.183056202756, 6313.873722525524, 6320.051992201114, 6338.904916426257, 6342.841428964312, 6094.169091873587, 6105.175801266772, 6118.253719382578, 6131.877362452815, 6214.285357183981, 6239.302245970246, 6280.371962803683, 6288.119663247057, 6293.213348331458, 6298.71655775482, 5957.940420595912, 6059.484943779652, 6084.361142080018, 6141.8464538385115, 6150.354212807591, 6095.6197031535285, 6099.340048627855, 6112.5946701277735, 6132.386102851662, 6229.1590635265475, 6066.545009124245, 6067.908981365372, 6076.1493390924425, 6084.8783024340155, 6123.540734445023, 6050.939490605214, 6070.484008859296, 6072.666003369857, 6075.908861366995, 6081.239845019372, 4621.560951709582, 4924.8276310328965, 5447.863803404946, 5572.693501857437, 5925.851853703692, 6096.6476373754385, 6106.399996025681, 6107.3708791890585, 6121.300552271563, 6124.441964285778, 4920.360353154067, 5978.3423823378525, 6005.558665920061, 6038.788642397495, 6039.245094363205], "value": 5562.516620811259, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.5634016704631, 475.91195628808674, 480.93266942628014, 516.7080599461302, 540.6431755041673, 34680.826595867045, 39647.80176099123, 41417.0, 41588.0, 41616.37575436371, 42293.57706422935, 42795.57204427955, 42807.571924280746, 42894.571054289445, 42947.570524294824, 9779.315447918649, 9805.705828825112, 9963.701088967342, 9983.800323993515, 9997.0, 9897.257705672067, 9932.801343973117, 10000.799984000316, 10002.449865257408, 10028.59885604575, 9992.350497217694, 10039.598416063349, 10042.598296068149, 10044.347117437379, 10068.546915388824, 9948.552315145836, 9986.300958932878, 10000.549975251131, 10004.349717268427, 10017.198624110126, 9771.071748183911, 9798.26513011527, 9810.411375317504, 9889.554970026365, 9914.0, 40505.0, 40550.78347649575, 40607.593924060675, 40695.59304406948, 40806.59193408058, 3149.889753858627, 3293.6212335581235, 3469.2367679110557, 3515.6132825389186, 4033.5361433434946, 30820.851877917932, 31406.842965785254, 31912.521312180335, 33150.17124571881, 33251.83374083138, 3024.5916801231774, 3226.56441380413, 3336.9332613347838, 3358.630550639428, 3431.24512607226, 431932.0, 514091.0, 516294.0, 520109.0, 520632.3968380134, 62026.379736202965, 63308.0, 63538.09385718436, 63631.36368636254, 63703.04445433322, 33366.332673346886, 34137.487937680955, 63684.68157659182, 66870.0, 67248.66375668091, 15916.840831591768, 16057.197140142945, 16312.67374652524, 16444.506664800076, 16503.6699266014, 12285.447154878051, 12554.372281385895, 12580.496780128875, 12657.493700251887, 12658.177218480769, 18762.906185468986, 19065.332713355245, 19077.0, 19087.90456047711, 19102.71345929812, 6456.967715161488, 7749.380049596019, 7868.881966770503, 7897.842043159105, 7955.920440795518, 827.6192951242375, 901.9729408117767, 1043.0925095167254, 1065.94606452513, 1084.6312253833735, 28984.855075724907, 30166.94415695484, 30599.0, 30619.540706889413, 30668.846655767025, 1020.6682828080903, 1055.4036969112426, 1063.4363787192801, 1064.7338165458636, 1106.5186643809807, 14691.85308146905, 14793.92603036978, 15172.924135379253, 15514.224288785515, 15518.689626207413, 612736.0, 656533.0, 656815.0, 657025.0, 657955.0, 42215.944601384595, 50866.0, 57621.13568296479, 57764.42235577675, 58403.4159658398, 1345.9125156864773, 1355.6746380868717, 1398.1960372785688, 1400.824896887889, 1406.9366878490493, 24376.87811560931, 29356.266093347836, 29430.558541621464, 29567.408651827274, 30076.84961575178, 50055.0, 50681.746591266805, 50776.0, 50906.49093509166, 51010.489895100574, 622872.0, 625596.0, 627539.0, 628502.0, 629752.8512357592, 26153.215403537924, 26338.604920926584, 26385.472290554466, 26722.931082756473, 27014.32464188411, 45966.770166148955, 47212.0, 47611.52388476071, 47699.28451073306, 47846.043079138915, 38977.0, 39144.21711565696, 39469.60530394659, 40217.39673904835, 40478.595214047484, 38726.22547549089, 38935.415968759924, 39340.60659393484, 39381.01547461336, 40495.392569110896, 38051.23897522089, 38732.41901371425, 39276.410853837784, 39351.6226932056, 40822.38766418447, 28129.0, 30361.24096897595, 30699.846500767355, 34906.30187396289, 35409.46885796663, 25874.870625646752, 25963.0, 26032.08887688922, 26428.20715378465, 26523.33691657724], "value": 20093.82530511435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.963603639636, 370.75900664568013, 374.28511542952947, 375.4124794696301, 404.830041180987, 18750.655748352503, 20281.188752449885, 20368.083436245368, 20936.0, 21109.788902110973, 19461.0, 19918.004099794987, 20114.79885201151, 20183.09176087076, 20303.59392812143, 5543.750531226085, 5932.495737862276, 6023.36754640763, 6111.938880611181, 6152.077188421727, 5138.332016837806, 6032.27612686476, 6154.138420621117, 6158.56890017699, 6171.938280617203, 4853.441854186761, 5174.016936782018, 5320.308359913206, 5899.380565040673, 5986.132010858423, 5885.117232415129, 5942.97028514859, 5998.040313549833, 5999.370066143036, 6065.848353791169, 4421.53573874745, 5172.818951336722, 5207.270982062514, 5280.894382112375, 5281.313429254211, 19367.612647747108, 24408.511829763484, 24428.26715198547, 24537.38656533583, 24727.505449891083, 1847.4489618647106, 2286.5769832581027, 2418.6130219165025, 2447.192426499251, 3136.870726538444, 14441.0, 15015.774763378558, 15205.01167424114, 15445.922770386076, 15643.395293800462, 1842.5209445544256, 1861.8882867027887, 1874.1191639929211, 1892.2147308866804, 1968.3406058970263, 110460.0, 111882.0, 112485.43757281161, 114548.0, 114556.0, 9010.63957441708, 11253.49359278818, 11394.829077563843, 11483.42582870853, 11598.18812683121, 14183.71632567343, 14191.78712319316, 14211.928940355232, 14219.217943013233, 14254.429822807178, 7880.566568838769, 7997.280244777998, 7998.920010799934, 8019.51882887017, 8352.958235208907, 8071.394645401619, 8195.95902020486, 8197.426180167451, 8370.707025254087, 8373.120822313569, 4407.2507673695545, 4439.311906654474, 4509.6843220974215, 4588.587027167571, 4599.425071866017, 1894.621075784821, 1937.651222779913, 1941.65050290949, 1943.3586916317581, 1948.1687214018777, 785.1707548615851, 847.5296210603051, 887.9378443508892, 888.9111088891059, 973.1582181413027, 19499.512512187026, 20363.0, 20505.2823151192, 20530.17879284842, 20571.691424628643, 841.3353450773942, 923.5223642172605, 928.1646518133599, 977.8386566216636, 992.533509250651, 9723.124918757347, 10222.539985700512, 10546.998035186645, 10786.298890572089, 10791.190660700478, 495664.0, 498929.0, 501098.0, 542723.0, 578606.0, 53284.73357633265, 77618.0, 91986.0, 126744.0988385175, 137934.0, 946.0, 971.7570607348305, 1003.1824063388315, 1008.9344192627456, 1010.5301035018605, 19030.42908712741, 19377.224911003403, 19468.026598669727, 19490.415287541397, 19496.0, 42523.78738106413, 53385.19922201248, 54602.45397546133, 54689.25762794849, 55695.72152139214, 61660.07509887266, 66612.666936665, 68735.31264687289, 74680.17137515139, 78448.25431109883, 7028.262032486719, 7893.921060789548, 8009.199080091944, 8078.192180781874, 8301.045379781403, 9201.401908875901, 11800.114991375509, 12986.545470908473, 13070.934645326712, 13405.262710551013, 9092.81793366858, 10115.848262275924, 10319.122874555747, 10861.0, 11457.713557161138, 8709.782255443664, 9702.660406885725, 11182.552697892319, 11183.384913829817, 11200.439978000904, 11100.722481938015, 11232.269902456641, 11350.659480215276, 11584.826227606423, 11732.354720490455, 6817.727290908507, 8113.7565873023905, 8329.416940814328, 8407.033191182847, 8526.658933642584, 7943.721969731263, 9540.33217674784, 11128.499217535393, 11335.489902954221, 11485.942570287096], "value": 9349.296968850864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.1957303909808, 1508.0122519749561, 1601.959951001224, 1670.5573023148868, 1848.926042958281, 7802.96098519508, 8035.357171426286, 8302.0, 9059.13938175874, 9112.817743645122, 8453.239208471236, 8768.824623507526, 8780.165884240987, 8900.0, 8931.883514560679, 2344.1443872986324, 2389.23544465771, 2390.9760902391013, 2393.9521209575796, 2401.435662619283, 2344.8475849069755, 2371.5494056129364, 2386.4391867911027, 2392.0, 2393.9760602393926, 2364.207990323244, 2373.6558199061124, 2375.2517956843626, 2381.559411508868, 2381.6903802505735, 2322.059565875823, 2328.604137296664, 2340.789328960393, 2354.9646755298686, 2360.1621424394434, 2328.988355058214, 2339.5554844579474, 2348.941276468085, 2350.9294721158394, 2363.2201373546686, 8918.464892106495, 8951.149640784115, 8996.77508062297, 9013.684521041732, 9020.594073266719, 5169.457206993249, 5321.255024296602, 5361.088614935431, 5371.597130215249, 5373.274607927958, 3605.080704420356, 3646.981765091184, 3653.12325041988, 3704.2591481703766, 3712.6472985066375, 1050.2858056521563, 1087.1791797193148, 1087.249797639634, 1093.3986307530906, 1100.6918062942389, 11617.361045142514, 11788.351640659761, 11807.232529885616, 11897.464614092387, 11924.403779811062, 3737.8691745788765, 4571.611413029863, 4764.4282686077895, 4790.281457781361, 4798.5441383068555, 9993.250506211918, 10047.24645651579, 10052.69841904744, 10053.396796192252, 10089.747756306004, 5249.212618107238, 5301.443348448434, 5323.334583177103, 5324.988252232063, 5328.280682107943, 4273.465816772903, 4410.735355878657, 4690.929636055462, 4836.685615434985, 4839.806407743651, 3866.864659736952, 3875.6899448044087, 4005.7997100144876, 4028.798560071985, 4037.454943582579, 1255.3095797311441, 1274.1781550899618, 1275.483429211171, 1282.602393258093, 1283.8266833977293, 900.8873890763655, 903.6837107012493, 910.6630546697631, 949.4540639132526, 952.1675257090129, 5751.338596061507, 5944.0, 5976.133460648181, 6129.570930034944, 6154.323024467305, 417.538619825095, 434.5806296923484, 435.1514546634013, 437.28722182841767, 440.63207221970015, 3247.2206670399405, 3898.590647981978, 3939.074317535377, 4032.9596704032583, 4086.713930024929, 8683.0, 10473.266871318934, 10785.514651840685, 10870.728231794268, 10954.0, 10617.84073238902, 10664.200184986157, 10738.516766745515, 10778.676639700821, 10898.72753181161, 8147.348212143014, 8182.1817818217705, 8303.95848020756, 8329.250367466957, 8366.121557236524, 4375.912481750283, 5867.20792692981, 5873.618214816023, 5953.226080609493, 5989.951758442342, 9967.551460184453, 10018.198544116307, 10055.798884022424, 10075.496225188564, 10109.39343639384, 9391.060893910555, 9589.808203835744, 10344.586216551555, 10374.22193335518, 10419.531121099417, 6811.114555107804, 7033.648317583998, 7206.0, 7464.141623713343, 7556.1310449299035, 8107.83784324322, 8498.405111642373, 8509.191626795444, 8509.276711479593, 8510.574471276288, 7143.285671432815, 7347.118345798538, 7520.623968801648, 7552.6223688816435, 7598.620068996639, 7247.891281630885, 7340.669669864976, 7356.521826081287, 7471.589062601609, 7476.140243871807, 6908.171019477695, 6915.723371065101, 6988.231294557696, 7007.404370628554, 7007.754728584475, 4667.369905062773, 4888.997755460051, 4936.185529387611, 5078.923816142835, 5099.184130539096, 4961.627877909099, 4994.126027945168, 5087.567556757569, 5128.538431541179, 5192.3769147702515], "value": 4493.411611639655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.7477621483376, 288.4188360453685, 305.94798884189686, 308.6080677539524, 309.0758631691244, 5376.462353764621, 5413.53984911283, 5560.944390556093, 5619.80330688426, 5766.1260090470605, 4756.382829837855, 5004.599632029438, 5453.618246722721, 5612.494875461208, 5631.380548139711, 3444.448888177892, 3737.897320290507, 4010.7994600270017, 4243.766592837393, 4275.242468607747, 4106.486689163855, 4260.254455470295, 4272.359146128075, 4286.207051695431, 4297.0, 3871.3031654302213, 4127.277726397883, 4176.60322269384, 4191.476065491814, 4250.553691862357, 3601.0637234319265, 3657.5428071490933, 3790.3177428062936, 3946.677862915912, 4154.729942553724, 3070.37482952075, 3173.3177366866003, 3546.29074185164, 3573.8213089345427, 3587.802670853102, 4100.5899410059055, 4559.886002849922, 4563.224251877189, 4876.756162191911, 5394.946050539484, 3844.673202777767, 4770.260609605517, 4775.0, 4777.80888764449, 4825.445073816521, 4882.780274887603, 5189.896202075975, 5255.76349064293, 5336.252924590561, 5372.952274306512, 3606.6753992140834, 3920.7847566125333, 3921.686265098785, 3922.2155568886337, 3933.252681990413, 5823.82528524145, 6048.5463590230465, 6063.969680151615, 6134.9079763803575, 6162.96918515409, 3479.338925604178, 3768.2275133597545, 3941.5365396627108, 3951.3677811550015, 3970.8808735737975, 3772.3775577030033, 3798.7654012446064, 3996.980769903656, 4021.6782657387926, 4040.070783719761, 3819.064329239299, 4609.400777898852, 4749.548792864673, 4758.833440829623, 4778.904421911612, 5147.9189370231925, 5378.2739330189925, 5778.393268706725, 5937.168796368512, 5964.254468191476, 1349.50068474665, 1374.7695812248182, 1377.435251546861, 1381.5648070857649, 1382.6612479942278, 776.3517462918526, 791.8676292901207, 822.7696245051395, 836.6946064686346, 840.6637345061902, 3690.630936906288, 4088.0801819590947, 4600.861974140781, 4623.606993405599, 4799.832005879777, 4926.48271931442, 4985.277134815431, 5143.897122057613, 5190.532852043334, 5190.584753219733, 3747.628554684769, 4216.566367435025, 4377.854851122926, 4680.742559159211, 4744.861233304051, 2584.8966041358135, 2660.5344064788583, 2671.305460580263, 2673.0109859352165, 2706.526357887362, 4515.525869783691, 4662.59876163776, 4665.906681866411, 4742.881427964328, 4843.6367272454, 4690.366800481959, 4878.243792257364, 4976.825811096594, 5052.225646763846, 5210.0, 4650.302454631832, 4712.670113092119, 4891.877703057452, 4948.412401009239, 5295.073362161606, 4708.8574698512775, 5064.41759197697, 5078.987599796267, 5129.666571672829, 5154.329937108152, 4579.35888975537, 5046.946597308723, 5059.128122594517, 5084.745762711776, 5313.574914006947, 5429.837104886859, 5623.775048997994, 5972.283326000907, 6145.692715364304, 6392.360763923571, 3687.1703866630864, 3993.960060399359, 4005.8798236052967, 4020.8994775130855, 4039.5152581690386, 5504.366997795305, 6180.845478862884, 6223.751049957951, 6235.594686345373, 6251.906221406592, 5827.79602713903, 5853.648781072979, 5920.555958303231, 5949.405059494189, 5972.790952316648, 5642.683347239283, 5963.926493231086, 5970.940290597038, 5990.221271234712, 6002.819915402545, 4451.732896026248, 4506.481754598263, 5432.886258317115, 5563.805266815642, 5837.737301821513, 5932.79235226765, 5980.34216236205, 5980.43185897339, 5980.461758441587, 5992.382056844541, 5310.7875684973715, 5852.648841069549, 5887.293524777054, 5920.171176035273, 5930.843485520282], "value": 4021.4816692048767, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.7290556682894, 699.3041923286329, 711.9323664251898, 748.6556184155288, 795.793093795613, 13308.667283317898, 14116.858831411682, 15227.923860380697, 16278.0, 16663.58341041473, 12029.939850300758, 14955.925220373883, 14959.0, 14991.550253492385, 15007.774883376758, 557.8326502049389, 643.1574637225226, 814.37293284171, 825.455199568285, 852.0414533649645, 715.9534630249043, 839.1859895900966, 858.1418581418582, 864.9697260595881, 866.3069544364515, 909.1590278991906, 910.8178364327127, 914.8216097860919, 917.9862302065441, 918.8851393575803, 872.3762509805456, 904.0, 907.3648446087765, 908.3278374003223, 909.8771665825161, 655.1057806094694, 677.6205325017957, 682.3415404134984, 684.9452043836482, 685.1504134872722, 15130.54608361751, 15138.394464221417, 15142.16718080505, 15190.088594684354, 15232.0, 14646.560603181815, 14735.631609209748, 14756.0, 14837.703245935021, 14871.100135473587, 9593.328467007312, 10780.622678206304, 11327.0, 12004.339761313124, 12077.93961030198, 3843.327417701891, 3865.536135663738, 3998.3602623580377, 4001.7198796084285, 4014.2573623879384, 119499.40250298692, 120552.0, 122036.38981805035, 124498.75501244962, 125941.37029314887, 10243.84634230487, 11131.552898123193, 11185.384803835866, 11325.433728313552, 11397.145214108808, 23785.048598055884, 23790.0, 23801.880990594935, 23843.523129537312, 23844.64233036506, 7082.468814838908, 7781.844363112819, 7927.801804954807, 7990.403118986353, 8099.392545558989, 4391.538888416734, 4499.1451624191295, 4552.203364411214, 4590.150822097922, 4634.397528321297, 3583.8387272572795, 3612.5303710517464, 3681.9631803682155, 3688.0, 3706.0, 643.8873197190472, 650.4991156809231, 655.6426747422666, 673.2829536543566, 673.4376795375819, 556.9415211402826, 601.2604496469368, 611.6849822341409, 613.8987067133872, 676.9424598909147, 8891.288696904232, 9373.343865929319, 9455.763605909908, 9469.195118415011, 9475.336726429085, 552.4227182594199, 565.1635579342513, 611.3122736920964, 613.8802933427938, 675.4900050461968, 4360.215161270939, 4616.261398176276, 4648.628109751279, 4697.6711630185555, 4802.975985120122, 127005.0, 147108.0, 152430.0, 153153.0, 155682.0, 115725.4213728926, 125145.0, 131183.0, 131377.0, 132958.0, 113465.59603212083, 113635.0, 113797.72404551863, 114841.4257928705, 116888.0, 8436.45163064399, 8589.269912057294, 8796.296296296154, 9025.368224224503, 9164.175224229584, 48594.0, 53816.92366152733, 55979.44020559742, 61215.38784612097, 61539.692301538205, 71731.0, 71798.1280748785, 85758.0, 100497.9850604483, 103023.0, 9871.0, 10595.398512751348, 10809.540712004093, 11492.712682183012, 11534.250273732181, 10075.697729068139, 11886.16796824214, 11989.700257493632, 12055.879441205476, 12506.499740010298, 11906.0, 11996.400179990791, 12039.398030098286, 12271.0, 12408.62774116778, 9655.903440965782, 10398.480075996322, 12062.45718942632, 12176.147669663038, 12469.875301247233, 11495.310281383145, 11779.823302650295, 11780.352080635646, 11795.646130616095, 11975.820362694392, 8159.755207343789, 8810.823783524422, 10085.848712269175, 10324.873649247424, 10497.16022718196, 8912.598933047899, 9218.078192180996, 10022.398656080659, 10177.0, 10253.179745620184], "value": 7555.737508034492, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 119.0, 119.0, 123.0, 178.0, 118.0, 118.0, 118.0, 117.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 114.0, 153.0, 118.0, 118.0, 115.0, 119.0, 186.0, 119.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 238.0, 201.0, 198.0, 198.0, 199.0, 198.0, 196.0, 219.0, 194.0], "value": 204.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 58.0, 84.0, 60.0, 60.0, 61.0, 60.0, 78.0, 60.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 71.0, 86.0, 96.0, 97.0, 71.0, 86.0, 69.0, 69.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 86.0, 89.0, 85.0, 89.0, 92.0, 88.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 99.0, 99.0, 100.0, 99.0, 100.0, 98.0, 102.0, 99.0, 100.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 93.0, 92.0, 91.0, 118.0, 149.0, 111.0, 90.0, 90.0, 92.0], "value": 105.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 65.0, 58.0, 56.0, 52.0, 46.0, 67.0, 89.0, 90.0, 79.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 104.0, 121.0, 111.0, 75.0, 69.0, 104.0, 102.0, 83.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 94.0, 109.0, 115.0, 101.0, 85.0, 87.0, 90.0, 98.0], "value": 95.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 133.0, 155.0, 137.0, 157.0, 170.0, 171.0, 189.0, 150.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 240.0, 187.0, 174.0, 173.0, 201.0, 237.0, 171.0, 170.0, 170.0], "value": 192.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 68.0, 72.0, 75.0, 75.0, 93.0, 89.0, 91.0], "value": 77.4, "unit": "score"}]}]} 16:25:47 INFO - Return code: 0 16:25:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:25:47 ERROR - # TBPL SUCCESS # 16:25:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:25:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:25:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:25:47 INFO - 2016-09-30 16:25:47.677 screenresolution[2023:14203] starting screenresolution argv=screenresolution get 16:25:47 INFO - 2016-09-30 16:25:47.679 screenresolution[2023:14203] Display 0: 1600x1200x32@60 16:25:47 INFO - 2016-09-30 16:25:47.686 screenresolution[2024:14206] starting screenresolution argv=screenresolution list 16:25:47 INFO - Available Modes on Display 0 16:25:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:25:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:25:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:25:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:25:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:25:47 INFO - Intel Iris: 16:25:47 INFO - Chipset Model: Intel Iris 16:25:47 INFO - Type: GPU 16:25:47 INFO - Bus: Built-In 16:25:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:25:47 INFO - Vendor: Intel (0x8086) 16:25:47 INFO - Device ID: 0x0a2e 16:25:47 INFO - Revision ID: 0x0009 16:25:47 INFO - Displays: 16:25:47 INFO - Display: 16:25:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:25:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:25:47 INFO - Display Serial Number: 1600x1200 60 16:25:47 INFO - Main Display: Yes 16:25:47 INFO - Mirror: Off 16:25:47 INFO - Online: Yes 16:25:47 INFO - Rotation: Supported 16:25:47 INFO - Return code: 0 16:25:47 INFO - Running post-action listener: _resource_record_post_action 16:25:47 INFO - [mozharness: 2016-09-30 23:25:47.921116Z] Finished run-tests step (success) 16:25:47 INFO - Running post-run listener: _resource_record_post_run 16:25:47 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 303104; Write bytes: 709783040; Read time: 7; Write time: 1943 16:25:47 INFO - TinderboxPrint: CPU usage
54.4% 16:25:47 INFO - TinderboxPrint: I/O read bytes / time
303,104 / 7 16:25:47 INFO - TinderboxPrint: I/O write bytes / time
709,783,040 / 1,943 16:25:47 INFO - TinderboxPrint: CPU idle
2,207.9 (45.6%) 16:25:47 INFO - TinderboxPrint: CPU system
981.0 (20.2%) 16:25:47 INFO - TinderboxPrint: CPU user
1,656.8 (34.2%) 16:25:47 INFO - TinderboxPrint: Swap in / out
407,523,328 / 0 16:25:47 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389132800; Write bytes: 383616512; Read time: 29537; Write time: 715 16:25:48 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 303104; Write bytes: 299771904; Read time: 7; Write time: 1176 16:25:48 INFO - Running post-run listener: _upload_blobber_files 16:25:48 INFO - Blob upload gear active. 16:25:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:25:48 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 16:25:48 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'] 16:25:48 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 16:25:48 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:25:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:49 INFO - (blobuploader) - INFO - Done attempting. 16:25:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:25:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:25:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:50 INFO - (blobuploader) - INFO - Done attempting. 16:25:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:25:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:53 INFO - (blobuploader) - INFO - Done attempting. 16:25:53 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:53 INFO - Return code: 0 16:25:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:25:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:25:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a590c2e23823f9c9bde56853e79e0c13009dd50f8043c84dfce09c3176d0e470a8b4eee50ddb01797d39df5e75b1204afb8155ec8b5741580f5809b7e6c74b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bc94e69b0c3df492bb487abb1a9089d1e50878fdb1a444a82321831a9cb39ad52043f7729d733f5cdc08826fedd77ec4861a1285750a081826a1b424b0500d3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/128936c58912a95171b23991a6fe04a3848de230e857b8495113bf73ae05bd06518259798677410d5fa9679a7fb682b49adde90d6bf95adbbd692c37dc770a03"} 16:25:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:25:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:25:53 INFO - Contents: 16:25:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a590c2e23823f9c9bde56853e79e0c13009dd50f8043c84dfce09c3176d0e470a8b4eee50ddb01797d39df5e75b1204afb8155ec8b5741580f5809b7e6c74b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bc94e69b0c3df492bb487abb1a9089d1e50878fdb1a444a82321831a9cb39ad52043f7729d733f5cdc08826fedd77ec4861a1285750a081826a1b424b0500d3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/128936c58912a95171b23991a6fe04a3848de230e857b8495113bf73ae05bd06518259798677410d5fa9679a7fb682b49adde90d6bf95adbbd692c37dc770a03"} 16:25:53 INFO - Running post-run listener: copy_logs_to_upload_dir 16:25:53 INFO - Copying logs to upload dir... 16:25:53 INFO - mkdir: /builds/slave/test/build/upload/logs 16:25:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.396013 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-30 16:25:53.662327) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 16:25:53.665524) ========= 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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/4a590c2e23823f9c9bde56853e79e0c13009dd50f8043c84dfce09c3176d0e470a8b4eee50ddb01797d39df5e75b1204afb8155ec8b5741580f5809b7e6c74b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bc94e69b0c3df492bb487abb1a9089d1e50878fdb1a444a82321831a9cb39ad52043f7729d733f5cdc08826fedd77ec4861a1285750a081826a1b424b0500d3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/128936c58912a95171b23991a6fe04a3848de230e857b8495113bf73ae05bd06518259798677410d5fa9679a7fb682b49adde90d6bf95adbbd692c37dc770a03"} build_url:https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010982 build_url: 'https://queue.taskcluster.net/v1/task/Y3dOt9rIRTe1x3z0RUMcxQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a590c2e23823f9c9bde56853e79e0c13009dd50f8043c84dfce09c3176d0e470a8b4eee50ddb01797d39df5e75b1204afb8155ec8b5741580f5809b7e6c74b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bc94e69b0c3df492bb487abb1a9089d1e50878fdb1a444a82321831a9cb39ad52043f7729d733f5cdc08826fedd77ec4861a1285750a081826a1b424b0500d3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/128936c58912a95171b23991a6fe04a3848de230e857b8495113bf73ae05bd06518259798677410d5fa9679a7fb682b49adde90d6bf95adbbd692c37dc770a03"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 16:25:53.699476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 16:25:53.699865) ========= 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.6sUsPzLlMy/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.uRg6HEwu2T/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005385 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 16:25:53.749496) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 16:25:53.749870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 16:25:53.750318) ========= ========= Total master_lag: 0.47 =========