builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1478427916.8 results: success (0) buildid: 20161106004004 builduid: 92dd89b45bf3443789979e9af66e3713 revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:16.795959) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:16.796404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:16.796680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:16.894677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:16.895212) ========= 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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 --2016-11-06 02:25:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 34.4M=0s 2016-11-06 02:25:17 (34.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.510544 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:17.431789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:17.432617) ========= 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.ztXiBwiMC5/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.1Nb2mYUVMJ/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.025526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:17.487867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:17.488223) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070cf059bb70aa991d50b4d266987adf26685915 --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 070cf059bb70aa991d50b4d266987adf26685915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ztXiBwiMC5/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.1Nb2mYUVMJ/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 2016-11-06 02:25:17,573 truncating revision to first 12 chars 2016-11-06 02:25:17,573 Setting DEBUG logging. 2016-11-06 02:25:17,573 attempt 1/10 2016-11-06 02:25:17,573 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/070cf059bb70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-06 02:25:18,236 unpacking tar archive at: mozilla-aurora-070cf059bb70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927009 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:18.437634) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:18.438002) ========= script_repo_revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:18.438455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:18.438766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-06 02:25:18.457454) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-06 02:25:18.457766) ========= /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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:25:18 INFO - MultiFileLogger online at 20161106 02:25:18 in /builds/slave/test 02:25:18 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 02:25:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:18 INFO - {'append_to_log': False, 02:25:18 INFO - 'base_work_dir': '/builds/slave/test', 02:25:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:25:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:18 INFO - 'branch': 'Mozilla-Aurora', 02:25:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:18 INFO - 'config_files': ('talos/mac_config.py',), 02:25:18 INFO - 'default_actions': ('clobber', 02:25:18 INFO - 'read-buildbot-config', 02:25:18 INFO - 'download-and-extract', 02:25:18 INFO - 'populate-webroot', 02:25:18 INFO - 'create-virtualenv', 02:25:18 INFO - 'install', 02:25:18 INFO - 'run-tests'), 02:25:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:18 INFO - 'download_minidump_stackwalk': True, 02:25:18 INFO - 'download_symbols': 'ondemand', 02:25:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:18 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:18 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:18 INFO - 'installer_path': 'installer.exe', 02:25:18 INFO - 'log_level': 'info', 02:25:18 INFO - 'log_name': 'talos', 02:25:18 INFO - 'log_to_console': True, 02:25:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:25:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:25:18 INFO - 'opt_config_files': (), 02:25:18 INFO - 'pip_index': False, 02:25:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:18 INFO - 'cmd': ('bash', 02:25:18 INFO - '-c', 02:25:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:18 INFO - 'enabled': True, 02:25:18 INFO - 'halt_on_failure': False, 02:25:18 INFO - 'name': 'check_screen_resolution'},), 02:25:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:18 INFO - 'cmd': ('bash', 02:25:18 INFO - '-c', 02:25:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:18 INFO - 'enabled': True, 02:25:18 INFO - 'halt_on_failure': False, 02:25:18 INFO - 'name': 'check_screen_resolution'},), 02:25:18 INFO - 'run_cmd_checks_enabled': True, 02:25:18 INFO - 'sps_profile': False, 02:25:18 INFO - 'sps_profile_interval': 0, 02:25:18 INFO - 'suite': 'dromaeojs', 02:25:18 INFO - 'system_bits': '32', 02:25:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:18 INFO - 'title': 't-yosemite-r7-0387', 02:25:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:18 INFO - 'use_talos_json': True, 02:25:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:18 INFO - 'work_dir': 'build'} 02:25:18 INFO - [mozharness: 2016-11-06 10:25:18.660725Z] Running clobber step. 02:25:18 INFO - Running pre-action listener: _resource_record_pre_action 02:25:18 INFO - Running main action method: clobber 02:25:18 INFO - rmtree: /builds/slave/test/build 02:25:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:21 INFO - Running post-action listener: _resource_record_post_action 02:25:21 INFO - [mozharness: 2016-11-06 10:25:21.191068Z] Finished clobber step (success) 02:25:21 INFO - [mozharness: 2016-11-06 10:25:21.191191Z] Running read-buildbot-config step. 02:25:21 INFO - Running pre-action listener: _resource_record_pre_action 02:25:21 INFO - Running main action method: read_buildbot_config 02:25:21 INFO - Using buildbot properties: 02:25:21 INFO - { 02:25:21 INFO - "project": "", 02:25:21 INFO - "product": "firefox", 02:25:21 INFO - "script_repo_revision": "production", 02:25:21 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:25:21 INFO - "repository": "", 02:25:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:25:21 INFO - "buildid": "20161106004004", 02:25:21 INFO - "stage_platform": "macosx64", 02:25:21 INFO - "basedir": "/builds/slave/test", 02:25:21 INFO - "nightly_build": "True", 02:25:21 INFO - "buildnumber": 8, 02:25:21 INFO - "slavename": "t-yosemite-r7-0387", 02:25:21 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:25:21 INFO - "platform": "yosemite_r7", 02:25:21 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:25:21 INFO - "branch": "mozilla-aurora", 02:25:21 INFO - "repo_path": "releases/mozilla-aurora", 02:25:21 INFO - "revision": "070cf059bb70aa991d50b4d266987adf26685915", 02:25:21 INFO - "pgo_build": "False", 02:25:21 INFO - "builduid": "92dd89b45bf3443789979e9af66e3713", 02:25:21 INFO - "slavebuilddir": "test" 02:25:21 INFO - } 02:25:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:25:21 INFO - Running post-action listener: _resource_record_post_action 02:25:21 INFO - [mozharness: 2016-11-06 10:25:21.194666Z] Finished read-buildbot-config step (success) 02:25:21 INFO - [mozharness: 2016-11-06 10:25:21.194791Z] Running download-and-extract step. 02:25:21 INFO - Running pre-action listener: _resource_record_pre_action 02:25:21 INFO - Running main action method: download_and_extract 02:25:21 INFO - mkdir: /builds/slave/test/build/tests 02:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:21 INFO - trying https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:25:21 INFO - Downloading https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 02:25:22 INFO - Downloaded 1199 bytes. 02:25:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:25:22 INFO - Using the following test package requirements: 02:25:22 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:25:22 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:25:22 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:25:22 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'jsshell-mac.zip'], 02:25:22 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:25:22 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:25:22 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:25:22 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:25:22 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:25:22 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:25:22 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:25:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:25:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:25:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:22 INFO - Fetch https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:25:22 INFO - Expected file size: 16421620 02:25:29 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:25:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:25:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:29 INFO - Fetch https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:25:30 INFO - Expected file size: 16421620 02:25:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:25:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:25:36 INFO - Fetch https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:25:37 INFO - Expected file size: 14414089 02:25: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')]} 02:25:38 INFO - trying https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:25:38 INFO - Downloading https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 02:25:40 INFO - Downloaded 115530230 bytes. 02:25:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:25:40 INFO - mkdir: /builds/slave/test/properties 02:25:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:25:40 INFO - Writing to file /builds/slave/test/properties/build_url 02:25:40 INFO - Contents: 02:25:40 INFO - build_url:https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:25:41 INFO - Running post-action listener: _resource_record_post_action 02:25:41 INFO - Running post-action listener: set_extra_try_arguments 02:25:41 INFO - [mozharness: 2016-11-06 10:25:41.675895Z] Finished download-and-extract step (success) 02:25:41 INFO - [mozharness: 2016-11-06 10:25:41.676042Z] Running populate-webroot step. 02:25:41 INFO - Running pre-action listener: _resource_record_pre_action 02:25:41 INFO - Running main action method: populate_webroot 02:25:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:25:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:25:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:25:41 INFO - '--tppagecycles', 02:25:41 INFO - '7'], 02:25:41 INFO - 'tests': ['tsvgm']}}, 02:25:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:25:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:25:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:25:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:25:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['damp', 'tps']}, 02:25:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'tests': ['damp', 'tps']}, 02:25:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['dromaeo_dom']}, 02:25:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:25:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['basic_compositor_video']}, 02:25:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:25:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['a11yr', 02:25:41 INFO - 'ts_paint', 02:25:41 INFO - 'tpaint', 02:25:41 INFO - 'sessionrestore', 02:25:41 INFO - 'sessionrestore_no_auto_restore', 02:25:41 INFO - 'tabpaint']}, 02:25:41 INFO - 'other-e10s': {'tests': ['a11yr', 02:25:41 INFO - 'ts_paint', 02:25:41 INFO - 'tpaint', 02:25:41 INFO - 'sessionrestore', 02:25:41 INFO - 'sessionrestore_no_auto_restore', 02:25:41 INFO - 'tabpaint']}, 02:25:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:25:41 INFO - 'ts_paint', 02:25:41 INFO - 'tpaint', 02:25:41 INFO - 'sessionrestore', 02:25:41 INFO - 'sessionrestore_no_auto_restore', 02:25:41 INFO - 'tabpaint']}, 02:25:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:25:41 INFO - 'ts_paint', 02:25:41 INFO - 'tpaint', 02:25:41 INFO - 'sessionrestore', 02:25:41 INFO - 'sessionrestore_no_auto_restore', 02:25:41 INFO - 'tabpaint']}, 02:25:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['a11yr', 02:25:41 INFO - 'ts_paint', 02:25:41 INFO - 'tpaint', 02:25:41 INFO - 'sessionrestore', 02:25:41 INFO - 'sessionrestore_no_auto_restore', 02:25:41 INFO - 'tabpaint']}, 02:25:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['a11yr', 02:25:41 INFO - 'ts_paint', 02:25:41 INFO - 'tpaint', 02:25:41 INFO - 'sessionrestore', 02:25:41 INFO - 'sessionrestore_no_auto_restore', 02:25:41 INFO - 'tabpaint']}, 02:25:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['tsvgx', 02:25:41 INFO - 'tsvgr_opacity', 02:25:41 INFO - 'tart', 02:25:41 INFO - 'tscrollx', 02:25:41 INFO - 'cart']}, 02:25:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:25:41 INFO - 'tsvgr_opacity', 02:25:41 INFO - 'tart', 02:25:41 INFO - 'tscrollx', 02:25:41 INFO - 'cart']}, 02:25:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'talos_options': ['--disable-e10s'], 02:25:41 INFO - 'tests': ['tp5o']}, 02:25:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'tests': ['tp5o']}, 02:25:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'talos_options': ['--disable-e10s', 02:25:41 INFO - '--xperf_path', 02:25:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:41 INFO - 'tests': ['tp5n']}, 02:25:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:41 INFO - 'talos_options': ['--xperf_path', 02:25:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:41 INFO - 'tests': ['tp5n']}}, 02:25:41 INFO - 'talos.zip': {'path': '', 02:25:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:25:41 INFO - Running post-action listener: _resource_record_post_action 02:25:41 INFO - [mozharness: 2016-11-06 10:25:41.694168Z] Finished populate-webroot step (success) 02:25:41 INFO - [mozharness: 2016-11-06 10:25:41.694274Z] Running create-virtualenv step. 02:25:41 INFO - Running pre-action listener: _resource_record_pre_action 02:25:41 INFO - Running main action method: create_virtualenv 02:25:41 INFO - Creating virtualenv /builds/slave/test/build/venv 02:25:41 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 02:25:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:25:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:25:41 INFO - Using real prefix '/tools/python27' 02:25:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:25:42 INFO - Installing distribute.............................................................................................................................................................................................done. 02:25:45 INFO - Installing pip.................done. 02:25:45 INFO - Return code: 0 02:25:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:25: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')]} 02:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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')]} 02:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:45 INFO - 'HOME': '/Users/cltbld', 02:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:45 INFO - 'LOGNAME': 'cltbld', 02:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:45 INFO - 'MOZ_NO_REMOTE': '1', 02:25:45 INFO - 'NO_EM_RESTART': '1', 02:25:45 INFO - 'PAGER': '/bin/cat', 02:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:45 INFO - 'PWD': '/builds/slave/test', 02:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:45 INFO - 'SHELL': '/bin/bash', 02:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:25:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:45 INFO - 'USER': 'cltbld', 02:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:45 INFO - 'XPC_FLAGS': '0x0', 02:25:45 INFO - 'XPC_SERVICE_NAME': '0', 02:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:45 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 02:25:45 INFO - Cleaning up... 02:25:45 INFO - Return code: 0 02:25:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:25: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')]} 02:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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')]} 02:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:45 INFO - 'HOME': '/Users/cltbld', 02:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:45 INFO - 'LOGNAME': 'cltbld', 02:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:45 INFO - 'MOZ_NO_REMOTE': '1', 02:25:45 INFO - 'NO_EM_RESTART': '1', 02:25:45 INFO - 'PAGER': '/bin/cat', 02:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:45 INFO - 'PWD': '/builds/slave/test', 02:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:45 INFO - 'SHELL': '/bin/bash', 02:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:25:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:45 INFO - 'USER': 'cltbld', 02:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:45 INFO - 'XPC_FLAGS': '0x0', 02:25:45 INFO - 'XPC_SERVICE_NAME': '0', 02:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:45 INFO - Downloading/unpacking psutil>=3.1.1 02:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:25:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:49 INFO - Installing collected packages: psutil 02:25:49 INFO - Running setup.py install for psutil 02:25:49 INFO - building 'psutil._psutil_osx' extension 02:25:49 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 02:25:50 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 02:25:50 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 02:25:50 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 02:25:50 INFO - building 'psutil._psutil_posix' extension 02:25:50 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 02:25:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:25:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:25:50 INFO - ^ 02:25:50 INFO - 1 warning generated. 02:25:50 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 02:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:50 INFO - Successfully installed psutil 02:25:50 INFO - Cleaning up... 02:25:50 INFO - Return code: 0 02:25:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:25:50 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')]} 02:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:50 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')]} 02:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:50 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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:25:50 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 02:25:50 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 02:25:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:25:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:50 INFO - 'HOME': '/Users/cltbld', 02:25:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:50 INFO - 'LOGNAME': 'cltbld', 02:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:50 INFO - 'MOZ_NO_REMOTE': '1', 02:25:50 INFO - 'NO_EM_RESTART': '1', 02:25:50 INFO - 'PAGER': '/bin/cat', 02:25:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:50 INFO - 'PWD': '/builds/slave/test', 02:25:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:50 INFO - 'SHELL': '/bin/bash', 02:25:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:25:50 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:25:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:50 INFO - 'USER': 'cltbld', 02:25:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:50 INFO - 'XPC_FLAGS': '0x0', 02:25:50 INFO - 'XPC_SERVICE_NAME': '0', 02:25:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:25:53 INFO - Installing collected packages: mozsystemmonitor 02:25:53 INFO - Running setup.py install for mozsystemmonitor 02:25:53 INFO - Successfully installed mozsystemmonitor 02:25:53 INFO - Cleaning up... 02:25:53 INFO - Return code: 0 02:25:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:25:53 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')]} 02:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:53 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')]} 02:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:53 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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:25:53 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 02:25:53 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 02:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:53 INFO - 'HOME': '/Users/cltbld', 02:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:53 INFO - 'LOGNAME': 'cltbld', 02:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:53 INFO - 'MOZ_NO_REMOTE': '1', 02:25:53 INFO - 'NO_EM_RESTART': '1', 02:25:53 INFO - 'PAGER': '/bin/cat', 02:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:53 INFO - 'PWD': '/builds/slave/test', 02:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:53 INFO - 'SHELL': '/bin/bash', 02:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:25:53 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:53 INFO - 'USER': 'cltbld', 02:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:53 INFO - 'XPC_FLAGS': '0x0', 02:25:53 INFO - 'XPC_SERVICE_NAME': '0', 02:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:54 INFO - Downloading/unpacking jsonschema==2.5.1 02:25:54 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 02:25:54 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 02:25:54 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 02:25:54 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 02:25:54 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 02:25:54 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 02:25:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:25:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:25:56 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 02:25:56 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 02:25:56 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 02:25:56 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 02:25:56 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 02:25:56 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 02:25:57 INFO - Downloading functools32-3.2.3-2.tar.gz 02:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:25:57 INFO - warning: no files found matching '*.txt' 02:25:57 INFO - no previously-included directories found matching 'build' 02:25:57 INFO - no previously-included directories found matching 'dist' 02:25:57 INFO - no previously-included directories found matching '.git*' 02:25:57 INFO - Installing collected packages: jsonschema, functools32 02:25:57 INFO - Running setup.py install for functools32 02:25:57 INFO - warning: no files found matching '*.txt' 02:25:57 INFO - no previously-included directories found matching 'build' 02:25:57 INFO - no previously-included directories found matching 'dist' 02:25:57 INFO - no previously-included directories found matching '.git*' 02:25:57 INFO - Successfully installed jsonschema functools32 02:25:57 INFO - Cleaning up... 02:25:57 INFO - Return code: 0 02:25:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:25:57 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 02:25:57 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 02:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:57 INFO - 'HOME': '/Users/cltbld', 02:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:57 INFO - 'LOGNAME': 'cltbld', 02:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:57 INFO - 'MOZ_NO_REMOTE': '1', 02:25:57 INFO - 'NO_EM_RESTART': '1', 02:25:57 INFO - 'PAGER': '/bin/cat', 02:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:57 INFO - 'PWD': '/builds/slave/test', 02:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:57 INFO - 'SHELL': '/bin/bash', 02:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:25:57 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:57 INFO - 'USER': 'cltbld', 02:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:57 INFO - 'XPC_FLAGS': '0x0', 02:25:57 INFO - 'XPC_SERVICE_NAME': '0', 02:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:25:57 INFO - Cleaning up... 02:25:57 INFO - Return code: 0 02:25:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:25:57 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 02:25:57 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 02:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:57 INFO - 'HOME': '/Users/cltbld', 02:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:57 INFO - 'LOGNAME': 'cltbld', 02:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:57 INFO - 'MOZ_NO_REMOTE': '1', 02:25:57 INFO - 'NO_EM_RESTART': '1', 02:25:57 INFO - 'PAGER': '/bin/cat', 02:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:57 INFO - 'PWD': '/builds/slave/test', 02:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:57 INFO - 'SHELL': '/bin/bash', 02:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:25:57 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:57 INFO - 'USER': 'cltbld', 02:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:57 INFO - 'XPC_FLAGS': '0x0', 02:25:57 INFO - 'XPC_SERVICE_NAME': '0', 02:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:25:57 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 02:25:57 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 02:25:57 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 02:25:57 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 02:25:57 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 02:25:57 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 02:26:00 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:00 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 02:26:00 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 02:26:00 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 02:26:00 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 02:26:00 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 02:26:00 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 02:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:01 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 02:26:01 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 02:26:01 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 02:26:01 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 02:26:01 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 02:26:01 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 02:26:01 INFO - Downloading docopt-0.6.1.tar.gz 02:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:01 INFO - Running setup.py install for blobuploader 02:26:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:01 INFO - Running setup.py install for requests 02:26:02 INFO - Running setup.py install for docopt 02:26:02 INFO - Successfully installed blobuploader requests docopt 02:26:02 INFO - Cleaning up... 02:26:02 INFO - Return code: 0 02:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:02 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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:26:02 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 02:26:02 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 02:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:02 INFO - 'HOME': '/Users/cltbld', 02:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:02 INFO - 'LOGNAME': 'cltbld', 02:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:02 INFO - 'MOZ_NO_REMOTE': '1', 02:26:02 INFO - 'NO_EM_RESTART': '1', 02:26:02 INFO - 'PAGER': '/bin/cat', 02:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:02 INFO - 'PWD': '/builds/slave/test', 02:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:02 INFO - 'SHELL': '/bin/bash', 02:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:26:02 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:02 INFO - 'USER': 'cltbld', 02:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:02 INFO - 'XPC_FLAGS': '0x0', 02:26:02 INFO - 'XPC_SERVICE_NAME': '0', 02:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-_Ei01a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:02 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-cu6PMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-uPjH9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-1ypVr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-15Fq9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-QIj6Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-qKLtZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-dRAfIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-_ciIhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-lUUk04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-U0F1eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:03 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Mk0su1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-vqVT7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fGTJW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-BP17tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-PeGLx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-sT0iri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:04 INFO - Running setup.py install for manifestparser 02:26:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:04 INFO - Running setup.py install for mozcrash 02:26:04 INFO - Running setup.py install for mozdebug 02:26:05 INFO - Running setup.py install for mozdevice 02:26:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Running setup.py install for mozfile 02:26:05 INFO - Running setup.py install for mozhttpd 02:26:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Running setup.py install for mozinfo 02:26:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Running setup.py install for mozInstall 02:26:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:05 INFO - Running setup.py install for mozleak 02:26:05 INFO - Running setup.py install for mozlog 02:26:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:06 INFO - Running setup.py install for moznetwork 02:26:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:06 INFO - Running setup.py install for mozprocess 02:26:06 INFO - Running setup.py install for mozprofile 02:26:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:06 INFO - Running setup.py install for mozrunner 02:26:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:06 INFO - Running setup.py install for mozscreenshot 02:26:06 INFO - Running setup.py install for moztest 02:26:07 INFO - Running setup.py install for mozversion 02:26:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:07 INFO - Cleaning up... 02:26:07 INFO - Return code: 0 02:26:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:07 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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:26:07 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 02:26:07 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 02:26:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:26:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:07 INFO - 'HOME': '/Users/cltbld', 02:26:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:07 INFO - 'LOGNAME': 'cltbld', 02:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:07 INFO - 'MOZ_NO_REMOTE': '1', 02:26:07 INFO - 'NO_EM_RESTART': '1', 02:26:07 INFO - 'PAGER': '/bin/cat', 02:26:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:07 INFO - 'PWD': '/builds/slave/test', 02:26:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:07 INFO - 'SHELL': '/bin/bash', 02:26:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:26:07 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:26:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:07 INFO - 'USER': 'cltbld', 02:26:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:07 INFO - 'XPC_FLAGS': '0x0', 02:26:07 INFO - 'XPC_SERVICE_NAME': '0', 02:26:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:07 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nbje8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:07 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)) 02:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:07 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nnPjQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:07 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-jLgWAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:07 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)) 02:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:07 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-UyNE6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:07 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-YDbMub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-E7E2Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-B67XuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CbkvsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-RIwC9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-39KxXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ld6YXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-MhwNCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8llqBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:08 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)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-26yJbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:08 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ov4Rix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:09 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)) 02:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-eO_Lzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-2gAUpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:09 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)) 02:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:26:09 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)) 02:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:11 INFO - Downloading blessings-1.6.tar.gz 02:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:11 INFO - Installing collected packages: blessings 02:26:11 INFO - Running setup.py install for blessings 02:26:12 INFO - Successfully installed blessings 02:26:12 INFO - Cleaning up... 02:26:12 INFO - Return code: 0 02:26:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:12 INFO - Reading from file tmpfile_stdout 02:26:12 INFO - Current package versions: 02:26:12 INFO - blessings == 1.6 02:26:12 INFO - blobuploader == 1.2.4 02:26:12 INFO - docopt == 0.6.1 02:26:12 INFO - functools32 == 3.2.3-2 02:26:12 INFO - jsonschema == 2.5.1 02:26:12 INFO - manifestparser == 1.1 02:26:12 INFO - mozInstall == 1.12 02:26:12 INFO - mozcrash == 0.17 02:26:12 INFO - mozdebug == 0.1 02:26:12 INFO - mozdevice == 0.48 02:26:12 INFO - mozfile == 1.2 02:26:12 INFO - mozhttpd == 0.7 02:26:12 INFO - mozinfo == 0.9 02:26:12 INFO - mozleak == 0.1 02:26:12 INFO - mozlog == 3.4 02:26:12 INFO - moznetwork == 0.27 02:26:12 INFO - mozprocess == 0.23 02:26:12 INFO - mozprofile == 0.28 02:26:12 INFO - mozrunner == 6.12 02:26:12 INFO - mozscreenshot == 0.1 02:26:12 INFO - mozsystemmonitor == 0.3 02:26:12 INFO - moztest == 0.7 02:26:12 INFO - mozversion == 1.4 02:26:12 INFO - psutil == 3.1.1 02:26:12 INFO - requests == 1.2.3 02:26:12 INFO - wsgiref == 0.1.2 02:26:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 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 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:26:12 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 02:26:12 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 02:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:12 INFO - 'HOME': '/Users/cltbld', 02:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:12 INFO - 'LOGNAME': 'cltbld', 02:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:12 INFO - 'MOZ_NO_REMOTE': '1', 02:26:12 INFO - 'NO_EM_RESTART': '1', 02:26:12 INFO - 'PAGER': '/bin/cat', 02:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:12 INFO - 'PWD': '/builds/slave/test', 02:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:12 INFO - 'SHELL': '/bin/bash', 02:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:26:12 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:12 INFO - 'USER': 'cltbld', 02:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:12 INFO - 'XPC_FLAGS': '0x0', 02:26:12 INFO - 'XPC_SERVICE_NAME': '0', 02:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 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)) 02:26:12 INFO - Cleaning up... 02:26:12 INFO - Return code: 0 02:26:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c418490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c38e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe92d7e3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, '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.ztXiBwiMC5/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.1Nb2mYUVMJ/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 02:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:12 INFO - 'HOME': '/Users/cltbld', 02:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:12 INFO - 'LOGNAME': 'cltbld', 02:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:12 INFO - 'MOZ_NO_REMOTE': '1', 02:26:12 INFO - 'NO_EM_RESTART': '1', 02:26:12 INFO - 'PAGER': '/bin/cat', 02:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:12 INFO - 'PWD': '/builds/slave/test', 02:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:12 INFO - 'SHELL': '/bin/bash', 02:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:26:12 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:12 INFO - 'USER': 'cltbld', 02:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:12 INFO - 'XPC_FLAGS': '0x0', 02:26:12 INFO - 'XPC_SERVICE_NAME': '0', 02:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:12 INFO - Cleaning up... 02:26:12 INFO - Return code: 0 02:26:12 INFO - Running post-action listener: _resource_record_post_action 02:26:12 INFO - Running post-action listener: _start_resource_monitoring 02:26:13 INFO - Starting resource monitoring. 02:26:13 INFO - [mozharness: 2016-11-06 10:26:13.006197Z] Finished create-virtualenv step (success) 02:26:13 INFO - [mozharness: 2016-11-06 10:26:13.007160Z] Running install step. 02:26:13 INFO - Running pre-action listener: _resource_record_pre_action 02:26:13 INFO - Running main action method: install 02:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:13 INFO - Reading from file tmpfile_stdout 02:26:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:13 INFO - Reading from file tmpfile_stdout 02:26:13 INFO - Output received: 02:26:13 INFO - Usage: mozinstall [options] installer 02:26:13 INFO - Options: 02:26:13 INFO - -h, --help show this help message and exit 02:26:13 INFO - -d DEST, --destination=DEST 02:26:13 INFO - Directory to install application into. [default: 02:26:13 INFO - "/builds/slave/test"] 02:26:13 INFO - --app=APP Application being installed. [default: firefox] 02:26:13 INFO - mkdir: /builds/slave/test/build/application 02:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:26:45 INFO - Reading from file tmpfile_stdout 02:26:45 INFO - Output received: 02:26:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:26:45 INFO - Running post-action listener: _resource_record_post_action 02:26:45 INFO - [mozharness: 2016-11-06 10:26:45.824853Z] Finished install step (success) 02:26:45 INFO - [mozharness: 2016-11-06 10:26:45.825028Z] Running run-tests step. 02:26:45 INFO - Running pre-action listener: _resource_record_pre_action 02:26:45 INFO - Running main action method: run_tests 02:26:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:26:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:26:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:26:45 INFO - 2016-11-06 02:26:45.839 screenresolution[1653:10024] starting screenresolution argv=screenresolution get 02:26:45 INFO - 2016-11-06 02:26:45.842 screenresolution[1653:10024] Display 0: 1600x1200x32@60 02:26:45 INFO - 2016-11-06 02:26:45.847 screenresolution[1654:10026] starting screenresolution argv=screenresolution list 02:26:45 INFO - Available Modes on Display 0 02:26:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:26:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:26:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:26:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:26:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:26:46 INFO - Intel Iris: 02:26:46 INFO - Chipset Model: Intel Iris 02:26:46 INFO - Type: GPU 02:26:46 INFO - Bus: Built-In 02:26:46 INFO - VRAM (Dynamic, Max): 1536 MB 02:26:46 INFO - Vendor: Intel (0x8086) 02:26:46 INFO - Device ID: 0x0a2e 02:26:46 INFO - Revision ID: 0x0009 02:26:46 INFO - Displays: 02:26:46 INFO - Display: 02:26:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:26:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:26:46 INFO - Display Serial Number: 1600x1200 60 02:26:46 INFO - Main Display: Yes 02:26:46 INFO - Mirror: Off 02:26:46 INFO - Online: Yes 02:26:46 INFO - Rotation: Supported 02:26:46 INFO - Return code: 0 02:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:46 INFO - Python 2.7.3 02:26:46 INFO - Return code: 0 02:26:46 INFO - grabbing minidump binary from tooltool 02:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:46 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 0x10c22cd30>, '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 0x10c092db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c224b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:46 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 02:26:46 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 02:26:46 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 02:26:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:46 INFO - Return code: 0 02:26:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:26:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:26:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:46 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/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.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 02:26:46 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/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.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 02:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ztXiBwiMC5/Render', 02:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:46 INFO - 'HOME': '/Users/cltbld', 02:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:46 INFO - 'LOGNAME': 'cltbld', 02:26:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:46 INFO - 'MOZ_NO_REMOTE': '1', 02:26:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:46 INFO - 'NO_EM_RESTART': '1', 02:26:46 INFO - 'PAGER': '/bin/cat', 02:26:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:46 INFO - 'PWD': '/builds/slave/test', 02:26:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:46 INFO - 'SHELL': '/bin/bash', 02:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1Nb2mYUVMJ/Listeners', 02:26:46 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 02:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:46 INFO - 'USER': 'cltbld', 02:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:46 INFO - 'XPC_FLAGS': '0x0', 02:26:46 INFO - 'XPC_SERVICE_NAME': '0', 02:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:46 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/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.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 02:26:46 INFO - mozversion application_buildid: 20161106004004 02:26:46 INFO - mozversion application_changeset: 070cf059bb70aa991d50b4d266987adf26685915 02:26:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:26:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:46 INFO - mozversion application_name: Firefox 02:26:46 INFO - mozversion application_remotingname: firefox-dev 02:26:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:26:46 INFO - mozversion application_vendor: Mozilla 02:26:46 INFO - mozversion application_version: 51.0a2 02:26:46 INFO - mozversion platform_buildid: 20161106004004 02:26:46 INFO - mozversion platform_changeset: 070cf059bb70aa991d50b4d266987adf26685915 02:26:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:26:46 INFO - mozversion platform_version: 51.0a2 02:26:46 INFO - using testdate: 1478428006 02:26:46 INFO - actual date: 1478428006 02:26:46 INFO - starting webserver on 'localhost:49276' 02:26:46 INFO - SUITE-START | Running 2 tests 02:26:46 INFO - TEST-START | dromaeo_css 02:26:46 INFO - operating with platform_type : mac_ 02:26:46 INFO - Initialising browser for dromaeo_css test... 02:26:46 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpDuGs_D/profile http://localhost:49276/getInfo.html) 02:26:48 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:26:48 INFO - PROCESS | 1664 | colorDepth:24 02:26:48 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:26:48 INFO - PROCESS | 1664 | __metrics 02:26:49 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:26:49 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:49 INFO - TEST-INFO | 1664: exit 0 02:26:49 INFO - Browser initialized. 02:26:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:26:49 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpDuGs_D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:01 INFO - PROCESS | 1669 | RSS: Main: 220155904 02:27:01 INFO - PROCESS | 1669 | 02:27:52 INFO - PROCESS | 1669 | 1478428072993 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:30:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:30:06 INFO - PROCESS | 1669 | RSS: Main: 376340480 02:30:06 INFO - PROCESS | 1669 | 02:33:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:33:09 INFO - PROCESS | 1669 | RSS: Main: 353443840 02:33:09 INFO - PROCESS | 1669 | 02:36:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 02:36:12 INFO - PROCESS | 1669 | RSS: Main: 319823872 02:36:12 INFO - PROCESS | 1669 | 02:39:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 02:39:15 INFO - PROCESS | 1669 | RSS: Main: 311873536 02:39:15 INFO - PROCESS | 1669 | 02:42:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 02:42:19 INFO - PROCESS | 1669 | RSS: Main: 308924416 02:42:19 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 02:45:22 INFO - PROCESS | 1669 | RSS: Main: 412233728 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | __start_tp_report 02:45:22 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 02:45:22 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 02:45:22 INFO - PROCESS | 1669 | |i|pagename|runs| 02:45:22 INFO - PROCESS | 1669 | |0;dojo.html;3272.018394481656;3287.1453422110253;3314.27086041071;3337.0989832745145;3365.377405180042;5610.186522954169;5616.859578510539;5657.12314591238;5670.234518340028;5697.230873832032;5579.776808927638;5665.951798917204;5683.488486036256;5685.431456854323;5733.627314224573;5098.490150984909;5136.229565565158;5143.53708166265;5164.096283150452;5183.429822719498;4769.236922092466;4896.338994235768;5140.100482415581;5152.871178220537;5267.209918512215;5181.35233095863;5187.19598462239;5204;5209.348831396075;5263.763130659129;5213.165893457067;5216.504432078966;5222.8694282642855;5285.6300058995885;5305.230741542455;5144.408393034774;5183.222516622499;5206.167013277857;5228.55557277628;5260.316158899319;4564.406627138484;5542.584306177013;5608.579356548275;5680.176374425727;5684.317881854204;6141.792871882774;6187.07193920911;6208.50331973441;6217.502599792006;6236.96881515594;6297.086922396273;6301.054841773771;6308.747650093991;6311.463525600329;6324.051392291147;5634.774609015634;5679.716014199274;5749.482546570745;5806.709664516799;5812.157237200582;6282.654454004982;6302.621842689453;6310;6312.936870631235;6319.46284565817;6141.6007959482495;6144.784932527429;6170.691465426711;6171;6171.938280617226;6126.264848218153;6145.20112385396;6158.507319414436;6168.25980882297;6289.276733175652;6160.630362178284;6173.166622505994;6242.500599951993;6244.594101383395;6267.4045965633195;5147.40804807452;5210.296609957683;6220.782272620437;6268.49852011838;6270.717817698214;4843.07981483517;4879.682820616648;4945.9258111128365;4965.255211718199;4980.551750342486;3750.3811871041516;4398.274284743045;4428.623566996777;4438.334249862546;4458.576435238647;5782.537397008229;5783;5788.334341550775;5795.623284486579;5808.88382232353;6298;6306.558540902093;6308.716107775161;6326.177596912372;6336.398042185985;5618.494335509824;5694.686792226467;5701.800436984769;5726.914096288559;5746.4253574643035;5351.063563876306;5375.978564072813;5378.11261141915;5380.757865896044;5384.219288203189;6296.181496405438;6308.02225655015;6312.179416675803;6317.399847014618;6333.145025421509;6111.135969295249;6169.784057557964;6247.094171345038;6306.369363063657;6313.43179113882;6191;6231.158793562992;6252.687365631791;6291.056341548804;6309.589876658002;6154.876902462015;6160.476359509313;6163.044728067157;6170.9074363885475;6179.474744646755;6108.554560543837;6204.224471941007;6245.125682404558;6264.091706702411;6267.46726528232;6036.788712395045;6047.304559975659;6047.606905551125;6062.242219722535;6138.51101655979;6086.756529738938;6088.238970128734;6098.237720284965;6109.480694141048;6138.109974053648;4740.336352910665;5938.406159384027;5953.702314884152;5960.821175364746;5963.91054134197;5884.08796636522;6013.9699301503215;6052.546059045677;6067.908981365372;6121.3572574879;5915.467607915309;5966.940330596639;5970.97014514942;5972.34304226526;5998.070299103646 02:45:22 INFO - PROCESS | 1669 | |1;ext.html;449.7099370905766;499.92751051097616;513.0918274653861;516.4886762105516;519.4286285086405;29655.25861853452;32686;32741.83629081854;32781;32994.17514562137;41331.96670083242;41923;42278.36582451266;44350.55649443505;44621.7768911155;9920.25598080145;10065.64770233042;10083.042110999444;10086.193104551618;10089.991000899925;8753.431026983226;9856.655017074403;9901.950490247538;10028.548715307828;10030.9498452508;10043.447610381463;10068.446235457048;10077.09306162449;10081.042300981395;10083.848742268872;9953;10017.449040302781;10031.247656425798;10045.949770251102;10071.597136114546;9898.802023959552;9960.053794889474;9964.451955142464;9973.2520060995;9986.350887192382;41416.378754318706;41741.58258417407;41817;41821.37267940983;41890.58109418897;3370.2922386298906;3397.0827876473213;3461.2558299965376;3515.630858759819;4012.0772222388723;30168.396632067455;30533.694663053306;30634.23414414635;31200.687993120006;32048.679513205036;2434.4522482441484;3104.28601421672;3115.3457773867517;3125;3137.1843320736543;525915;532079;532700;533286;533409;62354.37645623576;63001;63049.68475157687;63098.684506578094;63099;33980.49029264563;34325;34539.654603453644;36461.27077458489;66168.33831661718;17234.741478877826;17413.825861741472;17425.65148697019;17426.954382737076;17445;13343.866561334262;13444.260565668787;13446.46214151423;13455.32723363828;13459.865401346056;18983.33558325452;19152.04239788005;19196.136173872208;19202.695676518906;19215.423537293904;7870.606469676493;8011.599420028975;8057.348243610046;8075.475094118863;8120.715774947848;842.4945032980286;979.2264111352094;1024.5952848624752;1039.184240371305;1098.5605757696985;29487.967921122658;29743.851280743456;30174.24564385864;30220.395592088036;30502.847485762428;888.2050564744518;932.7668082979255;999.0758548342899;1098.4343063322394;1144.0047158971747;11496.54013839437;13228.603141905758;14679.899007574475;15244.923775381274;15359.232038398035;673972;681426;688421;688493;691839;57810.55473613193;58333.12500312499;58404.12393814096;58427.831443370895;58448.707756461794;1197.1978774221293;1225.2893321873291;1299.571141523314;1339.1964821107258;1357.633438971472;29268.41463170682;30921.226969325948;30926.0722178335;31403.371932561677;31642.683573163973;49963;50465;50592.74703626458;50614;50636.74681626568;566686;568284;570441;570582;570740;25821.741782581932;26906.32734181661;26929;26965;26983.86508067447;47230.76384618055;47519.28721069256;47577.52422475731;47870.76064619794;48213.758931206525;38096.42855357117;38691.41962870503;39099.02252443712;39623.40564891471;40321.59678403296;33517.66482335146;38329.23341533209;38544;39292;40242.59757402506;35605.465918010734;37123.44314835226;38195;38709;38872;31788.84105579457;33453.49819752657;33666;34270.14324641804;35040.64959350374;21557.568848623254;25594.872025639754;25639.743602563736;25873.870630647478;25977.610335845355 02:45:22 INFO - PROCESS | 1669 | |2;jquery.html;303.7099569910733;367.10792773560246;373.0952440332192;378.72542406755105;398.59542564297243;14992.250387480637;15130.697386052272;16106.35574577017;20570;21018;19951.201951921907;20412.387628371136;20718.171273149095;20968;21300.4674883128;5478.726063696819;5982.940170598304;6237.71930263137;6243.87512249757;6254.124422580842;6001.789937352193;6163.506919446456;6225.8132256032395;6231.750729970796;6232.626042437446;5884.2056322396575;6113.663748493831;6174.413430724074;6191.566590338678;6203.193584833965;6075.483583895352;6108.786192483241;6133.2026836511195;6136.938630613681;6142.447179753821;4539.341795439643;5063.746812659389;5228.37259528859;5271.630985830955;5283.841484755463;22986.310410687707;24367.512649747085;25296.98812047516;25541.61687574688;25584.744152558607;2062.463759422546;2092.299079808266;2162.4593851537115;2429.125514814665;3090.0729781065816;9949;10284.74288142795;10301.690949271533;10751.946240268826;13405.396757145854;1889.1215584753156;1902.3341830359402;1903.8572107092023;1925.9614807703908;1930.4112245765036;105272;108924.4553777234;111042.88957110407;113019.43490282579;114962.99999999917;9444.291678124167;10007.949960250153;10008.749781255527;10112.747181320527;10140.239482038876;12398.946089582307;12503.812442813365;12517.624471265877;12518.81221781674;12541.623751287476;7149.92850071503;8079.636416361278;8110.675572977133;8239.176082391832;8378.49729016261;8789;8797.340199485065;8815.030346661862;8950.641974321084;8963.014068452465;3778.282126395976;3886.145048089416;3886.145048089416;3924.05822602579;3928.508936382952;1861.4229588827236;1911.7801452833103;1918.2518817661123;1919.9136038878005;1924.6150769846088;825.4510750351069;827.5696637748338;835.7242110103651;876.4303202918154;947.5735918836551;19758.620001198098;21258.36224913255;21325.89337053336;21386.358409247747;21638.242661507087;790.727199116304;868.3574155125289;912.3203213605906;913.488446469979;916.4547094478775;10429.828068772551;10748.462576871125;10786.298890572089;11086.445677716081;12036.879631203576;606507;615682.9215853892;616635;620402;623513;141234;144245;150028.24985875218;151015;151290;954.1126752120595;994.105305225303;1025.958961641541;1029.8506716526063;1031.2471895516314;18899.338523151622;19015.809841901402;19738.703919440934;19764.703529446782;19823.107960142115;52130.21804672857;55078.173827391816;55350.72324638351;58161.4183858156;59426.70286648539;67336.98994515184;71909;77560.61219693866;77849.05377365384;78874.81687774573;8004.639791209526;8097.838043238984;8156.469829461066;8262.710805121791;8271.17288271168;12290.569830055905;12510.124291299522;12803.679908002001;12896.419661115086;13154.934225328812;8889.777755555904;10938.835917461085;10969.23215374916;11111.888881111085;11588.88411115878;9034.683786067719;11164.330140191614;11164.810326111021;11194.552217911192;11386.886131138583;10848.969347911936;10934.289271197347;11253.71865703364;11309.604163854226;11510.02164816;6734.259231484435;6929.757458488929;7390.815229619087;7910.406719495946;8190.959045204736;9967.900320996698;10972.122230221403;11133.109351252042;11407;11432.314061156358 02:45:22 INFO - PROCESS | 1669 | |3;mootools.html;1304.686875149964;1331.5738963531674;1497.4908531099425;1634.35443000015;1867.8505719542447;7850;8412.45319054261;8636.56817159141;8876.556172191396;8893;8786.648534058646;8839.337049721264;8849.380543361967;8850.955745221281;8858.247049000842;2355.1168311883043;2408.4460574067975;2412.1436889904094;2413.78275955164;2414.311921102486;2370.9051637934463;2398.772116648924;2410.8312418130736;2412.2401443545227;2415.1909110448023;2091.6090799618237;2375.323032935614;2397.61638137898;2401.651760494727;2406.639004149383;2309.31875096846;2353.5881220786464;2385.7375688674233;2388.6178211486254;2388.820838437124;2338.1115176233093;2371.098982386682;2381.2499062795337;2384;2387.283814855554;8894.066123057051;8900.955495222483;8995.415298005673;9006.099390060941;9017.729468115967;4650.697704649187;5206.661566998133;5383.865403364908;5417.729113544307;5478.972605136949;3434.0899661589697;3561.893143205682;3618.421052631593;3637.1452708613456;3670.7981061041633;1021.2136654775856;1036.6786296248113;1051.789642071581;1074.3392813419769;1075.1936047964027;11692.70768230801;11845.526178952832;11855.82216266748;11976.161668683195;12033.097517686121;4447.688661793643;4591.678582499259;4674.462436819809;4680.625549955996;4683.742394168354;9329.673461428818;9353.719388418358;9360.11078947499;9362;9366.531673416303;5282.709450980233;5286.841394758163;5289.761960711778;5293.073712100367;5298.443663415286;3719.795411252407;4342.848000319974;4414.404055452537;4540.182767101887;4935.333729946483;3747.8500859965297;3748.4002559590335;3811.6760075393904;3816.37029890065;3825.9426108608395;1096.1121491591837;1114.593173491686;1117.407773879845;1126.79717650822;1128.351198061118;783.6747749683817;878.2666473494703;906.4228242857381;916.757059379265;928.7492377058156;5986.670733109634;5995.340512543617;6015;6128.571000030044;6338.809835704937;888.3515034025069;899.4558292233236;923.9861402078974;937.1097457415483;965.9661911833052;3843.36584463566;4042.272390969595;4084.6936479764136;4099.569545197771;4124.505059392892;10570.365778053188;10865.293755905841;10897.019268265736;10957.342559446459;10960.342379457257;8534.445261058012;10739.194560408001;10746.355218686904;10879.619213327496;10963.945180274048;8164.469309494863;8350.4154709171;8355.289800366916;8395.244428001388;8398;5158.793648254028;5990.9700451497465;6001.819945401645;6053.515718742578;6221.06683997404;9865.654702085392;10036.899631003596;10138.949305253427;10180.032896874785;10309.020643038899;9409.85885211736;10021.74945626336;10089.848652270368;10322.638707645196;10413.791724165323;7069.646517674199;7286.854262914818;7320.1215854097845;7337.816554586178;7388.113426388868;8220.917790822015;8302;8305;8389.664413423394;8403.95798021006;7491.211122287503;7535.284148005931;7544.283293087148;7607.543547387175;7629.427792915664;7434.628268586657;7482.214367491335;7488.400927925862;7517.962410187914;7527.623618819147;6846.5892046477375;7012.263712310338;7096.432285417258;7105.25394833535;7113.466490013373;4888.535589119028;4948.8762780930765;5028.1200789860895;5106.183010718267;5235.4502777207845;4807.6394270429155;4973.875653108556;5147.948520514747;5202.583793296451;5296.761645726028 02:45:22 INFO - PROCESS | 1669 | |4;prototype.html;300.55517833606274;300.6827796674508;308.49098986671993;311.8316109300978;316.36252950305123;4801.639877009229;5146.202338637512;5370.973145134274;5378.596605254602;5411.509576323269;4062.3297155969303;4407.449068866392;5071.847844564669;5128.666636668614;5241.39723931748;3519.849734487632;3536.8938931832085;3810.485584446092;4067.4508941292843;4084.305668036426;3688.4877200347864;3723.808381317979;4019.2765302245584;4020.1909140886573;4083.774867539741;3896;4012.7929638698747;4030.0580576179404;4030.415589739486;4052.1490486997764;4030.6573941215033;4067.6949228807957;4085.651734927482;4101.0772576170275;4111.650509706678;3156.5580818685403;3323.8532706216315;3485.8431370588382;3505.6669616386403;3538.628444013393;4268.55180206077;5121.84634460963;5165.199394093884;5190.32525771651;5208.166693329087;4093;4339.5443478434945;4395.560443955611;4630.7453090080035;4678.619807156897;4534.750588717619;4993.779012536894;5547.944520554824;5585.441455854423;5621.831345059655;3926.823292951824;3931.506027709481;3934;3963.4451176835264;3968.5634580196156;4011.578784227643;5058.713644241776;5756.395578464285;5781.0977590126495;5800.738966746507;3641.4901913732097;3798.2023775007005;3831.099691572478;3846.1922996171115;3858.2476417098956;2958.3787404644836;3886.378179491268;3907.8241479133508;3915.7454765440157;3930.6069393060466;3399.6600339965808;4381.452318460192;4498.212812757754;4584.770761461914;4596.310553416947;4812.51874812523;4823.853385243603;5503.036968530491;5504.4495550444635;5658.179563963202;1169.4328250798355;1359.9728005439836;1376.167418711685;1386.597886612871;1393.108410617206;776.9961150194213;878.6441491196076;910.6402970826487;913.4154141349542;946.8674385586023;4480.692443391656;5267.947320526822;5268.341457317835;5281.551068159172;5292.285541451854;5751.6549007058875;5784.623999440107;5790.218320526675;5817.738201780845;5851.156885581028;4569.474510431276;5024.773885175103;5258.2638430619745;5373.731313434313;5429.348478182644;3015.54766784984;3051.7711171662213;3052.603161588979;3060.127863558875;3060.9234769130503;5802.854928626818;5969.403059694083;6047.516198704181;6063.636181829104;6091.208142941389;4875.390576177978;5089.465606111379;5839.737211825478;5890.764369425175;5962.791302304398;5975.7609695612555;6013.789517366871;6030.698465076729;6039.275286965504;6055.273367195965;4925.310456536016;5579.74891129892;5678.4605462480995;5695.715214239189;5798.33319168301;4950.603951683928;4966.205407134986;5538.9169162461785;5582.4138465462165;5656.321241451053;5331.680099194061;5533.114701647878;6001.36985616504;6003.279606447254;6006;3262.4943133814295;3835.4055121456217;3874.748141370802;3890.9221815564097;3914.8646892400884;4919.631027672867;4950.529699678525;5335.906139241524;5649.378568357395;5949.137375080676;5548.223248745098;5685.687287199078;5751.48236658686;5757.481826635623;5791.276090488689;5615.775368985195;5621.269234999424;5644.262532671733;5647.407022262603;5677.914831277617;4873.488283730299;5314.282571852905;5333.200019996876;5525.9447405527035;5572.637778544382;5072.239164125263;5508.531774799187;5574;5598.5848632335055;5640.377224590585;5471.945280547303;5477.643953143033;5504.311961004874;5509.311336082989;5535.612507124462 02:45:22 INFO - PROCESS | 1669 | |5;yui.html;702.290686406729;704.3801454719846;730.1311439387129;771.7028943856614;781.1251398433755;15775;16788.748168777478;16794.244259008326;16804.243809028594;16824.07467589282;14967.251637418112;14985.400583976656;15050.021748586334;15117.395304187847;15140.84859151408;674.1606699658931;691.9481038922075;698.8218004408868;699.087690563814;819.2585709932521;694.3507820188115;698.2005603583893;816.8978877640295;863.9913600864005;867.7526904832124;905.8324210021134;909.7316291693966;916.5096673279796;919.797644518205;922.0456827183866;908.582052255963;911.9817603647923;912.1562554637001;913.5523593439233;915.6795121707415;522.8797376603364;543.0252696409954;543.1689515041992;685.324954919404;685.7325642999234;12664.55674051413;12691.365431728376;12694.61916142508;14687.04534205284;15243.314050867626;14605.269736513132;15097.094174349575;15131.243437828065;15157.242137893061;15259.542213733606;10125.89874101257;11604.709882252926;12006.69983250417;12040.81938770919;12462;3843.6348546888003;3867.845286188549;3888.591697871739;3893.396523538856;3923.0580862473257;92406.5379673104;95485.52257238739;95789;119781;125005;10963.83554246687;11198.160137989684;11213.887861121448;11522.711932201595;11822.881771182178;22279.665805012937;22294.442638934157;22442.775572244394;22468.662970055462;22679;6790.5925644461495;8115.79710507242;8134.83730325402;8188.017437907489;8227.54748488827;4327.5239723630375;4368.213721530155;4440.178566965122;4646.442426908792;4695.765211739399;3640.381135207021;3781.565120011234;3784.7729136251914;3786.9431958520645;3788.412796016622;674.7570874485182;678.8913773796268;685.5612408058846;692.3526502719873;700.1423256510734;587.3333766175422;613.5306490534655;672.5628341578014;672.7914346552584;674.571647004146;7727.343175830005;9330.673426430043;9743.512824358895;9851.408915465096;9972.301938864355;580.8315588479378;655.3741177175785;673.9831504212434;674.6188403551978;687.5599616245606;4715.504871988461;4823.782929768169;4824.179889418807;4824.758762061953;4830.830920917751;145759;149196.50803492044;151782;152749.23625381803;156225.21887390717;105907;108371;119156;123576;124608.37695811463;112812.43593782143;112824.43587782008;113886;116449;116563;7770.417218708506;9069.093090690878;9112.31657625694;9216.815663686823;9345.701868150396;54218;65106;66208;66484.66757666375;67883.66058169876;83529.58235209028;88875.55562222148;95334.56998144895;98069;99013.01942762162;11718.88281117178;11847.466863990969;11949.283043017447;12142.332171730286;12158.939205303917;13382.9330853349;13448.1258718183;13515.459381625018;13528.255945922676;13562.254076025913;11881.643550693492;12153.939230303791;12307.630771076882;12327.50689972391;12346.567870124503;12124.696882577653;12302.446389912655;12308.138430309793;12668.936655317033;12677.112602117762;10941.507632156732;12880.742385152433;13117.803232951705;13980.300984950914;14557.708845822812;11319.207655464039;11328.921588228395;11711.238769479956;12001.099917506048;12045.457954392248;9957.203423726229;11511.30932144074;11737.3637413223;11752.58865939688;11905.821412678644 02:45:22 INFO - PROCESS | 1669 | __end_tp_report 02:45:22 INFO - PROCESS | 1669 | __start_cc_report 02:45:22 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1516 02:45:22 INFO - PROCESS | 1669 | __end_cc_report 02:45:22 INFO - PROCESS | 1669 | __startTimestamp1478429122853__endTimestamp 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | ------- Summary: start ------- 02:45:22 INFO - PROCESS | 1669 | Number of tests: 6 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5705.58 Median:5960.82 stddev:670.73 (11.3%) stddev-sans-first:645.04 02:45:22 INFO - PROCESS | 1669 | Values: 3272.0 3287.1 3314.3 3337.1 3365.4 5610.2 5616.9 5657.1 5670.2 5697.2 5579.8 5666.0 5683.5 5685.4 5733.6 5098.5 5136.2 5143.5 5164.1 5183.4 4769.2 4896.3 5140.1 5152.9 5267.2 5181.4 5187.2 5204.0 5209.3 5263.8 5213.2 5216.5 5222.9 5285.6 5305.2 5144.4 5183.2 5206.2 5228.6 5260.3 4564.4 5542.6 5608.6 5680.2 5684.3 6141.8 6187.1 6208.5 6217.5 6237.0 6297.1 6301.1 6308.7 6311.5 6324.1 5634.8 5679.7 5749.5 5806.7 5812.2 6282.7 6302.6 6310.0 6312.9 6319.5 6141.6 6144.8 6170.7 6171.0 6171.9 6126.3 6145.2 6158.5 6168.3 6289.3 6160.6 6173.2 6242.5 6244.6 6267.4 5147.4 5210.3 6220.8 6268.5 6270.7 4843.1 4879.7 4945.9 4965.3 4980.6 3750.4 4398.3 4428.6 4438.3 4458.6 5782.5 5783.0 5788.3 5795.6 5808.9 6298.0 6306.6 6308.7 6326.2 6336.4 5618.5 5694.7 5701.8 5726.9 5746.4 5351.1 5376.0 5378.1 5380.8 5384.2 6296.2 6308.0 6312.2 6317.4 6333.1 6111.1 6169.8 6247.1 6306.4 6313.4 6191.0 6231.2 6252.7 6291.1 6309.6 6154.9 6160.5 6163.0 6170.9 6179.5 6108.6 6204.2 6245.1 6264.1 6267.5 6036.8 6047.3 6047.6 6062.2 6138.5 6086.8 6088.2 6098.2 6109.5 6138.1 4740.3 5938.4 5953.7 5960.8 5963.9 5884.1 6014.0 6052.5 6067.9 6121.4 5915.5 5966.9 5971.0 5972.3 5998.1 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:71860.09 Median:19250.95 stddev:160283.70 (832.6%) stddev-sans-first:160643.67 02:45:22 INFO - PROCESS | 1669 | Values: 449.7 499.9 513.1 516.5 519.4 29655.3 32686.0 32741.8 32781.0 32994.2 41332.0 41923.0 42278.4 44350.6 44621.8 9920.3 10065.6 10083.0 10086.2 10090.0 8753.4 9856.7 9902.0 10028.5 10030.9 10043.4 10068.4 10077.1 10081.0 10083.8 9953.0 10017.4 10031.2 10045.9 10071.6 9898.8 9960.1 9964.5 9973.3 9986.4 41416.4 41741.6 41817.0 41821.4 41890.6 3370.3 3397.1 3461.3 3515.6 4012.1 30168.4 30533.7 30634.2 31200.7 32048.7 2434.5 3104.3 3115.3 3125.0 3137.2 525915.0 532079.0 532700.0 533286.0 533409.0 62354.4 63001.0 63049.7 63098.7 63099.0 33980.5 34325.0 34539.7 36461.3 66168.3 17234.7 17413.8 17425.7 17427.0 17445.0 13343.9 13444.3 13446.5 13455.3 13459.9 18983.3 19152.0 19196.1 19202.7 19215.4 7870.6 8011.6 8057.3 8075.5 8120.7 842.5 979.2 1024.6 1039.2 1098.6 29488.0 29743.9 30174.2 30220.4 30502.8 888.2 932.8 999.1 1098.4 1144.0 11496.5 13228.6 14679.9 15244.9 15359.2 673972.0 681426.0 688421.0 688493.0 691839.0 57810.6 58333.1 58404.1 58427.8 58448.7 1197.2 1225.3 1299.6 1339.2 1357.6 29268.4 30921.2 30926.1 31403.4 31642.7 49963.0 50465.0 50592.7 50614.0 50636.7 566686.0 568284.0 570441.0 570582.0 570740.0 25821.7 26906.3 26929.0 26965.0 26983.9 47230.8 47519.3 47577.5 47870.8 48213.8 38096.4 38691.4 39099.0 39623.4 40321.6 33517.7 38329.2 38544.0 39292.0 40242.6 35605.5 37123.4 38195.0 38709.0 38872.0 31788.8 33453.5 33666.0 34270.1 35040.6 21557.6 25594.9 25639.7 25873.9 25977.6 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:35692.07 Median:25563.18 stddev:103146.49 (403.5%) stddev-sans-first:103401.62 02:45:22 INFO - PROCESS | 1669 | Values: 303.7 367.1 373.1 378.7 398.6 14992.3 15130.7 16106.4 20570.0 21018.0 19951.2 20412.4 20718.2 20968.0 21300.5 5478.7 5982.9 6237.7 6243.9 6254.1 6001.8 6163.5 6225.8 6231.8 6232.6 5884.2 6113.7 6174.4 6191.6 6203.2 6075.5 6108.8 6133.2 6136.9 6142.4 4539.3 5063.7 5228.4 5271.6 5283.8 22986.3 24367.5 25297.0 25541.6 25584.7 2062.5 2092.3 2162.5 2429.1 3090.1 9949.0 10284.7 10301.7 10751.9 13405.4 1889.1 1902.3 1903.9 1926.0 1930.4 105272.0 108924.5 111042.9 113019.4 114963.0 9444.3 10007.9 10008.7 10112.7 10140.2 12398.9 12503.8 12517.6 12518.8 12541.6 7149.9 8079.6 8110.7 8239.2 8378.5 8789.0 8797.3 8815.0 8950.6 8963.0 3778.3 3886.1 3886.1 3924.1 3928.5 1861.4 1911.8 1918.3 1919.9 1924.6 825.5 827.6 835.7 876.4 947.6 19758.6 21258.4 21325.9 21386.4 21638.2 790.7 868.4 912.3 913.5 916.5 10429.8 10748.5 10786.3 11086.4 12036.9 606507.0 615682.9 616635.0 620402.0 623513.0 141234.0 144245.0 150028.2 151015.0 151290.0 954.1 994.1 1026.0 1029.9 1031.2 18899.3 19015.8 19738.7 19764.7 19823.1 52130.2 55078.2 55350.7 58161.4 59426.7 67337.0 71909.0 77560.6 77849.1 78874.8 8004.6 8097.8 8156.5 8262.7 8271.2 12290.6 12510.1 12803.7 12896.4 13154.9 8889.8 10938.8 10969.2 11111.9 11588.9 9034.7 11164.3 11164.8 11194.6 11386.9 10849.0 10934.3 11253.7 11309.6 11510.0 6734.3 6929.8 7390.8 7910.4 8191.0 9967.9 10972.1 11133.1 11407.0 11432.3 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5705.32 Median:4961.38 stddev:3213.99 (64.8%) stddev-sans-first:3205.99 02:45:22 INFO - PROCESS | 1669 | Values: 1304.7 1331.6 1497.5 1634.4 1867.9 7850.0 8412.5 8636.6 8876.6 8893.0 8786.6 8839.3 8849.4 8851.0 8858.2 2355.1 2408.4 2412.1 2413.8 2414.3 2370.9 2398.8 2410.8 2412.2 2415.2 2091.6 2375.3 2397.6 2401.7 2406.6 2309.3 2353.6 2385.7 2388.6 2388.8 2338.1 2371.1 2381.2 2384.0 2387.3 8894.1 8901.0 8995.4 9006.1 9017.7 4650.7 5206.7 5383.9 5417.7 5479.0 3434.1 3561.9 3618.4 3637.1 3670.8 1021.2 1036.7 1051.8 1074.3 1075.2 11692.7 11845.5 11855.8 11976.2 12033.1 4447.7 4591.7 4674.5 4680.6 4683.7 9329.7 9353.7 9360.1 9362.0 9366.5 5282.7 5286.8 5289.8 5293.1 5298.4 3719.8 4342.8 4414.4 4540.2 4935.3 3747.9 3748.4 3811.7 3816.4 3825.9 1096.1 1114.6 1117.4 1126.8 1128.4 783.7 878.3 906.4 916.8 928.7 5986.7 5995.3 6015.0 6128.6 6338.8 888.4 899.5 924.0 937.1 966.0 3843.4 4042.3 4084.7 4099.6 4124.5 10570.4 10865.3 10897.0 10957.3 10960.3 8534.4 10739.2 10746.4 10879.6 10963.9 8164.5 8350.4 8355.3 8395.2 8398.0 5158.8 5991.0 6001.8 6053.5 6221.1 9865.7 10036.9 10138.9 10180.0 10309.0 9409.9 10021.7 10089.8 10322.6 10413.8 7069.6 7286.9 7320.1 7337.8 7388.1 8220.9 8302.0 8305.0 8389.7 8404.0 7491.2 7535.3 7544.3 7607.5 7629.4 7434.6 7482.2 7488.4 7518.0 7527.6 6846.6 7012.3 7096.4 7105.3 7113.5 4888.5 4948.9 5028.1 5106.2 5235.5 4807.6 4973.9 5147.9 5202.6 5296.8 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4521.18 Median:5072.04 stddev:1400.32 (27.6%) stddev-sans-first:1367.94 02:45:22 INFO - PROCESS | 1669 | Values: 300.6 300.7 308.5 311.8 316.4 4801.6 5146.2 5371.0 5378.6 5411.5 4062.3 4407.4 5071.8 5128.7 5241.4 3519.8 3536.9 3810.5 4067.5 4084.3 3688.5 3723.8 4019.3 4020.2 4083.8 3896.0 4012.8 4030.1 4030.4 4052.1 4030.7 4067.7 4085.7 4101.1 4111.7 3156.6 3323.9 3485.8 3505.7 3538.6 4268.6 5121.8 5165.2 5190.3 5208.2 4093.0 4339.5 4395.6 4630.7 4678.6 4534.8 4993.8 5547.9 5585.4 5621.8 3926.8 3931.5 3934.0 3963.4 3968.6 4011.6 5058.7 5756.4 5781.1 5800.7 3641.5 3798.2 3831.1 3846.2 3858.2 2958.4 3886.4 3907.8 3915.7 3930.6 3399.7 4381.5 4498.2 4584.8 4596.3 4812.5 4823.9 5503.0 5504.4 5658.2 1169.4 1360.0 1376.2 1386.6 1393.1 777.0 878.6 910.6 913.4 946.9 4480.7 5267.9 5268.3 5281.6 5292.3 5751.7 5784.6 5790.2 5817.7 5851.2 4569.5 5024.8 5258.3 5373.7 5429.3 3015.5 3051.8 3052.6 3060.1 3060.9 5802.9 5969.4 6047.5 6063.6 6091.2 4875.4 5089.5 5839.7 5890.8 5962.8 5975.8 6013.8 6030.7 6039.3 6055.3 4925.3 5579.7 5678.5 5695.7 5798.3 4950.6 4966.2 5538.9 5582.4 5656.3 5331.7 5533.1 6001.4 6003.3 6006.0 3262.5 3835.4 3874.7 3890.9 3914.9 4919.6 4950.5 5335.9 5649.4 5949.1 5548.2 5685.7 5751.5 5757.5 5791.3 5615.8 5621.3 5644.3 5647.4 5677.9 4873.5 5314.3 5333.2 5525.9 5572.6 5072.2 5508.5 5574.0 5598.6 5640.4 5471.9 5477.6 5504.3 5509.3 5535.6 02:45:22 INFO - PROCESS | 1669 | 02:45:22 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:24618.37 Median:3816.02 stddev:39181.12 (1026.8%) stddev-sans-first:39249.89 02:45:22 INFO - PROCESS | 1669 | Values: 702.3 704.4 730.1 771.7 781.1 15775.0 16788.7 16794.2 16804.2 16824.1 14967.3 14985.4 15050.0 15117.4 15140.8 674.2 691.9 698.8 699.1 819.3 694.4 698.2 816.9 864.0 867.8 905.8 909.7 916.5 919.8 922.0 908.6 912.0 912.2 913.6 915.7 522.9 543.0 543.2 685.3 685.7 12664.6 12691.4 12694.6 14687.0 15243.3 14605.3 15097.1 15131.2 15157.2 15259.5 10125.9 11604.7 12006.7 12040.8 12462.0 3843.6 3867.8 3888.6 3893.4 3923.1 92406.5 95485.5 95789.0 119781.0 125005.0 10963.8 11198.2 11213.9 11522.7 11822.9 22279.7 22294.4 22442.8 22468.7 22679.0 6790.6 8115.8 8134.8 8188.0 8227.5 4327.5 4368.2 4440.2 4646.4 4695.8 3640.4 3781.6 3784.8 3786.9 3788.4 674.8 678.9 685.6 692.4 700.1 587.3 613.5 672.6 672.8 674.6 7727.3 9330.7 9743.5 9851.4 9972.3 580.8 655.4 674.0 674.6 687.6 4715.5 4823.8 4824.2 4824.8 4830.8 145759.0 149196.5 151782.0 152749.2 156225.2 105907.0 108371.0 119156.0 123576.0 124608.4 112812.4 112824.4 113886.0 116449.0 116563.0 7770.4 9069.1 9112.3 9216.8 9345.7 54218.0 65106.0 66208.0 66484.7 67883.7 83529.6 88875.6 95334.6 98069.0 99013.0 11718.9 11847.5 11949.3 12142.3 12158.9 13382.9 13448.1 13515.5 13528.3 13562.3 11881.6 12153.9 12307.6 12327.5 12346.6 12124.7 12302.4 12308.1 12668.9 12677.1 10941.5 12880.7 13117.8 13980.3 14557.7 11319.2 11328.9 11711.2 12001.1 12045.5 9957.2 11511.3 11737.4 11752.6 11905.8 02:45:22 INFO - PROCESS | 1669 | -------- Summary: end -------- 02:45:22 INFO - PROCESS | 1669 | 02:45:23 INFO - TEST-INFO | 1669: exit 0 02:45:23 INFO - TEST-OK | dromaeo_css | took 1117016ms 02:45:23 INFO - TEST-START | kraken 02:45:23 INFO - operating with platform_type : mac_ 02:45:23 INFO - Initialising browser for kraken test... 02:45:23 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpLjOWcd/profile http://localhost:49276/getInfo.html) 02:45:25 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 02:45:25 INFO - PROCESS | 1675 | colorDepth:24 02:45:25 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 02:45:25 INFO - PROCESS | 1675 | __metrics 02:45:25 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:45:25 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:45:26 INFO - TEST-INFO | 1675: exit 0 02:45:26 INFO - Browser initialized. 02:45:26 INFO - Running cycle 1/1 for kraken test... 02:45:26 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpLjOWcd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:38 INFO - PROCESS | 1677 | RSS: Main: 219455488 02:45:38 INFO - PROCESS | 1677 | 02:45:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 02:45:42 INFO - PROCESS | 1677 | RSS: Main: 269627392 02:45:42 INFO - PROCESS | 1677 | 02:45:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 02:45:45 INFO - PROCESS | 1677 | RSS: Main: 280932352 02:45:45 INFO - PROCESS | 1677 | 02:45:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 02:45:49 INFO - PROCESS | 1677 | RSS: Main: 377065472 02:45:49 INFO - PROCESS | 1677 | 02:45:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 02:45:51 INFO - PROCESS | 1677 | RSS: Main: 280788992 02:45:51 INFO - PROCESS | 1677 | 02:45:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:45:54 INFO - PROCESS | 1677 | RSS: Main: 282173440 02:45:54 INFO - PROCESS | 1677 | 02:45:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 02:45:57 INFO - PROCESS | 1677 | RSS: Main: 318758912 02:45:57 INFO - PROCESS | 1677 | 02:46:00 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:01 INFO - PROCESS | 1677 | RSS: Main: 320311296 02:46:01 INFO - PROCESS | 1677 | 02:46:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 02:46:04 INFO - PROCESS | 1677 | RSS: Main: 317739008 02:46:04 INFO - PROCESS | 1677 | 02:46:06 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:06 INFO - PROCESS | 1677 | RSS: Main: 291373056 02:46:06 INFO - PROCESS | 1677 | 02:46:08 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:09 INFO - PROCESS | 1677 | RSS: Main: 295092224 02:46:09 INFO - PROCESS | 1677 | 02:46:11 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:12 INFO - PROCESS | 1677 | RSS: Main: 304607232 02:46:12 INFO - PROCESS | 1677 | 02:46:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:15 INFO - PROCESS | 1677 | RSS: Main: 316329984 02:46:15 INFO - PROCESS | 1677 | 02:46:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:46:19 INFO - PROCESS | 1677 | RSS: Main: 310222848 02:46:19 INFO - PROCESS | 1677 | 02:46:20 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 02:46:21 INFO - PROCESS | 1677 | RSS: Main: 354410496 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | __start_tp_report 02:46:21 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 02:46:21 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 02:46:21 INFO - PROCESS | 1677 | |i|pagename|runs| 02:46:21 INFO - PROCESS | 1677 | |0;ai-astar;113;113;112;111;113;111;112;112;112;113 02:46:21 INFO - PROCESS | 1677 | |1;audio-beat-detection;141;107;112;172;137;108;110;134;137;108 02:46:21 INFO - PROCESS | 1677 | |2;audio-dft;183;185;182;182;182;184;181;184;183;182 02:46:21 INFO - PROCESS | 1677 | |3;audio-fft;80;59;59;86;59;59;59;58;81;58 02:46:21 INFO - PROCESS | 1677 | |4;audio-oscillator;92;71;94;68;69;70;91;68;69;89 02:46:21 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;87;84;87;84;86;83;87;83;86;83 02:46:21 INFO - PROCESS | 1677 | |6;imaging-darkroom;91;98;143;93;91;93;93;95;92;94 02:46:21 INFO - PROCESS | 1677 | |7;imaging-desaturate;83;84;86;100;133;138;84;85;85;86 02:46:21 INFO - PROCESS | 1677 | |8;json-parse-financial;58;53;53;51;55;58;56;56;58;52 02:46:21 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;77;72;81;71;73;72;71;73;73;73 02:46:21 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;79;85;84;80;79;70;96;95;104;101 02:46:21 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;139;138;141;138;136;137;141;162;181;138 02:46:21 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;162;162;228;167;163;162;160;163;161;163 02:46:21 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;65;66;66;65;64;67;65;67;65;66 02:46:21 INFO - PROCESS | 1677 | __end_tp_report 02:46:21 INFO - PROCESS | 1677 | __start_cc_report 02:46:21 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1961 02:46:21 INFO - PROCESS | 1677 | __end_cc_report 02:46:21 INFO - PROCESS | 1677 | __startTimestamp1478429181171__endTimestamp 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | ------- Summary: start ------- 02:46:21 INFO - PROCESS | 1677 | Number of tests: 14 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 02:46:21 INFO - PROCESS | 1677 | Values: 113.0 113.0 112.0 111.0 113.0 111.0 112.0 112.0 112.0 113.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:135.50 stddev:21.36 (15.8%) stddev-sans-first:22.01 02:46:21 INFO - PROCESS | 1677 | Values: 141.0 107.0 112.0 172.0 137.0 108.0 110.0 134.0 137.0 108.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 02:46:21 INFO - PROCESS | 1677 | Values: 183.0 185.0 182.0 182.0 182.0 184.0 181.0 184.0 183.0 182.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:65.80 Median:59.00 stddev:11.52 (19.5%) stddev-sans-first:11.01 02:46:21 INFO - PROCESS | 1677 | Values: 80.0 59.0 59.0 86.0 59.0 59.0 59.0 58.0 81.0 58.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.00 stddev:11.63 (14.5%) stddev-sans-first:11.19 02:46:21 INFO - PROCESS | 1677 | Values: 92.0 71.0 94.0 68.0 69.0 70.0 91.0 68.0 69.0 89.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.76 (2.1%) stddev-sans-first:1.72 02:46:21 INFO - PROCESS | 1677 | Values: 87.0 84.0 87.0 84.0 86.0 83.0 87.0 83.0 86.0 83.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:93.00 stddev:15.84 (17.0%) stddev-sans-first:16.58 02:46:21 INFO - PROCESS | 1677 | Values: 91.0 98.0 143.0 93.0 91.0 93.0 93.0 95.0 92.0 94.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:84.50 stddev:21.20 (25.1%) stddev-sans-first:21.93 02:46:21 INFO - PROCESS | 1677 | Values: 83.0 84.0 86.0 100.0 133.0 138.0 84.0 85.0 85.0 86.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:2.62 (4.7%) stddev-sans-first:2.55 02:46:21 INFO - PROCESS | 1677 | Values: 58.0 53.0 53.0 51.0 55.0 58.0 56.0 56.0 58.0 52.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:73.00 stddev:3.10 (4.2%) stddev-sans-first:3.03 02:46:21 INFO - PROCESS | 1677 | Values: 77.0 72.0 81.0 71.0 73.0 72.0 71.0 73.0 73.0 73.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:82.00 stddev:11.10 (13.5%) stddev-sans-first:11.36 02:46:21 INFO - PROCESS | 1677 | Values: 79.0 85.0 84.0 80.0 79.0 70.0 96.0 95.0 104.0 101.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:140.00 stddev:14.70 (10.5%) stddev-sans-first:15.43 02:46:21 INFO - PROCESS | 1677 | Values: 139.0 138.0 141.0 138.0 136.0 137.0 141.0 162.0 181.0 138.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:163.00 stddev:20.78 (12.7%) stddev-sans-first:21.88 02:46:21 INFO - PROCESS | 1677 | Values: 162.0 162.0 228.0 167.0 163.0 162.0 160.0 163.0 161.0 163.0 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 02:46:21 INFO - PROCESS | 1677 | Values: 65.0 66.0 66.0 65.0 64.0 67.0 65.0 67.0 65.0 66.0 02:46:21 INFO - PROCESS | 1677 | -------- Summary: end -------- 02:46:21 INFO - PROCESS | 1677 | 02:46:21 INFO - TEST-INFO | 1677: exit 0 02:46:22 INFO - TEST-OK | kraken | took 58587ms 02:46:22 INFO - SUITE-END | took 1175s 02:46:22 INFO - Completed test suite (00:19:35) 02:46:22 INFO - javascript benchmark 02:46:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.018394481656, 3287.1453422110253, 3314.27086041071, 3337.0989832745145, 3365.377405180042, 5610.186522954169, 5616.859578510539, 5657.12314591238, 5670.234518340028, 5697.230873832032, 5579.776808927638, 5665.951798917204, 5683.488486036256, 5685.431456854323, 5733.627314224573, 5098.490150984909, 5136.229565565158, 5143.53708166265, 5164.096283150452, 5183.429822719498, 4769.236922092466, 4896.338994235768, 5140.100482415581, 5152.871178220537, 5267.209918512215, 5181.35233095863, 5187.19598462239, 5204.0, 5209.348831396075, 5263.763130659129, 5213.165893457067, 5216.504432078966, 5222.8694282642855, 5285.6300058995885, 5305.230741542455, 5144.408393034774, 5183.222516622499, 5206.167013277857, 5228.55557277628, 5260.316158899319, 4564.406627138484, 5542.584306177013, 5608.579356548275, 5680.176374425727, 5684.317881854204, 6141.792871882774, 6187.07193920911, 6208.50331973441, 6217.502599792006, 6236.96881515594, 6297.086922396273, 6301.054841773771, 6308.747650093991, 6311.463525600329, 6324.051392291147, 5634.774609015634, 5679.716014199274, 5749.482546570745, 5806.709664516799, 5812.157237200582, 6282.654454004982, 6302.621842689453, 6310.0, 6312.936870631235, 6319.46284565817, 6141.6007959482495, 6144.784932527429, 6170.691465426711, 6171.0, 6171.938280617226, 6126.264848218153, 6145.20112385396, 6158.507319414436, 6168.25980882297, 6289.276733175652, 6160.630362178284, 6173.166622505994, 6242.500599951993, 6244.594101383395, 6267.4045965633195, 5147.40804807452, 5210.296609957683, 6220.782272620437, 6268.49852011838, 6270.717817698214, 4843.07981483517, 4879.682820616648, 4945.9258111128365, 4965.255211718199, 4980.551750342486, 3750.3811871041516, 4398.274284743045, 4428.623566996777, 4438.334249862546, 4458.576435238647, 5782.537397008229, 5783.0, 5788.334341550775, 5795.623284486579, 5808.88382232353, 6298.0, 6306.558540902093, 6308.716107775161, 6326.177596912372, 6336.398042185985, 5618.494335509824, 5694.686792226467, 5701.800436984769, 5726.914096288559, 5746.4253574643035, 5351.063563876306, 5375.978564072813, 5378.11261141915, 5380.757865896044, 5384.219288203189, 6296.181496405438, 6308.02225655015, 6312.179416675803, 6317.399847014618, 6333.145025421509, 6111.135969295249, 6169.784057557964, 6247.094171345038, 6306.369363063657, 6313.43179113882, 6191.0, 6231.158793562992, 6252.687365631791, 6291.056341548804, 6309.589876658002, 6154.876902462015, 6160.476359509313, 6163.044728067157, 6170.9074363885475, 6179.474744646755, 6108.554560543837, 6204.224471941007, 6245.125682404558, 6264.091706702411, 6267.46726528232, 6036.788712395045, 6047.304559975659, 6047.606905551125, 6062.242219722535, 6138.51101655979, 6086.756529738938, 6088.238970128734, 6098.237720284965, 6109.480694141048, 6138.109974053648, 4740.336352910665, 5938.406159384027, 5953.702314884152, 5960.821175364746, 5963.91054134197, 5884.08796636522, 6013.9699301503215, 6052.546059045677, 6067.908981365372, 6121.3572574879, 5915.467607915309, 5966.940330596639, 5970.97014514942, 5972.34304226526, 5998.070299103646], "value": 5661.644665327537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.7099370905766, 499.92751051097616, 513.0918274653861, 516.4886762105516, 519.4286285086405, 29655.25861853452, 32686.0, 32741.83629081854, 32781.0, 32994.17514562137, 41331.96670083242, 41923.0, 42278.36582451266, 44350.55649443505, 44621.7768911155, 9920.25598080145, 10065.64770233042, 10083.042110999444, 10086.193104551618, 10089.991000899925, 8753.431026983226, 9856.655017074403, 9901.950490247538, 10028.548715307828, 10030.9498452508, 10043.447610381463, 10068.446235457048, 10077.09306162449, 10081.042300981395, 10083.848742268872, 9953.0, 10017.449040302781, 10031.247656425798, 10045.949770251102, 10071.597136114546, 9898.802023959552, 9960.053794889474, 9964.451955142464, 9973.2520060995, 9986.350887192382, 41416.378754318706, 41741.58258417407, 41817.0, 41821.37267940983, 41890.58109418897, 3370.2922386298906, 3397.0827876473213, 3461.2558299965376, 3515.630858759819, 4012.0772222388723, 30168.396632067455, 30533.694663053306, 30634.23414414635, 31200.687993120006, 32048.679513205036, 2434.4522482441484, 3104.28601421672, 3115.3457773867517, 3125.0, 3137.1843320736543, 525915.0, 532079.0, 532700.0, 533286.0, 533409.0, 62354.37645623576, 63001.0, 63049.68475157687, 63098.684506578094, 63099.0, 33980.49029264563, 34325.0, 34539.654603453644, 36461.27077458489, 66168.33831661718, 17234.741478877826, 17413.825861741472, 17425.65148697019, 17426.954382737076, 17445.0, 13343.866561334262, 13444.260565668787, 13446.46214151423, 13455.32723363828, 13459.865401346056, 18983.33558325452, 19152.04239788005, 19196.136173872208, 19202.695676518906, 19215.423537293904, 7870.606469676493, 8011.599420028975, 8057.348243610046, 8075.475094118863, 8120.715774947848, 842.4945032980286, 979.2264111352094, 1024.5952848624752, 1039.184240371305, 1098.5605757696985, 29487.967921122658, 29743.851280743456, 30174.24564385864, 30220.395592088036, 30502.847485762428, 888.2050564744518, 932.7668082979255, 999.0758548342899, 1098.4343063322394, 1144.0047158971747, 11496.54013839437, 13228.603141905758, 14679.899007574475, 15244.923775381274, 15359.232038398035, 673972.0, 681426.0, 688421.0, 688493.0, 691839.0, 57810.55473613193, 58333.12500312499, 58404.12393814096, 58427.831443370895, 58448.707756461794, 1197.1978774221293, 1225.2893321873291, 1299.571141523314, 1339.1964821107258, 1357.633438971472, 29268.41463170682, 30921.226969325948, 30926.0722178335, 31403.371932561677, 31642.683573163973, 49963.0, 50465.0, 50592.74703626458, 50614.0, 50636.74681626568, 566686.0, 568284.0, 570441.0, 570582.0, 570740.0, 25821.741782581932, 26906.32734181661, 26929.0, 26965.0, 26983.86508067447, 47230.76384618055, 47519.28721069256, 47577.52422475731, 47870.76064619794, 48213.758931206525, 38096.42855357117, 38691.41962870503, 39099.02252443712, 39623.40564891471, 40321.59678403296, 33517.66482335146, 38329.23341533209, 38544.0, 39292.0, 40242.59757402506, 35605.465918010734, 37123.44314835226, 38195.0, 38709.0, 38872.0, 31788.84105579457, 33453.49819752657, 33666.0, 34270.14324641804, 35040.64959350374, 21557.568848623254, 25594.872025639754, 25639.743602563736, 25873.870630647478, 25977.610335845355], "value": 19855.616086605445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.7099569910733, 367.10792773560246, 373.0952440332192, 378.72542406755105, 398.59542564297243, 14992.250387480637, 15130.697386052272, 16106.35574577017, 20570.0, 21018.0, 19951.201951921907, 20412.387628371136, 20718.171273149095, 20968.0, 21300.4674883128, 5478.726063696819, 5982.940170598304, 6237.71930263137, 6243.87512249757, 6254.124422580842, 6001.789937352193, 6163.506919446456, 6225.8132256032395, 6231.750729970796, 6232.626042437446, 5884.2056322396575, 6113.663748493831, 6174.413430724074, 6191.566590338678, 6203.193584833965, 6075.483583895352, 6108.786192483241, 6133.2026836511195, 6136.938630613681, 6142.447179753821, 4539.341795439643, 5063.746812659389, 5228.37259528859, 5271.630985830955, 5283.841484755463, 22986.310410687707, 24367.512649747085, 25296.98812047516, 25541.61687574688, 25584.744152558607, 2062.463759422546, 2092.299079808266, 2162.4593851537115, 2429.125514814665, 3090.0729781065816, 9949.0, 10284.74288142795, 10301.690949271533, 10751.946240268826, 13405.396757145854, 1889.1215584753156, 1902.3341830359402, 1903.8572107092023, 1925.9614807703908, 1930.4112245765036, 105272.0, 108924.4553777234, 111042.88957110407, 113019.43490282579, 114962.99999999917, 9444.291678124167, 10007.949960250153, 10008.749781255527, 10112.747181320527, 10140.239482038876, 12398.946089582307, 12503.812442813365, 12517.624471265877, 12518.81221781674, 12541.623751287476, 7149.92850071503, 8079.636416361278, 8110.675572977133, 8239.176082391832, 8378.49729016261, 8789.0, 8797.340199485065, 8815.030346661862, 8950.641974321084, 8963.014068452465, 3778.282126395976, 3886.145048089416, 3886.145048089416, 3924.05822602579, 3928.508936382952, 1861.4229588827236, 1911.7801452833103, 1918.2518817661123, 1919.9136038878005, 1924.6150769846088, 825.4510750351069, 827.5696637748338, 835.7242110103651, 876.4303202918154, 947.5735918836551, 19758.620001198098, 21258.36224913255, 21325.89337053336, 21386.358409247747, 21638.242661507087, 790.727199116304, 868.3574155125289, 912.3203213605906, 913.488446469979, 916.4547094478775, 10429.828068772551, 10748.462576871125, 10786.298890572089, 11086.445677716081, 12036.879631203576, 606507.0, 615682.9215853892, 616635.0, 620402.0, 623513.0, 141234.0, 144245.0, 150028.24985875218, 151015.0, 151290.0, 954.1126752120595, 994.105305225303, 1025.958961641541, 1029.8506716526063, 1031.2471895516314, 18899.338523151622, 19015.809841901402, 19738.703919440934, 19764.703529446782, 19823.107960142115, 52130.21804672857, 55078.173827391816, 55350.72324638351, 58161.4183858156, 59426.70286648539, 67336.98994515184, 71909.0, 77560.61219693866, 77849.05377365384, 78874.81687774573, 8004.639791209526, 8097.838043238984, 8156.469829461066, 8262.710805121791, 8271.17288271168, 12290.569830055905, 12510.124291299522, 12803.679908002001, 12896.419661115086, 13154.934225328812, 8889.777755555904, 10938.835917461085, 10969.23215374916, 11111.888881111085, 11588.88411115878, 9034.683786067719, 11164.330140191614, 11164.810326111021, 11194.552217911192, 11386.886131138583, 10848.969347911936, 10934.289271197347, 11253.71865703364, 11309.604163854226, 11510.02164816, 6734.259231484435, 6929.757458488929, 7390.815229619087, 7910.406719495946, 8190.959045204736, 9967.900320996698, 10972.122230221403, 11133.109351252042, 11407.0, 11432.314061156358], "value": 9426.975938542824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.686875149964, 1331.5738963531674, 1497.4908531099425, 1634.35443000015, 1867.8505719542447, 7850.0, 8412.45319054261, 8636.56817159141, 8876.556172191396, 8893.0, 8786.648534058646, 8839.337049721264, 8849.380543361967, 8850.955745221281, 8858.247049000842, 2355.1168311883043, 2408.4460574067975, 2412.1436889904094, 2413.78275955164, 2414.311921102486, 2370.9051637934463, 2398.772116648924, 2410.8312418130736, 2412.2401443545227, 2415.1909110448023, 2091.6090799618237, 2375.323032935614, 2397.61638137898, 2401.651760494727, 2406.639004149383, 2309.31875096846, 2353.5881220786464, 2385.7375688674233, 2388.6178211486254, 2388.820838437124, 2338.1115176233093, 2371.098982386682, 2381.2499062795337, 2384.0, 2387.283814855554, 8894.066123057051, 8900.955495222483, 8995.415298005673, 9006.099390060941, 9017.729468115967, 4650.697704649187, 5206.661566998133, 5383.865403364908, 5417.729113544307, 5478.972605136949, 3434.0899661589697, 3561.893143205682, 3618.421052631593, 3637.1452708613456, 3670.7981061041633, 1021.2136654775856, 1036.6786296248113, 1051.789642071581, 1074.3392813419769, 1075.1936047964027, 11692.70768230801, 11845.526178952832, 11855.82216266748, 11976.161668683195, 12033.097517686121, 4447.688661793643, 4591.678582499259, 4674.462436819809, 4680.625549955996, 4683.742394168354, 9329.673461428818, 9353.719388418358, 9360.11078947499, 9362.0, 9366.531673416303, 5282.709450980233, 5286.841394758163, 5289.761960711778, 5293.073712100367, 5298.443663415286, 3719.795411252407, 4342.848000319974, 4414.404055452537, 4540.182767101887, 4935.333729946483, 3747.8500859965297, 3748.4002559590335, 3811.6760075393904, 3816.37029890065, 3825.9426108608395, 1096.1121491591837, 1114.593173491686, 1117.407773879845, 1126.79717650822, 1128.351198061118, 783.6747749683817, 878.2666473494703, 906.4228242857381, 916.757059379265, 928.7492377058156, 5986.670733109634, 5995.340512543617, 6015.0, 6128.571000030044, 6338.809835704937, 888.3515034025069, 899.4558292233236, 923.9861402078974, 937.1097457415483, 965.9661911833052, 3843.36584463566, 4042.272390969595, 4084.6936479764136, 4099.569545197771, 4124.505059392892, 10570.365778053188, 10865.293755905841, 10897.019268265736, 10957.342559446459, 10960.342379457257, 8534.445261058012, 10739.194560408001, 10746.355218686904, 10879.619213327496, 10963.945180274048, 8164.469309494863, 8350.4154709171, 8355.289800366916, 8395.244428001388, 8398.0, 5158.793648254028, 5990.9700451497465, 6001.819945401645, 6053.515718742578, 6221.06683997404, 9865.654702085392, 10036.899631003596, 10138.949305253427, 10180.032896874785, 10309.020643038899, 9409.85885211736, 10021.74945626336, 10089.848652270368, 10322.638707645196, 10413.791724165323, 7069.646517674199, 7286.854262914818, 7320.1215854097845, 7337.816554586178, 7388.113426388868, 8220.917790822015, 8302.0, 8305.0, 8389.664413423394, 8403.95798021006, 7491.211122287503, 7535.284148005931, 7544.283293087148, 7607.543547387175, 7629.427792915664, 7434.628268586657, 7482.214367491335, 7488.400927925862, 7517.962410187914, 7527.623618819147, 6846.5892046477375, 7012.263712310338, 7096.432285417258, 7105.25394833535, 7113.466490013373, 4888.535589119028, 4948.8762780930765, 5028.1200789860895, 5106.183010718267, 5235.4502777207845, 4807.6394270429155, 4973.875653108556, 5147.948520514747, 5202.583793296451, 5296.761645726028], "value": 4563.017771031075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.55517833606274, 300.6827796674508, 308.49098986671993, 311.8316109300978, 316.36252950305123, 4801.639877009229, 5146.202338637512, 5370.973145134274, 5378.596605254602, 5411.509576323269, 4062.3297155969303, 4407.449068866392, 5071.847844564669, 5128.666636668614, 5241.39723931748, 3519.849734487632, 3536.8938931832085, 3810.485584446092, 4067.4508941292843, 4084.305668036426, 3688.4877200347864, 3723.808381317979, 4019.2765302245584, 4020.1909140886573, 4083.774867539741, 3896.0, 4012.7929638698747, 4030.0580576179404, 4030.415589739486, 4052.1490486997764, 4030.6573941215033, 4067.6949228807957, 4085.651734927482, 4101.0772576170275, 4111.650509706678, 3156.5580818685403, 3323.8532706216315, 3485.8431370588382, 3505.6669616386403, 3538.628444013393, 4268.55180206077, 5121.84634460963, 5165.199394093884, 5190.32525771651, 5208.166693329087, 4093.0, 4339.5443478434945, 4395.560443955611, 4630.7453090080035, 4678.619807156897, 4534.750588717619, 4993.779012536894, 5547.944520554824, 5585.441455854423, 5621.831345059655, 3926.823292951824, 3931.506027709481, 3934.0, 3963.4451176835264, 3968.5634580196156, 4011.578784227643, 5058.713644241776, 5756.395578464285, 5781.0977590126495, 5800.738966746507, 3641.4901913732097, 3798.2023775007005, 3831.099691572478, 3846.1922996171115, 3858.2476417098956, 2958.3787404644836, 3886.378179491268, 3907.8241479133508, 3915.7454765440157, 3930.6069393060466, 3399.6600339965808, 4381.452318460192, 4498.212812757754, 4584.770761461914, 4596.310553416947, 4812.51874812523, 4823.853385243603, 5503.036968530491, 5504.4495550444635, 5658.179563963202, 1169.4328250798355, 1359.9728005439836, 1376.167418711685, 1386.597886612871, 1393.108410617206, 776.9961150194213, 878.6441491196076, 910.6402970826487, 913.4154141349542, 946.8674385586023, 4480.692443391656, 5267.947320526822, 5268.341457317835, 5281.551068159172, 5292.285541451854, 5751.6549007058875, 5784.623999440107, 5790.218320526675, 5817.738201780845, 5851.156885581028, 4569.474510431276, 5024.773885175103, 5258.2638430619745, 5373.731313434313, 5429.348478182644, 3015.54766784984, 3051.7711171662213, 3052.603161588979, 3060.127863558875, 3060.9234769130503, 5802.854928626818, 5969.403059694083, 6047.516198704181, 6063.636181829104, 6091.208142941389, 4875.390576177978, 5089.465606111379, 5839.737211825478, 5890.764369425175, 5962.791302304398, 5975.7609695612555, 6013.789517366871, 6030.698465076729, 6039.275286965504, 6055.273367195965, 4925.310456536016, 5579.74891129892, 5678.4605462480995, 5695.715214239189, 5798.33319168301, 4950.603951683928, 4966.205407134986, 5538.9169162461785, 5582.4138465462165, 5656.321241451053, 5331.680099194061, 5533.114701647878, 6001.36985616504, 6003.279606447254, 6006.0, 3262.4943133814295, 3835.4055121456217, 3874.748141370802, 3890.9221815564097, 3914.8646892400884, 4919.631027672867, 4950.529699678525, 5335.906139241524, 5649.378568357395, 5949.137375080676, 5548.223248745098, 5685.687287199078, 5751.48236658686, 5757.481826635623, 5791.276090488689, 5615.775368985195, 5621.269234999424, 5644.262532671733, 5647.407022262603, 5677.914831277617, 4873.488283730299, 5314.282571852905, 5333.200019996876, 5525.9447405527035, 5572.637778544382, 5072.239164125263, 5508.531774799187, 5574.0, 5598.5848632335055, 5640.377224590585, 5471.945280547303, 5477.643953143033, 5504.311961004874, 5509.311336082989, 5535.612507124462], "value": 4079.1814444540705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.290686406729, 704.3801454719846, 730.1311439387129, 771.7028943856614, 781.1251398433755, 15775.0, 16788.748168777478, 16794.244259008326, 16804.243809028594, 16824.07467589282, 14967.251637418112, 14985.400583976656, 15050.021748586334, 15117.395304187847, 15140.84859151408, 674.1606699658931, 691.9481038922075, 698.8218004408868, 699.087690563814, 819.2585709932521, 694.3507820188115, 698.2005603583893, 816.8978877640295, 863.9913600864005, 867.7526904832124, 905.8324210021134, 909.7316291693966, 916.5096673279796, 919.797644518205, 922.0456827183866, 908.582052255963, 911.9817603647923, 912.1562554637001, 913.5523593439233, 915.6795121707415, 522.8797376603364, 543.0252696409954, 543.1689515041992, 685.324954919404, 685.7325642999234, 12664.55674051413, 12691.365431728376, 12694.61916142508, 14687.04534205284, 15243.314050867626, 14605.269736513132, 15097.094174349575, 15131.243437828065, 15157.242137893061, 15259.542213733606, 10125.89874101257, 11604.709882252926, 12006.69983250417, 12040.81938770919, 12462.0, 3843.6348546888003, 3867.845286188549, 3888.591697871739, 3893.396523538856, 3923.0580862473257, 92406.5379673104, 95485.52257238739, 95789.0, 119781.0, 125005.0, 10963.83554246687, 11198.160137989684, 11213.887861121448, 11522.711932201595, 11822.881771182178, 22279.665805012937, 22294.442638934157, 22442.775572244394, 22468.662970055462, 22679.0, 6790.5925644461495, 8115.79710507242, 8134.83730325402, 8188.017437907489, 8227.54748488827, 4327.5239723630375, 4368.213721530155, 4440.178566965122, 4646.442426908792, 4695.765211739399, 3640.381135207021, 3781.565120011234, 3784.7729136251914, 3786.9431958520645, 3788.412796016622, 674.7570874485182, 678.8913773796268, 685.5612408058846, 692.3526502719873, 700.1423256510734, 587.3333766175422, 613.5306490534655, 672.5628341578014, 672.7914346552584, 674.571647004146, 7727.343175830005, 9330.673426430043, 9743.512824358895, 9851.408915465096, 9972.301938864355, 580.8315588479378, 655.3741177175785, 673.9831504212434, 674.6188403551978, 687.5599616245606, 4715.504871988461, 4823.782929768169, 4824.179889418807, 4824.758762061953, 4830.830920917751, 145759.0, 149196.50803492044, 151782.0, 152749.23625381803, 156225.21887390717, 105907.0, 108371.0, 119156.0, 123576.0, 124608.37695811463, 112812.43593782143, 112824.43587782008, 113886.0, 116449.0, 116563.0, 7770.417218708506, 9069.093090690878, 9112.31657625694, 9216.815663686823, 9345.701868150396, 54218.0, 65106.0, 66208.0, 66484.66757666375, 67883.66058169876, 83529.58235209028, 88875.55562222148, 95334.56998144895, 98069.0, 99013.01942762162, 11718.88281117178, 11847.466863990969, 11949.283043017447, 12142.332171730286, 12158.939205303917, 13382.9330853349, 13448.1258718183, 13515.459381625018, 13528.255945922676, 13562.254076025913, 11881.643550693492, 12153.939230303791, 12307.630771076882, 12327.50689972391, 12346.567870124503, 12124.696882577653, 12302.446389912655, 12308.138430309793, 12668.936655317033, 12677.112602117762, 10941.507632156732, 12880.742385152433, 13117.803232951705, 13980.300984950914, 14557.708845822812, 11319.207655464039, 11328.921588228395, 11711.238769479956, 12001.099917506048, 12045.457954392248, 9957.203423726229, 11511.30932144074, 11737.3637413223, 11752.58865939688, 11905.821412678644], "value": 7747.004637341205, "unit": "score"}], "name": "dromaeo_css", "value": 7311.961409730035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 111.0, 113.0, 111.0, 112.0, 112.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 112.0, 172.0, 137.0, 108.0, 110.0, 134.0, 137.0, 108.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 182.0, 182.0, 184.0, 181.0, 184.0, 183.0, 182.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 86.0, 59.0, 59.0, 59.0, 58.0, 81.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 71.0, 94.0, 68.0, 69.0, 70.0, 91.0, 68.0, 69.0, 89.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 83.0, 87.0, 83.0, 86.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 98.0, 143.0, 93.0, 91.0, 93.0, 93.0, 95.0, 92.0, 94.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 100.0, 133.0, 138.0, 84.0, 85.0, 85.0, 86.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 53.0, 51.0, 55.0, 58.0, 56.0, 56.0, 58.0, 52.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 81.0, 71.0, 73.0, 72.0, 71.0, 73.0, 73.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 84.0, 80.0, 79.0, 70.0, 96.0, 95.0, 104.0, 101.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 141.0, 138.0, 136.0, 137.0, 141.0, 162.0, 181.0, 138.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 228.0, 167.0, 163.0, 162.0, 160.0, 163.0, 161.0, 163.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 64.0, 67.0, 65.0, 67.0, 65.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1440.8999999999996, "alertThreshold": 2.0}]} 02:46:22 INFO - Return code: 0 02:46:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:46:22 INFO - # TBPL SUCCESS # 02:46:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:46:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:46:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:46:22 INFO - 2016-11-06 02:46:22.507 screenresolution[1681:12296] starting screenresolution argv=screenresolution get 02:46:22 INFO - 2016-11-06 02:46:22.510 screenresolution[1681:12296] Display 0: 1600x1200x32@60 02:46:22 INFO - 2016-11-06 02:46:22.516 screenresolution[1682:12299] starting screenresolution argv=screenresolution list 02:46:22 INFO - Available Modes on Display 0 02:46:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:46:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:46:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:46:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:46:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:46:22 INFO - Intel Iris: 02:46:22 INFO - Chipset Model: Intel Iris 02:46:22 INFO - Type: GPU 02:46:22 INFO - Bus: Built-In 02:46:22 INFO - VRAM (Dynamic, Max): 1536 MB 02:46:22 INFO - Vendor: Intel (0x8086) 02:46:22 INFO - Device ID: 0x0a2e 02:46:22 INFO - Revision ID: 0x0009 02:46:22 INFO - Displays: 02:46:22 INFO - Display: 02:46:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:46:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:46:22 INFO - Display Serial Number: 1600x1200 60 02:46:22 INFO - Main Display: Yes 02:46:22 INFO - Mirror: Off 02:46:22 INFO - Online: Yes 02:46:22 INFO - Rotation: Supported 02:46:22 INFO - Return code: 0 02:46:22 INFO - Running post-action listener: _resource_record_post_action 02:46:22 INFO - [mozharness: 2016-11-06 10:46:22.751609Z] Finished run-tests step (success) 02:46:22 INFO - Running post-run listener: _resource_record_post_run 02:46:22 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32164864; Write bytes: 665978880; Read time: 203; Write time: 1890 02:46:22 INFO - TinderboxPrint: CPU usage
53.3% 02:46:22 INFO - TinderboxPrint: I/O read bytes / time
32,164,864 / 203 02:46:22 INFO - TinderboxPrint: I/O write bytes / time
665,978,880 / 1,890 02:46:22 INFO - TinderboxPrint: CPU idle
2,258.8 (46.7%) 02:46:22 INFO - TinderboxPrint: CPU system
968.5 (20.0%) 02:46:22 INFO - TinderboxPrint: CPU user
1,610.3 (33.3%) 02:46:22 INFO - TinderboxPrint: Swap in / out
391,729,152 / 0 02:46:22 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355506688; Write bytes: 355448320; Read time: 27267; Write time: 736 02:46:22 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31243264; Write bytes: 300376576; Read time: 193; Write time: 1122 02:46:23 INFO - Running post-run listener: _upload_blobber_files 02:46:23 INFO - Blob upload gear active. 02:46:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:46:23 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 02:46:23 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'] 02:46:23 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 02:46:23 INFO - (blobuploader) - INFO - Open directory for files ... 02:46:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:46:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:24 INFO - (blobuploader) - INFO - Done attempting. 02:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:25 INFO - (blobuploader) - INFO - Done attempting. 02:46:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:46:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:27 INFO - (blobuploader) - INFO - Done attempting. 02:46:27 INFO - (blobuploader) - INFO - Iteration through files over. 02:46:27 INFO - Return code: 0 02:46:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:46:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:46:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaa0ecb963501a56bdea764a3850972b6c9ebf4e347665befa94ca4ac90598221ad681ac2a92e6aef641cda0539bd6d685b2c4699b9703500625678aaf3ac704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b3c053dcb2790c949f91ffb0e62fff50b250044e81559f2881ff50cd287a653ce3e45ee077132d9df82584e59cf780ef699bc1a2ae03111e166f39e192c818c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee720225677b9e93d940e82c29a153a110327362fc5770e516c6d2182cd8564ecc33f87a31ac764c73bbbbbc9026b9a41eb547c6a02080dcd71a5d15d8bfb5a6"} 02:46:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:46:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:46:27 INFO - Contents: 02:46:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaa0ecb963501a56bdea764a3850972b6c9ebf4e347665befa94ca4ac90598221ad681ac2a92e6aef641cda0539bd6d685b2c4699b9703500625678aaf3ac704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b3c053dcb2790c949f91ffb0e62fff50b250044e81559f2881ff50cd287a653ce3e45ee077132d9df82584e59cf780ef699bc1a2ae03111e166f39e192c818c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee720225677b9e93d940e82c29a153a110327362fc5770e516c6d2182cd8564ecc33f87a31ac764c73bbbbbc9026b9a41eb547c6a02080dcd71a5d15d8bfb5a6"} 02:46:27 INFO - Running post-run listener: copy_logs_to_upload_dir 02:46:27 INFO - Copying logs to upload dir... 02:46:27 INFO - mkdir: /builds/slave/test/build/upload/logs 02:46:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.035084 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-06 02:46:27.533489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-06 02:46:27.537377) ========= 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.ztXiBwiMC5/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.1Nb2mYUVMJ/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/eaa0ecb963501a56bdea764a3850972b6c9ebf4e347665befa94ca4ac90598221ad681ac2a92e6aef641cda0539bd6d685b2c4699b9703500625678aaf3ac704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b3c053dcb2790c949f91ffb0e62fff50b250044e81559f2881ff50cd287a653ce3e45ee077132d9df82584e59cf780ef699bc1a2ae03111e166f39e192c818c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee720225677b9e93d940e82c29a153a110327362fc5770e516c6d2182cd8564ecc33f87a31ac764c73bbbbbc9026b9a41eb547c6a02080dcd71a5d15d8bfb5a6"} build_url:https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010987 build_url: 'https://queue.taskcluster.net/v1/task/RGLv_IcZSR6raPfZDIEvpw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaa0ecb963501a56bdea764a3850972b6c9ebf4e347665befa94ca4ac90598221ad681ac2a92e6aef641cda0539bd6d685b2c4699b9703500625678aaf3ac704", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b3c053dcb2790c949f91ffb0e62fff50b250044e81559f2881ff50cd287a653ce3e45ee077132d9df82584e59cf780ef699bc1a2ae03111e166f39e192c818c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee720225677b9e93d940e82c29a153a110327362fc5770e516c6d2182cd8564ecc33f87a31ac764c73bbbbbc9026b9a41eb547c6a02080dcd71a5d15d8bfb5a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-06 02:46:27.571122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:46:27.571465) ========= 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.ztXiBwiMC5/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.1Nb2mYUVMJ/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.005023 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-06 02:46:27.619728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-06 02:46:27.620057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-06 02:46:27.620389) ========= ========= Total master_lag: 0.18 =========