builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1486049443.32 results: success (0) buildid: 20170202061208 builduid: 82cf8ed124404346821a7e1666eb2c4a revision: d1569ed822af8f33141533522e7ea3b3ab6f2eea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.316985) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.317543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.318684) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.344886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.345330) ========= 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.aruRv57Khh/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.iFpD53x374/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 --2017-02-02 07:30:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-02-02 07:30:43 (46.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147418 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.519084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.519730) ========= 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.aruRv57Khh/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.iFpD53x374/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.020693 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:43.573037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 07:30:43.573414) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d1569ed822af8f33141533522e7ea3b3ab6f2eea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d1569ed822af8f33141533522e7ea3b3ab6f2eea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aruRv57Khh/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.iFpD53x374/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 2017-02-02 07:30:43,664 truncating revision to first 12 chars 2017-02-02 07:30:43,664 Setting DEBUG logging. 2017-02-02 07:30:43,664 attempt 1/10 2017-02-02 07:30:43,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d1569ed822af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 07:30:44,485 unpacking tar archive at: mozilla-aurora-d1569ed822af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.085989 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 07:30:44.686041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:44.686382) ========= script_repo_revision: d1569ed822af8f33141533522e7ea3b3ab6f2eea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:44.686778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:44.687069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 07:30:44.707018) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-02 07:30:44.707447) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aruRv57Khh/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.iFpD53x374/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:30:44 INFO - MultiFileLogger online at 20170202 07:30:44 in /builds/slave/test 07:30:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:30:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:44 INFO - {'append_to_log': False, 07:30:44 INFO - 'base_work_dir': '/builds/slave/test', 07:30:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:30:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:44 INFO - 'branch': 'Mozilla-Aurora', 07:30:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:44 INFO - 'config_files': ('talos/mac_config.py',), 07:30:44 INFO - 'default_actions': ('clobber', 07:30:44 INFO - 'read-buildbot-config', 07:30:44 INFO - 'download-and-extract', 07:30:44 INFO - 'populate-webroot', 07:30:44 INFO - 'create-virtualenv', 07:30:44 INFO - 'install', 07:30:44 INFO - 'run-tests'), 07:30:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:44 INFO - 'download_minidump_stackwalk': True, 07:30:44 INFO - 'download_symbols': 'ondemand', 07:30:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:44 INFO - 'installer_path': 'installer.exe', 07:30:44 INFO - 'log_level': 'info', 07:30:44 INFO - 'log_name': 'talos', 07:30:44 INFO - 'log_to_console': True, 07:30:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:30:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:30:44 INFO - 'opt_config_files': (), 07:30:44 INFO - 'pip_index': False, 07:30:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:44 INFO - 'cmd': ('bash', 07:30:44 INFO - '-c', 07:30:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:44 INFO - 'enabled': True, 07:30:44 INFO - 'halt_on_failure': False, 07:30:44 INFO - 'name': 'check_screen_resolution'},), 07:30:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:44 INFO - 'cmd': ('bash', 07:30:44 INFO - '-c', 07:30:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:44 INFO - 'enabled': True, 07:30:44 INFO - 'halt_on_failure': False, 07:30:44 INFO - 'name': 'check_screen_resolution'},), 07:30:44 INFO - 'run_cmd_checks_enabled': True, 07:30:44 INFO - 'sps_profile': False, 07:30:44 INFO - 'sps_profile_interval': 0, 07:30:44 INFO - 'suite': 'dromaeojs', 07:30:44 INFO - 'system_bits': '32', 07:30:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:44 INFO - 'title': 't-yosemite-r7-0387', 07:30:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:44 INFO - 'use_talos_json': True, 07:30:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:44 INFO - 'work_dir': 'build'} 07:30:44 INFO - [mozharness: 2017-02-02 15:30:44.918086Z] Running clobber step. 07:30:44 INFO - Running pre-action listener: _resource_record_pre_action 07:30:44 INFO - Running main action method: clobber 07:30:44 INFO - rmtree: /builds/slave/test/build 07:30:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:45 INFO - Running post-action listener: _resource_record_post_action 07:30:45 INFO - [mozharness: 2017-02-02 15:30:45.855707Z] Finished clobber step (success) 07:30:45 INFO - [mozharness: 2017-02-02 15:30:45.855871Z] Running read-buildbot-config step. 07:30:45 INFO - Running pre-action listener: _resource_record_pre_action 07:30:45 INFO - Running main action method: read_buildbot_config 07:30:45 INFO - Using buildbot properties: 07:30:45 INFO - { 07:30:45 INFO - "project": "", 07:30:45 INFO - "product": "firefox", 07:30:45 INFO - "script_repo_revision": "production", 07:30:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:30:45 INFO - "repository": "", 07:30:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:30:45 INFO - "buildid": "20170202061208", 07:30:45 INFO - "pgo_build": "False", 07:30:45 INFO - "basedir": "/builds/slave/test", 07:30:45 INFO - "buildnumber": 48, 07:30:45 INFO - "slavename": "t-yosemite-r7-0387", 07:30:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:30:45 INFO - "platform": "yosemite_r7", 07:30:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:30:45 INFO - "branch": "mozilla-aurora", 07:30:45 INFO - "repo_path": "releases/mozilla-aurora", 07:30:45 INFO - "revision": "d1569ed822af8f33141533522e7ea3b3ab6f2eea", 07:30:45 INFO - "stage_platform": "macosx64", 07:30:45 INFO - "builduid": "82cf8ed124404346821a7e1666eb2c4a", 07:30:45 INFO - "slavebuilddir": "test" 07:30:45 INFO - } 07:30:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 07:30:45 INFO - Running post-action listener: _resource_record_post_action 07:30:45 INFO - [mozharness: 2017-02-02 15:30:45.859351Z] Finished read-buildbot-config step (success) 07:30:45 INFO - [mozharness: 2017-02-02 15:30:45.859474Z] Running download-and-extract step. 07:30:45 INFO - Running pre-action listener: _resource_record_pre_action 07:30:45 INFO - Running main action method: download_and_extract 07:30:45 INFO - mkdir: /builds/slave/test/build/tests 07:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:45 INFO - trying https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 07:30:45 INFO - Downloading https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 07:30:46 INFO - Downloaded 1199 bytes. 07:30:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:30:46 INFO - Using the following test package requirements: 07:30:46 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:30:46 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 07:30:46 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 07:30:46 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'jsshell-mac.zip'], 07:30:46 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 07:30:46 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:30:46 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 07:30:46 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 07:30:46 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 07:30:46 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:46 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 07:30:46 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:30:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:30:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:30:46 INFO - Fetch https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:30:47 INFO - Expected file size: 16356058 07:30:47 INFO - Obtained file size: 16356058 07:30:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:30:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:30:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:30:54 INFO - Fetch https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:30:55 INFO - Expected file size: 16356058 07:30:55 INFO - Obtained file size: 16356058 07:31:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 07:31:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:31:01 INFO - Fetch https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 07:31:02 INFO - Expected file size: 14403485 07:31:02 INFO - Obtained file size: 14403485 07:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:02 INFO - trying https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:31:02 INFO - Downloading https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 07:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 07:31:05 INFO - Downloaded 73824774 bytes. 07:31:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:31:05 INFO - mkdir: /builds/slave/test/properties 07:31:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:31:05 INFO - Writing to file /builds/slave/test/properties/build_url 07:31:05 INFO - Contents: 07:31:05 INFO - build_url:https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:31:07 INFO - Running post-action listener: _resource_record_post_action 07:31:07 INFO - Running post-action listener: set_extra_try_arguments 07:31:07 INFO - [mozharness: 2017-02-02 15:31:07.068961Z] Finished download-and-extract step (success) 07:31:07 INFO - [mozharness: 2017-02-02 15:31:07.069115Z] Running populate-webroot step. 07:31:07 INFO - Running pre-action listener: _resource_record_pre_action 07:31:07 INFO - Running main action method: populate_webroot 07:31:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:31:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:31:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:31:07 INFO - '--tppagecycles', 07:31:07 INFO - '7'], 07:31:07 INFO - 'tests': ['tsvgm']}}, 07:31:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:31:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:31:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:31:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:31:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:31:07 INFO - 'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:31:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:31:07 INFO - 'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['damp', 'tps']}, 07:31:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:31:07 INFO - 'tests': ['damp', 'tps']}, 07:31:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['dromaeo_dom']}, 07:31:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:31:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['basic_compositor_video']}, 07:31:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:31:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['a11yr', 07:31:07 INFO - 'ts_paint', 07:31:07 INFO - 'tpaint', 07:31:07 INFO - 'sessionrestore', 07:31:07 INFO - 'sessionrestore_no_auto_restore', 07:31:07 INFO - 'tabpaint']}, 07:31:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:31:07 INFO - 'ts_paint', 07:31:07 INFO - 'tpaint', 07:31:07 INFO - 'sessionrestore', 07:31:07 INFO - 'sessionrestore_no_auto_restore', 07:31:07 INFO - 'tabpaint']}, 07:31:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:31:07 INFO - 'ts_paint', 07:31:07 INFO - 'tpaint', 07:31:07 INFO - 'sessionrestore', 07:31:07 INFO - 'sessionrestore_no_auto_restore', 07:31:07 INFO - 'tabpaint']}, 07:31:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:31:07 INFO - 'ts_paint', 07:31:07 INFO - 'tpaint', 07:31:07 INFO - 'sessionrestore', 07:31:07 INFO - 'sessionrestore_no_auto_restore', 07:31:07 INFO - 'tabpaint']}, 07:31:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['a11yr', 07:31:07 INFO - 'ts_paint', 07:31:07 INFO - 'tpaint', 07:31:07 INFO - 'sessionrestore', 07:31:07 INFO - 'sessionrestore_no_auto_restore', 07:31:07 INFO - 'tabpaint']}, 07:31:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['a11yr', 07:31:07 INFO - 'ts_paint', 07:31:07 INFO - 'tpaint', 07:31:07 INFO - 'sessionrestore', 07:31:07 INFO - 'sessionrestore_no_auto_restore', 07:31:07 INFO - 'tabpaint']}, 07:31:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['tsvgx', 07:31:07 INFO - 'tsvgr_opacity', 07:31:07 INFO - 'tart', 07:31:07 INFO - 'tscrollx', 07:31:07 INFO - 'cart', 07:31:07 INFO - 'tsvg_static']}, 07:31:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:31:07 INFO - 'tsvgr_opacity', 07:31:07 INFO - 'tart', 07:31:07 INFO - 'tscrollx', 07:31:07 INFO - 'cart', 07:31:07 INFO - 'tsvg_static']}, 07:31:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:31:07 INFO - 'talos_options': ['--disable-e10s'], 07:31:07 INFO - 'tests': ['tp5o']}, 07:31:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:31:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:31:07 INFO - 'talos_options': ['--disable-e10s', 07:31:07 INFO - '--xperf_path', 07:31:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:07 INFO - 'tests': ['tp5n']}, 07:31:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:31:07 INFO - 'talos_options': ['--xperf_path', 07:31:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:07 INFO - 'tests': ['tp5n']}}, 07:31:07 INFO - 'talos.zip': {'path': '', 07:31:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:31:07 INFO - Running post-action listener: _resource_record_post_action 07:31:07 INFO - [mozharness: 2017-02-02 15:31:07.087918Z] Finished populate-webroot step (success) 07:31:07 INFO - [mozharness: 2017-02-02 15:31:07.088056Z] Running create-virtualenv step. 07:31:07 INFO - Running pre-action listener: _resource_record_pre_action 07:31:07 INFO - Running main action method: create_virtualenv 07:31:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:31:07 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 07:31:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:31:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:31:07 INFO - Using real prefix '/tools/python27' 07:31:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:31:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:31:10 INFO - Installing pip.................done. 07:31:10 INFO - Return code: 0 07:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:31:11 INFO - Reading from file tmpfile_stdout 07:31:11 INFO - Output received: 07:31:11 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) 07:31:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:11 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:11 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 07:31:11 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 07:31:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:11 INFO - 'HOME': '/Users/cltbld', 07:31:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:11 INFO - 'LOGNAME': 'cltbld', 07:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:11 INFO - 'MOZ_NO_REMOTE': '1', 07:31:11 INFO - 'NO_EM_RESTART': '1', 07:31:11 INFO - 'PAGER': '/bin/cat', 07:31:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:11 INFO - 'PWD': '/builds/slave/test', 07:31:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:11 INFO - 'SHELL': '/bin/bash', 07:31:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:11 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:11 INFO - 'USER': 'cltbld', 07:31:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:11 INFO - 'XPC_FLAGS': '0x0', 07:31:11 INFO - 'XPC_SERVICE_NAME': '0', 07:31:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:11 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 07:31:11 INFO - Cleaning up... 07:31:11 INFO - Return code: 0 07:31:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:11 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:11 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 07:31:11 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 07:31:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:11 INFO - 'HOME': '/Users/cltbld', 07:31:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:11 INFO - 'LOGNAME': 'cltbld', 07:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:11 INFO - 'MOZ_NO_REMOTE': '1', 07:31:11 INFO - 'NO_EM_RESTART': '1', 07:31:11 INFO - 'PAGER': '/bin/cat', 07:31:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:11 INFO - 'PWD': '/builds/slave/test', 07:31:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:11 INFO - 'SHELL': '/bin/bash', 07:31:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:11 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:11 INFO - 'USER': 'cltbld', 07:31:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:11 INFO - 'XPC_FLAGS': '0x0', 07:31:11 INFO - 'XPC_SERVICE_NAME': '0', 07:31:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:11 INFO - Downloading/unpacking psutil>=3.1.1 07:31:11 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 07:31:11 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 07:31:11 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 07:31:11 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 07:31:11 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 07:31:11 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 07:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:15 INFO - Installing collected packages: psutil 07:31:15 INFO - Running setup.py install for psutil 07:31:15 INFO - building 'psutil._psutil_osx' extension 07:31:15 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 07:31:15 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 07:31:15 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 07:31:15 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 07:31:15 INFO - building 'psutil._psutil_posix' extension 07:31:15 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 07:31:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:31:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:31:15 INFO - ^ 07:31:15 INFO - 1 warning generated. 07:31:15 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 07:31:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:16 INFO - Successfully installed psutil 07:31:16 INFO - Cleaning up... 07:31:16 INFO - Return code: 0 07:31:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:16 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:16 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 07:31:16 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 07:31:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:16 INFO - 'HOME': '/Users/cltbld', 07:31:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:16 INFO - 'LOGNAME': 'cltbld', 07:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:16 INFO - 'MOZ_NO_REMOTE': '1', 07:31:16 INFO - 'NO_EM_RESTART': '1', 07:31:16 INFO - 'PAGER': '/bin/cat', 07:31:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:16 INFO - 'PWD': '/builds/slave/test', 07:31:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:16 INFO - 'SHELL': '/bin/bash', 07:31:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:16 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:16 INFO - 'USER': 'cltbld', 07:31:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:16 INFO - 'XPC_FLAGS': '0x0', 07:31:16 INFO - 'XPC_SERVICE_NAME': '0', 07:31:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:31:16 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 07:31:16 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 07:31:16 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 07:31:16 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 07:31:16 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 07:31:16 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 07:31:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:31:19 INFO - Installing collected packages: mozsystemmonitor 07:31:19 INFO - Running setup.py install for mozsystemmonitor 07:31:19 INFO - Successfully installed mozsystemmonitor 07:31:19 INFO - Cleaning up... 07:31:19 INFO - Return code: 0 07:31:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:31:19 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')]} 07:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:19 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')]} 07:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:19 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:19 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 07:31:19 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 07:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:19 INFO - 'HOME': '/Users/cltbld', 07:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:19 INFO - 'LOGNAME': 'cltbld', 07:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:19 INFO - 'MOZ_NO_REMOTE': '1', 07:31:19 INFO - 'NO_EM_RESTART': '1', 07:31:19 INFO - 'PAGER': '/bin/cat', 07:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:19 INFO - 'PWD': '/builds/slave/test', 07:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:19 INFO - 'SHELL': '/bin/bash', 07:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:19 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:19 INFO - 'USER': 'cltbld', 07:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:19 INFO - 'XPC_FLAGS': '0x0', 07:31:19 INFO - 'XPC_SERVICE_NAME': '0', 07:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:31:19 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 07:31:19 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 07:31:19 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 07:31:19 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 07:31:19 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 07:31:19 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 07:31:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:31:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:31:22 INFO - warning: no files found matching '*.txt' 07:31:22 INFO - no previously-included directories found matching 'build' 07:31:22 INFO - no previously-included directories found matching 'dist' 07:31:22 INFO - no previously-included directories found matching '.git*' 07:31:22 INFO - Installing collected packages: jsonschema, functools32 07:31:22 INFO - Running setup.py install for functools32 07:31:22 INFO - warning: no files found matching '*.txt' 07:31:22 INFO - no previously-included directories found matching 'build' 07:31:22 INFO - no previously-included directories found matching 'dist' 07:31:22 INFO - no previously-included directories found matching '.git*' 07:31:22 INFO - Successfully installed jsonschema functools32 07:31:22 INFO - Cleaning up... 07:31:23 INFO - Return code: 0 07:31:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:31:23 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')]} 07:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:23 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')]} 07:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:23 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:23 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 07:31:23 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 07:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:23 INFO - 'HOME': '/Users/cltbld', 07:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:23 INFO - 'LOGNAME': 'cltbld', 07:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:23 INFO - 'MOZ_NO_REMOTE': '1', 07:31:23 INFO - 'NO_EM_RESTART': '1', 07:31:23 INFO - 'PAGER': '/bin/cat', 07:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:23 INFO - 'PWD': '/builds/slave/test', 07:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:23 INFO - 'SHELL': '/bin/bash', 07:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:23 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:23 INFO - 'USER': 'cltbld', 07:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:23 INFO - 'XPC_FLAGS': '0x0', 07:31:23 INFO - 'XPC_SERVICE_NAME': '0', 07:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:31:23 INFO - Cleaning up... 07:31:23 INFO - Return code: 0 07:31:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:31:23 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')]} 07:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:23 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')]} 07:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:23 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:23 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 07:31:23 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 07:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:23 INFO - 'HOME': '/Users/cltbld', 07:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:23 INFO - 'LOGNAME': 'cltbld', 07:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:23 INFO - 'MOZ_NO_REMOTE': '1', 07:31:23 INFO - 'NO_EM_RESTART': '1', 07:31:23 INFO - 'PAGER': '/bin/cat', 07:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:23 INFO - 'PWD': '/builds/slave/test', 07:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:23 INFO - 'SHELL': '/bin/bash', 07:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:23 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:23 INFO - 'USER': 'cltbld', 07:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:23 INFO - 'XPC_FLAGS': '0x0', 07:31:23 INFO - 'XPC_SERVICE_NAME': '0', 07:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:23 INFO - Downloading/unpacking blobuploader==1.2.4 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:31:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:31:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:27 INFO - Downloading docopt-0.6.1.tar.gz 07:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:31:27 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:27 INFO - Running setup.py install for blobuploader 07:31:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:31:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:31:27 INFO - Running setup.py install for requests 07:31:28 INFO - Running setup.py install for docopt 07:31:28 INFO - Successfully installed blobuploader requests docopt 07:31:28 INFO - Cleaning up... 07:31:28 INFO - Return code: 0 07:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:28 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')]} 07:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:28 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')]} 07:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:28 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:28 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 07:31:28 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 07:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:28 INFO - 'HOME': '/Users/cltbld', 07:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:28 INFO - 'LOGNAME': 'cltbld', 07:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:28 INFO - 'MOZ_NO_REMOTE': '1', 07:31:28 INFO - 'NO_EM_RESTART': '1', 07:31:28 INFO - 'PAGER': '/bin/cat', 07:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:28 INFO - 'PWD': '/builds/slave/test', 07:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:28 INFO - 'SHELL': '/bin/bash', 07:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:28 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:28 INFO - 'USER': 'cltbld', 07:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:28 INFO - 'XPC_FLAGS': '0x0', 07:31:28 INFO - 'XPC_SERVICE_NAME': '0', 07:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:28 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CPOgDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:28 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-H0_j6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:28 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-URy7zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:28 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-EvjcHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-6pXzoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-gehT8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Ymud4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Yvz9mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-MWRDEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-xmPeFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-yTlSnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-mwXmrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-735jrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:29 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-uAoEqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:30 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-p2UnI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:30 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ETyYvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:30 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-3hmaDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:30 INFO - Running setup.py install for manifestparser 07:31:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:31:30 INFO - Running setup.py install for mozcrash 07:31:30 INFO - Running setup.py install for mozdebug 07:31:30 INFO - Running setup.py install for mozdevice 07:31:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:31:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozfile 07:31:31 INFO - Running setup.py install for mozhttpd 07:31:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozinfo 07:31:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozInstall 07:31:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozleak 07:31:31 INFO - Running setup.py install for mozlog 07:31:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for moznetwork 07:31:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:31:32 INFO - Running setup.py install for mozprocess 07:31:32 INFO - Running setup.py install for mozprofile 07:31:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:31:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:31:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:31:32 INFO - Running setup.py install for mozrunner 07:31:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:31:32 INFO - Running setup.py install for mozscreenshot 07:31:32 INFO - Running setup.py install for moztest 07:31:32 INFO - Running setup.py install for mozversion 07:31:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:31:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:32 INFO - Cleaning up... 07:31:33 INFO - Return code: 0 07:31:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:33 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:33 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 07:31:33 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 07:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:33 INFO - 'HOME': '/Users/cltbld', 07:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:33 INFO - 'LOGNAME': 'cltbld', 07:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:33 INFO - 'MOZ_NO_REMOTE': '1', 07:31:33 INFO - 'NO_EM_RESTART': '1', 07:31:33 INFO - 'PAGER': '/bin/cat', 07:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:33 INFO - 'PWD': '/builds/slave/test', 07:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:33 INFO - 'SHELL': '/bin/bash', 07:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:33 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:33 INFO - 'USER': 'cltbld', 07:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:33 INFO - 'XPC_FLAGS': '0x0', 07:31:33 INFO - 'XPC_SERVICE_NAME': '0', 07:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:33 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-TXgmJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:33 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)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:33 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-JwfoZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:33 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GlFjXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:33 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)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:33 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-M6PnKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:33 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GgdhzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:33 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)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:33 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-PxBZH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:33 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)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:33 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zt7nwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:34 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CKOi5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:34 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-oUovgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:34 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-KYKixh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:34 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-VidKAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:34 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-J4IN0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-2cmfyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:34 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-APVREf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-q7fIF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:34 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)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:34 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-k1WBnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 07:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:35 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-hWB_71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:35 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)) 07:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:35 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)) 07:31:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:35 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:37 INFO - Downloading blessings-1.6.tar.gz 07:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:37 INFO - Installing collected packages: blessings 07:31:37 INFO - Running setup.py install for blessings 07:31:38 INFO - Successfully installed blessings 07:31:38 INFO - Cleaning up... 07:31:38 INFO - Return code: 0 07:31:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:38 INFO - Reading from file tmpfile_stdout 07:31:38 INFO - Current package versions: 07:31:38 INFO - blessings == 1.6 07:31:38 INFO - blobuploader == 1.2.4 07:31:38 INFO - docopt == 0.6.1 07:31:38 INFO - functools32 == 3.2.3-2 07:31:38 INFO - jsonschema == 2.5.1 07:31:38 INFO - manifestparser == 1.1 07:31:38 INFO - mozInstall == 1.12 07:31:38 INFO - mozcrash == 1.0 07:31:38 INFO - mozdebug == 0.1 07:31:38 INFO - mozdevice == 0.49 07:31:38 INFO - mozfile == 1.2 07:31:38 INFO - mozhttpd == 0.7 07:31:38 INFO - mozinfo == 0.9 07:31:38 INFO - mozleak == 0.1 07:31:38 INFO - mozlog == 3.4 07:31:38 INFO - moznetwork == 0.27 07:31:38 INFO - mozprocess == 0.24 07:31:38 INFO - mozprofile == 0.28 07:31:38 INFO - mozrunner == 6.13 07:31:38 INFO - mozscreenshot == 0.1 07:31:38 INFO - mozsystemmonitor == 0.3 07:31:38 INFO - moztest == 0.8 07:31:38 INFO - mozversion == 1.4 07:31:38 INFO - psutil == 3.1.1 07:31:38 INFO - requests == 1.2.3 07:31:38 INFO - wsgiref == 0.1.2 07:31:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:38 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')]} 07:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:38 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')]} 07:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:38 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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31:38 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 07:31:38 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 07:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:38 INFO - 'HOME': '/Users/cltbld', 07:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:38 INFO - 'LOGNAME': 'cltbld', 07:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:38 INFO - 'MOZ_NO_REMOTE': '1', 07:31:38 INFO - 'NO_EM_RESTART': '1', 07:31:38 INFO - 'PAGER': '/bin/cat', 07:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:38 INFO - 'PWD': '/builds/slave/test', 07:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:38 INFO - 'SHELL': '/bin/bash', 07:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:38 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:38 INFO - 'USER': 'cltbld', 07:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:38 INFO - 'XPC_FLAGS': '0x0', 07:31:38 INFO - 'XPC_SERVICE_NAME': '0', 07:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 INFO - Cleaning up... 07:31:38 INFO - Return code: 0 07:31:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:31:38 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')]} 07:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:38 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')]} 07:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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 0x1010f2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010f5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2d24f4cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, '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.aruRv57Khh/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.iFpD53x374/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 07:31: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 07:31: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 07:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:39 INFO - 'HOME': '/Users/cltbld', 07:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:39 INFO - 'LOGNAME': 'cltbld', 07:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:39 INFO - 'MOZ_NO_REMOTE': '1', 07:31:39 INFO - 'NO_EM_RESTART': '1', 07:31:39 INFO - 'PAGER': '/bin/cat', 07:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:39 INFO - 'PWD': '/builds/slave/test', 07:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:39 INFO - 'SHELL': '/bin/bash', 07:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:31:39 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:39 INFO - 'USER': 'cltbld', 07:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:39 INFO - 'XPC_FLAGS': '0x0', 07:31:39 INFO - 'XPC_SERVICE_NAME': '0', 07:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:31:39 INFO - Cleaning up... 07:31:39 INFO - Return code: 0 07:31:39 INFO - Running post-action listener: _resource_record_post_action 07:31:39 INFO - Running post-action listener: _start_resource_monitoring 07:31:39 INFO - Starting resource monitoring. 07:31:39 INFO - [mozharness: 2017-02-02 15:31:39.450970Z] Finished create-virtualenv step (success) 07:31:39 INFO - [mozharness: 2017-02-02 15:31:39.451911Z] Running install step. 07:31:39 INFO - Running pre-action listener: _resource_record_pre_action 07:31:39 INFO - Running main action method: install 07:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:39 INFO - Reading from file tmpfile_stdout 07:31:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:39 INFO - Reading from file tmpfile_stdout 07:31:39 INFO - Output received: 07:31:39 INFO - Usage: mozinstall [options] installer 07:31:39 INFO - Options: 07:31:39 INFO - -h, --help show this help message and exit 07:31:39 INFO - -d DEST, --destination=DEST 07:31:39 INFO - Directory to install application into. [default: 07:31:39 INFO - "/builds/slave/test"] 07:31:39 INFO - --app=APP Application being installed. [default: firefox] 07:31:39 INFO - mkdir: /builds/slave/test/build/application 07:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:32:00 INFO - Reading from file tmpfile_stdout 07:32:00 INFO - Output received: 07:32:00 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:32:00 INFO - Running post-action listener: _resource_record_post_action 07:32:00 INFO - [mozharness: 2017-02-02 15:32:00.133806Z] Finished install step (success) 07:32:00 INFO - [mozharness: 2017-02-02 15:32:00.133948Z] Running run-tests step. 07:32:00 INFO - Running pre-action listener: _resource_record_pre_action 07:32:00 INFO - Running main action method: run_tests 07:32:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:32:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:32:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:32:00 INFO - 2017-02-02 07:32:00.148 screenresolution[2540:35844] starting screenresolution argv=screenresolution get 07:32:00 INFO - 2017-02-02 07:32:00.151 screenresolution[2540:35844] Display 0: 1600x1200x32@60 07:32:00 INFO - 2017-02-02 07:32:00.157 screenresolution[2541:35846] starting screenresolution argv=screenresolution list 07:32:00 INFO - Available Modes on Display 0 07:32:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:32:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:32:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:32:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:32:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:32:00 INFO - Intel Iris: 07:32:00 INFO - Chipset Model: Intel Iris 07:32:00 INFO - Type: GPU 07:32:00 INFO - Bus: Built-In 07:32:00 INFO - VRAM (Dynamic, Max): 1536 MB 07:32:00 INFO - Vendor: Intel (0x8086) 07:32:00 INFO - Device ID: 0x0a2e 07:32:00 INFO - Revision ID: 0x0009 07:32:00 INFO - Displays: 07:32:00 INFO - Display: 07:32:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:32:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:32:00 INFO - Display Serial Number: 1600x1200 60 07:32:00 INFO - Main Display: Yes 07:32:00 INFO - Mirror: Off 07:32:00 INFO - Online: Yes 07:32:00 INFO - Rotation: Supported 07:32:00 INFO - Return code: 0 07:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:32:00 INFO - Python 2.7.3 07:32:00 INFO - Return code: 0 07:32:00 INFO - grabbing minidump binary from tooltool 07:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:00 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 0x100ed0d30>, '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 0x100df7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ec5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:32:00 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 07:32:00 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 07:32:00 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 07:32:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:32:00 INFO - Return code: 0 07:32:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:32:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:32:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:32:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:32:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 07:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --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 07:32:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aruRv57Khh/Render', 07:32:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:00 INFO - 'HOME': '/Users/cltbld', 07:32:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:00 INFO - 'LOGNAME': 'cltbld', 07:32:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:32:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:00 INFO - 'MOZ_NO_REMOTE': '1', 07:32:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:32:00 INFO - 'NO_EM_RESTART': '1', 07:32:00 INFO - 'PAGER': '/bin/cat', 07:32:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:00 INFO - 'PWD': '/builds/slave/test', 07:32:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:32:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:00 INFO - 'SHELL': '/bin/bash', 07:32:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iFpD53x374/Listeners', 07:32:00 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 07:32:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:00 INFO - 'USER': 'cltbld', 07:32:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:00 INFO - 'XPC_FLAGS': '0x0', 07:32:00 INFO - 'XPC_SERVICE_NAME': '0', 07:32:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 07:32:00 INFO - mozversion application_buildid: 20170202061208 07:32:00 INFO - mozversion application_changeset: d1569ed822af8f33141533522e7ea3b3ab6f2eea 07:32:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:32:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:32:00 INFO - mozversion application_name: Firefox 07:32:00 INFO - mozversion application_remotingname: firefox-dev 07:32:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:32:00 INFO - mozversion application_vendor: Mozilla 07:32:00 INFO - mozversion application_version: 53.0a2 07:32:00 INFO - mozversion platform_buildid: 20170202061208 07:32:00 INFO - mozversion platform_changeset: d1569ed822af8f33141533522e7ea3b3ab6f2eea 07:32:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:32:00 INFO - mozversion platform_version: 53.0a2 07:32:00 INFO - using testdate: 1486049520 07:32:00 INFO - actual date: 1486049520 07:32:00 INFO - starting webserver on 'localhost:56519' 07:32:00 INFO - SUITE-START | Running 2 tests 07:32:00 INFO - TEST-START | dromaeo_css 07:32:00 INFO - operating with platform_type : mac_ 07:32:00 INFO - Initialising browser for dromaeo_css test... 07:32:00 INFO - TEST-INFO | started process 2551 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp0F5wif/profile http://localhost:56519/getInfo.html) 07:32:03 INFO - PROCESS | 2551 | __metrics Screen width/height:1600/1200 07:32:03 INFO - PROCESS | 2551 | colorDepth:24 07:32:03 INFO - PROCESS | 2551 | Browser inner width/height: 1024/689 07:32:03 INFO - PROCESS | 2551 | __metrics 07:32:03 INFO - PROCESS | 2551 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:32:03 INFO - PROCESS | 2551 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:32:03 INFO - TEST-INFO | 2551: exit 0 07:32:03 INFO - Browser initialized. 07:32:03 INFO - Running cycle 1/1 for dromaeo_css test... 07:32:03 INFO - TEST-INFO | started process 2553 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp0F5wif/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:15 INFO - PROCESS | 2553 | RSS: Main: 213020672 07:32:15 INFO - PROCESS | 2553 | 07:35:19 INFO - PROCESS | 2553 | Cycle 1(1): loaded http://localhost:56519/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56519/tests/dromaeo/cssquery-ext.html) 07:35:21 INFO - PROCESS | 2553 | RSS: Main: 359370752 07:35:21 INFO - PROCESS | 2553 | 07:37:06 INFO - PROCESS | 2553 | ************************* 07:37:06 INFO - PROCESS | 2553 | A coding exception was thrown and uncaught in a Task. 07:37:06 INFO - PROCESS | 2553 | 07:37:06 ERROR - PROCESS | 2553 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:37:06 INFO - PROCESS | 2553 | Full stack: 07:37:06 INFO - PROCESS | 2553 | ************************* 07:38:24 INFO - PROCESS | 2553 | Cycle 1(1): loaded http://localhost:56519/tests/dromaeo/cssquery-ext.html (next: http://localhost:56519/tests/dromaeo/cssquery-jquery.html) 07:38:24 INFO - PROCESS | 2553 | RSS: Main: 349085696 07:38:24 INFO - PROCESS | 2553 | 07:41:27 INFO - PROCESS | 2553 | Cycle 1(1): loaded http://localhost:56519/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56519/tests/dromaeo/cssquery-mootools.html) 07:41:27 INFO - PROCESS | 2553 | RSS: Main: 323522560 07:41:27 INFO - PROCESS | 2553 | 07:44:29 INFO - PROCESS | 2553 | Cycle 1(1): loaded http://localhost:56519/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56519/tests/dromaeo/cssquery-prototype.html) 07:44:30 INFO - PROCESS | 2553 | RSS: Main: 324689920 07:44:30 INFO - PROCESS | 2553 | 07:47:34 INFO - PROCESS | 2553 | Cycle 1(1): loaded http://localhost:56519/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56519/tests/dromaeo/cssquery-yui.html) 07:47:34 INFO - PROCESS | 2553 | RSS: Main: 314253312 07:47:34 INFO - PROCESS | 2553 | 07:50:37 INFO - PROCESS | 2553 | Cycle 1(1): loaded http://localhost:56519/tests/dromaeo/cssquery-yui.html (next: http://localhost:56519/tests/dromaeo/cssquery-dojo.html) 07:50:38 INFO - PROCESS | 2553 | RSS: Main: 530599936 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | __start_tp_report 07:50:38 INFO - PROCESS | 2553 | _x_x_mozilla_page_load 07:50:38 INFO - PROCESS | 2553 | _x_x_mozilla_page_load_details 07:50:38 INFO - PROCESS | 2553 | |i|pagename|runs| 07:50:38 INFO - PROCESS | 2553 | |0;dojo.html;3258.6089669239686;3280.4587243104897;3281.60620725513;3304.1409233599256;3340.2317466982595;5662.971685141573;5712.771489140439;5735.397783232758;5741.799037033705;5754.827355179346;5643.379228284885;5717.571182161334;5734;5734.254546908906;5754.971225143879;5154.149565321717;5177.792888284464;5223.738813059351;5227.242049902762;5289.338832645919;5138.897222055557;5153.1754919212935;5173.870653233662;5292.047431462354;5302.2841916341185;5184.274201611777;5185.714785686786;5234.738263086831;5235.790568377261;5245.239440281157;5218.165093585008;5264.368275806909;5269.314989051437;5273.182656688219;5278.788848446057;4404.273294906337;5055.949440505585;5116.897662046776;5223.294855194538;5231.058409486291;5535.169724541311;5579.721013949327;5696.829095127153;5704.572157088193;5806.854828629276;6116.649330353797;6144.341027922436;6170;6189.907151392733;6264.655443950581;6175.2898416681755;6244.687765611747;6245.313015568284;6252.3122456529745;6283.937160628427;5778.479936805624;5849.941500585025;5849.947009538324;5857.4435428634215;5862;6145.801568694062;6161.84595385119;6175.96912015446;6194.969025154845;6205.28639206488;6134.987727024991;6141.477974372139;6143.986242269975;6144.9246381882995;6157.291911430243;6163.691815409212;6218.1916350875;6226.875462490725;6227.470664993526;6235;6056.364081771439;6114.602550834182;6118.938810611926;6119.632822030692;6201.6899155042065;6108.835692699231;6141.332587233735;6158.414950579688;6209.410106039919;6214;4942.332785074041;4949.480304567968;4964.379452568429;4964.478729733326;4988.152014157602;4362.236608593484;4444.8444304449185;4450.888727781831;4458.974435879701;4473;5569.0254205513875;5630.127330263816;5640;5645.407232240637;5655.5475561954945;6196.442320191204;6212.782552610637;6239.188905442264;6245.656488893063;6259.280182779039;5593.804216852391;5640.915386269127;5672.801451949162;5710;5717.199592057115;5337.439568845293;5402.054640437907;5408.648437851527;5416.21464887597;5418.349798024262;6211.192544969125;6218.471429928507;6224.844378890564;6228.252609686957;6245.219347581552;6174.629522228681;6201.224846894138;6228.688565571794;6233.065040244;6250.124982502362;5317.920231196458;6298.653574053471;6313.715882785194;6315.936840631535;6330.936690633035;5996.2504686914135;6048.0625503047095;6059.030555111161;6090.390960904051;6184;6227.937720622917;6237.7193026314835;6247.468965138014;6254.124422580933;6258.186435763504;5065.366829146356;6085.361037091042;6103.084537319438;6109.541784366279;6114.785982490592;5931.1992880960515;6001.699915004319;6039.516838652985;6041.275046994213;6065.939340606537;5829.883402331845;5914.172015917689;6003.339632640494;6011.368806275453;6053.213082299273;6143.723532440961;6154.815355539341;6160;6176.783812566719;6198.597091189058;5688.40271771458;5789.1895134680335;6011.819645410645;6012.8797424052145;6018.007028840192 07:50:38 INFO - PROCESS | 2553 | |1;ext.html;435.8583460375377;461;465.4066065766148;473.8223166312633;494.9260105570911;30494.69505304946;40158.397624035664;41911;42026;42145.57854421455;41507.584924150826;41807;41899.581004189946;42014;42223.57776422235;8373.790655233637;9199.356045076831;9397;9413.341066125375;9429.528523573828;8400.663973441055;11151.776964460705;11392.54429822806;11418.71453213668;11576.652700419001;11319.151063670217;11398.145139114558;11400.087992960585;11433.314001159915;11436.2566433182;8393.580320983927;11304.830427543553;11374.260673056226;11377.601783937605;11390.829137562943;8405.285550728195;11057;11323.377214253213;11339.206255562114;11578.94210528942;35753.46369804455;39337.40993885094;40875.7956210217;41040.79479602613;41280.587194128275;3898.2203559288255;3974.324364857981;3974.8012599369918;4023.698222633285;4036.2734707752593;28533;28629.57055644167;28696.85212591494;30623;31413.528797068062;3163.7469002479975;3238.70851623355;3244.756643251742;3372.6121496028027;3402.3705614461155;479439.9999999965;479985;481487;481790;481931;50921;62662;62665.37334626595;62681.05978410327;62826;65614;65707.67146164335;65728.34271657222;65785;65839.67080164568;15988;16469.34122635081;16492.25784839661;16493.257803398636;16515.66968660644;11575.016123629417;11886.286822790487;12722.045846561545;12781.872181278255;12828.230306181658;15230.923845380703;16838.66322673564;17126.40057597978;17216.569585760455;17392.826071739375;7502.84994300111;7607.847843043108;7608.619569021526;7630.2751238632245;7648.617569121633;883.2051153961357;890.6749036601723;903.2593273515654;906.6509393883271;933.6218831373304;28769.56845647317;28901.710982890323;29690.55464168039;29888.103356899326;30326.54510182305;1042.6559235452435;1046.8325067989085;1072.2736394405001;1075.9031687148195;1080.6001779341693;13765.724685506233;14212.360443779848;14419.94362367808;14576.052556583789;14683.853161468249;617146;621459;621594;621932;622568;51217;51535;51561.96876062458;51652;51682.74158629183;1414.886809055273;1430.6924011337612;1469.4709904434394;1471.9484818031317;1474.7566651502596;22240.888795556566;26615.866920665274;26851.86574067117;27454.5881811769;27645.58531621987;45242.773786130856;45705.628831135116;45719.314210286204;45815.54184458113;45872.8531786708;398441;400164;400586;400801;401637.92629331164;24117.15589954343;24315.270541883772;24406.02375904944;24536.6319505204;24546.386340341633;40843.59156408398;42035;42645;42833.92915177145;43102.92242693958;35354;35503.46744798779;35648;35777.64222357743;36349.00080495492;35514.82242588874;35591;35746;36224;36292.63707362998;34042.65957340494;34211;34576.48135278023;34890.65109348975;34908.47637285494;29722;31809.204769880937;31849.044528664177;31890.52164217492;31982.840085799424;19577.70633440471;23813.166539171045;24150.87924560366;24195.516089677756;24240.030398783852 07:50:38 INFO - PROCESS | 2553 | |2;jquery.html;330.7717674804385;332.3021654525497;366.1377456090904;398.3646084495229;413.33040474431425;15506.767398489017;15924.363025478982;16287.1042092685;17720.379786707468;20672.896635516838;18456.815431845676;21363;21469.355919322406;21691.891540542314;22113.778862211373;4941.110600091982;5787.971060144704;5912.556558258127;5963.910541341883;5971.910421343683;5884.2056322396575;5946.524278057766;5963.910541341862;5996.5202783777195;6020.909686354708;5638.661680299175;5753.769849206027;5893.64638121712;5899.321578018518;5918.792842250522;5855.941440585582;5913.172155898178;5913.970430147821;5930.733117009745;5941.168236446879;5212.087884620214;5216.608754343401;6852.554583952027;7359.595222262774;7747.147813740484;29424;29811.70188298111;30170.396592068257;30245.546316805267;30263.69736302631;2698.338906967786;3011.8945836895823;3015.7888947773663;3047.101105173979;3069.0639354996715;17152.742708859376;17256.965728268067;17369.47891563255;17458;18002.09989500533;1946.5036415714044;1998.9100490477963;1999.9700004499798;2003.9980009995002;2011.2357304224302;143414;152439.47560524475;161512;161777;165111;23883.641745373832;24408.877955610464;24473.38816529601;24593.385165371008;24709.629355559682;42644.360334595;42798.78600606977;42919.57080429156;43912.780436097615;44135.55864441379;8415;8618.353623478264;8923.063078376807;8923.196912277926;9004.144606262395;8647.890267018905;8781.560921953876;8797.824043519095;8913.420627659181;8942.86585701215;4725.5983241424865;4789.137955168103;4808.422989241313;4869.172240719086;4899;1976.663967125592;2034.5422279986885;2046.2531176120906;2055.797358545268;2057.77364489906;859.4928991894812;896.4312453206888;897.9281657467387;912.1061359867367;913.2693844924034;21420.92895355257;21812.454688632595;21923.561528769336;22034.228801991852;22144.557108857734;911.3165126155384;922.377395258198;926.5135803703109;930.2186163622589;943.1700103908516;10885.401302928256;11376.54493820238;11394.601188958346;11421.885781142248;11489;339448;366478;528780.7121928731;720436;752134;105360.94639053511;132848.33575832253;138288.30855845657;168299.15850420913;172728.27271727374;982.1651596143221;1023.2172388123092;1073.6027669762238;1076.8976947190004;1080.7946490166844;19502.707459387835;19606.019699015276;20041.899790500953;20074.297399590945;20094.995250237724;57186.7140664294;61210.69394653176;61442.77114457775;63429.365706342345;63776;91471.54264228637;91715;94650;95729.5213523928;96035.59911002281;8071.4753541019645;8134.227248411392;8199.180081991753;8500;8573.442726222776;9314.906850931404;11195.888041119484;12951.740965180832;13406.463741450232;13640.727185456433;11407.144464165387;11473.541058357907;11487.597934072268;11725.706857328634;12043.217190882564;9162.312826537904;9491.762705932131;11354.26197297173;11892.702682432662;12057.457414416196;11650.76698466009;11769.411529423323;11806.232594881305;11808.76382472363;12100.152989290666;7449.404047676281;8251.546164960744;8356.247937685393;8365.707200247962;8707.08575599553;8519.574021298786;11355.54577816878;11632.243904146204;11938.403079846146;11991.100667449802 07:50:38 INFO - PROCESS | 2553 | |3;mootools.html;1446.3636000159922;1451.3831621560835;1461.7734251191066;1467.6330917270682;1471.1246808149147;8116.472429292092;8493.362997775168;8521;8523.488590684563;8527.019392769826;7361.190269070411;7661.387089032878;7666.88499672504;8013.318867896236;8237.258646721793;2276.5902137615262;2320.466292752668;2323.1636610820174;2324;2330.0563271874917;2307.365474494519;2332.976670233293;2334.1830359374167;2338.6608941703444;2346.7770561796688;2279.589673858705;2284.5088306014204;2292.885355732215;2295.1393227539675;2309.1571576374586;2261.0955617752866;2274.727032756063;2291.140822191678;2318.455163036685;2323.2217207235594;2302.067662596651;2326.174208156097;2331.184085570037;2332.7433982261937;2335.474518233401;8380.120087390858;8435.451695639764;8435.578221088921;8440.324774018063;8441.98696156459;5029.547340739351;5192.013517431676;5192.273081768518;5193.558547523465;5196.974015129938;3137.2470607054142;3268.8855890043974;3437.204910292744;3491.6508349165133;3556.590992035897;1184.129664696456;1228.7112528555783;1248.6691026877884;1255.761405332993;1255.8492980842266;10619.469026548642;10725.088367488774;10726.302790318605;10728.517216725266;10739.78520429595;4367.497737760134;4593;4675.158471475099;4677.64917631179;4684.882877928011;9444.197243234265;9452.8582071269;9453.480058596706;9453.716388508356;9456.338056336128;5184.37787465499;5210.348706411699;5226.764795584208;5227.372715274191;5232.790688372423;3944.7041471889725;4250.617444430016;4400.141972315432;4695.460022097503;4756.500567440369;3840.9039774005314;3862.748921320105;3937.015746063484;3949.1311911379453;3991.9421353341386;1167.6963989362657;1253.9749205015848;1285.203174032106;1288.3686993373367;1305.7388522295578;780.3055280800093;816.0737562866071;883.765802062454;907.8865141857268;909.7907481279343;5533.612647114744;5566.137248726453;5594.021046316879;5887.786537779859;5895.823125306248;1014.9086582207636;1030.8917563655857;1031.257494603884;1038.7403149212696;1043.0664555223034;3712.795796231233;3793.791341476245;3813.370793819044;3833.1375440526217;3912.237113762789;9789.510524473748;9940.304178707422;10107.69676909694;10116.797664046679;10121.1903047756;9909.603615855429;10027.197824174049;10028.548715307828;10043.347182433119;10048.49757512136;7420.85158296831;7653.502522336031;7670.8082297943;7885.723999659985;7995.280424761683;4870.634702397264;5386;5400.351957765093;5414.7292635367285;5625.943740562542;9050.321225908216;9085.636574536944;9256.629734810533;9345.626174952926;9362.204212642002;9306.674266400643;9374.062593740571;9434.669786557437;9460.148586626961;9530.618775248913;6072.72672729737;6655.800325990228;6858.965705171442;6880.518363714492;7217.7473788417155;7789.688412463438;8108.39187060961;8112.634931427981;8118.675252989814;8175.305099066646;7135;7415.629218538944;7436.628168591657;7497.550146991198;7645.120811106794;7212;7299.708011679473;7342.412606991321;7408.444366672414;7414.369778568882;5831.067029275296;5999.430054144849;6505.934940650533;6511.120998665309;6523.11937888379;4886.853394398174;5024.84925452237;5044.6201045299;5208.765605547836;5255.448177941261;4962.206047032458;5049.520295571915;5070.2141168119;5121.359830021247;5124.5131712487255 07:50:38 INFO - PROCESS | 2553 | |4;prototype.html;344.7142159744154;357.4584504475718;358.9515415418919;370.2299217627334;371.82710039831505;4580.564846339596;5164.173732202848;5228.503292187241;5356.455683550312;5544.750486228119;4738.218193997986;5064.544191022807;5199.402068762084;5204.048481819318;5261.368635763704;3975.3043217436975;4148.668106551484;4184.531126635285;4196.454460920076;4211.410402543646;3678.6505281998166;4086.6117718816813;4151.771652559108;4225.535191128974;4242.703010789246;3774.924501509968;4150.709450338478;4154.4183814266025;4195.685323600727;4223.965128543511;3311.4701647736365;3482.860685572574;4154.626083652486;4162.105147393325;4200.516940551845;3683.631636836322;3684.613115622848;3693.630636936312;3695.8521659133603;3709.1995543364856;4288.656907447396;4813.687110337817;4939.876503087416;5190.377154741455;5267.315249017642;4234.68239882007;4400.3058822353305;4452.172870227397;4688.944987377847;4827.734474603895;5655.604107712462;5657.51911087554;5664.20701101846;5665.3201615806365;5672.716364181774;3472.861085556575;4035.2131334389805;4095.2833254180696;4100.17996400721;4168.832207252211;5487.780488780444;5562.666240025571;5807.564432667525;5837.795677151279;5920.644761314249;3428.8856121760527;4169.207850508394;4194.224068547329;4197.9370309445385;4290.2706539888295;4072.7963601819793;4195.97902010488;4209.915801683949;4230.302000169999;4258.254805409041;4804.759762011886;4824.445188803263;4836.443808961944;4841.685290456109;4924.630652701062;4816.157172494799;5639.802606908738;5673.723412232214;5677.801276955287;5740.253767010262;1237.9910373045939;1302.426932149851;1314.8619394963582;1361.3329468560335;1363.7749771287627;819.5082950229814;894.3320706881749;948.1750876737283;958.8561715742694;981.7545613596601;4938.456769755324;4953.910139769245;4975.591719671964;5027.396712394536;5050.696958182521;4712.81148754046;4873.780679869415;5449.264349312872;5499.835004949858;5534.952067734884;4256.106217694257;4405.06202730694;4419.867403977886;4661.067786442725;4888.826681596463;2337.8947947342413;2453.1291391556097;2547.7261369315343;2822.350859302372;2898.2464559214754;4928.507149285043;4944;5003.574696150795;5390.838274851761;5685.630434021776;5454.645448045864;5656.5757568181725;5673.858153546194;5674.77300907959;6018.6990650467305;5463.453654634504;6004.759809607567;6024.614338702123;6029.397060293935;6054.90917636227;4991.925121123113;5384.19237114436;5812.389699081536;5849.502792262535;5871.26797594702;4648.976755116203;5699.347189315218;5789.813088316969;5804.6807425592;5807.535397168301;5951.345352011189;5999.790007349722;6024.939750602438;6025.939740602538;6047.462234592813;3749.8500059998387;3792.715546333981;3900.9609903901733;3913.7651740895635;3936.547297060875;5212.348456442945;5749.712514374348;5763.423657634203;5814.284785988059;5843.532517398513;5518.668879867221;5518.944810551843;5525.397634685896;5533.446655334596;5540.972295138498;5143.871403214949;5179.741012949413;5436.891262174813;5516.227728118147;5678.488935995781;5347.598930080182;5479.53423958968;5535.501804837584;5539.7230138492105;5547.306586676666;4735.6211503078985;5622;5637.8590535236945;5667.882664534407;5670.8015219467125;4613.907721845477;5496.367917689517;5517.393086760373;5527.309086364205;5541.3806016727 07:50:38 INFO - PROCESS | 2553 | |5;yui.html;699.4474365251451;713.7787285941355;727.8944553039813;745.4781652843011;749.9700011999519;14857.702845943088;15801.525954221377;15806.209689515506;15834.920825395886;15837;14435.927820360883;14446.783298250535;14450.060746051526;14463;14507;685.9725610975555;705.633070803182;709.8118998465411;860.0754189246585;861.0958493581729;776;870.8606622940331;881.801594641207;882.2500874256895;883.483162350026;944.8441007233832;946.2855544064222;946.8295706772813;947.5499137909472;950.1638558068925;724.3625609463638;749.2395218852869;941.3692825806726;941.3786900645541;941.5527624378366;670.9832254193635;690.7375197424947;694.3854688600575;694.9027136200936;697.7209116353448;14856.257187140707;15211.61970950724;15264.38942442301;15273.236338183046;15306.540803775904;11595.826062609067;13925.860741392558;14017.560548032507;14073.577792666236;14250.144991300554;12218.938905305506;12824.909882659986;13011.284379359131;13190.60428187156;13562.779349858462;4398.604125628709;4471.7987690554;4496.527864574238;4665.580097791215;4675;103005.96994030113;103513.4824325881;104055;104750;104901.47549262205;10458.790824183627;10881.727956800985;10909.563617455371;11156.442177891235;11257.268277561932;22810.42973925632;22822.31533054011;22829.7717022831;22858.885705571367;22859.657105143437;7395;7655.272749088827;7686.039245094364;7729.768106956801;7983.600819959095;4161.583841615814;4183.058811767328;4281.207976524353;4306.440162778818;4387.407699960465;3504.0714210734177;3519.982400087983;3599.7480176387403;3600.5499312585926;3605.6754892059316;572.093232226925;576.2537513919484;577.3504807092022;582.6474982635444;584.6871923520896;651.2998526583847;655.2759201082735;663.5355251324092;665.7569986954727;679.3681875855502;9303.674371396968;9920.900790991998;9947.701568952943;10081.042300981395;10104.191664666809;621.1862460177182;666.1440049536322;675.5777638975641;676.3912478769049;677.0487465111527;4078.3678529827926;4723.48041715411;4776.450708168536;4831.758412079382;4856.077345304451;102563;106081.40877886838;106985;107101;108585.45707271571;80201;88390.11609883947;90531.54734226287;93065.53467232756;96527;64241.678791606675;79510;82332.58833705913;82547.17452825516;82596.58701706454;9374.343795934219;9392.95303523478;9407.2003879671;9414.717558473258;9420.811583768424;51107.97784044224;52554.47445525649;53351.46648533465;53886.730566346916;54635.72682136723;67129.66435167793;67564.6621766888;67982.64034719179;68639;68676.31323686898;11480.540778369106;11501.827472588086;11507.942460287644;11573.479193436484;12152.878471215176;9750.317477776487;11483.655490335303;11490.08079353633;12030.338331391857;12534.435950382436;11326.32042077478;11816.46825892854;11901.880981190077;12447.626571202878;13906.791398129239;11043.447827608748;13280.335983200994;13990.720185596434;14079.859201408264;14223.431062757374;12214.6946326339;13270.402831872781;13345.532906348231;13347.065705400917;13347.20880101085;10388.324758890649;11274.549018039186;11280.943595281971;11298.548058077586;11917.463714133059;8871.334649901411;8976.326775491994;9792.216622670026;10886.836697449386;10893.128549716163 07:50:38 INFO - PROCESS | 2553 | __end_tp_report 07:50:38 INFO - PROCESS | 2553 | __start_cc_report 07:50:38 INFO - PROCESS | 2553 | _x_x_mozilla_cycle_collect,1423 07:50:38 INFO - PROCESS | 2553 | __end_cc_report 07:50:38 INFO - PROCESS | 2553 | __startTimestamp1486050638093__endTimestamp 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | ------- Summary: start ------- 07:50:38 INFO - PROCESS | 2553 | Number of tests: 6 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | [#0] dojo.html Cycles:165 Average:5713.15 Median:5996.25 stddev:639.90 (10.7%) stddev-sans-first:612.21 07:50:38 INFO - PROCESS | 2553 | Values: 3258.6 3280.5 3281.6 3304.1 3340.2 5663.0 5712.8 5735.4 5741.8 5754.8 5643.4 5717.6 5734.0 5734.3 5755.0 5154.1 5177.8 5223.7 5227.2 5289.3 5138.9 5153.2 5173.9 5292.0 5302.3 5184.3 5185.7 5234.7 5235.8 5245.2 5218.2 5264.4 5269.3 5273.2 5278.8 4404.3 5055.9 5116.9 5223.3 5231.1 5535.2 5579.7 5696.8 5704.6 5806.9 6116.6 6144.3 6170.0 6189.9 6264.7 6175.3 6244.7 6245.3 6252.3 6283.9 5778.5 5849.9 5849.9 5857.4 5862.0 6145.8 6161.8 6176.0 6195.0 6205.3 6135.0 6141.5 6144.0 6144.9 6157.3 6163.7 6218.2 6226.9 6227.5 6235.0 6056.4 6114.6 6118.9 6119.6 6201.7 6108.8 6141.3 6158.4 6209.4 6214.0 4942.3 4949.5 4964.4 4964.5 4988.2 4362.2 4444.8 4450.9 4459.0 4473.0 5569.0 5630.1 5640.0 5645.4 5655.5 6196.4 6212.8 6239.2 6245.7 6259.3 5593.8 5640.9 5672.8 5710.0 5717.2 5337.4 5402.1 5408.6 5416.2 5418.3 6211.2 6218.5 6224.8 6228.3 6245.2 6174.6 6201.2 6228.7 6233.1 6250.1 5317.9 6298.7 6313.7 6315.9 6330.9 5996.3 6048.1 6059.0 6090.4 6184.0 6227.9 6237.7 6247.5 6254.1 6258.2 5065.4 6085.4 6103.1 6109.5 6114.8 5931.2 6001.7 6039.5 6041.3 6065.9 5829.9 5914.2 6003.3 6011.4 6053.2 6143.7 6154.8 6160.0 6176.8 6198.6 5688.4 5789.2 6011.8 6012.9 6018.0 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | [#1] ext.html Cycles:180 Average:63625.85 Median:35552.91 stddev:135848.67 (382.1%) stddev-sans-first:136146.91 07:50:38 INFO - PROCESS | 2553 | Values: 435.9 461.0 465.4 473.8 494.9 30494.7 40158.4 41911.0 42026.0 42145.6 41507.6 41807.0 41899.6 42014.0 42223.6 8373.8 9199.4 9397.0 9413.3 9429.5 8400.7 11151.8 11392.5 11418.7 11576.7 11319.2 11398.1 11400.1 11433.3 11436.3 8393.6 11304.8 11374.3 11377.6 11390.8 8405.3 11057.0 11323.4 11339.2 11578.9 35753.5 39337.4 40875.8 41040.8 41280.6 3898.2 3974.3 3974.8 4023.7 4036.3 28533.0 28629.6 28696.9 30623.0 31413.5 3163.7 3238.7 3244.8 3372.6 3402.4 479440.0 479985.0 481487.0 481790.0 481931.0 50921.0 62662.0 62665.4 62681.1 62826.0 65614.0 65707.7 65728.3 65785.0 65839.7 15988.0 16469.3 16492.3 16493.3 16515.7 11575.0 11886.3 12722.0 12781.9 12828.2 15230.9 16838.7 17126.4 17216.6 17392.8 7502.8 7607.8 7608.6 7630.3 7648.6 883.2 890.7 903.3 906.7 933.6 28769.6 28901.7 29690.6 29888.1 30326.5 1042.7 1046.8 1072.3 1075.9 1080.6 13765.7 14212.4 14419.9 14576.1 14683.9 617146.0 621459.0 621594.0 621932.0 622568.0 51217.0 51535.0 51562.0 51652.0 51682.7 1414.9 1430.7 1469.5 1471.9 1474.8 22240.9 26615.9 26851.9 27454.6 27645.6 45242.8 45705.6 45719.3 45815.5 45872.9 398441.0 400164.0 400586.0 400801.0 401637.9 24117.2 24315.3 24406.0 24536.6 24546.4 40843.6 42035.0 42645.0 42833.9 43102.9 35354.0 35503.5 35648.0 35777.6 36349.0 35514.8 35591.0 35746.0 36224.0 36292.6 34042.7 34211.0 34576.5 34890.7 34908.5 29722.0 31809.2 31849.0 31890.5 31982.8 19577.7 23813.2 24150.9 24195.5 24240.0 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | [#2] jquery.html Cycles:180 Average:37223.40 Median:331.54 stddev:97161.76 (29306.5%) stddev-sans-first:97394.84 07:50:38 INFO - PROCESS | 2553 | Values: 330.8 332.3 366.1 398.4 413.3 15506.8 15924.4 16287.1 17720.4 20672.9 18456.8 21363.0 21469.4 21691.9 22113.8 4941.1 5788.0 5912.6 5963.9 5971.9 5884.2 5946.5 5963.9 5996.5 6020.9 5638.7 5753.8 5893.6 5899.3 5918.8 5855.9 5913.2 5914.0 5930.7 5941.2 5212.1 5216.6 6852.6 7359.6 7747.1 29424.0 29811.7 30170.4 30245.5 30263.7 2698.3 3011.9 3015.8 3047.1 3069.1 17152.7 17257.0 17369.5 17458.0 18002.1 1946.5 1998.9 2000.0 2004.0 2011.2 143414.0 152439.5 161512.0 161777.0 165111.0 23883.6 24408.9 24473.4 24593.4 24709.6 42644.4 42798.8 42919.6 43912.8 44135.6 8415.0 8618.4 8923.1 8923.2 9004.1 8647.9 8781.6 8797.8 8913.4 8942.9 4725.6 4789.1 4808.4 4869.2 4899.0 1976.7 2034.5 2046.3 2055.8 2057.8 859.5 896.4 897.9 912.1 913.3 21420.9 21812.5 21923.6 22034.2 22144.6 911.3 922.4 926.5 930.2 943.2 10885.4 11376.5 11394.6 11421.9 11489.0 339448.0 366478.0 528780.7 720436.0 752134.0 105360.9 132848.3 138288.3 168299.2 172728.3 982.2 1023.2 1073.6 1076.9 1080.8 19502.7 19606.0 20041.9 20074.3 20095.0 57186.7 61210.7 61442.8 63429.4 63776.0 91471.5 91715.0 94650.0 95729.5 96035.6 8071.5 8134.2 8199.2 8500.0 8573.4 9314.9 11195.9 12951.7 13406.5 13640.7 11407.1 11473.5 11487.6 11725.7 12043.2 9162.3 9491.8 11354.3 11892.7 12057.5 11650.8 11769.4 11806.2 11808.8 12100.2 7449.4 8251.5 8356.2 8365.7 8707.1 8519.6 11355.5 11632.2 11938.4 11991.1 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | [#3] mootools.html Cycles:180 Average:5447.79 Median:5122.94 stddev:2960.53 (57.8%) stddev-sans-first:2953.56 07:50:38 INFO - PROCESS | 2553 | Values: 1446.4 1451.4 1461.8 1467.6 1471.1 8116.5 8493.4 8521.0 8523.5 8527.0 7361.2 7661.4 7666.9 8013.3 8237.3 2276.6 2320.5 2323.2 2324.0 2330.1 2307.4 2333.0 2334.2 2338.7 2346.8 2279.6 2284.5 2292.9 2295.1 2309.2 2261.1 2274.7 2291.1 2318.5 2323.2 2302.1 2326.2 2331.2 2332.7 2335.5 8380.1 8435.5 8435.6 8440.3 8442.0 5029.5 5192.0 5192.3 5193.6 5197.0 3137.2 3268.9 3437.2 3491.7 3556.6 1184.1 1228.7 1248.7 1255.8 1255.8 10619.5 10725.1 10726.3 10728.5 10739.8 4367.5 4593.0 4675.2 4677.6 4684.9 9444.2 9452.9 9453.5 9453.7 9456.3 5184.4 5210.3 5226.8 5227.4 5232.8 3944.7 4250.6 4400.1 4695.5 4756.5 3840.9 3862.7 3937.0 3949.1 3991.9 1167.7 1254.0 1285.2 1288.4 1305.7 780.3 816.1 883.8 907.9 909.8 5533.6 5566.1 5594.0 5887.8 5895.8 1014.9 1030.9 1031.3 1038.7 1043.1 3712.8 3793.8 3813.4 3833.1 3912.2 9789.5 9940.3 10107.7 10116.8 10121.2 9909.6 10027.2 10028.5 10043.3 10048.5 7420.9 7653.5 7670.8 7885.7 7995.3 4870.6 5386.0 5400.4 5414.7 5625.9 9050.3 9085.6 9256.6 9345.6 9362.2 9306.7 9374.1 9434.7 9460.1 9530.6 6072.7 6655.8 6859.0 6880.5 7217.7 7789.7 8108.4 8112.6 8118.7 8175.3 7135.0 7415.6 7436.6 7497.6 7645.1 7212.0 7299.7 7342.4 7408.4 7414.4 5831.1 5999.4 6505.9 6511.1 6523.1 4886.9 5024.8 5044.6 5208.8 5255.4 4962.2 5049.5 5070.2 5121.4 5124.5 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | [#4] prototype.html Cycles:180 Average:4560.10 Median:4983.76 stddev:1378.12 (27.7%) stddev-sans-first:1345.17 07:50:38 INFO - PROCESS | 2553 | Values: 344.7 357.5 359.0 370.2 371.8 4580.6 5164.2 5228.5 5356.5 5544.8 4738.2 5064.5 5199.4 5204.0 5261.4 3975.3 4148.7 4184.5 4196.5 4211.4 3678.7 4086.6 4151.8 4225.5 4242.7 3774.9 4150.7 4154.4 4195.7 4224.0 3311.5 3482.9 4154.6 4162.1 4200.5 3683.6 3684.6 3693.6 3695.9 3709.2 4288.7 4813.7 4939.9 5190.4 5267.3 4234.7 4400.3 4452.2 4688.9 4827.7 5655.6 5657.5 5664.2 5665.3 5672.7 3472.9 4035.2 4095.3 4100.2 4168.8 5487.8 5562.7 5807.6 5837.8 5920.6 3428.9 4169.2 4194.2 4197.9 4290.3 4072.8 4196.0 4209.9 4230.3 4258.3 4804.8 4824.4 4836.4 4841.7 4924.6 4816.2 5639.8 5673.7 5677.8 5740.3 1238.0 1302.4 1314.9 1361.3 1363.8 819.5 894.3 948.2 958.9 981.8 4938.5 4953.9 4975.6 5027.4 5050.7 4712.8 4873.8 5449.3 5499.8 5535.0 4256.1 4405.1 4419.9 4661.1 4888.8 2337.9 2453.1 2547.7 2822.4 2898.2 4928.5 4944.0 5003.6 5390.8 5685.6 5454.6 5656.6 5673.9 5674.8 6018.7 5463.5 6004.8 6024.6 6029.4 6054.9 4991.9 5384.2 5812.4 5849.5 5871.3 4649.0 5699.3 5789.8 5804.7 5807.5 5951.3 5999.8 6024.9 6025.9 6047.5 3749.9 3792.7 3901.0 3913.8 3936.5 5212.3 5749.7 5763.4 5814.3 5843.5 5518.7 5518.9 5525.4 5533.4 5541.0 5143.9 5179.7 5436.9 5516.2 5678.5 5347.6 5479.5 5535.5 5539.7 5547.3 4735.6 5622.0 5637.9 5667.9 5670.8 4613.9 5496.4 5517.4 5527.3 5541.4 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - PROCESS | 2553 | [#5] yui.html Cycles:180 Average:20517.83 Median:4484.16 stddev:29741.14 (663.2%) stddev-sans-first:29787.34 07:50:38 INFO - PROCESS | 2553 | Values: 699.4 713.8 727.9 745.5 750.0 14857.7 15801.5 15806.2 15834.9 15837.0 14435.9 14446.8 14450.1 14463.0 14507.0 686.0 705.6 709.8 860.1 861.1 776.0 870.9 881.8 882.3 883.5 944.8 946.3 946.8 947.5 950.2 724.4 749.2 941.4 941.4 941.6 671.0 690.7 694.4 694.9 697.7 14856.3 15211.6 15264.4 15273.2 15306.5 11595.8 13925.9 14017.6 14073.6 14250.1 12218.9 12824.9 13011.3 13190.6 13562.8 4398.6 4471.8 4496.5 4665.6 4675.0 103006.0 103513.5 104055.0 104750.0 104901.5 10458.8 10881.7 10909.6 11156.4 11257.3 22810.4 22822.3 22829.8 22858.9 22859.7 7395.0 7655.3 7686.0 7729.8 7983.6 4161.6 4183.1 4281.2 4306.4 4387.4 3504.1 3520.0 3599.7 3600.5 3605.7 572.1 576.3 577.4 582.6 584.7 651.3 655.3 663.5 665.8 679.4 9303.7 9920.9 9947.7 10081.0 10104.2 621.2 666.1 675.6 676.4 677.0 4078.4 4723.5 4776.5 4831.8 4856.1 102563.0 106081.4 106985.0 107101.0 108585.5 80201.0 88390.1 90531.5 93065.5 96527.0 64241.7 79510.0 82332.6 82547.2 82596.6 9374.3 9393.0 9407.2 9414.7 9420.8 51108.0 52554.5 53351.5 53886.7 54635.7 67129.7 67564.7 67982.6 68639.0 68676.3 11480.5 11501.8 11507.9 11573.5 12152.9 9750.3 11483.7 11490.1 12030.3 12534.4 11326.3 11816.5 11901.9 12447.6 13906.8 11043.4 13280.3 13990.7 14079.9 14223.4 12214.7 13270.4 13345.5 13347.1 13347.2 10388.3 11274.5 11280.9 11298.5 11917.5 8871.3 8976.3 9792.2 10886.8 10893.1 07:50:38 INFO - PROCESS | 2553 | -------- Summary: end -------- 07:50:38 INFO - PROCESS | 2553 | 07:50:38 INFO - TEST-INFO | 2553: exit 0 07:50:38 INFO - TEST-OK | dromaeo_css | took 1117997ms 07:50:38 INFO - TEST-START | kraken 07:50:38 INFO - operating with platform_type : mac_ 07:50:38 INFO - Initialising browser for kraken test... 07:50:38 INFO - TEST-INFO | started process 2556 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpAeUcvS/profile http://localhost:56519/getInfo.html) 07:50:40 INFO - PROCESS | 2556 | __metrics Screen width/height:1600/1200 07:50:40 INFO - PROCESS | 2556 | colorDepth:24 07:50:40 INFO - PROCESS | 2556 | Browser inner width/height: 1024/689 07:50:40 INFO - PROCESS | 2556 | __metrics 07:50:41 INFO - PROCESS | 2556 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:50:41 INFO - PROCESS | 2556 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:41 INFO - TEST-INFO | 2556: exit 0 07:50:41 INFO - Browser initialized. 07:50:41 INFO - Running cycle 1/1 for kraken test... 07:50:41 INFO - TEST-INFO | started process 2557 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpAeUcvS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:53 INFO - PROCESS | 2557 | RSS: Main: 212951040 07:50:53 INFO - PROCESS | 2557 | 07:50:56 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56519/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:57 INFO - PROCESS | 2557 | RSS: Main: 265822208 07:50:57 INFO - PROCESS | 2557 | 07:51:00 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56519/tests/kraken/driver.html?testName=audio-dft) 07:51:00 INFO - PROCESS | 2557 | RSS: Main: 274862080 07:51:00 INFO - PROCESS | 2557 | 07:51:04 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56519/tests/kraken/driver.html?testName=audio-fft) 07:51:04 INFO - PROCESS | 2557 | RSS: Main: 372609024 07:51:04 INFO - PROCESS | 2557 | 07:51:06 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56519/tests/kraken/driver.html?testName=audio-oscillator) 07:51:07 INFO - PROCESS | 2557 | RSS: Main: 276037632 07:51:07 INFO - PROCESS | 2557 | 07:51:09 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56519/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:51:09 INFO - PROCESS | 2557 | RSS: Main: 278585344 07:51:09 INFO - PROCESS | 2557 | 07:51:12 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56519/tests/kraken/driver.html?testName=imaging-darkroom) 07:51:13 INFO - PROCESS | 2557 | RSS: Main: 320425984 07:51:13 INFO - PROCESS | 2557 | 07:51:16 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56519/tests/kraken/driver.html?testName=imaging-desaturate) 07:51:16 INFO - PROCESS | 2557 | RSS: Main: 320528384 07:51:16 INFO - PROCESS | 2557 | 07:51:19 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56519/tests/kraken/driver.html?testName=json-parse-financial) 07:51:20 INFO - PROCESS | 2557 | RSS: Main: 319307776 07:51:20 INFO - PROCESS | 2557 | 07:51:22 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56519/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:51:22 INFO - PROCESS | 2557 | RSS: Main: 295337984 07:51:22 INFO - PROCESS | 2557 | 07:51:24 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:51:25 INFO - PROCESS | 2557 | RSS: Main: 297545728 07:51:25 INFO - PROCESS | 2557 | 07:51:27 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:51:28 INFO - PROCESS | 2557 | RSS: Main: 299917312 07:51:28 INFO - PROCESS | 2557 | 07:51:31 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:51:31 INFO - PROCESS | 2557 | RSS: Main: 316801024 07:51:31 INFO - PROCESS | 2557 | 07:51:34 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:35 INFO - PROCESS | 2557 | RSS: Main: 310460416 07:51:35 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | Cycle 1(1): loaded http://localhost:56519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56519/tests/kraken/driver.html?testName=ai-astar) 07:51:37 INFO - PROCESS | 2557 | RSS: Main: 354992128 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | __start_tp_report 07:51:37 INFO - PROCESS | 2557 | _x_x_mozilla_page_load 07:51:37 INFO - PROCESS | 2557 | _x_x_mozilla_page_load_details 07:51:37 INFO - PROCESS | 2557 | |i|pagename|runs| 07:51:37 INFO - PROCESS | 2557 | |0;ai-astar;116;116;113;115;115;116;116;115;115;114 07:51:37 INFO - PROCESS | 2557 | |1;audio-beat-detection;148;111;111;149;140;139;110;113;131;109 07:51:37 INFO - PROCESS | 2557 | |2;audio-dft;184;185;184;187;184;183;186;185;184;186 07:51:37 INFO - PROCESS | 2557 | |3;audio-fft;78;59;57;92;62;61;58;59;75;58 07:51:37 INFO - PROCESS | 2557 | |4;audio-oscillator;88;74;87;70;69;70;82;69;70;83 07:51:37 INFO - PROCESS | 2557 | |5;imaging-gaussian-blur;93;90;92;89;92;89;92;87;93;88 07:51:37 INFO - PROCESS | 2557 | |6;imaging-darkroom;101;100;100;100;100;100;100;100;100;100 07:51:37 INFO - PROCESS | 2557 | |7;imaging-desaturate;86;85;87;86;99;132;139;70;131;138 07:51:37 INFO - PROCESS | 2557 | |8;json-parse-financial;54;53;55;54;58;57;58;57;57;58 07:51:37 INFO - PROCESS | 2557 | |9;json-stringify-tinderbox;66;74;82;105;90;72;72;71;73;72 07:51:37 INFO - PROCESS | 2557 | |10;stanford-crypto-aes;83;84;84;83;84;85;83;88;82;85 07:51:37 INFO - PROCESS | 2557 | |11;stanford-crypto-ccm;143;149;140;139;136;144;143;142;204;166 07:51:37 INFO - PROCESS | 2557 | |12;stanford-crypto-pbkdf2;169;168;170;171;168;167;168;168;171;173 07:51:37 INFO - PROCESS | 2557 | |13;stanford-crypto-sha256-iterative;67;65;66;65;63;65;67;66;66;65 07:51:37 INFO - PROCESS | 2557 | __end_tp_report 07:51:37 INFO - PROCESS | 2557 | __start_cc_report 07:51:37 INFO - PROCESS | 2557 | _x_x_mozilla_cycle_collect,2015 07:51:37 INFO - PROCESS | 2557 | __end_cc_report 07:51:37 INFO - PROCESS | 2557 | __startTimestamp1486050697421__endTimestamp 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | ------- Summary: start ------- 07:51:37 INFO - PROCESS | 2557 | Number of tests: 14 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.50 stddev:0.99 (0.9%) stddev-sans-first:1.00 07:51:37 INFO - PROCESS | 2557 | Values: 116.0 116.0 113.0 115.0 115.0 116.0 116.0 115.0 115.0 114.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:135.00 stddev:16.89 (12.5%) stddev-sans-first:15.95 07:51:37 INFO - PROCESS | 2557 | Values: 148.0 111.0 111.0 149.0 140.0 139.0 110.0 113.0 131.0 109.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.23 (0.7%) stddev-sans-first:1.27 07:51:37 INFO - PROCESS | 2557 | Values: 184.0 185.0 184.0 187.0 184.0 183.0 186.0 185.0 184.0 186.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.50 stddev:11.78 (19.2%) stddev-sans-first:11.65 07:51:37 INFO - PROCESS | 2557 | Values: 78.0 59.0 57.0 92.0 62.0 61.0 58.0 59.0 75.0 58.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:78.00 stddev:7.89 (10.1%) stddev-sans-first:7.11 07:51:37 INFO - PROCESS | 2557 | Values: 88.0 74.0 87.0 70.0 69.0 70.0 82.0 69.0 70.0 83.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:92.00 stddev:2.17 (2.4%) stddev-sans-first:2.11 07:51:37 INFO - PROCESS | 2557 | Values: 93.0 90.0 92.0 89.0 92.0 89.0 92.0 87.0 93.0 88.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:100.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:51:37 INFO - PROCESS | 2557 | Values: 101.0 100.0 100.0 100.0 100.0 100.0 100.0 100.0 100.0 100.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#7] imaging-desaturate Cycles:10 Average:105.30 Median:85.50 stddev:26.58 (31.1%) stddev-sans-first:27.25 07:51:37 INFO - PROCESS | 2557 | Values: 86.0 85.0 87.0 86.0 99.0 132.0 139.0 70.0 131.0 138.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:1.91 (3.4%) stddev-sans-first:1.87 07:51:37 INFO - PROCESS | 2557 | Values: 54.0 53.0 55.0 54.0 58.0 57.0 58.0 57.0 57.0 58.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:72.50 stddev:11.69 (16.1%) stddev-sans-first:11.61 07:51:37 INFO - PROCESS | 2557 | Values: 66.0 74.0 82.0 105.0 90.0 72.0 72.0 71.0 73.0 72.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:1.66 (2.0%) stddev-sans-first:1.72 07:51:37 INFO - PROCESS | 2557 | Values: 83.0 84.0 84.0 83.0 84.0 85.0 83.0 88.0 82.0 85.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:143.50 stddev:20.51 (14.3%) stddev-sans-first:21.56 07:51:37 INFO - PROCESS | 2557 | Values: 143.0 149.0 140.0 139.0 136.0 144.0 143.0 142.0 204.0 166.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:1.89 (1.1%) stddev-sans-first:2.00 07:51:37 INFO - PROCESS | 2557 | Values: 169.0 168.0 170.0 171.0 168.0 167.0 168.0 168.0 171.0 173.0 07:51:37 INFO - PROCESS | 2557 | 07:51:37 INFO - PROCESS | 2557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:1.12 07:51:37 INFO - PROCESS | 2557 | Values: 67.0 65.0 66.0 65.0 63.0 65.0 67.0 66.0 66.0 65.0 07:51:37 INFO - PROCESS | 2557 | -------- Summary: end -------- 07:51:37 INFO - PROCESS | 2557 | 07:51:38 INFO - TEST-INFO | 2557: exit 0 07:51:38 INFO - TEST-OK | kraken | took 59630ms 07:51:38 INFO - SUITE-END | took 1177s 07:51:38 INFO - Completed test suite (00:19:37) 07:51:38 INFO - javascript benchmark 07:51:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3258.6089669239686, 3280.4587243104897, 3281.60620725513, 3304.1409233599256, 3340.2317466982595, 5662.971685141573, 5712.771489140439, 5735.397783232758, 5741.799037033705, 5754.827355179346, 5643.379228284885, 5717.571182161334, 5734.0, 5734.254546908906, 5754.971225143879, 5154.149565321717, 5177.792888284464, 5223.738813059351, 5227.242049902762, 5289.338832645919, 5138.897222055557, 5153.1754919212935, 5173.870653233662, 5292.047431462354, 5302.2841916341185, 5184.274201611777, 5185.714785686786, 5234.738263086831, 5235.790568377261, 5245.239440281157, 5218.165093585008, 5264.368275806909, 5269.314989051437, 5273.182656688219, 5278.788848446057, 4404.273294906337, 5055.949440505585, 5116.897662046776, 5223.294855194538, 5231.058409486291, 5535.169724541311, 5579.721013949327, 5696.829095127153, 5704.572157088193, 5806.854828629276, 6116.649330353797, 6144.341027922436, 6170.0, 6189.907151392733, 6264.655443950581, 6175.2898416681755, 6244.687765611747, 6245.313015568284, 6252.3122456529745, 6283.937160628427, 5778.479936805624, 5849.941500585025, 5849.947009538324, 5857.4435428634215, 5862.0, 6145.801568694062, 6161.84595385119, 6175.96912015446, 6194.969025154845, 6205.28639206488, 6134.987727024991, 6141.477974372139, 6143.986242269975, 6144.9246381882995, 6157.291911430243, 6163.691815409212, 6218.1916350875, 6226.875462490725, 6227.470664993526, 6235.0, 6056.364081771439, 6114.602550834182, 6118.938810611926, 6119.632822030692, 6201.6899155042065, 6108.835692699231, 6141.332587233735, 6158.414950579688, 6209.410106039919, 6214.0, 4942.332785074041, 4949.480304567968, 4964.379452568429, 4964.478729733326, 4988.152014157602, 4362.236608593484, 4444.8444304449185, 4450.888727781831, 4458.974435879701, 4473.0, 5569.0254205513875, 5630.127330263816, 5640.0, 5645.407232240637, 5655.5475561954945, 6196.442320191204, 6212.782552610637, 6239.188905442264, 6245.656488893063, 6259.280182779039, 5593.804216852391, 5640.915386269127, 5672.801451949162, 5710.0, 5717.199592057115, 5337.439568845293, 5402.054640437907, 5408.648437851527, 5416.21464887597, 5418.349798024262, 6211.192544969125, 6218.471429928507, 6224.844378890564, 6228.252609686957, 6245.219347581552, 6174.629522228681, 6201.224846894138, 6228.688565571794, 6233.065040244, 6250.124982502362, 5317.920231196458, 6298.653574053471, 6313.715882785194, 6315.936840631535, 6330.936690633035, 5996.2504686914135, 6048.0625503047095, 6059.030555111161, 6090.390960904051, 6184.0, 6227.937720622917, 6237.7193026314835, 6247.468965138014, 6254.124422580933, 6258.186435763504, 5065.366829146356, 6085.361037091042, 6103.084537319438, 6109.541784366279, 6114.785982490592, 5931.1992880960515, 6001.699915004319, 6039.516838652985, 6041.275046994213, 6065.939340606537, 5829.883402331845, 5914.172015917689, 6003.339632640494, 6011.368806275453, 6053.213082299273, 6143.723532440961, 6154.815355539341, 6160.0, 6176.783812566719, 6198.597091189058, 5688.40271771458, 5789.1895134680335, 6011.819645410645, 6012.8797424052145, 6018.007028840192], "value": 5671.731844349958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.8583460375377, 461.0, 465.4066065766148, 473.8223166312633, 494.9260105570911, 30494.69505304946, 40158.397624035664, 41911.0, 42026.0, 42145.57854421455, 41507.584924150826, 41807.0, 41899.581004189946, 42014.0, 42223.57776422235, 8373.790655233637, 9199.356045076831, 9397.0, 9413.341066125375, 9429.528523573828, 8400.663973441055, 11151.776964460705, 11392.54429822806, 11418.71453213668, 11576.652700419001, 11319.151063670217, 11398.145139114558, 11400.087992960585, 11433.314001159915, 11436.2566433182, 8393.580320983927, 11304.830427543553, 11374.260673056226, 11377.601783937605, 11390.829137562943, 8405.285550728195, 11057.0, 11323.377214253213, 11339.206255562114, 11578.94210528942, 35753.46369804455, 39337.40993885094, 40875.7956210217, 41040.79479602613, 41280.587194128275, 3898.2203559288255, 3974.324364857981, 3974.8012599369918, 4023.698222633285, 4036.2734707752593, 28533.0, 28629.57055644167, 28696.85212591494, 30623.0, 31413.528797068062, 3163.7469002479975, 3238.70851623355, 3244.756643251742, 3372.6121496028027, 3402.3705614461155, 479439.9999999965, 479985.0, 481487.0, 481790.0, 481931.0, 50921.0, 62662.0, 62665.37334626595, 62681.05978410327, 62826.0, 65614.0, 65707.67146164335, 65728.34271657222, 65785.0, 65839.67080164568, 15988.0, 16469.34122635081, 16492.25784839661, 16493.257803398636, 16515.66968660644, 11575.016123629417, 11886.286822790487, 12722.045846561545, 12781.872181278255, 12828.230306181658, 15230.923845380703, 16838.66322673564, 17126.40057597978, 17216.569585760455, 17392.826071739375, 7502.84994300111, 7607.847843043108, 7608.619569021526, 7630.2751238632245, 7648.617569121633, 883.2051153961357, 890.6749036601723, 903.2593273515654, 906.6509393883271, 933.6218831373304, 28769.56845647317, 28901.710982890323, 29690.55464168039, 29888.103356899326, 30326.54510182305, 1042.6559235452435, 1046.8325067989085, 1072.2736394405001, 1075.9031687148195, 1080.6001779341693, 13765.724685506233, 14212.360443779848, 14419.94362367808, 14576.052556583789, 14683.853161468249, 617146.0, 621459.0, 621594.0, 621932.0, 622568.0, 51217.0, 51535.0, 51561.96876062458, 51652.0, 51682.74158629183, 1414.886809055273, 1430.6924011337612, 1469.4709904434394, 1471.9484818031317, 1474.7566651502596, 22240.888795556566, 26615.866920665274, 26851.86574067117, 27454.5881811769, 27645.58531621987, 45242.773786130856, 45705.628831135116, 45719.314210286204, 45815.54184458113, 45872.8531786708, 398441.0, 400164.0, 400586.0, 400801.0, 401637.92629331164, 24117.15589954343, 24315.270541883772, 24406.02375904944, 24536.6319505204, 24546.386340341633, 40843.59156408398, 42035.0, 42645.0, 42833.92915177145, 43102.92242693958, 35354.0, 35503.46744798779, 35648.0, 35777.64222357743, 36349.00080495492, 35514.82242588874, 35591.0, 35746.0, 36224.0, 36292.63707362998, 34042.65957340494, 34211.0, 34576.48135278023, 34890.65109348975, 34908.47637285494, 29722.0, 31809.204769880937, 31849.044528664177, 31890.52164217492, 31982.840085799424, 19577.70633440471, 23813.166539171045, 24150.87924560366, 24195.516089677756, 24240.030398783852], "value": 19397.7378408814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7717674804385, 332.3021654525497, 366.1377456090904, 398.3646084495229, 413.33040474431425, 15506.767398489017, 15924.363025478982, 16287.1042092685, 17720.379786707468, 20672.896635516838, 18456.815431845676, 21363.0, 21469.355919322406, 21691.891540542314, 22113.778862211373, 4941.110600091982, 5787.971060144704, 5912.556558258127, 5963.910541341883, 5971.910421343683, 5884.2056322396575, 5946.524278057766, 5963.910541341862, 5996.5202783777195, 6020.909686354708, 5638.661680299175, 5753.769849206027, 5893.64638121712, 5899.321578018518, 5918.792842250522, 5855.941440585582, 5913.172155898178, 5913.970430147821, 5930.733117009745, 5941.168236446879, 5212.087884620214, 5216.608754343401, 6852.554583952027, 7359.595222262774, 7747.147813740484, 29424.0, 29811.70188298111, 30170.396592068257, 30245.546316805267, 30263.69736302631, 2698.338906967786, 3011.8945836895823, 3015.7888947773663, 3047.101105173979, 3069.0639354996715, 17152.742708859376, 17256.965728268067, 17369.47891563255, 17458.0, 18002.09989500533, 1946.5036415714044, 1998.9100490477963, 1999.9700004499798, 2003.9980009995002, 2011.2357304224302, 143414.0, 152439.47560524475, 161512.0, 161777.0, 165111.0, 23883.641745373832, 24408.877955610464, 24473.38816529601, 24593.385165371008, 24709.629355559682, 42644.360334595, 42798.78600606977, 42919.57080429156, 43912.780436097615, 44135.55864441379, 8415.0, 8618.353623478264, 8923.063078376807, 8923.196912277926, 9004.144606262395, 8647.890267018905, 8781.560921953876, 8797.824043519095, 8913.420627659181, 8942.86585701215, 4725.5983241424865, 4789.137955168103, 4808.422989241313, 4869.172240719086, 4899.0, 1976.663967125592, 2034.5422279986885, 2046.2531176120906, 2055.797358545268, 2057.77364489906, 859.4928991894812, 896.4312453206888, 897.9281657467387, 912.1061359867367, 913.2693844924034, 21420.92895355257, 21812.454688632595, 21923.561528769336, 22034.228801991852, 22144.557108857734, 911.3165126155384, 922.377395258198, 926.5135803703109, 930.2186163622589, 943.1700103908516, 10885.401302928256, 11376.54493820238, 11394.601188958346, 11421.885781142248, 11489.0, 339448.0, 366478.0, 528780.7121928731, 720436.0, 752134.0, 105360.94639053511, 132848.33575832253, 138288.30855845657, 168299.15850420913, 172728.27271727374, 982.1651596143221, 1023.2172388123092, 1073.6027669762238, 1076.8976947190004, 1080.7946490166844, 19502.707459387835, 19606.019699015276, 20041.899790500953, 20074.297399590945, 20094.995250237724, 57186.7140664294, 61210.69394653176, 61442.77114457775, 63429.365706342345, 63776.0, 91471.54264228637, 91715.0, 94650.0, 95729.5213523928, 96035.59911002281, 8071.4753541019645, 8134.227248411392, 8199.180081991753, 8500.0, 8573.442726222776, 9314.906850931404, 11195.888041119484, 12951.740965180832, 13406.463741450232, 13640.727185456433, 11407.144464165387, 11473.541058357907, 11487.597934072268, 11725.706857328634, 12043.217190882564, 9162.312826537904, 9491.762705932131, 11354.26197297173, 11892.702682432662, 12057.457414416196, 11650.76698466009, 11769.411529423323, 11806.232594881305, 11808.76382472363, 12100.152989290666, 7449.404047676281, 8251.546164960744, 8356.247937685393, 8365.707200247962, 8707.08575599553, 8519.574021298786, 11355.54577816878, 11632.243904146204, 11938.403079846146, 11991.100667449802], "value": 10669.478810773788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.3636000159922, 1451.3831621560835, 1461.7734251191066, 1467.6330917270682, 1471.1246808149147, 8116.472429292092, 8493.362997775168, 8521.0, 8523.488590684563, 8527.019392769826, 7361.190269070411, 7661.387089032878, 7666.88499672504, 8013.318867896236, 8237.258646721793, 2276.5902137615262, 2320.466292752668, 2323.1636610820174, 2324.0, 2330.0563271874917, 2307.365474494519, 2332.976670233293, 2334.1830359374167, 2338.6608941703444, 2346.7770561796688, 2279.589673858705, 2284.5088306014204, 2292.885355732215, 2295.1393227539675, 2309.1571576374586, 2261.0955617752866, 2274.727032756063, 2291.140822191678, 2318.455163036685, 2323.2217207235594, 2302.067662596651, 2326.174208156097, 2331.184085570037, 2332.7433982261937, 2335.474518233401, 8380.120087390858, 8435.451695639764, 8435.578221088921, 8440.324774018063, 8441.98696156459, 5029.547340739351, 5192.013517431676, 5192.273081768518, 5193.558547523465, 5196.974015129938, 3137.2470607054142, 3268.8855890043974, 3437.204910292744, 3491.6508349165133, 3556.590992035897, 1184.129664696456, 1228.7112528555783, 1248.6691026877884, 1255.761405332993, 1255.8492980842266, 10619.469026548642, 10725.088367488774, 10726.302790318605, 10728.517216725266, 10739.78520429595, 4367.497737760134, 4593.0, 4675.158471475099, 4677.64917631179, 4684.882877928011, 9444.197243234265, 9452.8582071269, 9453.480058596706, 9453.716388508356, 9456.338056336128, 5184.37787465499, 5210.348706411699, 5226.764795584208, 5227.372715274191, 5232.790688372423, 3944.7041471889725, 4250.617444430016, 4400.141972315432, 4695.460022097503, 4756.500567440369, 3840.9039774005314, 3862.748921320105, 3937.015746063484, 3949.1311911379453, 3991.9421353341386, 1167.6963989362657, 1253.9749205015848, 1285.203174032106, 1288.3686993373367, 1305.7388522295578, 780.3055280800093, 816.0737562866071, 883.765802062454, 907.8865141857268, 909.7907481279343, 5533.612647114744, 5566.137248726453, 5594.021046316879, 5887.786537779859, 5895.823125306248, 1014.9086582207636, 1030.8917563655857, 1031.257494603884, 1038.7403149212696, 1043.0664555223034, 3712.795796231233, 3793.791341476245, 3813.370793819044, 3833.1375440526217, 3912.237113762789, 9789.510524473748, 9940.304178707422, 10107.69676909694, 10116.797664046679, 10121.1903047756, 9909.603615855429, 10027.197824174049, 10028.548715307828, 10043.347182433119, 10048.49757512136, 7420.85158296831, 7653.502522336031, 7670.8082297943, 7885.723999659985, 7995.280424761683, 4870.634702397264, 5386.0, 5400.351957765093, 5414.7292635367285, 5625.943740562542, 9050.321225908216, 9085.636574536944, 9256.629734810533, 9345.626174952926, 9362.204212642002, 9306.674266400643, 9374.062593740571, 9434.669786557437, 9460.148586626961, 9530.618775248913, 6072.72672729737, 6655.800325990228, 6858.965705171442, 6880.518363714492, 7217.7473788417155, 7789.688412463438, 8108.39187060961, 8112.634931427981, 8118.675252989814, 8175.305099066646, 7135.0, 7415.629218538944, 7436.628168591657, 7497.550146991198, 7645.120811106794, 7212.0, 7299.708011679473, 7342.412606991321, 7408.444366672414, 7414.369778568882, 5831.067029275296, 5999.430054144849, 6505.934940650533, 6511.120998665309, 6523.11937888379, 4886.853394398174, 5024.84925452237, 5044.6201045299, 5208.765605547836, 5255.448177941261, 4962.206047032458, 5049.520295571915, 5070.2141168119, 5121.359830021247, 5124.5131712487255], "value": 4439.414420459113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.7142159744154, 357.4584504475718, 358.9515415418919, 370.2299217627334, 371.82710039831505, 4580.564846339596, 5164.173732202848, 5228.503292187241, 5356.455683550312, 5544.750486228119, 4738.218193997986, 5064.544191022807, 5199.402068762084, 5204.048481819318, 5261.368635763704, 3975.3043217436975, 4148.668106551484, 4184.531126635285, 4196.454460920076, 4211.410402543646, 3678.6505281998166, 4086.6117718816813, 4151.771652559108, 4225.535191128974, 4242.703010789246, 3774.924501509968, 4150.709450338478, 4154.4183814266025, 4195.685323600727, 4223.965128543511, 3311.4701647736365, 3482.860685572574, 4154.626083652486, 4162.105147393325, 4200.516940551845, 3683.631636836322, 3684.613115622848, 3693.630636936312, 3695.8521659133603, 3709.1995543364856, 4288.656907447396, 4813.687110337817, 4939.876503087416, 5190.377154741455, 5267.315249017642, 4234.68239882007, 4400.3058822353305, 4452.172870227397, 4688.944987377847, 4827.734474603895, 5655.604107712462, 5657.51911087554, 5664.20701101846, 5665.3201615806365, 5672.716364181774, 3472.861085556575, 4035.2131334389805, 4095.2833254180696, 4100.17996400721, 4168.832207252211, 5487.780488780444, 5562.666240025571, 5807.564432667525, 5837.795677151279, 5920.644761314249, 3428.8856121760527, 4169.207850508394, 4194.224068547329, 4197.9370309445385, 4290.2706539888295, 4072.7963601819793, 4195.97902010488, 4209.915801683949, 4230.302000169999, 4258.254805409041, 4804.759762011886, 4824.445188803263, 4836.443808961944, 4841.685290456109, 4924.630652701062, 4816.157172494799, 5639.802606908738, 5673.723412232214, 5677.801276955287, 5740.253767010262, 1237.9910373045939, 1302.426932149851, 1314.8619394963582, 1361.3329468560335, 1363.7749771287627, 819.5082950229814, 894.3320706881749, 948.1750876737283, 958.8561715742694, 981.7545613596601, 4938.456769755324, 4953.910139769245, 4975.591719671964, 5027.396712394536, 5050.696958182521, 4712.81148754046, 4873.780679869415, 5449.264349312872, 5499.835004949858, 5534.952067734884, 4256.106217694257, 4405.06202730694, 4419.867403977886, 4661.067786442725, 4888.826681596463, 2337.8947947342413, 2453.1291391556097, 2547.7261369315343, 2822.350859302372, 2898.2464559214754, 4928.507149285043, 4944.0, 5003.574696150795, 5390.838274851761, 5685.630434021776, 5454.645448045864, 5656.5757568181725, 5673.858153546194, 5674.77300907959, 6018.6990650467305, 5463.453654634504, 6004.759809607567, 6024.614338702123, 6029.397060293935, 6054.90917636227, 4991.925121123113, 5384.19237114436, 5812.389699081536, 5849.502792262535, 5871.26797594702, 4648.976755116203, 5699.347189315218, 5789.813088316969, 5804.6807425592, 5807.535397168301, 5951.345352011189, 5999.790007349722, 6024.939750602438, 6025.939740602538, 6047.462234592813, 3749.8500059998387, 3792.715546333981, 3900.9609903901733, 3913.7651740895635, 3936.547297060875, 5212.348456442945, 5749.712514374348, 5763.423657634203, 5814.284785988059, 5843.532517398513, 5518.668879867221, 5518.944810551843, 5525.397634685896, 5533.446655334596, 5540.972295138498, 5143.871403214949, 5179.741012949413, 5436.891262174813, 5516.227728118147, 5678.488935995781, 5347.598930080182, 5479.53423958968, 5535.501804837584, 5539.7230138492105, 5547.306586676666, 4735.6211503078985, 5622.0, 5637.8590535236945, 5667.882664534407, 5670.8015219467125, 4613.907721845477, 5496.367917689517, 5517.393086760373, 5527.309086364205, 5541.3806016727], "value": 4134.17641037913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.4474365251451, 713.7787285941355, 727.8944553039813, 745.4781652843011, 749.9700011999519, 14857.702845943088, 15801.525954221377, 15806.209689515506, 15834.920825395886, 15837.0, 14435.927820360883, 14446.783298250535, 14450.060746051526, 14463.0, 14507.0, 685.9725610975555, 705.633070803182, 709.8118998465411, 860.0754189246585, 861.0958493581729, 776.0, 870.8606622940331, 881.801594641207, 882.2500874256895, 883.483162350026, 944.8441007233832, 946.2855544064222, 946.8295706772813, 947.5499137909472, 950.1638558068925, 724.3625609463638, 749.2395218852869, 941.3692825806726, 941.3786900645541, 941.5527624378366, 670.9832254193635, 690.7375197424947, 694.3854688600575, 694.9027136200936, 697.7209116353448, 14856.257187140707, 15211.61970950724, 15264.38942442301, 15273.236338183046, 15306.540803775904, 11595.826062609067, 13925.860741392558, 14017.560548032507, 14073.577792666236, 14250.144991300554, 12218.938905305506, 12824.909882659986, 13011.284379359131, 13190.60428187156, 13562.779349858462, 4398.604125628709, 4471.7987690554, 4496.527864574238, 4665.580097791215, 4675.0, 103005.96994030113, 103513.4824325881, 104055.0, 104750.0, 104901.47549262205, 10458.790824183627, 10881.727956800985, 10909.563617455371, 11156.442177891235, 11257.268277561932, 22810.42973925632, 22822.31533054011, 22829.7717022831, 22858.885705571367, 22859.657105143437, 7395.0, 7655.272749088827, 7686.039245094364, 7729.768106956801, 7983.600819959095, 4161.583841615814, 4183.058811767328, 4281.207976524353, 4306.440162778818, 4387.407699960465, 3504.0714210734177, 3519.982400087983, 3599.7480176387403, 3600.5499312585926, 3605.6754892059316, 572.093232226925, 576.2537513919484, 577.3504807092022, 582.6474982635444, 584.6871923520896, 651.2998526583847, 655.2759201082735, 663.5355251324092, 665.7569986954727, 679.3681875855502, 9303.674371396968, 9920.900790991998, 9947.701568952943, 10081.042300981395, 10104.191664666809, 621.1862460177182, 666.1440049536322, 675.5777638975641, 676.3912478769049, 677.0487465111527, 4078.3678529827926, 4723.48041715411, 4776.450708168536, 4831.758412079382, 4856.077345304451, 102563.0, 106081.40877886838, 106985.0, 107101.0, 108585.45707271571, 80201.0, 88390.11609883947, 90531.54734226287, 93065.53467232756, 96527.0, 64241.678791606675, 79510.0, 82332.58833705913, 82547.17452825516, 82596.58701706454, 9374.343795934219, 9392.95303523478, 9407.2003879671, 9414.717558473258, 9420.811583768424, 51107.97784044224, 52554.47445525649, 53351.46648533465, 53886.730566346916, 54635.72682136723, 67129.66435167793, 67564.6621766888, 67982.64034719179, 68639.0, 68676.31323686898, 11480.540778369106, 11501.827472588086, 11507.942460287644, 11573.479193436484, 12152.878471215176, 9750.317477776487, 11483.655490335303, 11490.08079353633, 12030.338331391857, 12534.435950382436, 11326.32042077478, 11816.46825892854, 11901.880981190077, 12447.626571202878, 13906.791398129239, 11043.447827608748, 13280.335983200994, 13990.720185596434, 14079.859201408264, 14223.431062757374, 12214.6946326339, 13270.402831872781, 13345.532906348231, 13347.065705400917, 13347.20880101085, 10388.324758890649, 11274.549018039186, 11280.943595281971, 11298.548058077586, 11917.463714133059, 8871.334649901411, 8976.326775491994, 9792.216622670026, 10886.836697449386, 10893.128549716163], "value": 7416.146838524145, "unit": "score"}], "name": "dromaeo_css", "value": 7366.4524774892325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 113.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 111.0, 149.0, 140.0, 139.0, 110.0, 113.0, 131.0, 109.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 187.0, 184.0, 183.0, 186.0, 185.0, 184.0, 186.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 57.0, 92.0, 62.0, 61.0, 58.0, 59.0, 75.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 74.0, 87.0, 70.0, 69.0, 70.0, 82.0, 69.0, 70.0, 83.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 92.0, 89.0, 92.0, 89.0, 92.0, 87.0, 93.0, 88.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 100.0, 100.0, 100.0, 100.0, 100.0, 100.0, 100.0, 100.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 86.0, 99.0, 132.0, 139.0, 70.0, 131.0, 138.0], "value": 105.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 54.0, 58.0, 57.0, 58.0, 57.0, 57.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 82.0, 105.0, 90.0, 72.0, 72.0, 71.0, 73.0, 72.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 83.0, 84.0, 85.0, 83.0, 88.0, 82.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 149.0, 140.0, 139.0, 136.0, 144.0, 143.0, 142.0, 204.0, 166.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 170.0, 171.0, 168.0, 167.0, 168.0, 168.0, 171.0, 173.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 63.0, 65.0, 67.0, 66.0, 66.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1467.3, "alertThreshold": 2.0}]} 07:51:38 INFO - Return code: 0 07:51:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:51:38 ERROR - # TBPL SUCCESS # 07:51:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:51:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:51:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:51:38 INFO - 2017-02-02 07:51:38.752 screenresolution[2561:37930] starting screenresolution argv=screenresolution get 07:51:38 INFO - 2017-02-02 07:51:38.755 screenresolution[2561:37930] Display 0: 1600x1200x32@60 07:51:38 INFO - 2017-02-02 07:51:38.761 screenresolution[2562:37933] starting screenresolution argv=screenresolution list 07:51:38 INFO - Available Modes on Display 0 07:51:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:51:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:51:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:51:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:51:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:51:38 INFO - Intel Iris: 07:51:38 INFO - Chipset Model: Intel Iris 07:51:38 INFO - Type: GPU 07:51:38 INFO - Bus: Built-In 07:51:38 INFO - VRAM (Dynamic, Max): 1536 MB 07:51:38 INFO - Vendor: Intel (0x8086) 07:51:38 INFO - Device ID: 0x0a2e 07:51:38 INFO - Revision ID: 0x0009 07:51:38 INFO - Displays: 07:51:38 INFO - Display: 07:51:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:51:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:51:38 INFO - Display Serial Number: 1600x1200 60 07:51:38 INFO - Main Display: Yes 07:51:38 INFO - Mirror: Off 07:51:38 INFO - Online: Yes 07:51:38 INFO - Rotation: Supported 07:51:39 INFO - Return code: 0 07:51:39 INFO - Running post-action listener: _resource_record_post_action 07:51:39 INFO - [mozharness: 2017-02-02 15:51:39.001729Z] Finished run-tests step (success) 07:51:39 INFO - Running post-run listener: _resource_record_post_run 07:51:39 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 135168; Write bytes: 505467904; Read time: 3; Write time: 1550 07:51:39 INFO - TinderboxPrint: CPU usage
53.8% 07:51:39 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 3 07:51:39 INFO - TinderboxPrint: I/O write bytes / time
505,467,904 / 1,550 07:51:39 INFO - TinderboxPrint: CPU idle
2,215.7 (46.2%) 07:51:39 INFO - TinderboxPrint: CPU system
969.0 (20.2%) 07:51:39 INFO - TinderboxPrint: CPU user
1,612.9 (33.6%) 07:51:39 INFO - TinderboxPrint: Swap in / out
207,089,664 / 0 07:51:39 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 200892928; Write bytes: 198778880; Read time: 15642; Write time: 412 07:51:39 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 135168; Write bytes: 296875008; Read time: 3; Write time: 1108 07:51:39 INFO - Running post-run listener: _upload_blobber_files 07:51:39 INFO - Blob upload gear active. 07:51:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:39 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 07:51:39 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:51:39 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:51:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:40 INFO - (blobuploader) - INFO - Done attempting. 07:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:41 INFO - (blobuploader) - INFO - Done attempting. 07:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:51:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:42 INFO - (blobuploader) - INFO - Done attempting. 07:51:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:51:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:44 INFO - (blobuploader) - INFO - Done attempting. 07:51:44 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:44 INFO - Return code: 0 07:51:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a16aa26ec1ee0cb364408f107e68d4a77e0d9bff59760f3414183095b363d507aa0c937f02e492ad30224640a2bc69ff4668b1394ddfd6f684e87b493892936", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71782c00cf55e148320028a820d43c70b2d6b6c67f4e2d0b62f3d5c8ea3777528b1da4f81836faa33e0168065b2eef3cf45477f8c424cc2f106c1e25dc0eb87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9b0dad9b039cda00d0bffe6ec34e8d665526b7ef395dbb81f527905b67e88b7c264f7283b6eddd57c245fadbbaa632ba3a4dfb212047401abd6a8c99647fa0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c91e33007be94cf671b39849711ac3f07271043d247ad1308258962140324c6bfc242c5a986598de9e5debf03e4168f44419389caa2469aea39e41cacb3f4a5"} 07:51:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:44 INFO - Contents: 07:51:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a16aa26ec1ee0cb364408f107e68d4a77e0d9bff59760f3414183095b363d507aa0c937f02e492ad30224640a2bc69ff4668b1394ddfd6f684e87b493892936", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71782c00cf55e148320028a820d43c70b2d6b6c67f4e2d0b62f3d5c8ea3777528b1da4f81836faa33e0168065b2eef3cf45477f8c424cc2f106c1e25dc0eb87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9b0dad9b039cda00d0bffe6ec34e8d665526b7ef395dbb81f527905b67e88b7c264f7283b6eddd57c245fadbbaa632ba3a4dfb212047401abd6a8c99647fa0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c91e33007be94cf671b39849711ac3f07271043d247ad1308258962140324c6bfc242c5a986598de9e5debf03e4168f44419389caa2469aea39e41cacb3f4a5"} 07:51:44 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:44 INFO - Copying logs to upload dir... 07:51:44 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.292225 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-02 07:51:45.038082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 07:51:45.041260) ========= 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.aruRv57Khh/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.iFpD53x374/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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/Mozilla-Aurora/sha512/9a16aa26ec1ee0cb364408f107e68d4a77e0d9bff59760f3414183095b363d507aa0c937f02e492ad30224640a2bc69ff4668b1394ddfd6f684e87b493892936", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71782c00cf55e148320028a820d43c70b2d6b6c67f4e2d0b62f3d5c8ea3777528b1da4f81836faa33e0168065b2eef3cf45477f8c424cc2f106c1e25dc0eb87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9b0dad9b039cda00d0bffe6ec34e8d665526b7ef395dbb81f527905b67e88b7c264f7283b6eddd57c245fadbbaa632ba3a4dfb212047401abd6a8c99647fa0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c91e33007be94cf671b39849711ac3f07271043d247ad1308258962140324c6bfc242c5a986598de9e5debf03e4168f44419389caa2469aea39e41cacb3f4a5"} build_url:https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011544 build_url: 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a16aa26ec1ee0cb364408f107e68d4a77e0d9bff59760f3414183095b363d507aa0c937f02e492ad30224640a2bc69ff4668b1394ddfd6f684e87b493892936", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71782c00cf55e148320028a820d43c70b2d6b6c67f4e2d0b62f3d5c8ea3777528b1da4f81836faa33e0168065b2eef3cf45477f8c424cc2f106c1e25dc0eb87a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9b0dad9b039cda00d0bffe6ec34e8d665526b7ef395dbb81f527905b67e88b7c264f7283b6eddd57c245fadbbaa632ba3a4dfb212047401abd6a8c99647fa0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c91e33007be94cf671b39849711ac3f07271043d247ad1308258962140324c6bfc242c5a986598de9e5debf03e4168f44419389caa2469aea39e41cacb3f4a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 07:51:45.076464) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:51:45.076788) ========= 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.aruRv57Khh/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.iFpD53x374/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005029 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:51:45.125770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 07:51:45.126093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 07:51:45.126426) ========= ========= Total master_lag: 0.19 =========