builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0089 starttime: 1476766003.12 results: success (0) buildid: 20161017204448 builduid: aeb3738441724f7a9c4d9ffa9084744b revision: 861d1ff45502652e0cf118d38d155fe4d68d211f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:43.119347) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:43.119761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:43.120045) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:43.150888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:43.151202) ========= 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.2HMGt7im0t/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.XZH6cmt0ax/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-17 21:46:43-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.40M=0.001s 2016-10-17 21:46:43 (8.40 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.818878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:43.991988) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:43.992301) ========= 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.2HMGt7im0t/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.XZH6cmt0ax/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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.018794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:44.040283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 21:46:44.040657) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 861d1ff45502652e0cf118d38d155fe4d68d211f --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 861d1ff45502652e0cf118d38d155fe4d68d211f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2HMGt7im0t/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.XZH6cmt0ax/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-17 21:46:44,116 truncating revision to first 12 chars 2016-10-17 21:46:44,117 Setting DEBUG logging. 2016-10-17 21:46:44,117 attempt 1/10 2016-10-17 21:46:44,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/861d1ff45502?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 21:46:44,868 unpacking tar archive at: autoland-861d1ff45502/testing/mozharness/ program finished with exit code 0 elapsedTime=1.007292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 21:46:45.069610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:45.069937) ========= script_repo_revision: 861d1ff45502652e0cf118d38d155fe4d68d211f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:45.070329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:45.070609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:46:45.088355) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-17 21:46:45.088664) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2HMGt7im0t/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.XZH6cmt0ax/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:46:45 INFO - MultiFileLogger online at 20161017 21:46:45 in /builds/slave/test 21:46:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:46:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:45 INFO - {'append_to_log': False, 21:46:45 INFO - 'base_work_dir': '/builds/slave/test', 21:46:45 INFO - 'blob_upload_branch': 'Autoland', 21:46:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:45 INFO - 'branch': 'Autoland', 21:46:45 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:45 INFO - 'config_files': ('talos/mac_config.py',), 21:46:45 INFO - 'default_actions': ('clobber', 21:46:45 INFO - 'read-buildbot-config', 21:46:45 INFO - 'download-and-extract', 21:46:45 INFO - 'populate-webroot', 21:46:45 INFO - 'create-virtualenv', 21:46:45 INFO - 'install', 21:46:45 INFO - 'run-tests'), 21:46:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:45 INFO - 'download_minidump_stackwalk': True, 21:46:45 INFO - 'download_symbols': 'ondemand', 21:46:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:45 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:45 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:45 INFO - 'installer_path': 'installer.exe', 21:46:45 INFO - 'log_level': 'info', 21:46:45 INFO - 'log_name': 'talos', 21:46:45 INFO - 'log_to_console': True, 21:46:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:46:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:46:45 INFO - 'opt_config_files': (), 21:46:45 INFO - 'pip_index': False, 21:46:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:45 INFO - 'cmd': ('bash', 21:46:45 INFO - '-c', 21:46:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:45 INFO - 'enabled': True, 21:46:45 INFO - 'halt_on_failure': False, 21:46:45 INFO - 'name': 'check_screen_resolution'},), 21:46:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:45 INFO - 'cmd': ('bash', 21:46:45 INFO - '-c', 21:46:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:45 INFO - 'enabled': True, 21:46:45 INFO - 'halt_on_failure': False, 21:46:45 INFO - 'name': 'check_screen_resolution'},), 21:46:45 INFO - 'run_cmd_checks_enabled': True, 21:46:45 INFO - 'sps_profile': False, 21:46:45 INFO - 'sps_profile_interval': 0, 21:46:45 INFO - 'suite': 'dromaeojs', 21:46:45 INFO - 'system_bits': '32', 21:46:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:45 INFO - 'title': 't-yosemite-r7-0089', 21:46:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:45 INFO - 'use_talos_json': True, 21:46:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:45 INFO - 'work_dir': 'build'} 21:46:45 INFO - [mozharness: 2016-10-18 04:46:45.282134Z] Running clobber step. 21:46:45 INFO - Running pre-action listener: _resource_record_pre_action 21:46:45 INFO - Running main action method: clobber 21:46:45 INFO - rmtree: /builds/slave/test/build 21:46:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:46 INFO - Running post-action listener: _resource_record_post_action 21:46:46 INFO - [mozharness: 2016-10-18 04:46:46.810015Z] Finished clobber step (success) 21:46:46 INFO - [mozharness: 2016-10-18 04:46:46.810147Z] Running read-buildbot-config step. 21:46:46 INFO - Running pre-action listener: _resource_record_pre_action 21:46:46 INFO - Running main action method: read_buildbot_config 21:46:46 INFO - Using buildbot properties: 21:46:46 INFO - { 21:46:46 INFO - "project": "", 21:46:46 INFO - "product": "firefox", 21:46:46 INFO - "script_repo_revision": "production", 21:46:46 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 21:46:46 INFO - "repository": "", 21:46:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 21:46:46 INFO - "buildid": "20161017204448", 21:46:46 INFO - "pgo_build": "False", 21:46:46 INFO - "basedir": "/builds/slave/test", 21:46:46 INFO - "buildnumber": 383, 21:46:46 INFO - "slavename": "t-yosemite-r7-0089", 21:46:46 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:46:46 INFO - "platform": "yosemite_r7", 21:46:46 INFO - "scheduler": "tests-autoland-macosx64-talos", 21:46:46 INFO - "branch": "autoland", 21:46:46 INFO - "repo_path": "integration/autoland", 21:46:46 INFO - "revision": "861d1ff45502652e0cf118d38d155fe4d68d211f", 21:46:46 INFO - "stage_platform": "macosx64", 21:46:46 INFO - "builduid": "aeb3738441724f7a9c4d9ffa9084744b", 21:46:46 INFO - "slavebuilddir": "test" 21:46:46 INFO - } 21:46:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:46:46 INFO - Running post-action listener: _resource_record_post_action 21:46:46 INFO - [mozharness: 2016-10-18 04:46:46.813462Z] Finished read-buildbot-config step (success) 21:46:46 INFO - [mozharness: 2016-10-18 04:46:46.813561Z] Running download-and-extract step. 21:46:46 INFO - Running pre-action listener: _resource_record_pre_action 21:46:46 INFO - Running main action method: download_and_extract 21:46:46 INFO - mkdir: /builds/slave/test/build/tests 21:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:46 INFO - trying https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:46:46 INFO - Downloading https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/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 21:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/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 21:46:48 INFO - Downloaded 1199 bytes. 21:46:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:46:48 INFO - Using the following test package requirements: 21:46:48 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:46:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:46:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:46:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'jsshell-mac.zip'], 21:46:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:46:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:46:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:46:48 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:46:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:46:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:46:48 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:46:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:46:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:46:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:46:48 INFO - Fetch https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:46:48 INFO - Http code: 200 21:46:48 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 21:46:48 INFO - x-amz-cf-id: GvEFKC74m_d-ly3D3VWW0TDXTGpjFtGY4pchsS05_DCJFARhtLXjrQ== 21:46:48 INFO - x-amz-version-id: dcYrOqSCfDvzZXmfgMjAhMMvtPc6C0yz 21:46:49 INFO - Expected file size: 16483787 21:46:49 INFO - Obtained file size: 16483787 21:46:55 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 21:46:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:46:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:46:55 INFO - Fetch https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:46:56 INFO - Http code: 200 21:46:56 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 21:46:56 INFO - x-amz-cf-id: CXMwxhws_z6MLdunhcDw6QABUyx0hwTRZ4mXW9SLaqUoRG44-F1m3A== 21:46:56 INFO - x-amz-version-id: dcYrOqSCfDvzZXmfgMjAhMMvtPc6C0yz 21:46:56 INFO - Expected file size: 16483787 21:46:56 INFO - Obtained file size: 16483787 21:47:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:47:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:47:03 INFO - Fetch https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:47:04 INFO - Http code: 200 21:47:04 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 21:47:04 INFO - x-amz-cf-id: qqCv1PMpFrl5jcGA96hnFqHlQsWuu45elE3muz01b2MApoOW_9SgqQ== 21:47:04 INFO - x-amz-version-id: LKNe3fOyVGVAv.m6BGvzMkrIqzC.QAio 21:47:04 INFO - Expected file size: 14409028 21:47:04 INFO - Obtained file size: 14409028 21:47:05 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')]} 21:47:05 INFO - trying https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:47:05 INFO - Downloading https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/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 21:47:07 INFO - Downloaded 111635811 bytes. 21:47:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:47:07 INFO - mkdir: /builds/slave/test/properties 21:47:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:47:07 INFO - Writing to file /builds/slave/test/properties/build_url 21:47:07 INFO - Contents: 21:47:07 INFO - build_url:https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:47:08 INFO - Running post-action listener: _resource_record_post_action 21:47:08 INFO - Running post-action listener: set_extra_try_arguments 21:47:08 INFO - [mozharness: 2016-10-18 04:47:08.444264Z] Finished download-and-extract step (success) 21:47:08 INFO - [mozharness: 2016-10-18 04:47:08.444384Z] Running populate-webroot step. 21:47:08 INFO - Running pre-action listener: _resource_record_pre_action 21:47:08 INFO - Running main action method: populate_webroot 21:47:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:08 INFO - '--tppagecycles', 21:47:08 INFO - '7'], 21:47:08 INFO - 'tests': ['tsvgm']}}, 21:47:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:47:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:47:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:47:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['damp', 'tps']}, 21:47:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'tests': ['damp', 'tps']}, 21:47:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['dromaeo_dom']}, 21:47:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['basic_compositor_video']}, 21:47:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:47:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['a11yr', 21:47:08 INFO - 'ts_paint', 21:47:08 INFO - 'tpaint', 21:47:08 INFO - 'sessionrestore', 21:47:08 INFO - 'sessionrestore_no_auto_restore', 21:47:08 INFO - 'tabpaint']}, 21:47:08 INFO - 'other-e10s': {'tests': ['a11yr', 21:47:08 INFO - 'ts_paint', 21:47:08 INFO - 'tpaint', 21:47:08 INFO - 'sessionrestore', 21:47:08 INFO - 'sessionrestore_no_auto_restore', 21:47:08 INFO - 'tabpaint']}, 21:47:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:47:08 INFO - 'ts_paint', 21:47:08 INFO - 'tpaint', 21:47:08 INFO - 'sessionrestore', 21:47:08 INFO - 'sessionrestore_no_auto_restore', 21:47:08 INFO - 'tabpaint']}, 21:47:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:47:08 INFO - 'ts_paint', 21:47:08 INFO - 'tpaint', 21:47:08 INFO - 'sessionrestore', 21:47:08 INFO - 'sessionrestore_no_auto_restore', 21:47:08 INFO - 'tabpaint']}, 21:47:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['a11yr', 21:47:08 INFO - 'ts_paint', 21:47:08 INFO - 'tpaint', 21:47:08 INFO - 'sessionrestore', 21:47:08 INFO - 'sessionrestore_no_auto_restore', 21:47:08 INFO - 'tabpaint']}, 21:47:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['a11yr', 21:47:08 INFO - 'ts_paint', 21:47:08 INFO - 'tpaint', 21:47:08 INFO - 'sessionrestore', 21:47:08 INFO - 'sessionrestore_no_auto_restore', 21:47:08 INFO - 'tabpaint']}, 21:47:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['tsvgx', 21:47:08 INFO - 'tsvgr_opacity', 21:47:08 INFO - 'tart', 21:47:08 INFO - 'tscrollx', 21:47:08 INFO - 'cart']}, 21:47:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:47:08 INFO - 'tsvgr_opacity', 21:47:08 INFO - 'tart', 21:47:08 INFO - 'tscrollx', 21:47:08 INFO - 'cart']}, 21:47:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'talos_options': ['--disable-e10s'], 21:47:08 INFO - 'tests': ['tp5o']}, 21:47:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'tests': ['tp5o']}, 21:47:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'talos_options': ['--disable-e10s', 21:47:08 INFO - '--xperf_path', 21:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:08 INFO - 'tests': ['tp5n']}, 21:47:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:08 INFO - 'talos_options': ['--xperf_path', 21:47:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:08 INFO - 'tests': ['tp5n']}}, 21:47:08 INFO - 'talos.zip': {'path': '', 21:47:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:08 INFO - Running post-action listener: _resource_record_post_action 21:47:08 INFO - [mozharness: 2016-10-18 04:47:08.463703Z] Finished populate-webroot step (success) 21:47:08 INFO - [mozharness: 2016-10-18 04:47:08.463846Z] Running create-virtualenv step. 21:47:08 INFO - Running pre-action listener: _resource_record_pre_action 21:47:08 INFO - Running main action method: create_virtualenv 21:47:08 INFO - Creating virtualenv /builds/slave/test/build/venv 21:47:08 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 21:47:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:47:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:08 INFO - Using real prefix '/tools/python27' 21:47:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:47:09 INFO - Installing distribute.............................................................................................................................................................................................done. 21:47:12 INFO - Installing pip.................done. 21:47:12 INFO - Return code: 0 21:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:47:12 INFO - Reading from file tmpfile_stdout 21:47:12 INFO - Output received: 21:47:12 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) 21:47:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:12 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:12 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 21:47:12 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 21:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:12 INFO - 'HOME': '/Users/cltbld', 21:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:12 INFO - 'LOGNAME': 'cltbld', 21:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:12 INFO - 'MOZ_NO_REMOTE': '1', 21:47:12 INFO - 'NO_EM_RESTART': '1', 21:47:12 INFO - 'PAGER': '/bin/cat', 21:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:12 INFO - 'PWD': '/builds/slave/test', 21:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:12 INFO - 'SHELL': '/bin/bash', 21:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:12 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:12 INFO - 'USER': 'cltbld', 21:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:12 INFO - 'XPC_FLAGS': '0x0', 21:47:12 INFO - 'XPC_SERVICE_NAME': '0', 21:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:12 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 21:47:12 INFO - Cleaning up... 21:47:12 INFO - Return code: 0 21:47:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:12 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:12 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 21:47:12 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 21:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:12 INFO - 'HOME': '/Users/cltbld', 21:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:12 INFO - 'LOGNAME': 'cltbld', 21:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:12 INFO - 'MOZ_NO_REMOTE': '1', 21:47:12 INFO - 'NO_EM_RESTART': '1', 21:47:12 INFO - 'PAGER': '/bin/cat', 21:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:12 INFO - 'PWD': '/builds/slave/test', 21:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:12 INFO - 'SHELL': '/bin/bash', 21:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:12 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:12 INFO - 'USER': 'cltbld', 21:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:12 INFO - 'XPC_FLAGS': '0x0', 21:47:12 INFO - 'XPC_SERVICE_NAME': '0', 21:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:12 INFO - Downloading/unpacking psutil>=3.1.1 21:47:12 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 21:47:12 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 21:47:12 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 21:47:12 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 21:47:12 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 21:47:12 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 21:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:16 INFO - Installing collected packages: psutil 21:47:16 INFO - Running setup.py install for psutil 21:47:16 INFO - building 'psutil._psutil_osx' extension 21:47:16 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 21:47:17 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 21:47:17 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 21:47:17 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 21:47:17 INFO - building 'psutil._psutil_posix' extension 21:47:17 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 21:47:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:47:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:47:17 INFO - ^ 21:47:17 INFO - 1 warning generated. 21:47:17 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 21:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:17 INFO - Successfully installed psutil 21:47:17 INFO - Cleaning up... 21:47:17 INFO - Return code: 0 21:47:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:47: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 mozsystemmonitor==0.3 21:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:17 INFO - 'HOME': '/Users/cltbld', 21:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:17 INFO - 'LOGNAME': 'cltbld', 21:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:17 INFO - 'MOZ_NO_REMOTE': '1', 21:47:17 INFO - 'NO_EM_RESTART': '1', 21:47:17 INFO - 'PAGER': '/bin/cat', 21:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:17 INFO - 'PWD': '/builds/slave/test', 21:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:17 INFO - 'SHELL': '/bin/bash', 21:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:17 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:17 INFO - 'USER': 'cltbld', 21:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:17 INFO - 'XPC_FLAGS': '0x0', 21:47:17 INFO - 'XPC_SERVICE_NAME': '0', 21:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:47:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:47:20 INFO - Installing collected packages: mozsystemmonitor 21:47:20 INFO - Running setup.py install for mozsystemmonitor 21:47:20 INFO - Successfully installed mozsystemmonitor 21:47:20 INFO - Cleaning up... 21:47:20 INFO - Return code: 0 21:47:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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', '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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:47: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 jsonschema==2.5.1 21:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:20 INFO - 'HOME': '/Users/cltbld', 21:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:20 INFO - 'LOGNAME': 'cltbld', 21:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:20 INFO - 'MOZ_NO_REMOTE': '1', 21:47:20 INFO - 'NO_EM_RESTART': '1', 21:47:20 INFO - 'PAGER': '/bin/cat', 21:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:20 INFO - 'PWD': '/builds/slave/test', 21:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:20 INFO - 'SHELL': '/bin/bash', 21:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:20 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:20 INFO - 'USER': 'cltbld', 21:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:20 INFO - 'XPC_FLAGS': '0x0', 21:47:20 INFO - 'XPC_SERVICE_NAME': '0', 21:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:47:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47:24 INFO - Downloading functools32-3.2.3-2.tar.gz 21:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:47:24 INFO - warning: no files found matching '*.txt' 21:47:24 INFO - no previously-included directories found matching 'build' 21:47:24 INFO - no previously-included directories found matching 'dist' 21:47:24 INFO - no previously-included directories found matching '.git*' 21:47:24 INFO - Installing collected packages: jsonschema, functools32 21:47:24 INFO - Running setup.py install for functools32 21:47:24 INFO - warning: no files found matching '*.txt' 21:47:24 INFO - no previously-included directories found matching 'build' 21:47:24 INFO - no previously-included directories found matching 'dist' 21:47:24 INFO - no previously-included directories found matching '.git*' 21:47:24 INFO - Successfully installed jsonschema functools32 21:47:24 INFO - Cleaning up... 21:47:24 INFO - Return code: 0 21:47:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:47:24 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')]} 21:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 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')]} 21:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:24 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 21:47:24 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 21:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:24 INFO - 'HOME': '/Users/cltbld', 21:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:24 INFO - 'LOGNAME': 'cltbld', 21:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:24 INFO - 'MOZ_NO_REMOTE': '1', 21:47:24 INFO - 'NO_EM_RESTART': '1', 21:47:24 INFO - 'PAGER': '/bin/cat', 21:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:24 INFO - 'PWD': '/builds/slave/test', 21:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:24 INFO - 'SHELL': '/bin/bash', 21:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:24 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:24 INFO - 'USER': 'cltbld', 21:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:24 INFO - 'XPC_FLAGS': '0x0', 21:47:24 INFO - 'XPC_SERVICE_NAME': '0', 21:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:47:24 INFO - Cleaning up... 21:47:24 INFO - Return code: 0 21:47:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:47:24 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')]} 21:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 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')]} 21:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:24 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:24 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 21:47:24 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 21:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:24 INFO - 'HOME': '/Users/cltbld', 21:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:24 INFO - 'LOGNAME': 'cltbld', 21:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:24 INFO - 'MOZ_NO_REMOTE': '1', 21:47:24 INFO - 'NO_EM_RESTART': '1', 21:47:24 INFO - 'PAGER': '/bin/cat', 21:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:24 INFO - 'PWD': '/builds/slave/test', 21:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:24 INFO - 'SHELL': '/bin/bash', 21:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:24 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:24 INFO - 'USER': 'cltbld', 21:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:24 INFO - 'XPC_FLAGS': '0x0', 21:47:24 INFO - 'XPC_SERVICE_NAME': '0', 21:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:24 INFO - Downloading/unpacking blobuploader==1.2.4 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47:27 INFO - Downloading blobuploader-1.2.4.tar.gz 21:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:47:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:47:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:28 INFO - Downloading docopt-0.6.1.tar.gz 21:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:47:28 INFO - Installing collected packages: blobuploader, requests, docopt 21:47:28 INFO - Running setup.py install for blobuploader 21:47:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:47:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:47:28 INFO - Running setup.py install for requests 21:47:29 INFO - Running setup.py install for docopt 21:47:29 INFO - Successfully installed blobuploader requests docopt 21:47:29 INFO - Cleaning up... 21:47:29 INFO - Return code: 0 21:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:29 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')]} 21:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:29 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')]} 21:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:29 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:29 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 21:47:29 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 21:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:29 INFO - 'HOME': '/Users/cltbld', 21:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:29 INFO - 'LOGNAME': 'cltbld', 21:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:29 INFO - 'MOZ_NO_REMOTE': '1', 21:47:29 INFO - 'NO_EM_RESTART': '1', 21:47:29 INFO - 'PAGER': '/bin/cat', 21:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:29 INFO - 'PWD': '/builds/slave/test', 21:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:29 INFO - 'SHELL': '/bin/bash', 21:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:29 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:29 INFO - 'USER': 'cltbld', 21:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:29 INFO - 'XPC_FLAGS': '0x0', 21:47:29 INFO - 'XPC_SERVICE_NAME': '0', 21:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:29 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-a6TFkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-NKMx8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-KZGgxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-8diB4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-yMgbLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-VRqIRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-FgEUbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-qLw6yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-BogmX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-u0iKie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:30 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-MSbZDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:31 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-1EqGjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:31 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-eNfQep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:31 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-stdj6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:31 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-sqv7DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:31 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-OQ0pFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:31 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-JLbIKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:47:31 INFO - Running setup.py install for manifestparser 21:47:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:47:31 INFO - Running setup.py install for mozcrash 21:47:31 INFO - Running setup.py install for mozdebug 21:47:32 INFO - Running setup.py install for mozdevice 21:47:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Running setup.py install for mozfile 21:47:32 INFO - Running setup.py install for mozhttpd 21:47:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Running setup.py install for mozinfo 21:47:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Running setup.py install for mozInstall 21:47:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:47:32 INFO - Running setup.py install for mozleak 21:47:32 INFO - Running setup.py install for mozlog 21:47:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:47:33 INFO - Running setup.py install for moznetwork 21:47:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:47:33 INFO - Running setup.py install for mozprocess 21:47:33 INFO - Running setup.py install for mozprofile 21:47:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:47:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:47:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:47:33 INFO - Running setup.py install for mozrunner 21:47:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:47:33 INFO - Running setup.py install for mozscreenshot 21:47:33 INFO - Running setup.py install for moztest 21:47:34 INFO - Running setup.py install for mozversion 21:47:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:47:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:47:34 INFO - Cleaning up... 21:47:34 INFO - Return code: 0 21:47:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:34 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')]} 21:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:34 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')]} 21:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:34 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:34 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 21:47:34 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 21:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:34 INFO - 'HOME': '/Users/cltbld', 21:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:34 INFO - 'LOGNAME': 'cltbld', 21:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:34 INFO - 'MOZ_NO_REMOTE': '1', 21:47:34 INFO - 'NO_EM_RESTART': '1', 21:47:34 INFO - 'PAGER': '/bin/cat', 21:47:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:34 INFO - 'PWD': '/builds/slave/test', 21:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:34 INFO - 'SHELL': '/bin/bash', 21:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:34 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:34 INFO - 'USER': 'cltbld', 21:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:34 INFO - 'XPC_FLAGS': '0x0', 21:47:34 INFO - 'XPC_SERVICE_NAME': '0', 21:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:34 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-1q6T0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:34 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)) 21:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:34 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-A05v4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:34 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)) 21:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:34 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-2WiFfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:34 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)) 21:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:34 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-mobvUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:34 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)) 21:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:34 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-Bw0lhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-f8H4uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-2ANbyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-Sa67_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-hOYyoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-HLHwMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-OPshPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-kEnsDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-Na2mJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:35 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)) 21:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:35 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-tsBZxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:36 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)) 21:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:36 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-yi8tLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:36 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)) 21:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:36 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-ARP5hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:36 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)) 21:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:36 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-Ojx6xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:36 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)) 21:47:36 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)) 21:47:36 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)) 21:47:36 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)) 21:47:36 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)) 21:47:36 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)) 21:47:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:47:36 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 21:47:36 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 21:47:36 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 21:47:36 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 21:47:36 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 21:47:36 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 21:47:38 INFO - Downloading blessings-1.6.tar.gz 21:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:47:39 INFO - Installing collected packages: blessings 21:47:39 INFO - Running setup.py install for blessings 21:47:39 INFO - Successfully installed blessings 21:47:39 INFO - Cleaning up... 21:47:39 INFO - Return code: 0 21:47:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:39 INFO - Reading from file tmpfile_stdout 21:47:39 INFO - Current package versions: 21:47:39 INFO - blessings == 1.6 21:47:39 INFO - blobuploader == 1.2.4 21:47:39 INFO - docopt == 0.6.1 21:47:39 INFO - functools32 == 3.2.3-2 21:47:39 INFO - jsonschema == 2.5.1 21:47:39 INFO - manifestparser == 1.1 21:47:39 INFO - mozInstall == 1.12 21:47:39 INFO - mozcrash == 0.17 21:47:39 INFO - mozdebug == 0.1 21:47:39 INFO - mozdevice == 0.48 21:47:39 INFO - mozfile == 1.2 21:47:39 INFO - mozhttpd == 0.7 21:47:39 INFO - mozinfo == 0.9 21:47:39 INFO - mozleak == 0.1 21:47:39 INFO - mozlog == 3.4 21:47:39 INFO - moznetwork == 0.27 21:47:39 INFO - mozprocess == 0.23 21:47:39 INFO - mozprofile == 0.28 21:47:39 INFO - mozrunner == 6.12 21:47:39 INFO - mozscreenshot == 0.1 21:47:39 INFO - mozsystemmonitor == 0.3 21:47:39 INFO - moztest == 0.7 21:47:39 INFO - mozversion == 1.4 21:47:39 INFO - psutil == 3.1.1 21:47:39 INFO - requests == 1.2.3 21:47:39 INFO - wsgiref == 0.1.2 21:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:39 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:39 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 21:47:39 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 21:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:39 INFO - 'HOME': '/Users/cltbld', 21:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:39 INFO - 'LOGNAME': 'cltbld', 21:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:39 INFO - 'MOZ_NO_REMOTE': '1', 21:47:39 INFO - 'NO_EM_RESTART': '1', 21:47:39 INFO - 'PAGER': '/bin/cat', 21:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:39 INFO - 'PWD': '/builds/slave/test', 21:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:39 INFO - 'SHELL': '/bin/bash', 21:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:39 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:39 INFO - 'USER': 'cltbld', 21:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:39 INFO - 'XPC_FLAGS': '0x0', 21:47:39 INFO - 'XPC_SERVICE_NAME': '0', 21:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 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)) 21:47:39 INFO - Cleaning up... 21:47:39 INFO - Return code: 0 21:47:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:39 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 0x109356490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092cc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3124af9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, '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.2HMGt7im0t/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.XZH6cmt0ax/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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 21:47:39 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 21:47:39 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 21:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:39 INFO - 'HOME': '/Users/cltbld', 21:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:39 INFO - 'LOGNAME': 'cltbld', 21:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:39 INFO - 'MOZ_NO_REMOTE': '1', 21:47:39 INFO - 'NO_EM_RESTART': '1', 21:47:39 INFO - 'PAGER': '/bin/cat', 21:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:39 INFO - 'PWD': '/builds/slave/test', 21:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:39 INFO - 'SHELL': '/bin/bash', 21:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:47:39 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:39 INFO - 'USER': 'cltbld', 21:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:39 INFO - 'XPC_FLAGS': '0x0', 21:47:39 INFO - 'XPC_SERVICE_NAME': '0', 21:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:47:40 INFO - Cleaning up... 21:47:40 INFO - Return code: 0 21:47:40 INFO - Running post-action listener: _resource_record_post_action 21:47:40 INFO - Running post-action listener: _start_resource_monitoring 21:47:40 INFO - Starting resource monitoring. 21:47:40 INFO - [mozharness: 2016-10-18 04:47:40.183650Z] Finished create-virtualenv step (success) 21:47:40 INFO - [mozharness: 2016-10-18 04:47:40.184679Z] Running install step. 21:47:40 INFO - Running pre-action listener: _resource_record_pre_action 21:47:40 INFO - Running main action method: install 21:47:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:40 INFO - Reading from file tmpfile_stdout 21:47:40 INFO - Detecting whether we're running mozinstall >=1.0... 21:47:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:47:40 INFO - Reading from file tmpfile_stdout 21:47:40 INFO - Output received: 21:47:40 INFO - Usage: mozinstall [options] installer 21:47:40 INFO - Options: 21:47:40 INFO - -h, --help show this help message and exit 21:47:40 INFO - -d DEST, --destination=DEST 21:47:40 INFO - Directory to install application into. [default: 21:47:40 INFO - "/builds/slave/test"] 21:47:40 INFO - --app=APP Application being installed. [default: firefox] 21:47:40 INFO - mkdir: /builds/slave/test/build/application 21:47:40 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'] 21:47:40 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 21:48:15 INFO - Reading from file tmpfile_stdout 21:48:15 INFO - Output received: 21:48:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:48:15 INFO - Running post-action listener: _resource_record_post_action 21:48:15 INFO - [mozharness: 2016-10-18 04:48:15.117121Z] Finished install step (success) 21:48:15 INFO - [mozharness: 2016-10-18 04:48:15.117249Z] Running run-tests step. 21:48:15 INFO - Running pre-action listener: _resource_record_pre_action 21:48:15 INFO - Running main action method: run_tests 21:48:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:48:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:48:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:48:15 INFO - 2016-10-17 21:48:15.131 screenresolution[1958:19711] starting screenresolution argv=screenresolution get 21:48:15 INFO - 2016-10-17 21:48:15.134 screenresolution[1958:19711] Display 0: 1600x1200x32@60 21:48:15 INFO - 2016-10-17 21:48:15.140 screenresolution[1959:19713] starting screenresolution argv=screenresolution list 21:48:15 INFO - Available Modes on Display 0 21:48:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:48:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:48:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:48:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:48:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:48:15 INFO - Intel Iris: 21:48:15 INFO - Chipset Model: Intel Iris 21:48:15 INFO - Type: GPU 21:48:15 INFO - Bus: Built-In 21:48:15 INFO - VRAM (Dynamic, Max): 1536 MB 21:48:15 INFO - Vendor: Intel (0x8086) 21:48:15 INFO - Device ID: 0x0a2e 21:48:15 INFO - Revision ID: 0x0009 21:48:15 INFO - Displays: 21:48:15 INFO - Display: 21:48:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:48:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:48:15 INFO - Display Serial Number: 1600x1200 60 21:48:15 INFO - Main Display: Yes 21:48:15 INFO - Mirror: Off 21:48:15 INFO - Online: Yes 21:48:15 INFO - Rotation: Supported 21:48:15 INFO - Return code: 0 21:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:48:15 INFO - Python 2.7.3 21:48:15 INFO - Return code: 0 21:48:15 INFO - grabbing minidump binary from tooltool 21:48:15 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')]} 21:48:15 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 0x10916ad30>, '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 0x108f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109162b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:48:15 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 21:48:15 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 21:48:15 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 21:48:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:15 INFO - Return code: 0 21:48:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:48:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:48:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:48:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:48:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:48:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2HMGt7im0t/Render', 21:48:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:15 INFO - 'HOME': '/Users/cltbld', 21:48:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:15 INFO - 'LOGNAME': 'cltbld', 21:48:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:48:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:15 INFO - 'MOZ_NO_REMOTE': '1', 21:48:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:48:15 INFO - 'NO_EM_RESTART': '1', 21:48:15 INFO - 'PAGER': '/bin/cat', 21:48:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:15 INFO - 'PWD': '/builds/slave/test', 21:48:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:48:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:15 INFO - 'SHELL': '/bin/bash', 21:48:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XZH6cmt0ax/Listeners', 21:48:15 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 21:48:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:15 INFO - 'USER': 'cltbld', 21:48:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:15 INFO - 'XPC_FLAGS': '0x0', 21:48:15 INFO - 'XPC_SERVICE_NAME': '0', 21:48:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:48:15 INFO - mozversion application_buildid: 20161017204448 21:48:15 INFO - mozversion application_changeset: 861d1ff45502652e0cf118d38d155fe4d68d211f 21:48:15 INFO - mozversion application_display_name: Nightly 21:48:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:15 INFO - mozversion application_name: Firefox 21:48:15 INFO - mozversion application_remotingname: firefox 21:48:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:48:15 INFO - mozversion application_vendor: Mozilla 21:48:15 INFO - mozversion application_version: 52.0a1 21:48:15 INFO - mozversion platform_buildid: 20161017204448 21:48:15 INFO - mozversion platform_changeset: 861d1ff45502652e0cf118d38d155fe4d68d211f 21:48:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:48:15 INFO - mozversion platform_version: 52.0a1 21:48:15 INFO - using testdate: 1476766095 21:48:15 INFO - actual date: 1476766095 21:48:15 INFO - starting webserver on 'localhost:54400' 21:48:15 INFO - SUITE-START | Running 2 tests 21:48:15 INFO - TEST-START | dromaeo_css 21:48:15 INFO - operating with platform_type : mac_ 21:48:15 INFO - Initialising browser for dromaeo_css test... 21:48:15 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpz43sli/profile http://localhost:54400/getInfo.html) 21:48:18 INFO - PROCESS | 1969 | __metrics Screen width/height:1600/1200 21:48:18 INFO - PROCESS | 1969 | colorDepth:24 21:48:18 INFO - PROCESS | 1969 | Browser inner width/height: 1024/689 21:48:18 INFO - PROCESS | 1969 | __metrics 21:48:18 INFO - PROCESS | 1969 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:48:18 INFO - PROCESS | 1969 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:48:18 INFO - TEST-INFO | 1969: exit 0 21:48:18 INFO - Browser initialized. 21:48:18 INFO - Running cycle 1/1 for dromaeo_css test... 21:48:18 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpz43sli/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:30 INFO - PROCESS | 1972 | RSS: Main: 247099392 21:48:30 INFO - PROCESS | 1972 | 21:49:21 INFO - PROCESS | 1972 | 1476766161798 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] 21:51:36 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:54400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54400/tests/dromaeo/cssquery-ext.html) 21:51:38 INFO - PROCESS | 1972 | RSS: Main: 424517632 21:51:38 INFO - PROCESS | 1972 | 21:54:41 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:54400/tests/dromaeo/cssquery-ext.html (next: http://localhost:54400/tests/dromaeo/cssquery-jquery.html) 21:54:41 INFO - PROCESS | 1972 | RSS: Main: 386551808 21:54:41 INFO - PROCESS | 1972 | 21:57:44 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:54400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54400/tests/dromaeo/cssquery-mootools.html) 21:57:44 INFO - PROCESS | 1972 | RSS: Main: 344604672 21:57:44 INFO - PROCESS | 1972 | 22:00:47 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:54400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54400/tests/dromaeo/cssquery-prototype.html) 22:00:47 INFO - PROCESS | 1972 | RSS: Main: 344141824 22:00:47 INFO - PROCESS | 1972 | 22:03:51 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:54400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54400/tests/dromaeo/cssquery-yui.html) 22:03:51 INFO - PROCESS | 1972 | RSS: Main: 341872640 22:03:51 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:54400/tests/dromaeo/cssquery-yui.html (next: http://localhost:54400/tests/dromaeo/cssquery-dojo.html) 22:06:55 INFO - PROCESS | 1972 | RSS: Main: 479289344 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | __start_tp_report 22:06:55 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 22:06:55 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 22:06:55 INFO - PROCESS | 1972 | |i|pagename|runs| 22:06:55 INFO - PROCESS | 1972 | |0;dojo.html;3266.0854960611023;3300.9339813203724;3305.983470082649;3342.8328583570815;3348.6483919188486;5512.062949298619;5632.915506267399;5659.801906933259;5729.455701708342;5776.884462310752;5659.943400565993;5671.120976248678;5676.914846277309;5686.573506986972;5698.287714035746;5103.030424219386;5125.077486052509;5145.33110695611;5146.459621739719;5161.251618515313;5222.242774797652;5229.843104706865;5236.476352364771;5241.109011468059;5249.921251181236;4592.839250626229;5175.9906818170475;5202.557782588485;5211.192265198882;5242.977619364226;5244.606654500928;5251.6061295403;5257.447967963385;5265.447128051576;5311.256424100629;5004.374453193351;5117.948820511821;5208.374995000586;5216.217567364888;5217.791288348461;5595.104783234663;5612.522935550483;5660.716964151817;5685.260916080924;5686.516646085088;6119.724612392409;6137.2635283765785;6146.539009574255;6166.84582885427;6240.157578726859;6093.847653808646;6150.969245153746;6153.661548614825;6155.261368635793;6161.938380616181;5627.212190293321;5689.601727879009;5693.743781529841;5707.1153971134545;5748.19525266463;6138.917619782795;6153.630782153085;6160.722767475474;6168.321484636686;6172.753089876444;6075.574709770273;6100.382642271707;6105.5916412017805;6105.754895139613;6108.908366374508;6096.72564734588;6101.481374083252;6110.21867679903;6155.045967874987;6160.507159427235;6068.423499767515;6091.944896581856;6100.278413292402;6119;6132.115494996328;6109.655875707337;6145.815625531151;6150.415710507495;6151.446369826737;6172.043333283348;4835.709857408567;4886.926696099561;4913.926291105637;4933.753312334369;4966.255061740768;4367.563243675607;4389.604935555815;4394.231009573312;4411.470623525133;4443.955670417449;5749.8562535936935;5773.8556536086935;5774.855628609318;5790.305163380422;5823.068309070529;6201.007838745779;6208.2239720034995;6218.844528886723;6225.252969643671;6227.875442491216;5602.607817452821;5621.887562248732;5656.575756818255;5748.109043098327;5778;5356.46435356469;5360.973195134077;5371.086915224421;5373.382061063028;5393.78424863009;6178.814635560851;6193.040078787795;6196;6196.721147548461;6238.532110091671;6127.938720612915;6165.229346331708;6176.722047507783;6182.536309776695;6184.81445556616;6159;6218.409251121137;6228.377162283917;6247.5001999840815;6272.874542509216;6154.3845615438095;6161.815145545641;6172.444479996821;6172.567920245539;6184.81445556634;4970.527799859007;6136.355682653436;6219.191505104308;6223.688815559294;6228.28374736893;5974.402559744165;5996.970015149896;6037.909431358621;6040;6117.510599152146;4739.4075740532435;6005.939940600538;6071.939280607137;6072.14989901423;6075.331713511422;5902.5277977762535;5914.58597898143;5916.408359164049;5919.704014799329;5923.466887980103;5907.704614769158;5990.3710110439515;5995.520358371407;6059.666718330534;6080.270367555921;5764.567657425794;5801.361850196559;5818.272715910512;5826;5864.970675146597 22:06:55 INFO - PROCESS | 1972 | |1;ext.html;488.367564004614;509.31497136351607;526.5445389737873;547.2639300141309;548.755803667368;30339;42476.78761606191;42901.35647965283;43029;43569;42308;43409.7829510852;43696;43763;43787.90530236738;9409.482478463682;9568.712938611852;9573.52132393381;9586.23310135191;9603.4718090505;9480.525973701322;9526.714198574055;9590.08894155054;9593.328467007312;9610.711678649617;9579;9624.422534647909;9642.180414664763;9643;9662.468564228964;9515.666951656693;9574.856377154349;9580.61677532898;9589;9614.375065620747;9432;9494.430334179971;9499.95500494945;9506.429614223169;9542.618295268181;39412.60587394118;39458;39539.81380558588;39774;40331.59668403337;3162.2012672753763;3331.3170799986187;3740.981295093507;3751.906202344936;3987.6610488108545;26243.606345904635;30460.8476957616;31745;31987.680123198934;32252.193695157574;3180.507021411685;3193.4411477991257;3195.584574005388;3315.602127744662;3333.233356328034;474467;480361;480531.1681299168;482544;493685;34062;61348.38651613516;61458.38541614527;61473.07790383148;61716.69141654263;28960;35794.64205357965;35806.82096589501;35826;35878.820605896806;14147.221902795445;14261.85738142626;14282.50011249622;14283.78574321386;14298.714025719635;11536.826947595793;11570;11585.6524304271;11616.825747613793;11624.709382265512;7727.574983375968;7761.758920345542;7767.456278060595;7815.179406162385;7837.7648670539975;3242.4812030075545;3269.8038117713013;3271.1985563537087;3279.065466342081;3294.275259442919;922.561783152997;930.423137654645;973.3089506450499;973.9318247722733;994.8358520844124;22926.082956681545;22944.885275573848;30334;31185.532217016764;31258;1010.5242156716075;1019.1591936652292;1031.1441503552035;1129.3562669278433;1155.3010428690689;13806.516771913135;15189.848101519065;15772;15816.683666326839;16082.312921801846;650311;657831;658526;660199;663704;59397.703011484664;60069.098963515586;60147;60189.69905150446;60291;1218.3908045977012;1273.5351596667335;1277.4570807406815;1357.0636260979893;1363.12078709232;29577.556336654536;30016.549751754177;31566.526502102945;32256.516152258206;32541.861034863665;46808.765956171366;49331;56955;57290.713546432;57465.85068298527;566204;569489;569966;570347;572401;23738;24223.394415139763;26196.73803261943;26828.731712682624;27177.86411068011;44096.779516102215;48306.792330192024;48348.033039339716;48889.511104888494;48945;28351.149465516068;38701.80649096736;39181.21637567176;39336;39858.601413986646;38212.808935955145;39576.81269561918;40236;40767.59232407638;41450;37346.626533734314;37708.62291377161;38175;38291.6170838288;38336;32746;33943.151421214665;35275;35320.47019294661;35374.64625353713;25321.240362789147;25540.744592553838;25834.87082564575;25884.832021731134;25925.611115833653 22:06:55 INFO - PROCESS | 1972 | |2;jquery.html;361.61488015263745;363.2353895050918;373.72531189575665;385.55275879979195;392.9587393323701;11666.824997625032;12196.024318054568;12325;12346.197497162679;19629.901850490747;21445.67831482529;22778.430539236488;22797.4300642484;22844.65733014006;22917.77082229177;5948.018576934801;6443.387878151568;6793.320667933217;6916.619585922772;6927.0648462457675;6917;6926.411255043327;6966.094407726989;6987.336203060727;6994.510384273103;6647.50143739219;6937.895931561005;6982.3715865572085;7014.22843487216;7018.4385249180195;6555.836104097388;6906.205786334585;6948.583085014865;6968.895466568006;6986.685599148025;6544.9345506544805;6545.821752084623;6559.639219842907;6635.8009259722285;6641.402273795382;23066.884665576734;23176.188833390752;28807.135785926246;29034.709652903413;29303.413931721247;2335.8832058397184;2368.59733845245;2525.4191535946834;2531.253280282321;2616.188981415748;14314.928425357806;16794.580135496588;17118.40085596998;17159;17417.65164696699;1953.5702145527962;2029.1984666056971;2070.3892351756267;2080.2615071649498;2082.3648787119923;114427;115417;118767.2184917227;137983.6201637991;145073;16785.91607041957;19741;20990.370288891358;21393.358199254046;21520.677189842165;35693.64306356955;35751.4637280441;35804.820975895476;35925.10187245288;35928;10335.94832025835;10562.20783441245;10722.158627963596;10725.034746872663;10960.013598776148;8652.3510736695;8736.082711315348;8769.342299327576;8908.8663670045;8968.955155224183;7743.574103424366;9393.624255029723;9721.513924303756;9770.847862907272;9878.308518403786;3137.2313783122822;3610.332088563624;3718.3121122592406;3732.384156614128;3733.4586484959527;769.4344656677338;797.9401544884157;857.4855086947781;909.4043401571981;949.943003419797;21201.57596848085;21616.459588510097;21866.671999920014;21945;21967.011484483235;881.7663319220412;905.6060613633091;906.7007887397143;928.4336554701626;935.5602866652663;11032.28290161137;11496.77006459866;11589.130815188895;11609.883901161049;11620.477078531487;578411;586563;599067;605412;614281;117798.4110079444;127431;127941;128130;128915;899.1817446124127;909.2589539525266;955.3980991975011;957.042957042957;968.5496244246318;19033;19327.710084349026;19564.60870782548;19581;19642;53240.20139697985;54521;55328.08398950131;55713;55892;77219;77476;77625.61187194027;79232.60383698044;79475.60262198652;7638.618069096634;7779.4554381192775;7912.4856884302335;7924.286814186751;7971.282584567417;9054.366194366332;9946.950265248917;12259.387030648253;12341.50633974631;12459.127861050001;10777.838332425177;10839.458027098455;10871.075958543612;10880.183986201226;10907.672769816918;10379.84430233532;10415.218858585788;10464.267501274837;10640.361578305326;10687.732806679895;10290.970902909648;10797.082248009006;10811.189160813128;10850.403227822546;11027.724306892393;6508.967455162694;6835.282295358916;7367.26327367259;7374.741884034248;7400.926865604565;9242.676506322246;10157.644482443078;10756.354618722902;11073.94463027712;11162.609308674157 22:06:55 INFO - PROCESS | 1972 | |3;mootools.html;1398.608389650898;1554.5336399080277;1575.1730341570676;1828.8354048135666;1975.9604807903834;6257.655828929407;7877.684892604296;8374.246317831394;8893.777655558599;8927.464352138877;8729.91270087299;8831.867521987158;8834.469931804097;8846.24806891415;8849.380543361951;2351.8824058797036;2377.346229786805;2379.7501262367464;2380.1550449590404;2386.2006227913585;2343.0744855781954;2371.2649078785544;2372.1578839511985;2384.916527921523;2388.199953015742;2335.7313908900437;2352.2355234548754;2356.6582845487396;2357.3870793593705;2365.503244318695;2312.826538009639;2331.8484298520543;2336.5910965580956;2343.871087090209;2368.6802281692094;1965.9901700491548;2323.1984965186984;2323.744388117306;2326.1044497868274;2327.755585663515;8761.912380876174;8821.647134114628;8881.200691937756;8905.955470222672;8910.55447227636;5205.869853253661;5402.540784033362;5420.457954204588;5423.132298832207;5451.155070964007;3580.5166302549083;3587.928241435183;3640.854365825364;3647.76289541179;3668.743187976843;1043.1498328861953;1053.1732589916878;1056.6513050693252;1065.6589891234808;1076.3703233608348;11613.012893903944;11754.118441116865;11767.176297659082;11781;11831.290122592673;4374.5625437456;4546.636269098464;4642;4653.511381304982;4660.487346391894;9140;9167.862482062774;9177.816443671089;9193.264538836876;9210.263178945668;5247.658902171423;5275.261463395128;5282.788688452496;5289.18017707256;5301.416844147141;3682.226732386229;4145.751254924714;4571.519990401027;4576.222042252825;4946.109700253917;3757.5866654667966;3794.449804778347;3845.307844587945;3870.283997460479;3882.417637354363;974.192872222018;1147.1167201254987;1154.3593305715408;1164.545827127421;1169.0063446070772;869.387082107113;870.3820287595878;877.6840337478502;901.5717534171347;932.5430539035959;4278.507971583245;5153.536181743586;5448.264484294569;5675.233843431167;5728.570357223141;416.93537501687285;421.1030505024279;423.8558889977361;428.2227756621722;429.32810152111847;3649.7445178837756;3736.252749450121;3738.682212011955;3740.2893450244364;3804.7336686432236;10147.188224941987;10339;10755.139588832875;10922;10926.071283940795;10504.684859454228;10745.462726863781;10763.892361076445;10770.299930504492;10772.138228941823;7852.136265010844;8012.599370031475;8226.835463290701;8298.917010829935;8312.210340017567;4634.397528321431;5218.634695571273;5659.717014149359;5678.545716342765;5813.534917206698;9821.312508124363;9824.901750982399;9833.164181044405;9853.950730246303;9926.702198934043;9346.392484488486;9676.661316853877;10256.38461692301;10266.538005789607;10359.96400359958;7028.9297107030325;7295.927040729737;7436.330730234305;7678.731244406419;7697.807554811175;8191.590420479071;8365.832683346178;8384.329253659815;8454.57727113654;8503.064662887202;7552.207018263003;7558.886616700864;7612.961935190288;7625.123110842324;7678.462507624636;7369.963150184215;7422;7436.442266830118;7501.249875012455;7556.546607203585;6988.40598549129;7088.326608972139;7121.82195445118;7147.82130446743;7190.6404679764755;4800.783964721526;4813.470518243061;4837.975810120927;4879.756012199305;5034.144195486703;4359.803808828547;4912.1649319615035;4939.580135688507;5002.299678045149;5011.148104822116 22:06:55 INFO - PROCESS | 1972 | |4;prototype.html;231.7358211638732;266.2757300143609;296.09985643643324;305.72055945866543;308.60498561840836;4115.374427101293;4643.373144625474;4894.583960363365;5106.361704786902;5171.586273098153;4469.865904022877;4811.446683631383;5081.6696914700615;5091.949080509194;5140.686690989051;3949.526056873165;3979.582143874895;3989.2021595680835;3992.686070561427;4025.1144748155357;3837.4841937434835;3983.24318379507;3996.440498330236;4000.519937607491;4016.49793775778;3595.6740015485702;3966.662833659128;3979.1047014421815;3997.980514968679;3999.3201155803436;3931.9017024574614;3958.9802050989706;3967.4445577619013;3972.483577134983;3972.880813575597;3453.322211844403;3470.8091054991964;3484.372812893678;3488.7963652539834;3488.982555087234;4873.731944743037;5029.3964724232965;5044.041632089928;5046.21783623539;5070.467600901889;4478.350639157336;4490;4503.864884053483;4536.523665015159;4548.929472605978;5385.649932754398;5391.353037635469;5399.406065332811;5399.811006614749;5437.728113594305;3187.7927934684403;3560.6973407260416;3629.9274014519824;3781.3760729479604;3797.626483447845;4624.28323609841;4855.198892182786;5292.311999440125;5639.15412688096;5659.773609055674;3836.712246581518;3838.616138386195;3844.8462061517785;3846.9615303846604;3854.4989151410136;3837.827297771607;3914.4911161549385;3924.0778417071965;3926.960730392717;3931.0958479549863;3698.8705395311035;4073.7759423231414;4458.732476051382;4539.6368290536675;4558.652294068557;4231.915361692811;5353.9196912046355;5377.311344327836;5382.77033779729;5424.077906755782;1154.4054811771944;1234.802431610938;1295.2811189789757;1299.8050292456019;1337.5452346202144;777.3470284960547;835.849547081519;919.9531043428452;920.7237828651378;925.7916968682127;4371.759553224603;4549.431321084864;5161.948380516222;5180.922286165711;5183.377994640592;4849.563539281482;5149;5232.686038837682;5419.972900135474;5637.520810731052;5086.287919691246;5086.847394578169;5091.541761241506;5104.285400043997;5125.309776960582;2481.85108893467;2889.8699558519916;2920.576516405152;2928.1654728402304;2941.6468424524533;4752.477227504972;5335.653182543122;5453.018456677757;5658.886822263532;5782.045962416154;4970.478099799541;5344;5354.598405119554;5778.6821724804695;5797.594168408255;5654.547636189095;5803.47768700819;5824.767009319665;5831.446012628793;5909.261342332295;4561.521040290721;4935.975320123376;4947.678400904074;5014.022265658162;5663.631863928831;4061.634452899135;5146.713321669583;5507.752151153128;5533.944660553504;5567.8886422272135;4582.358469814295;5788.507976822018;5799.246098007232;5809.50619197373;5845.386234445322;3276.4921437177277;3762.6425489578446;3801.6388443097862;3804.904877378088;3811.352070148026;5247.265382846481;5628.380878103487;5634.661920284796;5643.181738647955;5672.269957662952;5172.5603323716405;5478.91781623268;5506.760978779903;5544.889102217852;5601.60788744784;5430.294061771944;5460.453954604508;5471.179323101566;5480.91778623313;5486.159688218183;4736.50266722003;4975.825846095369;5061.96229772903;5213.791448342024;5245.239440281061;5485.040117979258;5499.670019798665;5507.604192176416;5516.310461192351;5580.525655319181;4301.655867530528;5009.922866583702;5137.974310128426;5332.600054995968;5374.677519348852 22:06:55 INFO - PROCESS | 1972 | |5;yui.html;717.9497435179538;749.1534565940486;767.9001729775129;778.8325510015345;864.4640322999741;13117.934410327958;15676.84323156768;15796.842031579681;15814.288357023932;15879.444219452336;14202.28988550571;14330.498432554863;14331.928340358283;14362.928185359086;14363.56909292723;685.0614657918659;708.4509505133511;856.0711627883738;858.3948316436897;882.3250213586612;874.7944233105216;879.705298724928;879.7712594725385;880.0451510111504;880.9295256379474;936.8313703533362;937.5078084005884;938.5776400619715;939.4410325856105;939.8496240601505;724.4457989637931;747.6336595068432;902.9909700902973;916.1296768070359;931.9347645664773;684.5174152222671;688.8518968421813;689.2521614048763;690.8687349403597;692.0829900382014;14540.781888271684;14551.490697825526;14822.110673359633;14987.925060374628;15062.397504099823;11444.771104577861;13749.450021999108;13932.651683707887;13986;14120.71758564823;12054.939725301318;12311.384430778426;12484.438200281009;12846.421911014028;13046.412911418915;4403.713758605712;4408.096340250273;4489.820407183709;4596.264597664358;4696.647751418657;89915;115394.42302788432;116708.41645791802;117322;120954;9102.408343457653;10703;10757.56969721218;10778.4071876046;10905.645322162472;20895.95520224013;21766.455838603844;21886.89056554739;21896.343109706733;21915.780842191692;7467.715046405798;7505.362044226193;7614.200508946592;7643.923560764432;7921.762347129596;3825.5600605930117;4156.958430415718;4218.734379686082;4423.889402764957;4590.655700822452;3423.623401425841;3891.6497515223764;4081.1429599783783;4088.2436749201493;4102;708.2209569473538;724.0623392706458;728.1517032656895;731.4331393170336;737.71229220604;509.5923261390872;542.5973857578205;589.2016317889284;607.1439270628392;647.3623480871338;8667.696630617898;9213.12475314844;9313.301502387212;9360.063993600585;9387.389819661701;534.3374215972244;564.1875698993518;570.2045646323355;645.2643985856128;654.6824789976857;4286.121345124242;4350.564943505624;4588.545520457284;4653.7207767534055;4688.578027977498;98742;142342;152812;156094;156469;130482;132338;134361;134393;137192;114125.28812067826;114867;115113.4244328773;115660.42169789097;119646.40176799234;7717.58698243155;7869.803254918673;8858;8874.778130546789;8957.143284385425;46950;63948.68025659842;64989.02516462162;65036.674816625615;66198.66900665466;89866;95632.52183739036;95908;96713;97579;11680.123990700562;12225.633231003085;12238.49110932239;12244.326562039174;12460.750784984068;12734.61796146117;12903.161294515827;13008.479660813462;13102.082854200115;13125.54060607874;10244.487775611338;12005.25398418823;12068.879311206776;12171;12539.059570532065;11940.52237910474;12046.457909393923;12393.442295096562;12554.937225313815;12564.811527827273;11753.706157346134;12082.577109801116;12390.5663301784;12420.130590858915;12488.37558122072;9433.622655093719;9572.186364158846;9629.903700963181;9724.222062235145;9876;8632.827343452971;9581.904180958101;9632.566534506104;9639;9650.179734722346 22:06:55 INFO - PROCESS | 1972 | __end_tp_report 22:06:55 INFO - PROCESS | 1972 | __start_cc_report 22:06:55 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,1809 22:06:55 INFO - PROCESS | 1972 | __end_cc_report 22:06:55 INFO - PROCESS | 1972 | __startTimestamp1476767215434__endTimestamp 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | ------- Summary: start ------- 22:06:55 INFO - PROCESS | 1972 | Number of tests: 6 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | [#0] dojo.html Cycles:165 Average:5680.27 Median:5902.53 stddev:630.42 (10.7%) stddev-sans-first:603.24 22:06:55 INFO - PROCESS | 1972 | Values: 3266.1 3300.9 3306.0 3342.8 3348.6 5512.1 5632.9 5659.8 5729.5 5776.9 5659.9 5671.1 5676.9 5686.6 5698.3 5103.0 5125.1 5145.3 5146.5 5161.3 5222.2 5229.8 5236.5 5241.1 5249.9 4592.8 5176.0 5202.6 5211.2 5243.0 5244.6 5251.6 5257.4 5265.4 5311.3 5004.4 5117.9 5208.4 5216.2 5217.8 5595.1 5612.5 5660.7 5685.3 5686.5 6119.7 6137.3 6146.5 6166.8 6240.2 6093.8 6151.0 6153.7 6155.3 6161.9 5627.2 5689.6 5693.7 5707.1 5748.2 6138.9 6153.6 6160.7 6168.3 6172.8 6075.6 6100.4 6105.6 6105.8 6108.9 6096.7 6101.5 6110.2 6155.0 6160.5 6068.4 6091.9 6100.3 6119.0 6132.1 6109.7 6145.8 6150.4 6151.4 6172.0 4835.7 4886.9 4913.9 4933.8 4966.3 4367.6 4389.6 4394.2 4411.5 4444.0 5749.9 5773.9 5774.9 5790.3 5823.1 6201.0 6208.2 6218.8 6225.3 6227.9 5602.6 5621.9 5656.6 5748.1 5778.0 5356.5 5361.0 5371.1 5373.4 5393.8 6178.8 6193.0 6196.0 6196.7 6238.5 6127.9 6165.2 6176.7 6182.5 6184.8 6159.0 6218.4 6228.4 6247.5 6272.9 6154.4 6161.8 6172.4 6172.6 6184.8 4970.5 6136.4 6219.2 6223.7 6228.3 5974.4 5997.0 6037.9 6040.0 6117.5 4739.4 6005.9 6071.9 6072.1 6075.3 5902.5 5914.6 5916.4 5919.7 5923.5 5907.7 5990.4 5995.5 6059.7 6080.3 5764.6 5801.4 5818.3 5826.0 5865.0 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | [#1] ext.html Cycles:180 Average:69072.25 Median:39816.30 stddev:153880.71 (386.5%) stddev-sans-first:154226.22 22:06:55 INFO - PROCESS | 1972 | Values: 488.4 509.3 526.5 547.3 548.8 30339.0 42476.8 42901.4 43029.0 43569.0 42308.0 43409.8 43696.0 43763.0 43787.9 9409.5 9568.7 9573.5 9586.2 9603.5 9480.5 9526.7 9590.1 9593.3 9610.7 9579.0 9624.4 9642.2 9643.0 9662.5 9515.7 9574.9 9580.6 9589.0 9614.4 9432.0 9494.4 9500.0 9506.4 9542.6 39412.6 39458.0 39539.8 39774.0 40331.6 3162.2 3331.3 3741.0 3751.9 3987.7 26243.6 30460.8 31745.0 31987.7 32252.2 3180.5 3193.4 3195.6 3315.6 3333.2 474467.0 480361.0 480531.2 482544.0 493685.0 34062.0 61348.4 61458.4 61473.1 61716.7 28960.0 35794.6 35806.8 35826.0 35878.8 14147.2 14261.9 14282.5 14283.8 14298.7 11536.8 11570.0 11585.7 11616.8 11624.7 7727.6 7761.8 7767.5 7815.2 7837.8 3242.5 3269.8 3271.2 3279.1 3294.3 922.6 930.4 973.3 973.9 994.8 22926.1 22944.9 30334.0 31185.5 31258.0 1010.5 1019.2 1031.1 1129.4 1155.3 13806.5 15189.8 15772.0 15816.7 16082.3 650311.0 657831.0 658526.0 660199.0 663704.0 59397.7 60069.1 60147.0 60189.7 60291.0 1218.4 1273.5 1277.5 1357.1 1363.1 29577.6 30016.5 31566.5 32256.5 32541.9 46808.8 49331.0 56955.0 57290.7 57465.9 566204.0 569489.0 569966.0 570347.0 572401.0 23738.0 24223.4 26196.7 26828.7 27177.9 44096.8 48306.8 48348.0 48889.5 48945.0 28351.1 38701.8 39181.2 39336.0 39858.6 38212.8 39576.8 40236.0 40767.6 41450.0 37346.6 37708.6 38175.0 38291.6 38336.0 32746.0 33943.2 35275.0 35320.5 35374.6 25321.2 25540.7 25834.9 25884.8 25925.6 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | [#2] jquery.html Cycles:180 Average:36468.97 Median:35864.96 stddev:99601.74 (277.7%) stddev-sans-first:99844.25 22:06:55 INFO - PROCESS | 1972 | Values: 361.6 363.2 373.7 385.6 393.0 11666.8 12196.0 12325.0 12346.2 19629.9 21445.7 22778.4 22797.4 22844.7 22917.8 5948.0 6443.4 6793.3 6916.6 6927.1 6917.0 6926.4 6966.1 6987.3 6994.5 6647.5 6937.9 6982.4 7014.2 7018.4 6555.8 6906.2 6948.6 6968.9 6986.7 6544.9 6545.8 6559.6 6635.8 6641.4 23066.9 23176.2 28807.1 29034.7 29303.4 2335.9 2368.6 2525.4 2531.3 2616.2 14314.9 16794.6 17118.4 17159.0 17417.7 1953.6 2029.2 2070.4 2080.3 2082.4 114427.0 115417.0 118767.2 137983.6 145073.0 16785.9 19741.0 20990.4 21393.4 21520.7 35693.6 35751.5 35804.8 35925.1 35928.0 10335.9 10562.2 10722.2 10725.0 10960.0 8652.4 8736.1 8769.3 8908.9 8969.0 7743.6 9393.6 9721.5 9770.8 9878.3 3137.2 3610.3 3718.3 3732.4 3733.5 769.4 797.9 857.5 909.4 949.9 21201.6 21616.5 21866.7 21945.0 21967.0 881.8 905.6 906.7 928.4 935.6 11032.3 11496.8 11589.1 11609.9 11620.5 578411.0 586563.0 599067.0 605412.0 614281.0 117798.4 127431.0 127941.0 128130.0 128915.0 899.2 909.3 955.4 957.0 968.5 19033.0 19327.7 19564.6 19581.0 19642.0 53240.2 54521.0 55328.1 55713.0 55892.0 77219.0 77476.0 77625.6 79232.6 79475.6 7638.6 7779.5 7912.5 7924.3 7971.3 9054.4 9947.0 12259.4 12341.5 12459.1 10777.8 10839.5 10871.1 10880.2 10907.7 10379.8 10415.2 10464.3 10640.4 10687.7 10291.0 10797.1 10811.2 10850.4 11027.7 6509.0 6835.3 7367.3 7374.7 7400.9 9242.7 10157.6 10756.4 11073.9 11162.6 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | [#3] mootools.html Cycles:180 Average:5610.77 Median:4825.72 stddev:3208.09 (66.5%) stddev-sans-first:3201.48 22:06:55 INFO - PROCESS | 1972 | Values: 1398.6 1554.5 1575.2 1828.8 1976.0 6257.7 7877.7 8374.2 8893.8 8927.5 8729.9 8831.9 8834.5 8846.2 8849.4 2351.9 2377.3 2379.8 2380.2 2386.2 2343.1 2371.3 2372.2 2384.9 2388.2 2335.7 2352.2 2356.7 2357.4 2365.5 2312.8 2331.8 2336.6 2343.9 2368.7 1966.0 2323.2 2323.7 2326.1 2327.8 8761.9 8821.6 8881.2 8906.0 8910.6 5205.9 5402.5 5420.5 5423.1 5451.2 3580.5 3587.9 3640.9 3647.8 3668.7 1043.1 1053.2 1056.7 1065.7 1076.4 11613.0 11754.1 11767.2 11781.0 11831.3 4374.6 4546.6 4642.0 4653.5 4660.5 9140.0 9167.9 9177.8 9193.3 9210.3 5247.7 5275.3 5282.8 5289.2 5301.4 3682.2 4145.8 4571.5 4576.2 4946.1 3757.6 3794.4 3845.3 3870.3 3882.4 974.2 1147.1 1154.4 1164.5 1169.0 869.4 870.4 877.7 901.6 932.5 4278.5 5153.5 5448.3 5675.2 5728.6 416.9 421.1 423.9 428.2 429.3 3649.7 3736.3 3738.7 3740.3 3804.7 10147.2 10339.0 10755.1 10922.0 10926.1 10504.7 10745.5 10763.9 10770.3 10772.1 7852.1 8012.6 8226.8 8298.9 8312.2 4634.4 5218.6 5659.7 5678.5 5813.5 9821.3 9824.9 9833.2 9854.0 9926.7 9346.4 9676.7 10256.4 10266.5 10360.0 7028.9 7295.9 7436.3 7678.7 7697.8 8191.6 8365.8 8384.3 8454.6 8503.1 7552.2 7558.9 7613.0 7625.1 7678.5 7370.0 7422.0 7436.4 7501.2 7556.5 6988.4 7088.3 7121.8 7147.8 7190.6 4800.8 4813.5 4838.0 4879.8 5034.1 4359.8 4912.2 4939.6 5002.3 5011.1 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | [#4] prototype.html Cycles:180 Average:4405.34 Median:4973.15 stddev:1335.59 (26.9%) stddev-sans-first:1302.08 22:06:55 INFO - PROCESS | 1972 | Values: 231.7 266.3 296.1 305.7 308.6 4115.4 4643.4 4894.6 5106.4 5171.6 4469.9 4811.4 5081.7 5091.9 5140.7 3949.5 3979.6 3989.2 3992.7 4025.1 3837.5 3983.2 3996.4 4000.5 4016.5 3595.7 3966.7 3979.1 3998.0 3999.3 3931.9 3959.0 3967.4 3972.5 3972.9 3453.3 3470.8 3484.4 3488.8 3489.0 4873.7 5029.4 5044.0 5046.2 5070.5 4478.4 4490.0 4503.9 4536.5 4548.9 5385.6 5391.4 5399.4 5399.8 5437.7 3187.8 3560.7 3629.9 3781.4 3797.6 4624.3 4855.2 5292.3 5639.2 5659.8 3836.7 3838.6 3844.8 3847.0 3854.5 3837.8 3914.5 3924.1 3927.0 3931.1 3698.9 4073.8 4458.7 4539.6 4558.7 4231.9 5353.9 5377.3 5382.8 5424.1 1154.4 1234.8 1295.3 1299.8 1337.5 777.3 835.8 920.0 920.7 925.8 4371.8 4549.4 5161.9 5180.9 5183.4 4849.6 5149.0 5232.7 5420.0 5637.5 5086.3 5086.8 5091.5 5104.3 5125.3 2481.9 2889.9 2920.6 2928.2 2941.6 4752.5 5335.7 5453.0 5658.9 5782.0 4970.5 5344.0 5354.6 5778.7 5797.6 5654.5 5803.5 5824.8 5831.4 5909.3 4561.5 4936.0 4947.7 5014.0 5663.6 4061.6 5146.7 5507.8 5533.9 5567.9 4582.4 5788.5 5799.2 5809.5 5845.4 3276.5 3762.6 3801.6 3804.9 3811.4 5247.3 5628.4 5634.7 5643.2 5672.3 5172.6 5478.9 5506.8 5544.9 5601.6 5430.3 5460.5 5471.2 5480.9 5486.2 4736.5 4975.8 5062.0 5213.8 5245.2 5485.0 5499.7 5507.6 5516.3 5580.5 4301.7 5009.9 5138.0 5332.6 5374.7 22:06:55 INFO - PROCESS | 1972 | 22:06:55 INFO - PROCESS | 1972 | [#5] yui.html Cycles:180 Average:24774.42 Median:4539.18 stddev:40268.78 (887.1%) stddev-sans-first:40341.24 22:06:55 INFO - PROCESS | 1972 | Values: 717.9 749.2 767.9 778.8 864.5 13117.9 15676.8 15796.8 15814.3 15879.4 14202.3 14330.5 14331.9 14362.9 14363.6 685.1 708.5 856.1 858.4 882.3 874.8 879.7 879.8 880.0 880.9 936.8 937.5 938.6 939.4 939.8 724.4 747.6 903.0 916.1 931.9 684.5 688.9 689.3 690.9 692.1 14540.8 14551.5 14822.1 14987.9 15062.4 11444.8 13749.5 13932.7 13986.0 14120.7 12054.9 12311.4 12484.4 12846.4 13046.4 4403.7 4408.1 4489.8 4596.3 4696.6 89915.0 115394.4 116708.4 117322.0 120954.0 9102.4 10703.0 10757.6 10778.4 10905.6 20896.0 21766.5 21886.9 21896.3 21915.8 7467.7 7505.4 7614.2 7643.9 7921.8 3825.6 4157.0 4218.7 4423.9 4590.7 3423.6 3891.6 4081.1 4088.2 4102.0 708.2 724.1 728.2 731.4 737.7 509.6 542.6 589.2 607.1 647.4 8667.7 9213.1 9313.3 9360.1 9387.4 534.3 564.2 570.2 645.3 654.7 4286.1 4350.6 4588.5 4653.7 4688.6 98742.0 142342.0 152812.0 156094.0 156469.0 130482.0 132338.0 134361.0 134393.0 137192.0 114125.3 114867.0 115113.4 115660.4 119646.4 7717.6 7869.8 8858.0 8874.8 8957.1 46950.0 63948.7 64989.0 65036.7 66198.7 89866.0 95632.5 95908.0 96713.0 97579.0 11680.1 12225.6 12238.5 12244.3 12460.8 12734.6 12903.2 13008.5 13102.1 13125.5 10244.5 12005.3 12068.9 12171.0 12539.1 11940.5 12046.5 12393.4 12554.9 12564.8 11753.7 12082.6 12390.6 12420.1 12488.4 9433.6 9572.2 9629.9 9724.2 9876.0 8632.8 9581.9 9632.6 9639.0 9650.2 22:06:55 INFO - PROCESS | 1972 | -------- Summary: end -------- 22:06:55 INFO - PROCESS | 1972 | 22:06:56 INFO - TEST-INFO | 1972: exit 0 22:06:56 INFO - TEST-OK | dromaeo_css | took 1120417ms 22:06:56 INFO - TEST-START | kraken 22:06:56 INFO - operating with platform_type : mac_ 22:06:56 INFO - Initialising browser for kraken test... 22:06:56 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpeSArfK/profile http://localhost:54400/getInfo.html) 22:06:58 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 22:06:58 INFO - PROCESS | 1976 | colorDepth:24 22:06:58 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 22:06:58 INFO - PROCESS | 1976 | __metrics 22:06:58 INFO - PROCESS | 1976 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:06:58 INFO - PROCESS | 1976 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:06:59 INFO - TEST-INFO | 1976: exit 0 22:06:59 INFO - Browser initialized. 22:06:59 INFO - Running cycle 1/1 for kraken test... 22:06:59 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpeSArfK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:11 INFO - PROCESS | 1977 | RSS: Main: 248483840 22:07:11 INFO - PROCESS | 1977 | 22:07:14 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54400/tests/kraken/driver.html?testName=audio-beat-detection) 22:07:15 INFO - PROCESS | 1977 | RSS: Main: 305135616 22:07:15 INFO - PROCESS | 1977 | 22:07:17 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54400/tests/kraken/driver.html?testName=audio-dft) 22:07:18 INFO - PROCESS | 1977 | RSS: Main: 306008064 22:07:18 INFO - PROCESS | 1977 | 22:07:22 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54400/tests/kraken/driver.html?testName=audio-fft) 22:07:22 INFO - PROCESS | 1977 | RSS: Main: 395874304 22:07:22 INFO - PROCESS | 1977 | 22:07:24 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54400/tests/kraken/driver.html?testName=audio-oscillator) 22:07:25 INFO - PROCESS | 1977 | RSS: Main: 297873408 22:07:25 INFO - PROCESS | 1977 | 22:07:27 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:07:28 INFO - PROCESS | 1977 | RSS: Main: 299462656 22:07:28 INFO - PROCESS | 1977 | 22:07:31 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54400/tests/kraken/driver.html?testName=imaging-darkroom) 22:07:31 INFO - PROCESS | 1977 | RSS: Main: 338808832 22:07:31 INFO - PROCESS | 1977 | 22:07:34 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54400/tests/kraken/driver.html?testName=imaging-desaturate) 22:07:35 INFO - PROCESS | 1977 | RSS: Main: 338403328 22:07:35 INFO - PROCESS | 1977 | 22:07:38 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54400/tests/kraken/driver.html?testName=json-parse-financial) 22:07:38 INFO - PROCESS | 1977 | RSS: Main: 336424960 22:07:38 INFO - PROCESS | 1977 | 22:07:40 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:07:40 INFO - PROCESS | 1977 | RSS: Main: 312635392 22:07:40 INFO - PROCESS | 1977 | 22:07:42 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:07:43 INFO - PROCESS | 1977 | RSS: Main: 315695104 22:07:43 INFO - PROCESS | 1977 | 22:07:45 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:07:46 INFO - PROCESS | 1977 | RSS: Main: 317517824 22:07:46 INFO - PROCESS | 1977 | 22:07:49 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:07:50 INFO - PROCESS | 1977 | RSS: Main: 326819840 22:07:50 INFO - PROCESS | 1977 | 22:07:53 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:07:53 INFO - PROCESS | 1977 | RSS: Main: 326725632 22:07:53 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:54400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54400/tests/kraken/driver.html?testName=ai-astar) 22:07:55 INFO - PROCESS | 1977 | RSS: Main: 370290688 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | __start_tp_report 22:07:55 INFO - PROCESS | 1977 | _x_x_mozilla_page_load 22:07:55 INFO - PROCESS | 1977 | _x_x_mozilla_page_load_details 22:07:55 INFO - PROCESS | 1977 | |i|pagename|runs| 22:07:55 INFO - PROCESS | 1977 | |0;ai-astar;104;114;114;112;113;114;114;113;112;115 22:07:55 INFO - PROCESS | 1977 | |1;audio-beat-detection;169;143;143;151;143;146;141;116;143;112 22:07:55 INFO - PROCESS | 1977 | |2;audio-dft;185;185;184;185;185;184;199;259;176;254 22:07:55 INFO - PROCESS | 1977 | |3;audio-fft;80;59;60;90;61;59;60;76;106;82 22:07:55 INFO - PROCESS | 1977 | |4;audio-oscillator;89;70;97;101;97;98;92;68;69;91 22:07:55 INFO - PROCESS | 1977 | |5;imaging-gaussian-blur;90;98;132;87;89;87;91;88;89;86 22:07:55 INFO - PROCESS | 1977 | |6;imaging-darkroom;94;95;96;109;133;95;95;96;95;94 22:07:55 INFO - PROCESS | 1977 | |7;imaging-desaturate;82;78;80;82;81;82;82;85;87;105 22:07:55 INFO - PROCESS | 1977 | |8;json-parse-financial;57;55;55;54;54;55;54;54;55;54 22:07:55 INFO - PROCESS | 1977 | |9;json-stringify-tinderbox;66;79;80;72;74;70;69;70;71;71 22:07:55 INFO - PROCESS | 1977 | |10;stanford-crypto-aes;88;87;87;88;86;95;106;86;91;89 22:07:55 INFO - PROCESS | 1977 | |11;stanford-crypto-ccm;138;161;154;127;153;158;157;158;186;147 22:07:55 INFO - PROCESS | 1977 | |12;stanford-crypto-pbkdf2;179;235;196;174;172;174;172;165;174;172 22:07:55 INFO - PROCESS | 1977 | |13;stanford-crypto-sha256-iterative;67;71;70;70;68;68;70;77;85;72 22:07:55 INFO - PROCESS | 1977 | __end_tp_report 22:07:55 INFO - PROCESS | 1977 | __start_cc_report 22:07:55 INFO - PROCESS | 1977 | _x_x_mozilla_cycle_collect,2020 22:07:55 INFO - PROCESS | 1977 | __end_cc_report 22:07:55 INFO - PROCESS | 1977 | __startTimestamp1476767275708__endTimestamp 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | ------- Summary: start ------- 22:07:55 INFO - PROCESS | 1977 | Number of tests: 14 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.14 (2.8%) stddev-sans-first:1.01 22:07:55 INFO - PROCESS | 1977 | Values: 104.0 114.0 114.0 112.0 113.0 114.0 114.0 113.0 112.0 115.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:143.00 stddev:16.30 (11.4%) stddev-sans-first:13.69 22:07:55 INFO - PROCESS | 1977 | Values: 169.0 143.0 143.0 151.0 143.0 146.0 141.0 116.0 143.0 112.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#2] audio-dft Cycles:10 Average:199.60 Median:185.00 stddev:30.52 (16.5%) stddev-sans-first:31.91 22:07:55 INFO - PROCESS | 1977 | Values: 185.0 185.0 184.0 185.0 185.0 184.0 199.0 259.0 176.0 254.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#3] audio-fft Cycles:10 Average:73.30 Median:68.50 stddev:16.30 (23.8%) stddev-sans-first:17.10 22:07:55 INFO - PROCESS | 1977 | Values: 80.0 59.0 60.0 90.0 61.0 59.0 60.0 76.0 106.0 82.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:91.50 stddev:13.06 (14.3%) stddev-sans-first:13.84 22:07:55 INFO - PROCESS | 1977 | Values: 89.0 70.0 97.0 101.0 97.0 98.0 92.0 68.0 69.0 91.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:89.00 stddev:13.87 (15.6%) stddev-sans-first:14.65 22:07:55 INFO - PROCESS | 1977 | Values: 90.0 98.0 132.0 87.0 89.0 87.0 91.0 88.0 89.0 86.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:95.00 stddev:12.35 (13.0%) stddev-sans-first:12.90 22:07:55 INFO - PROCESS | 1977 | Values: 94.0 95.0 96.0 109.0 133.0 95.0 95.0 96.0 95.0 94.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:82.00 stddev:7.65 (9.3%) stddev-sans-first:8.06 22:07:55 INFO - PROCESS | 1977 | Values: 82.0 78.0 80.0 82.0 81.0 82.0 82.0 85.0 87.0 105.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.53 22:07:55 INFO - PROCESS | 1977 | Values: 57.0 55.0 55.0 54.0 54.0 55.0 54.0 54.0 55.0 54.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:71.50 stddev:4.37 (6.1%) stddev-sans-first:4.01 22:07:55 INFO - PROCESS | 1977 | Values: 66.0 79.0 80.0 72.0 74.0 70.0 69.0 70.0 71.0 71.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:88.00 stddev:6.15 (7.0%) stddev-sans-first:6.46 22:07:55 INFO - PROCESS | 1977 | Values: 88.0 87.0 87.0 88.0 86.0 95.0 106.0 86.0 91.0 89.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:157.50 stddev:15.45 (9.8%) stddev-sans-first:15.28 22:07:55 INFO - PROCESS | 1977 | Values: 138.0 161.0 154.0 127.0 153.0 158.0 157.0 158.0 186.0 147.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.30 Median:174.00 stddev:20.52 (11.8%) stddev-sans-first:21.75 22:07:55 INFO - PROCESS | 1977 | Values: 179.0 235.0 196.0 174.0 172.0 174.0 172.0 165.0 174.0 172.0 22:07:55 INFO - PROCESS | 1977 | 22:07:55 INFO - PROCESS | 1977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:70.50 stddev:5.41 (7.7%) stddev-sans-first:5.45 22:07:55 INFO - PROCESS | 1977 | Values: 67.0 71.0 70.0 70.0 68.0 68.0 70.0 77.0 85.0 72.0 22:07:55 INFO - PROCESS | 1977 | -------- Summary: end -------- 22:07:55 INFO - PROCESS | 1977 | 22:07:56 INFO - TEST-INFO | 1977: exit 0 22:07:56 INFO - TEST-OK | kraken | took 60686ms 22:07:56 INFO - SUITE-END | took 1181s 22:07:56 INFO - Completed test suite (00:19:41) 22:07:56 INFO - javascript benchmark 22:07:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.0854960611023, 3300.9339813203724, 3305.983470082649, 3342.8328583570815, 3348.6483919188486, 5512.062949298619, 5632.915506267399, 5659.801906933259, 5729.455701708342, 5776.884462310752, 5659.943400565993, 5671.120976248678, 5676.914846277309, 5686.573506986972, 5698.287714035746, 5103.030424219386, 5125.077486052509, 5145.33110695611, 5146.459621739719, 5161.251618515313, 5222.242774797652, 5229.843104706865, 5236.476352364771, 5241.109011468059, 5249.921251181236, 4592.839250626229, 5175.9906818170475, 5202.557782588485, 5211.192265198882, 5242.977619364226, 5244.606654500928, 5251.6061295403, 5257.447967963385, 5265.447128051576, 5311.256424100629, 5004.374453193351, 5117.948820511821, 5208.374995000586, 5216.217567364888, 5217.791288348461, 5595.104783234663, 5612.522935550483, 5660.716964151817, 5685.260916080924, 5686.516646085088, 6119.724612392409, 6137.2635283765785, 6146.539009574255, 6166.84582885427, 6240.157578726859, 6093.847653808646, 6150.969245153746, 6153.661548614825, 6155.261368635793, 6161.938380616181, 5627.212190293321, 5689.601727879009, 5693.743781529841, 5707.1153971134545, 5748.19525266463, 6138.917619782795, 6153.630782153085, 6160.722767475474, 6168.321484636686, 6172.753089876444, 6075.574709770273, 6100.382642271707, 6105.5916412017805, 6105.754895139613, 6108.908366374508, 6096.72564734588, 6101.481374083252, 6110.21867679903, 6155.045967874987, 6160.507159427235, 6068.423499767515, 6091.944896581856, 6100.278413292402, 6119.0, 6132.115494996328, 6109.655875707337, 6145.815625531151, 6150.415710507495, 6151.446369826737, 6172.043333283348, 4835.709857408567, 4886.926696099561, 4913.926291105637, 4933.753312334369, 4966.255061740768, 4367.563243675607, 4389.604935555815, 4394.231009573312, 4411.470623525133, 4443.955670417449, 5749.8562535936935, 5773.8556536086935, 5774.855628609318, 5790.305163380422, 5823.068309070529, 6201.007838745779, 6208.2239720034995, 6218.844528886723, 6225.252969643671, 6227.875442491216, 5602.607817452821, 5621.887562248732, 5656.575756818255, 5748.109043098327, 5778.0, 5356.46435356469, 5360.973195134077, 5371.086915224421, 5373.382061063028, 5393.78424863009, 6178.814635560851, 6193.040078787795, 6196.0, 6196.721147548461, 6238.532110091671, 6127.938720612915, 6165.229346331708, 6176.722047507783, 6182.536309776695, 6184.81445556616, 6159.0, 6218.409251121137, 6228.377162283917, 6247.5001999840815, 6272.874542509216, 6154.3845615438095, 6161.815145545641, 6172.444479996821, 6172.567920245539, 6184.81445556634, 4970.527799859007, 6136.355682653436, 6219.191505104308, 6223.688815559294, 6228.28374736893, 5974.402559744165, 5996.970015149896, 6037.909431358621, 6040.0, 6117.510599152146, 4739.4075740532435, 6005.939940600538, 6071.939280607137, 6072.14989901423, 6075.331713511422, 5902.5277977762535, 5914.58597898143, 5916.408359164049, 5919.704014799329, 5923.466887980103, 5907.704614769158, 5990.3710110439515, 5995.520358371407, 6059.666718330534, 6080.270367555921, 5764.567657425794, 5801.361850196559, 5818.272715910512, 5826.0, 5864.970675146597], "value": 5640.438924264426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.367564004614, 509.31497136351607, 526.5445389737873, 547.2639300141309, 548.755803667368, 30339.0, 42476.78761606191, 42901.35647965283, 43029.0, 43569.0, 42308.0, 43409.7829510852, 43696.0, 43763.0, 43787.90530236738, 9409.482478463682, 9568.712938611852, 9573.52132393381, 9586.23310135191, 9603.4718090505, 9480.525973701322, 9526.714198574055, 9590.08894155054, 9593.328467007312, 9610.711678649617, 9579.0, 9624.422534647909, 9642.180414664763, 9643.0, 9662.468564228964, 9515.666951656693, 9574.856377154349, 9580.61677532898, 9589.0, 9614.375065620747, 9432.0, 9494.430334179971, 9499.95500494945, 9506.429614223169, 9542.618295268181, 39412.60587394118, 39458.0, 39539.81380558588, 39774.0, 40331.59668403337, 3162.2012672753763, 3331.3170799986187, 3740.981295093507, 3751.906202344936, 3987.6610488108545, 26243.606345904635, 30460.8476957616, 31745.0, 31987.680123198934, 32252.193695157574, 3180.507021411685, 3193.4411477991257, 3195.584574005388, 3315.602127744662, 3333.233356328034, 474467.0, 480361.0, 480531.1681299168, 482544.0, 493685.0, 34062.0, 61348.38651613516, 61458.38541614527, 61473.07790383148, 61716.69141654263, 28960.0, 35794.64205357965, 35806.82096589501, 35826.0, 35878.820605896806, 14147.221902795445, 14261.85738142626, 14282.50011249622, 14283.78574321386, 14298.714025719635, 11536.826947595793, 11570.0, 11585.6524304271, 11616.825747613793, 11624.709382265512, 7727.574983375968, 7761.758920345542, 7767.456278060595, 7815.179406162385, 7837.7648670539975, 3242.4812030075545, 3269.8038117713013, 3271.1985563537087, 3279.065466342081, 3294.275259442919, 922.561783152997, 930.423137654645, 973.3089506450499, 973.9318247722733, 994.8358520844124, 22926.082956681545, 22944.885275573848, 30334.0, 31185.532217016764, 31258.0, 1010.5242156716075, 1019.1591936652292, 1031.1441503552035, 1129.3562669278433, 1155.3010428690689, 13806.516771913135, 15189.848101519065, 15772.0, 15816.683666326839, 16082.312921801846, 650311.0, 657831.0, 658526.0, 660199.0, 663704.0, 59397.703011484664, 60069.098963515586, 60147.0, 60189.69905150446, 60291.0, 1218.3908045977012, 1273.5351596667335, 1277.4570807406815, 1357.0636260979893, 1363.12078709232, 29577.556336654536, 30016.549751754177, 31566.526502102945, 32256.516152258206, 32541.861034863665, 46808.765956171366, 49331.0, 56955.0, 57290.713546432, 57465.85068298527, 566204.0, 569489.0, 569966.0, 570347.0, 572401.0, 23738.0, 24223.394415139763, 26196.73803261943, 26828.731712682624, 27177.86411068011, 44096.779516102215, 48306.792330192024, 48348.033039339716, 48889.511104888494, 48945.0, 28351.149465516068, 38701.80649096736, 39181.21637567176, 39336.0, 39858.601413986646, 38212.808935955145, 39576.81269561918, 40236.0, 40767.59232407638, 41450.0, 37346.626533734314, 37708.62291377161, 38175.0, 38291.6170838288, 38336.0, 32746.0, 33943.151421214665, 35275.0, 35320.47019294661, 35374.64625353713, 25321.240362789147, 25540.744592553838, 25834.87082564575, 25884.832021731134, 25925.611115833653], "value": 18628.485362518015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.61488015263745, 363.2353895050918, 373.72531189575665, 385.55275879979195, 392.9587393323701, 11666.824997625032, 12196.024318054568, 12325.0, 12346.197497162679, 19629.901850490747, 21445.67831482529, 22778.430539236488, 22797.4300642484, 22844.65733014006, 22917.77082229177, 5948.018576934801, 6443.387878151568, 6793.320667933217, 6916.619585922772, 6927.0648462457675, 6917.0, 6926.411255043327, 6966.094407726989, 6987.336203060727, 6994.510384273103, 6647.50143739219, 6937.895931561005, 6982.3715865572085, 7014.22843487216, 7018.4385249180195, 6555.836104097388, 6906.205786334585, 6948.583085014865, 6968.895466568006, 6986.685599148025, 6544.9345506544805, 6545.821752084623, 6559.639219842907, 6635.8009259722285, 6641.402273795382, 23066.884665576734, 23176.188833390752, 28807.135785926246, 29034.709652903413, 29303.413931721247, 2335.8832058397184, 2368.59733845245, 2525.4191535946834, 2531.253280282321, 2616.188981415748, 14314.928425357806, 16794.580135496588, 17118.40085596998, 17159.0, 17417.65164696699, 1953.5702145527962, 2029.1984666056971, 2070.3892351756267, 2080.2615071649498, 2082.3648787119923, 114427.0, 115417.0, 118767.2184917227, 137983.6201637991, 145073.0, 16785.91607041957, 19741.0, 20990.370288891358, 21393.358199254046, 21520.677189842165, 35693.64306356955, 35751.4637280441, 35804.820975895476, 35925.10187245288, 35928.0, 10335.94832025835, 10562.20783441245, 10722.158627963596, 10725.034746872663, 10960.013598776148, 8652.3510736695, 8736.082711315348, 8769.342299327576, 8908.8663670045, 8968.955155224183, 7743.574103424366, 9393.624255029723, 9721.513924303756, 9770.847862907272, 9878.308518403786, 3137.2313783122822, 3610.332088563624, 3718.3121122592406, 3732.384156614128, 3733.4586484959527, 769.4344656677338, 797.9401544884157, 857.4855086947781, 909.4043401571981, 949.943003419797, 21201.57596848085, 21616.459588510097, 21866.671999920014, 21945.0, 21967.011484483235, 881.7663319220412, 905.6060613633091, 906.7007887397143, 928.4336554701626, 935.5602866652663, 11032.28290161137, 11496.77006459866, 11589.130815188895, 11609.883901161049, 11620.477078531487, 578411.0, 586563.0, 599067.0, 605412.0, 614281.0, 117798.4110079444, 127431.0, 127941.0, 128130.0, 128915.0, 899.1817446124127, 909.2589539525266, 955.3980991975011, 957.042957042957, 968.5496244246318, 19033.0, 19327.710084349026, 19564.60870782548, 19581.0, 19642.0, 53240.20139697985, 54521.0, 55328.08398950131, 55713.0, 55892.0, 77219.0, 77476.0, 77625.61187194027, 79232.60383698044, 79475.60262198652, 7638.618069096634, 7779.4554381192775, 7912.4856884302335, 7924.286814186751, 7971.282584567417, 9054.366194366332, 9946.950265248917, 12259.387030648253, 12341.50633974631, 12459.127861050001, 10777.838332425177, 10839.458027098455, 10871.075958543612, 10880.183986201226, 10907.672769816918, 10379.84430233532, 10415.218858585788, 10464.267501274837, 10640.361578305326, 10687.732806679895, 10290.970902909648, 10797.082248009006, 10811.189160813128, 10850.403227822546, 11027.724306892393, 6508.967455162694, 6835.282295358916, 7367.26327367259, 7374.741884034248, 7400.926865604565, 9242.676506322246, 10157.644482443078, 10756.354618722902, 11073.94463027712, 11162.609308674157], "value": 10654.322404770017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.608389650898, 1554.5336399080277, 1575.1730341570676, 1828.8354048135666, 1975.9604807903834, 6257.655828929407, 7877.684892604296, 8374.246317831394, 8893.777655558599, 8927.464352138877, 8729.91270087299, 8831.867521987158, 8834.469931804097, 8846.24806891415, 8849.380543361951, 2351.8824058797036, 2377.346229786805, 2379.7501262367464, 2380.1550449590404, 2386.2006227913585, 2343.0744855781954, 2371.2649078785544, 2372.1578839511985, 2384.916527921523, 2388.199953015742, 2335.7313908900437, 2352.2355234548754, 2356.6582845487396, 2357.3870793593705, 2365.503244318695, 2312.826538009639, 2331.8484298520543, 2336.5910965580956, 2343.871087090209, 2368.6802281692094, 1965.9901700491548, 2323.1984965186984, 2323.744388117306, 2326.1044497868274, 2327.755585663515, 8761.912380876174, 8821.647134114628, 8881.200691937756, 8905.955470222672, 8910.55447227636, 5205.869853253661, 5402.540784033362, 5420.457954204588, 5423.132298832207, 5451.155070964007, 3580.5166302549083, 3587.928241435183, 3640.854365825364, 3647.76289541179, 3668.743187976843, 1043.1498328861953, 1053.1732589916878, 1056.6513050693252, 1065.6589891234808, 1076.3703233608348, 11613.012893903944, 11754.118441116865, 11767.176297659082, 11781.0, 11831.290122592673, 4374.5625437456, 4546.636269098464, 4642.0, 4653.511381304982, 4660.487346391894, 9140.0, 9167.862482062774, 9177.816443671089, 9193.264538836876, 9210.263178945668, 5247.658902171423, 5275.261463395128, 5282.788688452496, 5289.18017707256, 5301.416844147141, 3682.226732386229, 4145.751254924714, 4571.519990401027, 4576.222042252825, 4946.109700253917, 3757.5866654667966, 3794.449804778347, 3845.307844587945, 3870.283997460479, 3882.417637354363, 974.192872222018, 1147.1167201254987, 1154.3593305715408, 1164.545827127421, 1169.0063446070772, 869.387082107113, 870.3820287595878, 877.6840337478502, 901.5717534171347, 932.5430539035959, 4278.507971583245, 5153.536181743586, 5448.264484294569, 5675.233843431167, 5728.570357223141, 416.93537501687285, 421.1030505024279, 423.8558889977361, 428.2227756621722, 429.32810152111847, 3649.7445178837756, 3736.252749450121, 3738.682212011955, 3740.2893450244364, 3804.7336686432236, 10147.188224941987, 10339.0, 10755.139588832875, 10922.0, 10926.071283940795, 10504.684859454228, 10745.462726863781, 10763.892361076445, 10770.299930504492, 10772.138228941823, 7852.136265010844, 8012.599370031475, 8226.835463290701, 8298.917010829935, 8312.210340017567, 4634.397528321431, 5218.634695571273, 5659.717014149359, 5678.545716342765, 5813.534917206698, 9821.312508124363, 9824.901750982399, 9833.164181044405, 9853.950730246303, 9926.702198934043, 9346.392484488486, 9676.661316853877, 10256.38461692301, 10266.538005789607, 10359.96400359958, 7028.9297107030325, 7295.927040729737, 7436.330730234305, 7678.731244406419, 7697.807554811175, 8191.590420479071, 8365.832683346178, 8384.329253659815, 8454.57727113654, 8503.064662887202, 7552.207018263003, 7558.886616700864, 7612.961935190288, 7625.123110842324, 7678.462507624636, 7369.963150184215, 7422.0, 7436.442266830118, 7501.249875012455, 7556.546607203585, 6988.40598549129, 7088.326608972139, 7121.82195445118, 7147.82130446743, 7190.6404679764755, 4800.783964721526, 4813.470518243061, 4837.975810120927, 4879.756012199305, 5034.144195486703, 4359.803808828547, 4912.1649319615035, 4939.580135688507, 5002.299678045149, 5011.148104822116], "value": 4412.051991827498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [231.7358211638732, 266.2757300143609, 296.09985643643324, 305.72055945866543, 308.60498561840836, 4115.374427101293, 4643.373144625474, 4894.583960363365, 5106.361704786902, 5171.586273098153, 4469.865904022877, 4811.446683631383, 5081.6696914700615, 5091.949080509194, 5140.686690989051, 3949.526056873165, 3979.582143874895, 3989.2021595680835, 3992.686070561427, 4025.1144748155357, 3837.4841937434835, 3983.24318379507, 3996.440498330236, 4000.519937607491, 4016.49793775778, 3595.6740015485702, 3966.662833659128, 3979.1047014421815, 3997.980514968679, 3999.3201155803436, 3931.9017024574614, 3958.9802050989706, 3967.4445577619013, 3972.483577134983, 3972.880813575597, 3453.322211844403, 3470.8091054991964, 3484.372812893678, 3488.7963652539834, 3488.982555087234, 4873.731944743037, 5029.3964724232965, 5044.041632089928, 5046.21783623539, 5070.467600901889, 4478.350639157336, 4490.0, 4503.864884053483, 4536.523665015159, 4548.929472605978, 5385.649932754398, 5391.353037635469, 5399.406065332811, 5399.811006614749, 5437.728113594305, 3187.7927934684403, 3560.6973407260416, 3629.9274014519824, 3781.3760729479604, 3797.626483447845, 4624.28323609841, 4855.198892182786, 5292.311999440125, 5639.15412688096, 5659.773609055674, 3836.712246581518, 3838.616138386195, 3844.8462061517785, 3846.9615303846604, 3854.4989151410136, 3837.827297771607, 3914.4911161549385, 3924.0778417071965, 3926.960730392717, 3931.0958479549863, 3698.8705395311035, 4073.7759423231414, 4458.732476051382, 4539.6368290536675, 4558.652294068557, 4231.915361692811, 5353.9196912046355, 5377.311344327836, 5382.77033779729, 5424.077906755782, 1154.4054811771944, 1234.802431610938, 1295.2811189789757, 1299.8050292456019, 1337.5452346202144, 777.3470284960547, 835.849547081519, 919.9531043428452, 920.7237828651378, 925.7916968682127, 4371.759553224603, 4549.431321084864, 5161.948380516222, 5180.922286165711, 5183.377994640592, 4849.563539281482, 5149.0, 5232.686038837682, 5419.972900135474, 5637.520810731052, 5086.287919691246, 5086.847394578169, 5091.541761241506, 5104.285400043997, 5125.309776960582, 2481.85108893467, 2889.8699558519916, 2920.576516405152, 2928.1654728402304, 2941.6468424524533, 4752.477227504972, 5335.653182543122, 5453.018456677757, 5658.886822263532, 5782.045962416154, 4970.478099799541, 5344.0, 5354.598405119554, 5778.6821724804695, 5797.594168408255, 5654.547636189095, 5803.47768700819, 5824.767009319665, 5831.446012628793, 5909.261342332295, 4561.521040290721, 4935.975320123376, 4947.678400904074, 5014.022265658162, 5663.631863928831, 4061.634452899135, 5146.713321669583, 5507.752151153128, 5533.944660553504, 5567.8886422272135, 4582.358469814295, 5788.507976822018, 5799.246098007232, 5809.50619197373, 5845.386234445322, 3276.4921437177277, 3762.6425489578446, 3801.6388443097862, 3804.904877378088, 3811.352070148026, 5247.265382846481, 5628.380878103487, 5634.661920284796, 5643.181738647955, 5672.269957662952, 5172.5603323716405, 5478.91781623268, 5506.760978779903, 5544.889102217852, 5601.60788744784, 5430.294061771944, 5460.453954604508, 5471.179323101566, 5480.91778623313, 5486.159688218183, 4736.50266722003, 4975.825846095369, 5061.96229772903, 5213.791448342024, 5245.239440281061, 5485.040117979258, 5499.670019798665, 5507.604192176416, 5516.310461192351, 5580.525655319181, 4301.655867530528, 5009.922866583702, 5137.974310128426, 5332.600054995968, 5374.677519348852], "value": 3973.787363184879, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.9497435179538, 749.1534565940486, 767.9001729775129, 778.8325510015345, 864.4640322999741, 13117.934410327958, 15676.84323156768, 15796.842031579681, 15814.288357023932, 15879.444219452336, 14202.28988550571, 14330.498432554863, 14331.928340358283, 14362.928185359086, 14363.56909292723, 685.0614657918659, 708.4509505133511, 856.0711627883738, 858.3948316436897, 882.3250213586612, 874.7944233105216, 879.705298724928, 879.7712594725385, 880.0451510111504, 880.9295256379474, 936.8313703533362, 937.5078084005884, 938.5776400619715, 939.4410325856105, 939.8496240601505, 724.4457989637931, 747.6336595068432, 902.9909700902973, 916.1296768070359, 931.9347645664773, 684.5174152222671, 688.8518968421813, 689.2521614048763, 690.8687349403597, 692.0829900382014, 14540.781888271684, 14551.490697825526, 14822.110673359633, 14987.925060374628, 15062.397504099823, 11444.771104577861, 13749.450021999108, 13932.651683707887, 13986.0, 14120.71758564823, 12054.939725301318, 12311.384430778426, 12484.438200281009, 12846.421911014028, 13046.412911418915, 4403.713758605712, 4408.096340250273, 4489.820407183709, 4596.264597664358, 4696.647751418657, 89915.0, 115394.42302788432, 116708.41645791802, 117322.0, 120954.0, 9102.408343457653, 10703.0, 10757.56969721218, 10778.4071876046, 10905.645322162472, 20895.95520224013, 21766.455838603844, 21886.89056554739, 21896.343109706733, 21915.780842191692, 7467.715046405798, 7505.362044226193, 7614.200508946592, 7643.923560764432, 7921.762347129596, 3825.5600605930117, 4156.958430415718, 4218.734379686082, 4423.889402764957, 4590.655700822452, 3423.623401425841, 3891.6497515223764, 4081.1429599783783, 4088.2436749201493, 4102.0, 708.2209569473538, 724.0623392706458, 728.1517032656895, 731.4331393170336, 737.71229220604, 509.5923261390872, 542.5973857578205, 589.2016317889284, 607.1439270628392, 647.3623480871338, 8667.696630617898, 9213.12475314844, 9313.301502387212, 9360.063993600585, 9387.389819661701, 534.3374215972244, 564.1875698993518, 570.2045646323355, 645.2643985856128, 654.6824789976857, 4286.121345124242, 4350.564943505624, 4588.545520457284, 4653.7207767534055, 4688.578027977498, 98742.0, 142342.0, 152812.0, 156094.0, 156469.0, 130482.0, 132338.0, 134361.0, 134393.0, 137192.0, 114125.28812067826, 114867.0, 115113.4244328773, 115660.42169789097, 119646.40176799234, 7717.58698243155, 7869.803254918673, 8858.0, 8874.778130546789, 8957.143284385425, 46950.0, 63948.68025659842, 64989.02516462162, 65036.674816625615, 66198.66900665466, 89866.0, 95632.52183739036, 95908.0, 96713.0, 97579.0, 11680.123990700562, 12225.633231003085, 12238.49110932239, 12244.326562039174, 12460.750784984068, 12734.61796146117, 12903.161294515827, 13008.479660813462, 13102.082854200115, 13125.54060607874, 10244.487775611338, 12005.25398418823, 12068.879311206776, 12171.0, 12539.059570532065, 11940.52237910474, 12046.457909393923, 12393.442295096562, 12554.937225313815, 12564.811527827273, 11753.706157346134, 12082.577109801116, 12390.5663301784, 12420.130590858915, 12488.37558122072, 9433.622655093719, 9572.186364158846, 9629.903700963181, 9724.222062235145, 9876.0, 8632.827343452971, 9581.904180958101, 9632.566534506104, 9639.0, 9650.179734722346], "value": 7660.158235956998, "unit": "score"}], "name": "dromaeo_css", "value": 7292.1887501989895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 112.0, 113.0, 114.0, 114.0, 113.0, 112.0, 115.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 143.0, 143.0, 151.0, 143.0, 146.0, 141.0, 116.0, 143.0, 112.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 185.0, 185.0, 184.0, 199.0, 259.0, 176.0, 254.0], "value": 199.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 90.0, 61.0, 59.0, 60.0, 76.0, 106.0, 82.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 97.0, 101.0, 97.0, 98.0, 92.0, 68.0, 69.0, 91.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 98.0, 132.0, 87.0, 89.0, 87.0, 91.0, 88.0, 89.0, 86.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 109.0, 133.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 80.0, 82.0, 81.0, 82.0, 82.0, 85.0, 87.0, 105.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 79.0, 80.0, 72.0, 74.0, 70.0, 69.0, 70.0, 71.0, 71.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 86.0, 95.0, 106.0, 86.0, 91.0, 89.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 161.0, 154.0, 127.0, 153.0, 158.0, 157.0, 158.0, 186.0, 147.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 235.0, 196.0, 174.0, 172.0, 174.0, 172.0, 165.0, 174.0, 172.0], "value": 181.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 70.0, 70.0, 68.0, 68.0, 70.0, 77.0, 85.0, 72.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1515.8000000000002, "alertThreshold": 2.0}]} 22:07:56 INFO - Return code: 0 22:07:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:07:57 INFO - # TBPL SUCCESS # 22:07:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:07:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:07:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:07:57 INFO - 2016-10-17 22:07:57.022 screenresolution[1981:21979] starting screenresolution argv=screenresolution get 22:07:57 INFO - 2016-10-17 22:07:57.025 screenresolution[1981:21979] Display 0: 1600x1200x32@60 22:07:57 INFO - 2016-10-17 22:07:57.031 screenresolution[1982:21982] starting screenresolution argv=screenresolution list 22:07:57 INFO - Available Modes on Display 0 22:07:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:07:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:07:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:07:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:07:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:07:57 INFO - Intel Iris: 22:07:57 INFO - Chipset Model: Intel Iris 22:07:57 INFO - Type: GPU 22:07:57 INFO - Bus: Built-In 22:07:57 INFO - VRAM (Dynamic, Max): 1536 MB 22:07:57 INFO - Vendor: Intel (0x8086) 22:07:57 INFO - Device ID: 0x0a2e 22:07:57 INFO - Revision ID: 0x0009 22:07:57 INFO - Displays: 22:07:57 INFO - Display: 22:07:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:07:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:07:57 INFO - Display Serial Number: 1600x1200 60 22:07:57 INFO - Main Display: Yes 22:07:57 INFO - Mirror: Off 22:07:57 INFO - Online: Yes 22:07:57 INFO - Rotation: Supported 22:07:57 INFO - Return code: 0 22:07:57 INFO - Running post-action listener: _resource_record_post_action 22:07:57 INFO - [mozharness: 2016-10-18 05:07:57.278475Z] Finished run-tests step (success) 22:07:57 INFO - Running post-run listener: _resource_record_post_run 22:07:57 INFO - Total resource usage - Wall time: 1216s; CPU: 53.0%; Read bytes: 5955584; Write bytes: 711306240; Read time: 240; Write time: 2217 22:07:57 INFO - TinderboxPrint: CPU usage
53.4% 22:07:57 INFO - TinderboxPrint: I/O read bytes / time
5,955,584 / 240 22:07:57 INFO - TinderboxPrint: I/O write bytes / time
711,306,240 / 2,217 22:07:57 INFO - TinderboxPrint: CPU idle
2,267.5 (46.6%) 22:07:57 INFO - TinderboxPrint: CPU system
975.8 (20.1%) 22:07:57 INFO - TinderboxPrint: CPU user
1,622.6 (33.3%) 22:07:57 INFO - TinderboxPrint: Swap in / out
411,566,080 / 0 22:07:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386824704; Write bytes: 382425088; Read time: 29203; Write time: 767 22:07:57 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 5955584; Write bytes: 301065216; Read time: 240; Write time: 1374 22:07:57 INFO - Running post-run listener: _upload_blobber_files 22:07:57 INFO - Blob upload gear active. 22:07:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:07:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:07:58 INFO - (blobuploader) - INFO - Open directory for files ... 22:07:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:07:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:07:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:59 INFO - (blobuploader) - INFO - Done attempting. 22:07:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:07:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:00 INFO - (blobuploader) - INFO - Done attempting. 22:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:08:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:03 INFO - (blobuploader) - INFO - Done attempting. 22:08:03 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:03 INFO - Return code: 0 22:08:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:08:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/055f728cef40f9a78d96dfbea96f08bc51a2e8543f29ee38fe63e60f640340c9b18ef1e0f8caeca22f2fa78fa02e1e84878cf06930a728512bf3277ed6d1bbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31b8e5536777e06a54931b8f8c10192093919949b6427b8c725ccc86ca8185ae1f01fff6c7f634e9a2025a7dadeb6a84503044efa4f01820da9865676d4c1dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41be97c0bac9e02e8c2553baaf5ff4235de175720f172a9a21725874213b50cd63f5808f9379436a09880437d09285059b2a16fbf87591a270377e829bd66426"} 22:08:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:08:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:08:03 INFO - Contents: 22:08:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/055f728cef40f9a78d96dfbea96f08bc51a2e8543f29ee38fe63e60f640340c9b18ef1e0f8caeca22f2fa78fa02e1e84878cf06930a728512bf3277ed6d1bbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31b8e5536777e06a54931b8f8c10192093919949b6427b8c725ccc86ca8185ae1f01fff6c7f634e9a2025a7dadeb6a84503044efa4f01820da9865676d4c1dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41be97c0bac9e02e8c2553baaf5ff4235de175720f172a9a21725874213b50cd63f5808f9379436a09880437d09285059b2a16fbf87591a270377e829bd66426"} 22:08:03 INFO - Running post-run listener: copy_logs_to_upload_dir 22:08:03 INFO - Copying logs to upload dir... 22:08:03 INFO - mkdir: /builds/slave/test/build/upload/logs 22:08:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.328829 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-17 22:08:03.456649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 22:08:03.460133) ========= 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.2HMGt7im0t/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.XZH6cmt0ax/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/055f728cef40f9a78d96dfbea96f08bc51a2e8543f29ee38fe63e60f640340c9b18ef1e0f8caeca22f2fa78fa02e1e84878cf06930a728512bf3277ed6d1bbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31b8e5536777e06a54931b8f8c10192093919949b6427b8c725ccc86ca8185ae1f01fff6c7f634e9a2025a7dadeb6a84503044efa4f01820da9865676d4c1dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41be97c0bac9e02e8c2553baaf5ff4235de175720f172a9a21725874213b50cd63f5808f9379436a09880437d09285059b2a16fbf87591a270377e829bd66426"} build_url:https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/K0FZqKWvRkixFrBY5IQ7mQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/055f728cef40f9a78d96dfbea96f08bc51a2e8543f29ee38fe63e60f640340c9b18ef1e0f8caeca22f2fa78fa02e1e84878cf06930a728512bf3277ed6d1bbf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31b8e5536777e06a54931b8f8c10192093919949b6427b8c725ccc86ca8185ae1f01fff6c7f634e9a2025a7dadeb6a84503044efa4f01820da9865676d4c1dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41be97c0bac9e02e8c2553baaf5ff4235de175720f172a9a21725874213b50cd63f5808f9379436a09880437d09285059b2a16fbf87591a270377e829bd66426"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 22:08:03.493352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 22:08:03.493715) ========= 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.2HMGt7im0t/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.XZH6cmt0ax/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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.005103 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 22:08:03.542782) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 22:08:03.543147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 22:08:03.543542) ========= ========= Total master_lag: 0.18 =========