builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0082 starttime: 1479151400.35 results: success (0) buildid: 20161114081643 builduid: da4be81bc0254b29b4f65eae2dfacea3 revision: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.354250) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.354717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.354998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.382149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.382564) ========= 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.SOxvdpDOte/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.8WQxCZjJkA/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-14 11:23:20-- 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% 9.69M=0.001s 2016-11-14 11:23:20 (9.69 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095107 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.503384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.503781) ========= 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.SOxvdpDOte/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.8WQxCZjJkA/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.026338 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:20.551983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-14 11:23:20.554426) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ed88686e49e3b941dd9b01f2f5c038f53187a05 --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-beta --rev 4ed88686e49e3b941dd9b01f2f5c038f53187a05 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SOxvdpDOte/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.8WQxCZjJkA/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-14 11:23:20,637 truncating revision to first 12 chars 2016-11-14 11:23:20,637 Setting DEBUG logging. 2016-11-14 11:23:20,637 attempt 1/10 2016-11-14 11:23:20,637 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ed88686e49e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:23:22,415 unpacking tar archive at: mozilla-beta-4ed88686e49e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.070321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-14 11:23:22.646798) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:22.647121) ========= script_repo_revision: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:22.647516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:22.647783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:23:22.670068) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-14 11:23:22.670361) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SOxvdpDOte/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.8WQxCZjJkA/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:23:22 INFO - MultiFileLogger online at 20161114 11:23:22 in /builds/slave/test 11:23:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:23:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:22 INFO - {'append_to_log': False, 11:23:22 INFO - 'base_work_dir': '/builds/slave/test', 11:23:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:23:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:22 INFO - 'branch': 'Mozilla-Beta', 11:23:22 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:22 INFO - 'config_files': ('talos/mac_config.py',), 11:23:22 INFO - 'default_actions': ('clobber', 11:23:22 INFO - 'read-buildbot-config', 11:23:22 INFO - 'download-and-extract', 11:23:22 INFO - 'populate-webroot', 11:23:22 INFO - 'create-virtualenv', 11:23:22 INFO - 'install', 11:23:22 INFO - 'run-tests'), 11:23:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:22 INFO - 'download_minidump_stackwalk': True, 11:23:22 INFO - 'download_symbols': 'ondemand', 11:23:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:22 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:22 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:22 INFO - 'installer_path': 'installer.exe', 11:23:22 INFO - 'log_level': 'info', 11:23:22 INFO - 'log_name': 'talos', 11:23:22 INFO - 'log_to_console': True, 11:23:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:23:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:23:22 INFO - 'opt_config_files': (), 11:23:22 INFO - 'pip_index': False, 11:23:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:22 INFO - 'cmd': ('bash', 11:23:22 INFO - '-c', 11:23:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:22 INFO - 'enabled': True, 11:23:22 INFO - 'halt_on_failure': False, 11:23:22 INFO - 'name': 'check_screen_resolution'},), 11:23:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:22 INFO - 'cmd': ('bash', 11:23:22 INFO - '-c', 11:23:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:22 INFO - 'enabled': True, 11:23:22 INFO - 'halt_on_failure': False, 11:23:22 INFO - 'name': 'check_screen_resolution'},), 11:23:22 INFO - 'run_cmd_checks_enabled': True, 11:23:22 INFO - 'sps_profile': False, 11:23:22 INFO - 'sps_profile_interval': 0, 11:23:22 INFO - 'suite': 'dromaeojs', 11:23:22 INFO - 'system_bits': '32', 11:23:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:22 INFO - 'title': 't-yosemite-r7-0082', 11:23:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:22 INFO - 'use_talos_json': True, 11:23:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:22 INFO - 'work_dir': 'build'} 11:23:22 INFO - [mozharness: 2016-11-14 19:23:22.876430Z] Running clobber step. 11:23:22 INFO - Running pre-action listener: _resource_record_pre_action 11:23:22 INFO - Running main action method: clobber 11:23:22 INFO - rmtree: /builds/slave/test/build 11:23:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:25 INFO - Running post-action listener: _resource_record_post_action 11:23:25 INFO - [mozharness: 2016-11-14 19:23:25.222141Z] Finished clobber step (success) 11:23:25 INFO - [mozharness: 2016-11-14 19:23:25.222268Z] Running read-buildbot-config step. 11:23:25 INFO - Running pre-action listener: _resource_record_pre_action 11:23:25 INFO - Running main action method: read_buildbot_config 11:23:25 INFO - Using buildbot properties: 11:23:25 INFO - { 11:23:25 INFO - "project": "", 11:23:25 INFO - "product": "firefox", 11:23:25 INFO - "script_repo_revision": "production", 11:23:25 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:23:25 INFO - "repository": "", 11:23:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:23:25 INFO - "buildid": "20161114081643", 11:23:25 INFO - "pgo_build": "False", 11:23:25 INFO - "basedir": "/builds/slave/test", 11:23:25 INFO - "buildnumber": 10, 11:23:25 INFO - "slavename": "t-yosemite-r7-0082", 11:23:25 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:23:25 INFO - "platform": "yosemite_r7", 11:23:25 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:23:25 INFO - "branch": "mozilla-beta", 11:23:25 INFO - "repo_path": "releases/mozilla-beta", 11:23:25 INFO - "revision": "4ed88686e49e3b941dd9b01f2f5c038f53187a05", 11:23:25 INFO - "stage_platform": "macosx64", 11:23:25 INFO - "builduid": "da4be81bc0254b29b4f65eae2dfacea3", 11:23:25 INFO - "slavebuilddir": "test" 11:23:25 INFO - } 11:23:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 11:23:25 INFO - Running post-action listener: _resource_record_post_action 11:23:25 INFO - [mozharness: 2016-11-14 19:23:25.225581Z] Finished read-buildbot-config step (success) 11:23:25 INFO - [mozharness: 2016-11-14 19:23:25.225731Z] Running download-and-extract step. 11:23:25 INFO - Running pre-action listener: _resource_record_pre_action 11:23:25 INFO - Running main action method: download_and_extract 11:23:25 INFO - mkdir: /builds/slave/test/build/tests 11:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:25 INFO - trying https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 11:23:25 INFO - Downloading https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 11:23:26 INFO - Downloaded 1165 bytes. 11:23:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 11:23:26 INFO - Using the following test package requirements: 11:23:26 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:23:26 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:26 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 11:23:26 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:26 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 11:23:26 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:23:26 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:26 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 11:23:26 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 11:23:26 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:26 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 11:23:26 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:26 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 11:23:26 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:26 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 11:23:26 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 11:23:26 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 11:23:26 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 11:23:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:23:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:23:26 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:23:27 INFO - Expected file size: 16231351 11:23:34 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:23:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 11:23:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 11:23:34 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 11:23:34 INFO - Expected file size: 16231351 11:23:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 11:23:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 11:23:41 INFO - Fetch https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 11:23:42 INFO - Expected file size: 14414089 11:23:42 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')]} 11:23:42 INFO - trying https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:23:42 INFO - Downloading https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 11:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 11:23:45 INFO - Downloaded 86008559 bytes. 11:23:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:23:45 INFO - mkdir: /builds/slave/test/properties 11:23:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:23:45 INFO - Writing to file /builds/slave/test/properties/build_url 11:23:45 INFO - Contents: 11:23:45 INFO - build_url:https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 11:23:45 INFO - Running post-action listener: _resource_record_post_action 11:23:45 INFO - Running post-action listener: set_extra_try_arguments 11:23:45 INFO - [mozharness: 2016-11-14 19:23:45.816524Z] Finished download-and-extract step (success) 11:23:45 INFO - [mozharness: 2016-11-14 19:23:45.816628Z] Running populate-webroot step. 11:23:45 INFO - Running pre-action listener: _resource_record_pre_action 11:23:45 INFO - Running main action method: populate_webroot 11:23:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:23:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:23:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:23:45 INFO - '--tppagecycles', 11:23:45 INFO - '7'], 11:23:45 INFO - 'tests': ['tsvgm']}}, 11:23:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:23:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:23:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:23:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:23:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['damp', 'tps']}, 11:23:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'tests': ['damp', 'tps']}, 11:23:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['dromaeo_dom']}, 11:23:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:23:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['basic_compositor_video']}, 11:23:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:23:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['a11yr', 11:23:45 INFO - 'ts_paint', 11:23:45 INFO - 'tpaint', 11:23:45 INFO - 'sessionrestore', 11:23:45 INFO - 'sessionrestore_no_auto_restore', 11:23:45 INFO - 'tabpaint']}, 11:23:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:23:45 INFO - 'ts_paint', 11:23:45 INFO - 'tpaint', 11:23:45 INFO - 'sessionrestore', 11:23:45 INFO - 'sessionrestore_no_auto_restore', 11:23:45 INFO - 'tabpaint']}, 11:23:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:23:45 INFO - 'ts_paint', 11:23:45 INFO - 'tpaint', 11:23:45 INFO - 'sessionrestore', 11:23:45 INFO - 'sessionrestore_no_auto_restore', 11:23:45 INFO - 'tabpaint']}, 11:23:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:23:45 INFO - 'ts_paint', 11:23:45 INFO - 'tpaint', 11:23:45 INFO - 'sessionrestore', 11:23:45 INFO - 'sessionrestore_no_auto_restore', 11:23:45 INFO - 'tabpaint']}, 11:23:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['a11yr', 11:23:45 INFO - 'ts_paint', 11:23:45 INFO - 'tpaint', 11:23:45 INFO - 'sessionrestore', 11:23:45 INFO - 'sessionrestore_no_auto_restore', 11:23:45 INFO - 'tabpaint']}, 11:23:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['a11yr', 11:23:45 INFO - 'ts_paint', 11:23:45 INFO - 'tpaint', 11:23:45 INFO - 'sessionrestore', 11:23:45 INFO - 'sessionrestore_no_auto_restore', 11:23:45 INFO - 'tabpaint']}, 11:23:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['tsvgx', 11:23:45 INFO - 'tsvgr_opacity', 11:23:45 INFO - 'tart', 11:23:45 INFO - 'tscrollx', 11:23:45 INFO - 'cart']}, 11:23:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:23:45 INFO - 'tsvgr_opacity', 11:23:45 INFO - 'tart', 11:23:45 INFO - 'tscrollx', 11:23:45 INFO - 'cart']}, 11:23:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'talos_options': ['--disable-e10s'], 11:23:45 INFO - 'tests': ['tp5o']}, 11:23:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'tests': ['tp5o']}, 11:23:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'talos_options': ['--disable-e10s', 11:23:45 INFO - '--xperf_path', 11:23:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:45 INFO - 'tests': ['tp5n']}, 11:23:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:45 INFO - 'talos_options': ['--xperf_path', 11:23:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:45 INFO - 'tests': ['tp5n']}}, 11:23:45 INFO - 'talos.zip': {'path': '', 11:23:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:23:45 INFO - Running post-action listener: _resource_record_post_action 11:23:45 INFO - [mozharness: 2016-11-14 19:23:45.835614Z] Finished populate-webroot step (success) 11:23:45 INFO - [mozharness: 2016-11-14 19:23:45.835751Z] Running create-virtualenv step. 11:23:45 INFO - Running pre-action listener: _resource_record_pre_action 11:23:45 INFO - Running main action method: create_virtualenv 11:23:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:23:45 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 11:23:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:23:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:23:45 INFO - Using real prefix '/tools/python27' 11:23:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:23:46 INFO - Installing distribute.............................................................................................................................................................................................done. 11:23:49 INFO - Installing pip.................done. 11:23:49 INFO - Return code: 0 11:23:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:23:49 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')]} 11:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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')]} 11:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:23:49 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 11:23:49 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 11:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:49 INFO - 'HOME': '/Users/cltbld', 11:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:49 INFO - 'LOGNAME': 'cltbld', 11:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:49 INFO - 'MOZ_NO_REMOTE': '1', 11:23:49 INFO - 'NO_EM_RESTART': '1', 11:23:49 INFO - 'PAGER': '/bin/cat', 11:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:49 INFO - 'PWD': '/builds/slave/test', 11:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:49 INFO - 'SHELL': '/bin/bash', 11:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:23:49 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:49 INFO - 'USER': 'cltbld', 11:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:49 INFO - 'XPC_FLAGS': '0x0', 11:23:49 INFO - 'XPC_SERVICE_NAME': '0', 11:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:49 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 11:23:49 INFO - Cleaning up... 11:23:49 INFO - Return code: 0 11:23:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:23:49 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')]} 11:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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')]} 11:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:23:49 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 11:23:49 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 11:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:49 INFO - 'HOME': '/Users/cltbld', 11:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:49 INFO - 'LOGNAME': 'cltbld', 11:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:49 INFO - 'MOZ_NO_REMOTE': '1', 11:23:49 INFO - 'NO_EM_RESTART': '1', 11:23:49 INFO - 'PAGER': '/bin/cat', 11:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:49 INFO - 'PWD': '/builds/slave/test', 11:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:49 INFO - 'SHELL': '/bin/bash', 11:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:23:49 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:49 INFO - 'USER': 'cltbld', 11:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:49 INFO - 'XPC_FLAGS': '0x0', 11:23:49 INFO - 'XPC_SERVICE_NAME': '0', 11:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:50 INFO - Downloading/unpacking psutil>=3.1.1 11:23:50 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 11:23:50 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 11:23:50 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 11:23:50 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 11:23:50 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 11:23:50 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 11:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:53 INFO - Installing collected packages: psutil 11:23:53 INFO - Running setup.py install for psutil 11:23:53 INFO - building 'psutil._psutil_osx' extension 11:23:53 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 11:23:53 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 11:23:53 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 11:23:53 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 11:23:53 INFO - building 'psutil._psutil_posix' extension 11:23:53 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 11:23:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:23:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:23:54 INFO - ^ 11:23:54 INFO - 1 warning generated. 11:23:54 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 11:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:54 INFO - Successfully installed psutil 11:23:54 INFO - Cleaning up... 11:23:54 INFO - Return code: 0 11:23:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:23:54 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')]} 11:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:54 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')]} 11:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:54 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:23:54 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 11:23:54 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 11:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:54 INFO - 'HOME': '/Users/cltbld', 11:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:54 INFO - 'LOGNAME': 'cltbld', 11:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:54 INFO - 'MOZ_NO_REMOTE': '1', 11:23:54 INFO - 'NO_EM_RESTART': '1', 11:23:54 INFO - 'PAGER': '/bin/cat', 11:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:54 INFO - 'PWD': '/builds/slave/test', 11:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:54 INFO - 'SHELL': '/bin/bash', 11:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:23:54 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:54 INFO - 'USER': 'cltbld', 11:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:54 INFO - 'XPC_FLAGS': '0x0', 11:23:54 INFO - 'XPC_SERVICE_NAME': '0', 11:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:23:57 INFO - Installing collected packages: mozsystemmonitor 11:23:57 INFO - Running setup.py install for mozsystemmonitor 11:23:57 INFO - Successfully installed mozsystemmonitor 11:23:57 INFO - Cleaning up... 11:23:57 INFO - Return code: 0 11:23:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:23: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')]} 11:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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')]} 11:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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', '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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:23: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:23: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 jsonschema==2.5.1 11:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:57 INFO - 'HOME': '/Users/cltbld', 11:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:57 INFO - 'LOGNAME': 'cltbld', 11:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:57 INFO - 'MOZ_NO_REMOTE': '1', 11:23:57 INFO - 'NO_EM_RESTART': '1', 11:23:57 INFO - 'PAGER': '/bin/cat', 11:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:57 INFO - 'PWD': '/builds/slave/test', 11:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:57 INFO - 'SHELL': '/bin/bash', 11:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:23:57 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:57 INFO - 'USER': 'cltbld', 11:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:57 INFO - 'XPC_FLAGS': '0x0', 11:23:57 INFO - 'XPC_SERVICE_NAME': '0', 11:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:24:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:00 INFO - warning: no files found matching '*.txt' 11:24:00 INFO - no previously-included directories found matching 'build' 11:24:00 INFO - no previously-included directories found matching 'dist' 11:24:00 INFO - no previously-included directories found matching '.git*' 11:24:00 INFO - Installing collected packages: jsonschema, functools32 11:24:00 INFO - Running setup.py install for functools32 11:24:00 INFO - warning: no files found matching '*.txt' 11:24:00 INFO - no previously-included directories found matching 'build' 11:24:00 INFO - no previously-included directories found matching 'dist' 11:24:00 INFO - no previously-included directories found matching '.git*' 11:24:00 INFO - Successfully installed jsonschema functools32 11:24:00 INFO - Cleaning up... 11:24:00 INFO - Return code: 0 11:24:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:00 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:24:00 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 11:24:00 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 11:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:00 INFO - 'HOME': '/Users/cltbld', 11:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:00 INFO - 'LOGNAME': 'cltbld', 11:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:00 INFO - 'MOZ_NO_REMOTE': '1', 11:24:00 INFO - 'NO_EM_RESTART': '1', 11:24:00 INFO - 'PAGER': '/bin/cat', 11:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:00 INFO - 'PWD': '/builds/slave/test', 11:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:00 INFO - 'SHELL': '/bin/bash', 11:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:24:00 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:00 INFO - 'USER': 'cltbld', 11:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:00 INFO - 'XPC_FLAGS': '0x0', 11:24:00 INFO - 'XPC_SERVICE_NAME': '0', 11:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:01 INFO - Cleaning up... 11:24:01 INFO - Return code: 0 11:24:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:01 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:24:01 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 11:24:01 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 11:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:01 INFO - 'HOME': '/Users/cltbld', 11:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:01 INFO - 'LOGNAME': 'cltbld', 11:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:01 INFO - 'MOZ_NO_REMOTE': '1', 11:24:01 INFO - 'NO_EM_RESTART': '1', 11:24:01 INFO - 'PAGER': '/bin/cat', 11:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:01 INFO - 'PWD': '/builds/slave/test', 11:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:01 INFO - 'SHELL': '/bin/bash', 11:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:24:01 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:01 INFO - 'USER': 'cltbld', 11:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:01 INFO - 'XPC_FLAGS': '0x0', 11:24:01 INFO - 'XPC_SERVICE_NAME': '0', 11:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:05 INFO - Downloading docopt-0.6.1.tar.gz 11:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:05 INFO - Running setup.py install for blobuploader 11:24:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:05 INFO - Running setup.py install for requests 11:24:06 INFO - Running setup.py install for docopt 11:24:06 INFO - Successfully installed blobuploader requests docopt 11:24:06 INFO - Cleaning up... 11:24:06 INFO - Return code: 0 11:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:06 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:24:06 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 11:24:06 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 11:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:06 INFO - 'HOME': '/Users/cltbld', 11:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:06 INFO - 'LOGNAME': 'cltbld', 11:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:06 INFO - 'MOZ_NO_REMOTE': '1', 11:24:06 INFO - 'NO_EM_RESTART': '1', 11:24:06 INFO - 'PAGER': '/bin/cat', 11:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:06 INFO - 'PWD': '/builds/slave/test', 11:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:06 INFO - 'SHELL': '/bin/bash', 11:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:24:06 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:06 INFO - 'USER': 'cltbld', 11:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:06 INFO - 'XPC_FLAGS': '0x0', 11:24:06 INFO - 'XPC_SERVICE_NAME': '0', 11:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:06 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-5uBMlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-wW7OBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-o8h9_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-BOATjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-zsDLwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-JymmMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-A4Hw9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-43e0aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-JM4z3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:07 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-LWUzcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:08 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-8GIhC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:08 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Kz2UMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:08 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-5WqeUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:08 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-kMPiCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:08 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-SkZZGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:08 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OxVWWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:08 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-PuTWgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:08 INFO - Running setup.py install for manifestparser 11:24:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:08 INFO - Running setup.py install for mozcrash 11:24:09 INFO - Running setup.py install for mozdebug 11:24:09 INFO - Running setup.py install for mozdevice 11:24:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozfile 11:24:09 INFO - Running setup.py install for mozhttpd 11:24:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozinfo 11:24:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozInstall 11:24:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozleak 11:24:10 INFO - Running setup.py install for mozlog 11:24:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Running setup.py install for moznetwork 11:24:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Running setup.py install for mozprocess 11:24:10 INFO - Running setup.py install for mozprofile 11:24:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Running setup.py install for mozrunner 11:24:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Running setup.py install for mozscreenshot 11:24:11 INFO - Running setup.py install for moztest 11:24:11 INFO - Running setup.py install for mozversion 11:24:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:11 INFO - Cleaning up... 11:24:11 INFO - Return code: 0 11:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:11 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:24:11 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 11:24:11 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 11:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:11 INFO - 'HOME': '/Users/cltbld', 11:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:11 INFO - 'LOGNAME': 'cltbld', 11:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:11 INFO - 'MOZ_NO_REMOTE': '1', 11:24:11 INFO - 'NO_EM_RESTART': '1', 11:24:11 INFO - 'PAGER': '/bin/cat', 11:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:11 INFO - 'PWD': '/builds/slave/test', 11:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:11 INFO - 'SHELL': '/bin/bash', 11:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:24:11 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:11 INFO - 'USER': 'cltbld', 11:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:11 INFO - 'XPC_FLAGS': '0x0', 11:24:11 INFO - 'XPC_SERVICE_NAME': '0', 11:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:11 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0dgawb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:11 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OM5avX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:11 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-fxG_Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:11 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1N_Cwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-eZe4Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-XnM3mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-yafbHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_PQV8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-gsS63z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Xqvflc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-wOrfIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-csDCSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:12 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-selrBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:13 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-niLq82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:13 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-XIhSiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:13 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-1qCKCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:13 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)) 11:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:13 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TOA8Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:13 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)) 11:24:13 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)) 11:24:13 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)) 11:24:13 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)) 11:24:13 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)) 11:24:13 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)) 11:24:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:13 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 11:24:13 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 11:24:13 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 11:24:13 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 11:24:13 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 11:24:13 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 11:24:16 INFO - Downloading blessings-1.6.tar.gz 11:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:16 INFO - Installing collected packages: blessings 11:24:16 INFO - Running setup.py install for blessings 11:24:16 INFO - Successfully installed blessings 11:24:16 INFO - Cleaning up... 11:24:16 INFO - Return code: 0 11:24:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:16 INFO - Reading from file tmpfile_stdout 11:24:16 INFO - Current package versions: 11:24:16 INFO - blessings == 1.6 11:24:16 INFO - blobuploader == 1.2.4 11:24:16 INFO - docopt == 0.6.1 11:24:16 INFO - functools32 == 3.2.3-2 11:24:16 INFO - jsonschema == 2.5.1 11:24:16 INFO - manifestparser == 1.1 11:24:16 INFO - mozInstall == 1.12 11:24:16 INFO - mozcrash == 0.17 11:24:16 INFO - mozdebug == 0.1 11:24:16 INFO - mozdevice == 0.48 11:24:16 INFO - mozfile == 1.2 11:24:16 INFO - mozhttpd == 0.7 11:24:16 INFO - mozinfo == 0.9 11:24:16 INFO - mozleak == 0.1 11:24:16 INFO - mozlog == 3.4 11:24:16 INFO - moznetwork == 0.27 11:24:16 INFO - mozprocess == 0.23 11:24:16 INFO - mozprofile == 0.28 11:24:16 INFO - mozrunner == 6.12 11:24:16 INFO - mozscreenshot == 0.1 11:24:16 INFO - mozsystemmonitor == 0.3 11:24:16 INFO - moztest == 0.7 11:24:16 INFO - mozversion == 1.4 11:24:16 INFO - psutil == 3.1.1 11:24:16 INFO - requests == 1.2.3 11:24:16 INFO - wsgiref == 0.1.2 11:24:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:16 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 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:24:16 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 11:24:16 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 11:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:16 INFO - 'HOME': '/Users/cltbld', 11:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:16 INFO - 'LOGNAME': 'cltbld', 11:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:16 INFO - 'MOZ_NO_REMOTE': '1', 11:24:16 INFO - 'NO_EM_RESTART': '1', 11:24:16 INFO - 'PAGER': '/bin/cat', 11:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:16 INFO - 'PWD': '/builds/slave/test', 11:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:16 INFO - 'SHELL': '/bin/bash', 11:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:24:16 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:16 INFO - 'USER': 'cltbld', 11:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:16 INFO - 'XPC_FLAGS': '0x0', 11:24:16 INFO - 'XPC_SERVICE_NAME': '0', 11:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 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)) 11:24:17 INFO - Cleaning up... 11:24:17 INFO - Return code: 0 11:24:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107253490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8d6bf80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, '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.SOxvdpDOte/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.8WQxCZjJkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 11:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:24:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:24:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:17 INFO - 'HOME': '/Users/cltbld', 11:24:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:17 INFO - 'LOGNAME': 'cltbld', 11:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:17 INFO - 'MOZ_NO_REMOTE': '1', 11:24:17 INFO - 'NO_EM_RESTART': '1', 11:24:17 INFO - 'PAGER': '/bin/cat', 11:24:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:17 INFO - 'PWD': '/builds/slave/test', 11:24:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:17 INFO - 'SHELL': '/bin/bash', 11:24:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:24:17 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:24:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:17 INFO - 'USER': 'cltbld', 11:24:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:17 INFO - 'XPC_FLAGS': '0x0', 11:24:17 INFO - 'XPC_SERVICE_NAME': '0', 11:24:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:17 INFO - Cleaning up... 11:24:17 INFO - Return code: 0 11:24:17 INFO - Running post-action listener: _resource_record_post_action 11:24:17 INFO - Running post-action listener: _start_resource_monitoring 11:24:17 INFO - Starting resource monitoring. 11:24:17 INFO - [mozharness: 2016-11-14 19:24:17.494503Z] Finished create-virtualenv step (success) 11:24:17 INFO - [mozharness: 2016-11-14 19:24:17.495459Z] Running install step. 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: install 11:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:17 INFO - Reading from file tmpfile_stdout 11:24:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:17 INFO - Reading from file tmpfile_stdout 11:24:17 INFO - Output received: 11:24:17 INFO - Usage: mozinstall [options] installer 11:24:17 INFO - Options: 11:24:17 INFO - -h, --help show this help message and exit 11:24:17 INFO - -d DEST, --destination=DEST 11:24:17 INFO - Directory to install application into. [default: 11:24:17 INFO - "/builds/slave/test"] 11:24:17 INFO - --app=APP Application being installed. [default: firefox] 11:24:17 INFO - mkdir: /builds/slave/test/build/application 11:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:24:39 INFO - Reading from file tmpfile_stdout 11:24:39 INFO - Output received: 11:24:39 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:24:39 INFO - Running post-action listener: _resource_record_post_action 11:24:39 INFO - [mozharness: 2016-11-14 19:24:39.747773Z] Finished install step (success) 11:24:39 INFO - [mozharness: 2016-11-14 19:24:39.747918Z] Running run-tests step. 11:24:39 INFO - Running pre-action listener: _resource_record_pre_action 11:24:39 INFO - Running main action method: run_tests 11:24:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:24:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:24:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:24:39 INFO - 2016-11-14 11:24:39.762 screenresolution[1643:7615] starting screenresolution argv=screenresolution get 11:24:39 INFO - 2016-11-14 11:24:39.765 screenresolution[1643:7615] Display 0: 1600x1200x32@60 11:24:39 INFO - 2016-11-14 11:24:39.770 screenresolution[1644:7617] starting screenresolution argv=screenresolution list 11:24:39 INFO - Available Modes on Display 0 11:24:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:24:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:24:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:24:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:24:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:24:39 INFO - Intel Iris: 11:24:39 INFO - Chipset Model: Intel Iris 11:24:39 INFO - Type: GPU 11:24:39 INFO - Bus: Built-In 11:24:39 INFO - VRAM (Dynamic, Max): 1536 MB 11:24:39 INFO - Vendor: Intel (0x8086) 11:24:39 INFO - Device ID: 0x0a2e 11:24:39 INFO - Revision ID: 0x0009 11:24:39 INFO - Displays: 11:24:39 INFO - Display: 11:24:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:24:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:24:39 INFO - Display Serial Number: 1600x1200 60 11:24:39 INFO - Main Display: Yes 11:24:39 INFO - Mirror: Off 11:24:39 INFO - Online: Yes 11:24:39 INFO - Rotation: Supported 11:24:40 INFO - Return code: 0 11:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:40 INFO - Python 2.7.3 11:24:40 INFO - Return code: 0 11:24:40 INFO - grabbing minidump binary from tooltool 11:24:40 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')]} 11:24:40 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 0x107067d30>, '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 0x106ecddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10705fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:40 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 11:24:40 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 11:24:40 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 11:24:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:40 INFO - Return code: 0 11:24:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:24:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:24:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 11:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 11:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOxvdpDOte/Render', 11:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:40 INFO - 'HOME': '/Users/cltbld', 11:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:40 INFO - 'LOGNAME': 'cltbld', 11:24:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:40 INFO - 'MOZ_NO_REMOTE': '1', 11:24:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:40 INFO - 'NO_EM_RESTART': '1', 11:24:40 INFO - 'PAGER': '/bin/cat', 11:24:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:40 INFO - 'PWD': '/builds/slave/test', 11:24:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:40 INFO - 'SHELL': '/bin/bash', 11:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8WQxCZjJkA/Listeners', 11:24:40 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 11:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:40 INFO - 'USER': 'cltbld', 11:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:40 INFO - 'XPC_FLAGS': '0x0', 11:24:40 INFO - 'XPC_SERVICE_NAME': '0', 11:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 11:24:40 INFO - mozversion application_buildid: 20161114081643 11:24:40 INFO - mozversion application_changeset: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 11:24:40 INFO - mozversion application_display_name: Firefox 11:24:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:40 INFO - mozversion application_name: Firefox 11:24:40 INFO - mozversion application_remotingname: firefox 11:24:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:24:40 INFO - mozversion application_vendor: Mozilla 11:24:40 INFO - mozversion application_version: 51.0 11:24:40 INFO - mozversion platform_buildid: 20161114081643 11:24:40 INFO - mozversion platform_changeset: 4ed88686e49e3b941dd9b01f2f5c038f53187a05 11:24:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:24:40 INFO - mozversion platform_version: 51.0 11:24:40 INFO - using testdate: 1479151480 11:24:40 INFO - actual date: 1479151480 11:24:40 INFO - starting webserver on 'localhost:49278' 11:24:40 INFO - SUITE-START | Running 2 tests 11:24:40 INFO - TEST-START | dromaeo_css 11:24:40 INFO - operating with platform_type : mac_ 11:24:40 INFO - Initialising browser for dromaeo_css test... 11:24:40 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpKalo59/profile http://localhost:49278/getInfo.html) 11:24:42 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 11:24:42 INFO - PROCESS | 1654 | colorDepth:24 11:24:42 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 11:24:42 INFO - PROCESS | 1654 | __metrics 11:24:42 INFO - PROCESS | 1654 | 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" 11:24:42 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:24:43 INFO - TEST-INFO | 1654: exit 0 11:24:43 INFO - Browser initialized. 11:24:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:43 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpKalo59/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:55 INFO - PROCESS | 1657 | RSS: Main: 168005632 11:24:55 INFO - PROCESS | 1657 | 11:25:51 INFO - PROCESS | 1657 | 1479151551598 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] 11:27:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 11:27:59 INFO - PROCESS | 1657 | RSS: Main: 300748800 11:27:59 INFO - PROCESS | 1657 | 11:31:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 11:31:02 INFO - PROCESS | 1657 | RSS: Main: 297713664 11:31:02 INFO - PROCESS | 1657 | 11:34:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 11:34:05 INFO - PROCESS | 1657 | RSS: Main: 291061760 11:34:05 INFO - PROCESS | 1657 | 11:37:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 11:37:08 INFO - PROCESS | 1657 | RSS: Main: 280133632 11:37:08 INFO - PROCESS | 1657 | 11:40:10 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 11:40:11 INFO - PROCESS | 1657 | RSS: Main: 263180288 11:40:11 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 11:43:14 INFO - PROCESS | 1657 | RSS: Main: 328388608 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | __start_tp_report 11:43:14 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 11:43:14 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 11:43:14 INFO - PROCESS | 1657 | |i|pagename|runs| 11:43:14 INFO - PROCESS | 1657 | |0;dojo.html;3470.9305813883716;3474.982625086875;3522.0842580928966;3549.077239917621;3557.270759494304;5770.451807078326;5804.129380592914;5842.532597392209;5844.123381492778;5876.412358764127;4725.9054818903605;5840.8247752567495;5843.561732870031;5848.795292164775;5851.385604511529;5273.050850846846;5304.443033481468;5321.840344789663;5354.464553544633;5363.6245462817615;5247.344081989751;5260.184671375943;5400.567954563626;5420;5428.5928555358305;5313.415524292324;5347.518723314901;5365.919511207316;5369.24830523727;5370.91943620846;5334.946650533484;5349.812756553541;5353.277307563468;5361.973190134064;5365.061114304981;5207.9479205207845;5330.866728331784;5339.279197308352;5340.439253878326;5343.919841202385;5860.2967643883;5980.671063091529;5982.611130276518;5986;5999.220101386835;6157.2919114301985;6202.534809889276;6325.810225693236;6340.239171299428;6372.044193370985;6227.626342419424;6288.151099601541;6288.654124023177;6337.714802833837;6372.076048972873;5919.822405327847;5930.881382372371;5931.466168044811;5932.377100404482;6002.759889604455;6292.716827742763;6343.397377249154;6358.395952384516;6369.745210191633;6389.3291204423795;6078.574499785061;6086.330503644595;6134.601250918676;6165.72254248551;6169.2288463942;6282.748690052346;6285.622862628257;6292.653904035322;6293.402126797947;6304.936950630527;5071.923921141186;5863.5309175265875;6097.115918191926;6172.660503672251;6213.968930155411;6180.567360284737;6181.1655426516845;6211.720472578745;6266.749330026748;6347.428731414195;5081.212412076134;5086.262491938648;5095.490450954875;5107.897842043212;5109;4477.977610111929;4539.977300113478;4544.227481328182;4552.339910712928;4579.542045795394;5773.797917072882;5824.446677565625;5832.591718579659;5832.708364581754;5855.619384739978;6237.844053898689;6276.058591211264;6343.175387199634;6348.77779277723;6362.84092897672;5883.499902508334;5917.674527900921;5921.259842519685;5933.495652869468;5937;5383.380911195184;5473.452654734495;5545.500904918576;5560.388357280696;5561.6663000220115;6325.683715814191;6328.272248691367;6386.87226255463;6392.840178995562;6492.740290388331;6296.527760418078;6310.6213627182515;6321.778737744157;6325.304216536086;6332.810015699536;5532.03189441838;6444.2911279758255;6456;6504.674766261763;6561.212654481493;4635;6118.43644382056;6135.532964508949;6163;6170.92008898432;6288.748450061947;6304.7162877671535;6319.652419116993;6324.810255692337;6327.620342779448;5996.190514280691;6209.379062093935;6216.098665693358;6219.129321895029;6246.6876656166105;6112.74665817949;6118.20463339763;6138.878900475427;6166.506679465542;6266.811995640138;6183.0107182850525;6186.350433204449;6194.318624951342;6197.81406557804;6208.317085120543;5198.844034678966;6278.874422511615;6279.434850863444;6298.1812364392335;6310.242770867525;5845.853853653693;5919.526437885045;6065.909011364744;6146.846328841814;6155.784547540815 11:43:14 INFO - PROCESS | 1657 | |1;ext.html;492.7142257490656;500.4795013186284;528.9761960711769;554.6034585271533;563.2340017576096;32206;41640.79179604101;43064.56935430645;43107.13785724284;43148.56851431481;43614.78192609041;44099.77950110253;44126.55873441265;44135;44249;9324.720258392224;10022.59909603615;10220.233482488806;10220.437875916821;10239.078482936535;9341.439513629204;12361.814572781415;12628.179168354074;12636.052296077785;12811.807822882663;12426;12499.3750312484;12515.687107822287;12515.937420312932;12556.995440364795;12587.622371328875;12674.36628168588;12678.61964141068;12682.365881705879;12702.682432939158;12487.250764954131;12572.874271257262;12576.245425274512;12577.434015469235;12577.874221257853;40302.798486007676;40588.39117413241;40672.77981660555;40692.79653601743;40788.77633670995;3426.794392336468;3556.5732112146447;3706.4810926470313;3950.3876899080688;3989.4414781930554;32144.83927580347;32563.837180813945;32703.67296327054;33011.504827427605;33548.83225583856;3250.528673342376;3298.5876765404323;3338.2655815720505;3343.3981883261004;3348.29685765987;509270;509940;510716;511574.8842511565;512290;33920.49119263213;59121.11318330229;59585.702071489366;59659.403405965386;59848.401515985155;35200.64799352025;36419.27161456756;36430.453543196345;36487.81756091202;36495.81752091223;13442.731145377038;15789.763153552476;16053.277602507682;16054.839451605569;16090;12310.199837010745;12630.926371258362;12634.81047784284;13446.93276533611;13563.932180339232;7564.886526702104;7621.771346859603;7808.84382312362;7981.48120372174;8044.517328960281;3304.3721692878275;3353.8826141084946;3356.3317162855587;3378.5607870977105;3386.610539787907;984.104464936904;1024.7233247023262;1027.8098551767798;1027.9023492768174;1053.6312290698195;25771.48457030849;30842.228944276125;30886;31476.055718328487;31590;981.6711401680517;1035.8394448860438;1088.7985722641338;1109.5672687651822;1148.133159464599;12908.16096953695;13920.05119283301;15962.840371596136;16110.275037623334;16215.919085312264;694684;701734;708528.7441376767;710618;715248;59018.40981590215;59738.402615974155;59808.40191598115;59857;59931.70034149889;1306.405585458614;1347.636138242669;1366.1052010932656;1443.1196969848595;1449.326063380533;30509.847450762605;32151;32376.514352284263;32787.67212327846;33015.17462063468;48853.5114648849;49378.75310623424;49415.50584494109;49546.50453495563;49630.751846240535;559675;564371;564637;565473.345266542;565613;22505.887470563197;26779;26830.060947866732;27528.58707119435;27574.448511030067;47696.046079078915;47962.760186198844;48123.75938120287;48997.75501122472;49175;34054.65945340515;39892.80053599829;40008.79995600003;40043.1991360177;40336.19327613372;39795.00512487211;39991;40054.59945400509;41258;41348.379774302804;38811.536673282935;39074.2185156301;39635.405468918565;39853.2029359417;40048.79975600103;33843.66156338405;35160;35610.82194589114;35733.10667233236;36304;26478.735212647625;26484.073057442896;26699.19902402931;26793.86603066972;27416.862915685295 11:43:14 INFO - PROCESS | 1657 | |2;jquery.html;370.57939238963775;377.9886603401897;378.990525236869;396.142351808335;402.8630265709658;16081.542468369298;17297.394591189295;20761.896190519063;20840.583188336223;21485.462863428424;20111.798882011175;20409.4897627559;20502.384928452135;20668;21121.788782112173;5267.051930652481;5650.124230744241;5944.227250457435;6161.753529858823;6208.286047104596;6105.908411373811;6143.784967526138;6156.722947467352;6175.62946223228;6176.876462470748;4997.5252351026775;5448.727563621823;5832;6121.908171377433;6147.077938309245;5931.169636250886;6104.603200791957;6182.907256391158;6193.504519638418;6215.192025036739;5229.111051121318;5765.596408251424;5897.764089436418;5971.134185543072;5977.193078934375;12785.808212876815;12999.675008124777;23477.88261058701;23776.692281924486;24376.634350484757;1888.688366419539;2181.8909054547366;2204.867707937529;2342.3090188394463;2951.837648929308;9550.713478595653;9617.134457898752;9849.90150098497;9886.159676427513;10182.643607473703;1884.1897983866932;1942.747442832437;1956.833669138125;1963.990180049105;1988.145097608028;86931.56534217352;107373.46313268461;123317.31603663604;126037;127518.08722869257;11061.336319820837;11135.777284454265;11199.384033878216;11398.715032124097;11571.01646360052;14406.639834004023;14417.207053611943;14419.855801442061;14421.278936053155;14423.85576144246;8450.87323690145;8764.03595604483;8793.252573531194;8842.734717958472;8868.467891926504;7976.481528700616;8721.08428614999;8724.171203735636;8879;8902.688405905763;4402.295632698753;4476.149531588988;4498.167838949805;4543.954560454353;4557.339185818038;1849.355421746888;1903.3052935678377;1927.4676632077533;1932.120884997323;1933.9613207735767;800.4356928365488;806.9354451643854;897.8383890899701;900.1628485508539;965.4545181972304;20068.69896951547;20705.58588828215;20759.27342543034;20794.792052079287;20957.790422095582;911.6626848066126;947.3984020147257;957.4686049242737;959.2805395953035;1036.5801850250662;10032.347897386646;10669.626563070255;10714.78570428587;10738.892611073788;10747.032767051003;608166;613083;613497;637339;643972;123934.38032809779;131899;134957;138414;143377;969.9369540979814;993.438707130469;1027.3271007490107;1027.6095083868083;1028.6091285311534;17627.735583966507;18038.188281527626;18349.633007340046;18380.724289135407;18669.533261668566;49192;49489.25766113583;50375.74060648513;50948.47154585368;52912;72873.27126728665;74823.62588187242;75011.62494187494;77517;78802.60598696969;7689.231076892266;7814.960925195338;7841.451098423056;7940.086890007723;7940.960295198487;10545.472726363805;12309.815352769536;12359.3820308986;12642.683932901751;12721.745565088831;10649.307794993301;10723.94638026836;10732;10924.945375273073;11056.557737690402;9463.952680236554;9906.009399060325;9931.056549627774;10861.511231994737;11116.277441966246;10407.94796026015;11028.558857645605;11185;11222.66332010041;11418.973971897287;7581.848363032598;7640.274173953466;7737.187595302412;7949.085855126503;8110.553919534246;7914.643841027052;9894.307398482037;10647.77550581662;10828.945855270673;10921.563137474412 11:43:14 INFO - PROCESS | 1657 | |3;mootools.html;1417.666848290652;1570.8821838362126;1598.3047374392138;1800.6488734696732;1938.7770406403258;8280.83438331233;8831.205191532761;9047.321450891177;9322.254219662427;9346;7724.536527808335;9213.539323033838;9218.124278193578;9352.298577606689;9373.953130234357;2455.2511483997373;2481.7146028206716;2481.937951551208;2482.8013758899247;2483.466054798218;2419.177479656916;2492.7382624824404;2493.9376515587164;2495.7129930058004;2496.3634273260295;2438.4879175373194;2466.1984854922134;2483.1184929350093;2485.1674688979215;2489.352768280242;2426;2451.3136321829916;2461.3600463879343;2462.544429280571;2464.950700985979;2266.9571996881455;2424.115197952752;2440.389902524369;2443.2059580636187;2452.828302018859;7849.293563579248;9231.307651926065;9310.67412640561;9313.90686093137;9324.766880828034;5455.8363249102595;5676.432356764331;5689.487946084831;5722.570807189436;5726.7995620153515;3763.284975854579;3799.202167544819;3835.5972622874474;3884;3893.377059670439;1111.1999360460457;1113.6770336602376;1114.1365441782602;1128.1482480727082;1137.7212582917155;12280;12315.261084334968;12416.006719462512;12423;12454.626361209179;4571.474280457724;4586.243269860503;4786.95213047865;4790.928136077961;4807.4471435784635;9583.424994500352;9617.23062155026;9621.951890240643;9623.422594644344;9633.08485693858;5482.945170548323;5489.149181876815;5494.09347457673;5496.120620700749;5505.972470137704;4378.978105109454;4646.4191976003;4786.353842231254;4815.3258543803895;5156.510131537498;3927.7839718815167;3953.2291203215095;4034.3141665916864;4066.6340029397497;4080.9183816323507;1025.8615086963164;1189.339916346436;1190.0955273991656;1194.396829601046;1206.5113628980278;845.4884794699242;930.7254359963827;949.7910459698855;949.9145076943108;952.9190018848337;5985.934852475976;6058.666773327421;6166.414190651881;6187.504999600022;6194.566380353423;445.0161666029266;445.7058341494663;460.0729529997059;461.0249322682502;465.28346346626495;4083.1629515949157;4090.079732060263;4112.239235741397;4142.440770495945;4210.936835947463;10849.403282819521;11383.88616113845;11394.25937314072;11402.429878506042;11408.771824563628;11231.438428078563;11275.54897804095;11312.773744525064;11324.433778311051;11328.71678208035;8183.386246031571;8507.70223042203;8563.100874408346;8609.096044915319;8625.482471051757;6169.598976066542;6206.379362063757;6214.564980451506;6240.469560087444;6296.496280297657;10444.112250458797;10606.151507879196;10708.3574985498;10751.462426878781;10767.407792571485;9979.800403992025;10341.069303762397;10589.205809564159;10960.671179864617;10986.890131098588;6291.842703932438;7830.09953855314;7974.481658692166;8027.919720802717;8048.396370272136;8783.868241976503;8799.824003520022;8881.644734210558;8914.643414263357;8923.955380223057;7784.883226751716;7937.523748575104;7986.520808751494;7995.560244186626;8071.23323284287;7707;7759.456838021284;7786.065672119382;7838.490498117604;7898.2891539761695;7291.52605080668;7426.220246874001;7436.702531898663;7439.9256007439235;7441.627918604157;5141.768620412166;5203.115470370122;5319.0691628964005;5409.187922046001;5444.945550544602;4009.6190861868076;5245.423003469539;5277.498637629419;5365.839024829262;5486.451354864482 11:43:14 INFO - PROCESS | 1657 | |4;prototype.html;293.8471994562826;298.51193298956207;305.6622432212406;310.47374699883704;314.317930091701;3991.6407523322896;4723.1734446471855;5179.482051794828;5337.653052551582;5412.621116521845;4823.855284341475;5272.92090618641;5337.11937530307;5356.866078348044;5368.986630013745;3736.7757934524016;3979.542352629441;4129.132882094764;4138.33786594145;4143.337066069437;4162.354835000579;4178.937315940263;4187.937180942288;4189.162167566484;4214.515330736974;3999.960000399988;4066.573009833969;4130.8967275818195;4132.2355364257555;4172.603602657758;4126.071633882382;4127.33962565988;4139.185353959307;4156.43888075109;4197.307444271692;3108.8341871798075;3440.122768693967;3586.4082426399614;3597.2086141048926;3605.7295702822394;4295.656347492193;5215.739213039333;5257.7108259045735;5260.631755777097;5316.362036555638;4568.223402021665;4609.787302095013;4633.907321853544;4642.605378542828;4681.719096854165;5283.28675628789;5320.76056577455;5621.297337832771;5632.887342253173;5681.034224181899;3786.9053273668105;3791.9241615167816;3814.141818090935;3817.4464702617965;3827.158025234444;5588.8542848715915;5759.424057594249;5780.219670344533;5846.9183201107935;5951.702414879239;3158.7788854780406;3513.631068737797;3745.606711295329;3838.251540949544;3860.652541271299;3933.331333673282;3956.030772460708;3959.6832253419657;3983.183447393277;3995.5604883462797;4097.569755175723;4569.086182763461;4600.217962946307;4601.608863246594;4621.23749581322;4674.555917187861;5268.81559145428;5285.603579731535;5696.430356964271;5709.600327977085;1321.2799024531653;1345.9501588760781;1347.968803865044;1348.3752078745088;1358.830146231721;719.4316489972967;784.6273020315305;814.9266566009088;829.6805729794073;830.9169083091642;4001.599840015975;4034.8789536313957;4041.3937909313836;4197.166912334163;4495.977520112378;4263.957360426418;4813.831515896927;4857.659963802571;4894.066843596759;4918.803247870045;3849;4373.310414095372;4440.666949978765;4483.237849565582;4536.8638940831825;2269.831037015938;2391.7682393567325;2485.6395822605623;2494.5634513959985;2539.9586169670347;4588.247051768912;4718.693284936468;5005.299258103868;5120.48795120485;5135.563477104488;4372.125574885035;4876.439869068697;4968.453470118284;5038.883668859088;5078.267473407042;4262;4365.890852728708;4640.628749700083;4722.197226471577;4785.521447855187;4212.736179146183;4800.4479484859685;4838.854834354975;4884.926726099183;4952.950470495249;4769.236922092448;4784.6889952153;4809.797550612347;4822.831200907952;4845.5881250092725;4516.458025037016;4786.659735274129;5091.567216786467;5110.514501122388;5155.381354237516;3364.713999310086;3366.495025746158;3418.3163367327134;3424.520567120655;3428.674275943781;4721.945953510234;4864.635152363516;4924.8276310328965;4930.6055515557955;4958.42978057528;4325.39444477767;4499.865004049884;4538.546145385567;4620.838270660645;4842.9757851211925;3967.4048892666333;4035.256025902297;4192.7065105442325;4213.873583792491;4826.227803551415;4146.79266036703;4322.697411181187;4388.29787234041;4597.655175861891;4692.859214223578;3832.9808350958065;3902.9804850975565;4400.669949753717;4527.501974782837;4787.385523929411;4126.401671757519;4674.205385084611;4718.301411491929;4753.358296630049;4760.500147484464 11:43:14 INFO - PROCESS | 1657 | |5;yui.html;728.2208037399984;755.7921571567819;810.8418858322626;859.6819176904546;889.3818795936827;16276.511704648865;17352.219150138244;17389.47831565055;17622.295108195674;18030.729539056923;15736.898417110808;16110.83889161108;16151.192440377963;16153.353865845382;16172.514824555254;728.6283995162479;746.6117618838201;896.9596368163416;900.1898291537619;921.3274309753883;909.0636644256426;926.7080869526111;928.1461055828654;929.3866048408051;930.0652843891913;980.8528720691918;983.2281658897766;984.5717113055808;985.6057576969198;987.6444479987199;973.3673112476876;973.7808992976594;974.5565767575736;975.0688092871362;978.0952618827556;716.7312257903286;718.3821913154683;720.2797202797203;720.672094197139;720.989185162223;15905.363785448568;16786.580335491588;16989.660206795917;17011.659766804594;17047.744283835753;11085.612003579836;13046.217226966317;13063.86936130636;13124.934375328157;13294;12216.755664886741;12257.693557661041;12767.680807979781;13247.138935969131;13789;4019.537753158395;4062.580606758087;4097.549269580344;4133.7106402551835;4244.702870799046;118099;120214.3989280048;121925;124598;125128.37435812854;9968.80062398748;10430.843537346946;11427.771444571063;11785.823212651818;12137.635870923887;24355.14756983497;24881.129160479297;24894;24896.875515622305;24923.75076249214;8411.957940210259;8594.312455003585;8693.956530217309;8851.822963540693;9039.954800225956;4549.840755573539;4624;4629.907401851944;4780;4892;3793.9566619179395;3928.1554465789422;3931.941020884689;3933.5083114610675;3933.645971862546;696.4498046543174;716.1084449859853;716.5915428205873;751.898493703354;755.3579457461224;488.6603810351771;580.8693044065136;633.7528363938068;701.4073108223542;703.3002162848;9209.125133112344;10058.245631577662;10181.592736290613;10186.592536298613;10210.132138768287;560.3555910702643;681.3629256645053;686.2656957055902;692.7125243024088;723.780429975493;4967.205247160437;4977.875553111201;5024.196128619404;5024.79900803971;5025.170846810309;102615;105055;126104;157381.42618573896;166244.16877915533;139033.91449128272;143513;143814.2809285947;143838.5616143846;147491.2625436866;99094;124090.37954810349;126773.73226267804;128874.35562822125;130023;9430.387024843363;9432.292578056811;9530.85703714431;9537.332386732862;9570;61132;70293.29706703073;70536.64731676309;70977.87066388017;71626.64186679033;82480.76278855943;97060.6028788989;107226.46386768016;109348.35977460185;111146;12453.25280483174;12502.874971250534;12556.811647825107;12745.808812868;12884.291363975071;13370.331483425984;13472.663183420102;13763.518276860263;14448.422063117778;14579.635509111933;11141.554337826396;11556.422178890854;11603.187776855877;11691.707707307385;12203.572874949334;12600.369981501071;12699.42852571655;13025.869741302844;13119.67200819949;13177.93411032977;12299.200551964093;12479.812802807783;12652.620421387373;12893.290869002294;12931.28877911724;9828.655997040069;10633.946830266108;11045.33727976324;11289.37908415045;11302.886971130183;10900.727481813017;11053.557857685924;11312.717182070513;11318.660440186808;11368.090552755595 11:43:14 INFO - PROCESS | 1657 | __end_tp_report 11:43:14 INFO - PROCESS | 1657 | __start_cc_report 11:43:14 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1143 11:43:14 INFO - PROCESS | 1657 | __end_cc_report 11:43:14 INFO - PROCESS | 1657 | __startTimestamp1479152594776__endTimestamp 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | ------- Summary: start ------- 11:43:14 INFO - PROCESS | 1657 | Number of tests: 6 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5818.93 Median:6002.76 stddev:629.05 (10.5%) stddev-sans-first:603.41 11:43:14 INFO - PROCESS | 1657 | Values: 3470.9 3475.0 3522.1 3549.1 3557.3 5770.5 5804.1 5842.5 5844.1 5876.4 4725.9 5840.8 5843.6 5848.8 5851.4 5273.1 5304.4 5321.8 5354.5 5363.6 5247.3 5260.2 5400.6 5420.0 5428.6 5313.4 5347.5 5365.9 5369.2 5370.9 5334.9 5349.8 5353.3 5362.0 5365.1 5207.9 5330.9 5339.3 5340.4 5343.9 5860.3 5980.7 5982.6 5986.0 5999.2 6157.3 6202.5 6325.8 6340.2 6372.0 6227.6 6288.2 6288.7 6337.7 6372.1 5919.8 5930.9 5931.5 5932.4 6002.8 6292.7 6343.4 6358.4 6369.7 6389.3 6078.6 6086.3 6134.6 6165.7 6169.2 6282.7 6285.6 6292.7 6293.4 6304.9 5071.9 5863.5 6097.1 6172.7 6214.0 6180.6 6181.2 6211.7 6266.7 6347.4 5081.2 5086.3 5095.5 5107.9 5109.0 4478.0 4540.0 4544.2 4552.3 4579.5 5773.8 5824.4 5832.6 5832.7 5855.6 6237.8 6276.1 6343.2 6348.8 6362.8 5883.5 5917.7 5921.3 5933.5 5937.0 5383.4 5473.5 5545.5 5560.4 5561.7 6325.7 6328.3 6386.9 6392.8 6492.7 6296.5 6310.6 6321.8 6325.3 6332.8 5532.0 6444.3 6456.0 6504.7 6561.2 4635.0 6118.4 6135.5 6163.0 6170.9 6288.7 6304.7 6319.7 6324.8 6327.6 5996.2 6209.4 6216.1 6219.1 6246.7 6112.7 6118.2 6138.9 6166.5 6266.8 6183.0 6186.4 6194.3 6197.8 6208.3 5198.8 6278.9 6279.4 6298.2 6310.2 5845.9 5919.5 6065.9 6146.8 6155.8 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:71716.99 Median:19293.40 stddev:160508.21 (831.9%) stddev-sans-first:160869.39 11:43:14 INFO - PROCESS | 1657 | Values: 492.7 500.5 529.0 554.6 563.2 32206.0 41640.8 43064.6 43107.1 43148.6 43614.8 44099.8 44126.6 44135.0 44249.0 9324.7 10022.6 10220.2 10220.4 10239.1 9341.4 12361.8 12628.2 12636.1 12811.8 12426.0 12499.4 12515.7 12515.9 12557.0 12587.6 12674.4 12678.6 12682.4 12702.7 12487.3 12572.9 12576.2 12577.4 12577.9 40302.8 40588.4 40672.8 40692.8 40788.8 3426.8 3556.6 3706.5 3950.4 3989.4 32144.8 32563.8 32703.7 33011.5 33548.8 3250.5 3298.6 3338.3 3343.4 3348.3 509270.0 509940.0 510716.0 511574.9 512290.0 33920.5 59121.1 59585.7 59659.4 59848.4 35200.6 36419.3 36430.5 36487.8 36495.8 13442.7 15789.8 16053.3 16054.8 16090.0 12310.2 12630.9 12634.8 13446.9 13563.9 7564.9 7621.8 7808.8 7981.5 8044.5 3304.4 3353.9 3356.3 3378.6 3386.6 984.1 1024.7 1027.8 1027.9 1053.6 25771.5 30842.2 30886.0 31476.1 31590.0 981.7 1035.8 1088.8 1109.6 1148.1 12908.2 13920.1 15962.8 16110.3 16215.9 694684.0 701734.0 708528.7 710618.0 715248.0 59018.4 59738.4 59808.4 59857.0 59931.7 1306.4 1347.6 1366.1 1443.1 1449.3 30509.8 32151.0 32376.5 32787.7 33015.2 48853.5 49378.8 49415.5 49546.5 49630.8 559675.0 564371.0 564637.0 565473.3 565613.0 22505.9 26779.0 26830.1 27528.6 27574.4 47696.0 47962.8 48123.8 48997.8 49175.0 34054.7 39892.8 40008.8 40043.2 40336.2 39795.0 39991.0 40054.6 41258.0 41348.4 38811.5 39074.2 39635.4 39853.2 40048.8 33843.7 35160.0 35610.8 35733.1 36304.0 26478.7 26484.1 26699.2 26793.9 27416.9 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:35374.06 Median:378.49 stddev:103955.65 (27465.9%) stddev-sans-first:104214.05 11:43:14 INFO - PROCESS | 1657 | Values: 370.6 378.0 379.0 396.1 402.9 16081.5 17297.4 20761.9 20840.6 21485.5 20111.8 20409.5 20502.4 20668.0 21121.8 5267.1 5650.1 5944.2 6161.8 6208.3 6105.9 6143.8 6156.7 6175.6 6176.9 4997.5 5448.7 5832.0 6121.9 6147.1 5931.2 6104.6 6182.9 6193.5 6215.2 5229.1 5765.6 5897.8 5971.1 5977.2 12785.8 12999.7 23477.9 23776.7 24376.6 1888.7 2181.9 2204.9 2342.3 2951.8 9550.7 9617.1 9849.9 9886.2 10182.6 1884.2 1942.7 1956.8 1964.0 1988.1 86931.6 107373.5 123317.3 126037.0 127518.1 11061.3 11135.8 11199.4 11398.7 11571.0 14406.6 14417.2 14419.9 14421.3 14423.9 8450.9 8764.0 8793.3 8842.7 8868.5 7976.5 8721.1 8724.2 8879.0 8902.7 4402.3 4476.1 4498.2 4544.0 4557.3 1849.4 1903.3 1927.5 1932.1 1934.0 800.4 806.9 897.8 900.2 965.5 20068.7 20705.6 20759.3 20794.8 20957.8 911.7 947.4 957.5 959.3 1036.6 10032.3 10669.6 10714.8 10738.9 10747.0 608166.0 613083.0 613497.0 637339.0 643972.0 123934.4 131899.0 134957.0 138414.0 143377.0 969.9 993.4 1027.3 1027.6 1028.6 17627.7 18038.2 18349.6 18380.7 18669.5 49192.0 49489.3 50375.7 50948.5 52912.0 72873.3 74823.6 75011.6 77517.0 78802.6 7689.2 7815.0 7841.5 7940.1 7941.0 10545.5 12309.8 12359.4 12642.7 12721.7 10649.3 10723.9 10732.0 10924.9 11056.6 9464.0 9906.0 9931.1 10861.5 11116.3 10407.9 11028.6 11185.0 11222.7 11419.0 7581.8 7640.3 7737.2 7949.1 8110.6 7914.6 9894.3 10647.8 10828.9 10921.6 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5939.84 Median:4788.94 stddev:3381.85 (70.6%) stddev-sans-first:3374.26 11:43:14 INFO - PROCESS | 1657 | Values: 1417.7 1570.9 1598.3 1800.6 1938.8 8280.8 8831.2 9047.3 9322.3 9346.0 7724.5 9213.5 9218.1 9352.3 9374.0 2455.3 2481.7 2481.9 2482.8 2483.5 2419.2 2492.7 2493.9 2495.7 2496.4 2438.5 2466.2 2483.1 2485.2 2489.4 2426.0 2451.3 2461.4 2462.5 2465.0 2267.0 2424.1 2440.4 2443.2 2452.8 7849.3 9231.3 9310.7 9313.9 9324.8 5455.8 5676.4 5689.5 5722.6 5726.8 3763.3 3799.2 3835.6 3884.0 3893.4 1111.2 1113.7 1114.1 1128.1 1137.7 12280.0 12315.3 12416.0 12423.0 12454.6 4571.5 4586.2 4787.0 4790.9 4807.4 9583.4 9617.2 9622.0 9623.4 9633.1 5482.9 5489.1 5494.1 5496.1 5506.0 4379.0 4646.4 4786.4 4815.3 5156.5 3927.8 3953.2 4034.3 4066.6 4080.9 1025.9 1189.3 1190.1 1194.4 1206.5 845.5 930.7 949.8 949.9 952.9 5985.9 6058.7 6166.4 6187.5 6194.6 445.0 445.7 460.1 461.0 465.3 4083.2 4090.1 4112.2 4142.4 4210.9 10849.4 11383.9 11394.3 11402.4 11408.8 11231.4 11275.5 11312.8 11324.4 11328.7 8183.4 8507.7 8563.1 8609.1 8625.5 6169.6 6206.4 6214.6 6240.5 6296.5 10444.1 10606.2 10708.4 10751.5 10767.4 9979.8 10341.1 10589.2 10960.7 10986.9 6291.8 7830.1 7974.5 8027.9 8048.4 8783.9 8799.8 8881.6 8914.6 8924.0 7784.9 7937.5 7986.5 7995.6 8071.2 7707.0 7759.5 7786.1 7838.5 7898.3 7291.5 7426.2 7436.7 7439.9 7441.6 5141.8 5203.1 5319.1 5409.2 5444.9 4009.6 5245.4 5277.5 5365.8 5486.5 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4157.09 Median:4521.98 stddev:1215.69 (26.9%) stddev-sans-first:1184.01 11:43:14 INFO - PROCESS | 1657 | Values: 293.8 298.5 305.7 310.5 314.3 3991.6 4723.2 5179.5 5337.7 5412.6 4823.9 5272.9 5337.1 5356.9 5369.0 3736.8 3979.5 4129.1 4138.3 4143.3 4162.4 4178.9 4187.9 4189.2 4214.5 4000.0 4066.6 4130.9 4132.2 4172.6 4126.1 4127.3 4139.2 4156.4 4197.3 3108.8 3440.1 3586.4 3597.2 3605.7 4295.7 5215.7 5257.7 5260.6 5316.4 4568.2 4609.8 4633.9 4642.6 4681.7 5283.3 5320.8 5621.3 5632.9 5681.0 3786.9 3791.9 3814.1 3817.4 3827.2 5588.9 5759.4 5780.2 5846.9 5951.7 3158.8 3513.6 3745.6 3838.3 3860.7 3933.3 3956.0 3959.7 3983.2 3995.6 4097.6 4569.1 4600.2 4601.6 4621.2 4674.6 5268.8 5285.6 5696.4 5709.6 1321.3 1346.0 1348.0 1348.4 1358.8 719.4 784.6 814.9 829.7 830.9 4001.6 4034.9 4041.4 4197.2 4496.0 4264.0 4813.8 4857.7 4894.1 4918.8 3849.0 4373.3 4440.7 4483.2 4536.9 2269.8 2391.8 2485.6 2494.6 2540.0 4588.2 4718.7 5005.3 5120.5 5135.6 4372.1 4876.4 4968.5 5038.9 5078.3 4262.0 4365.9 4640.6 4722.2 4785.5 4212.7 4800.4 4838.9 4884.9 4953.0 4769.2 4784.7 4809.8 4822.8 4845.6 4516.5 4786.7 5091.6 5110.5 5155.4 3364.7 3366.5 3418.3 3424.5 3428.7 4721.9 4864.6 4924.8 4930.6 4958.4 4325.4 4499.9 4538.5 4620.8 4843.0 3967.4 4035.3 4192.7 4213.9 4826.2 4146.8 4322.7 4388.3 4597.7 4692.9 3833.0 3903.0 4400.7 4527.5 4787.4 4126.4 4674.2 4718.3 4753.4 4760.5 11:43:14 INFO - PROCESS | 1657 | 11:43:14 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:26104.64 Median:24887.56 stddev:41746.65 (167.7%) stddev-sans-first:41820.28 11:43:14 INFO - PROCESS | 1657 | Values: 728.2 755.8 810.8 859.7 889.4 16276.5 17352.2 17389.5 17622.3 18030.7 15736.9 16110.8 16151.2 16153.4 16172.5 728.6 746.6 897.0 900.2 921.3 909.1 926.7 928.1 929.4 930.1 980.9 983.2 984.6 985.6 987.6 973.4 973.8 974.6 975.1 978.1 716.7 718.4 720.3 720.7 721.0 15905.4 16786.6 16989.7 17011.7 17047.7 11085.6 13046.2 13063.9 13124.9 13294.0 12216.8 12257.7 12767.7 13247.1 13789.0 4019.5 4062.6 4097.5 4133.7 4244.7 118099.0 120214.4 121925.0 124598.0 125128.4 9968.8 10430.8 11427.8 11785.8 12137.6 24355.1 24881.1 24894.0 24896.9 24923.8 8412.0 8594.3 8694.0 8851.8 9040.0 4549.8 4624.0 4629.9 4780.0 4892.0 3794.0 3928.2 3931.9 3933.5 3933.6 696.4 716.1 716.6 751.9 755.4 488.7 580.9 633.8 701.4 703.3 9209.1 10058.2 10181.6 10186.6 10210.1 560.4 681.4 686.3 692.7 723.8 4967.2 4977.9 5024.2 5024.8 5025.2 102615.0 105055.0 126104.0 157381.4 166244.2 139033.9 143513.0 143814.3 143838.6 147491.3 99094.0 124090.4 126773.7 128874.4 130023.0 9430.4 9432.3 9530.9 9537.3 9570.0 61132.0 70293.3 70536.6 70977.9 71626.6 82480.8 97060.6 107226.5 109348.4 111146.0 12453.3 12502.9 12556.8 12745.8 12884.3 13370.3 13472.7 13763.5 14448.4 14579.6 11141.6 11556.4 11603.2 11691.7 12203.6 12600.4 12699.4 13025.9 13119.7 13177.9 12299.2 12479.8 12652.6 12893.3 12931.3 9828.7 10633.9 11045.3 11289.4 11302.9 10900.7 11053.6 11312.7 11318.7 11368.1 11:43:14 INFO - PROCESS | 1657 | -------- Summary: end -------- 11:43:14 INFO - PROCESS | 1657 | 11:43:15 INFO - TEST-INFO | 1657: exit 0 11:43:15 INFO - TEST-OK | dromaeo_css | took 1115010ms 11:43:15 INFO - TEST-START | kraken 11:43:15 INFO - operating with platform_type : mac_ 11:43:15 INFO - Initialising browser for kraken test... 11:43:15 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp2D3OKf/profile http://localhost:49278/getInfo.html) 11:43:17 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 11:43:17 INFO - PROCESS | 1667 | colorDepth:24 11:43:17 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 11:43:17 INFO - PROCESS | 1667 | __metrics 11:43:17 INFO - PROCESS | 1667 | 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" 11:43:17 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:18 INFO - TEST-INFO | 1667: exit 0 11:43:18 INFO - Browser initialized. 11:43:18 INFO - Running cycle 1/1 for kraken test... 11:43:18 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp2D3OKf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:30 INFO - PROCESS | 1669 | RSS: Main: 164343808 11:43:30 INFO - PROCESS | 1669 | 11:43:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:33 INFO - PROCESS | 1669 | RSS: Main: 216076288 11:43:33 INFO - PROCESS | 1669 | 11:43:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 11:43:36 INFO - PROCESS | 1669 | RSS: Main: 231542784 11:43:36 INFO - PROCESS | 1669 | 11:43:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 11:43:40 INFO - PROCESS | 1669 | RSS: Main: 328712192 11:43:40 INFO - PROCESS | 1669 | 11:43:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 11:43:43 INFO - PROCESS | 1669 | RSS: Main: 226578432 11:43:43 INFO - PROCESS | 1669 | 11:43:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:43:45 INFO - PROCESS | 1669 | RSS: Main: 227897344 11:43:45 INFO - PROCESS | 1669 | 11:43:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 11:43:48 INFO - PROCESS | 1669 | RSS: Main: 263606272 11:43:48 INFO - PROCESS | 1669 | 11:43:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 11:43:52 INFO - PROCESS | 1669 | RSS: Main: 264359936 11:43:52 INFO - PROCESS | 1669 | 11:43:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 11:43:55 INFO - PROCESS | 1669 | RSS: Main: 263254016 11:43:55 INFO - PROCESS | 1669 | 11:43:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:43:57 INFO - PROCESS | 1669 | RSS: Main: 237449216 11:43:57 INFO - PROCESS | 1669 | 11:43:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:00 INFO - PROCESS | 1669 | RSS: Main: 243433472 11:44:00 INFO - PROCESS | 1669 | 11:44:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:03 INFO - PROCESS | 1669 | RSS: Main: 252207104 11:44:03 INFO - PROCESS | 1669 | 11:44:06 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:06 INFO - PROCESS | 1669 | RSS: Main: 255205376 11:44:06 INFO - PROCESS | 1669 | 11:44:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:10 INFO - PROCESS | 1669 | RSS: Main: 256483328 11:44:10 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 11:44:12 INFO - PROCESS | 1669 | RSS: Main: 300720128 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | __start_tp_report 11:44:12 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 11:44:12 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 11:44:12 INFO - PROCESS | 1669 | |i|pagename|runs| 11:44:12 INFO - PROCESS | 1669 | |0;ai-astar;103;114;114;114;115;115;114;115;114;115 11:44:12 INFO - PROCESS | 1669 | |1;audio-beat-detection;142;106;108;141;105;113;135;137;145;107 11:44:12 INFO - PROCESS | 1669 | |2;audio-dft;181;184;181;183;183;183;184;183;181;184 11:44:12 INFO - PROCESS | 1669 | |3;audio-fft;81;59;58;88;59;59;57;59;82;57 11:44:12 INFO - PROCESS | 1669 | |4;audio-oscillator;92;68;94;70;68;68;91;67;69;89 11:44:12 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;88;90;86;89;84;116;88;90;85 11:44:12 INFO - PROCESS | 1669 | |6;imaging-darkroom;95;88;146;95;95;95;95;95;94;95 11:44:12 INFO - PROCESS | 1669 | |7;imaging-desaturate;83;85;94;85;84;85;86;84;85;103 11:44:12 INFO - PROCESS | 1669 | |8;json-parse-financial;55;52;51;53;54;56;55;55;57;57 11:44:12 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;61;102;107;91;71;67;68;68;68;70 11:44:12 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;84;80;82;82;81;83;85;87;87;94 11:44:12 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;133;134;135;135;161;140;144;144;146;134 11:44:12 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;165;181;137;219;221;210;157;160;159;156 11:44:12 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;64;66;65;65;65;64;66;64;65;64 11:44:12 INFO - PROCESS | 1669 | __end_tp_report 11:44:12 INFO - PROCESS | 1669 | __start_cc_report 11:44:12 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1845 11:44:12 INFO - PROCESS | 1669 | __end_cc_report 11:44:12 INFO - PROCESS | 1669 | __startTimestamp1479152652270__endTimestamp 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | ------- Summary: start ------- 11:44:12 INFO - PROCESS | 1669 | Number of tests: 14 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.50 stddev:3.65 (3.2%) stddev-sans-first:0.53 11:44:12 INFO - PROCESS | 1669 | Values: 103.0 114.0 114.0 114.0 115.0 115.0 114.0 115.0 114.0 115.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:136.00 stddev:17.30 (12.7%) stddev-sans-first:17.07 11:44:12 INFO - PROCESS | 1669 | Values: 142.0 106.0 108.0 141.0 105.0 113.0 135.0 137.0 145.0 107.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.25 (0.7%) stddev-sans-first:1.17 11:44:12 INFO - PROCESS | 1669 | Values: 181.0 184.0 181.0 183.0 183.0 183.0 184.0 183.0 181.0 184.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:65.90 Median:59.00 stddev:12.41 (21.0%) stddev-sans-first:11.90 11:44:12 INFO - PROCESS | 1669 | Values: 81.0 59.0 58.0 88.0 59.0 59.0 57.0 59.0 82.0 57.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.50 stddev:12.05 (15.2%) stddev-sans-first:11.60 11:44:12 INFO - PROCESS | 1669 | Values: 92.0 68.0 94.0 70.0 68.0 68.0 91.0 67.0 69.0 89.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:88.50 stddev:9.19 (10.4%) stddev-sans-first:9.73 11:44:12 INFO - PROCESS | 1669 | Values: 89.0 88.0 90.0 86.0 89.0 84.0 116.0 88.0 90.0 85.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:95.00 stddev:16.55 (17.4%) stddev-sans-first:17.48 11:44:12 INFO - PROCESS | 1669 | Values: 95.0 88.0 146.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:87.40 Median:85.00 stddev:6.28 (7.4%) stddev-sans-first:6.45 11:44:12 INFO - PROCESS | 1669 | Values: 83.0 85.0 94.0 85.0 84.0 85.0 86.0 84.0 85.0 103.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:2.01 (3.7%) stddev-sans-first:2.13 11:44:12 INFO - PROCESS | 1669 | Values: 55.0 52.0 51.0 53.0 54.0 56.0 55.0 55.0 57.0 57.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:77.30 Median:68.00 stddev:16.34 (24.0%) stddev-sans-first:16.24 11:44:12 INFO - PROCESS | 1669 | Values: 61.0 102.0 107.0 91.0 71.0 67.0 68.0 68.0 68.0 70.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:4.09 (4.8%) stddev-sans-first:4.33 11:44:12 INFO - PROCESS | 1669 | Values: 84.0 80.0 82.0 82.0 81.0 83.0 85.0 87.0 87.0 94.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:142.00 stddev:8.67 (6.1%) stddev-sans-first:8.75 11:44:12 INFO - PROCESS | 1669 | Values: 133.0 134.0 135.0 135.0 161.0 140.0 144.0 144.0 146.0 134.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:173.00 stddev:29.82 (17.2%) stddev-sans-first:31.33 11:44:12 INFO - PROCESS | 1669 | Values: 165.0 181.0 137.0 219.0 221.0 210.0 157.0 160.0 159.0 156.0 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 11:44:12 INFO - PROCESS | 1669 | Values: 64.0 66.0 65.0 65.0 65.0 64.0 66.0 64.0 65.0 64.0 11:44:12 INFO - PROCESS | 1669 | -------- Summary: end -------- 11:44:12 INFO - PROCESS | 1669 | 11:44:12 INFO - TEST-INFO | 1669: exit 0 11:44:13 INFO - TEST-OK | kraken | took 57686ms 11:44:13 INFO - SUITE-END | took 1172s 11:44:13 INFO - Completed test suite (00:19:33) 11:44:13 INFO - javascript benchmark 11:44:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3470.9305813883716, 3474.982625086875, 3522.0842580928966, 3549.077239917621, 3557.270759494304, 5770.451807078326, 5804.129380592914, 5842.532597392209, 5844.123381492778, 5876.412358764127, 4725.9054818903605, 5840.8247752567495, 5843.561732870031, 5848.795292164775, 5851.385604511529, 5273.050850846846, 5304.443033481468, 5321.840344789663, 5354.464553544633, 5363.6245462817615, 5247.344081989751, 5260.184671375943, 5400.567954563626, 5420.0, 5428.5928555358305, 5313.415524292324, 5347.518723314901, 5365.919511207316, 5369.24830523727, 5370.91943620846, 5334.946650533484, 5349.812756553541, 5353.277307563468, 5361.973190134064, 5365.061114304981, 5207.9479205207845, 5330.866728331784, 5339.279197308352, 5340.439253878326, 5343.919841202385, 5860.2967643883, 5980.671063091529, 5982.611130276518, 5986.0, 5999.220101386835, 6157.2919114301985, 6202.534809889276, 6325.810225693236, 6340.239171299428, 6372.044193370985, 6227.626342419424, 6288.151099601541, 6288.654124023177, 6337.714802833837, 6372.076048972873, 5919.822405327847, 5930.881382372371, 5931.466168044811, 5932.377100404482, 6002.759889604455, 6292.716827742763, 6343.397377249154, 6358.395952384516, 6369.745210191633, 6389.3291204423795, 6078.574499785061, 6086.330503644595, 6134.601250918676, 6165.72254248551, 6169.2288463942, 6282.748690052346, 6285.622862628257, 6292.653904035322, 6293.402126797947, 6304.936950630527, 5071.923921141186, 5863.5309175265875, 6097.115918191926, 6172.660503672251, 6213.968930155411, 6180.567360284737, 6181.1655426516845, 6211.720472578745, 6266.749330026748, 6347.428731414195, 5081.212412076134, 5086.262491938648, 5095.490450954875, 5107.897842043212, 5109.0, 4477.977610111929, 4539.977300113478, 4544.227481328182, 4552.339910712928, 4579.542045795394, 5773.797917072882, 5824.446677565625, 5832.591718579659, 5832.708364581754, 5855.619384739978, 6237.844053898689, 6276.058591211264, 6343.175387199634, 6348.77779277723, 6362.84092897672, 5883.499902508334, 5917.674527900921, 5921.259842519685, 5933.495652869468, 5937.0, 5383.380911195184, 5473.452654734495, 5545.500904918576, 5560.388357280696, 5561.6663000220115, 6325.683715814191, 6328.272248691367, 6386.87226255463, 6392.840178995562, 6492.740290388331, 6296.527760418078, 6310.6213627182515, 6321.778737744157, 6325.304216536086, 6332.810015699536, 5532.03189441838, 6444.2911279758255, 6456.0, 6504.674766261763, 6561.212654481493, 4635.0, 6118.43644382056, 6135.532964508949, 6163.0, 6170.92008898432, 6288.748450061947, 6304.7162877671535, 6319.652419116993, 6324.810255692337, 6327.620342779448, 5996.190514280691, 6209.379062093935, 6216.098665693358, 6219.129321895029, 6246.6876656166105, 6112.74665817949, 6118.20463339763, 6138.878900475427, 6166.506679465542, 6266.811995640138, 6183.0107182850525, 6186.350433204449, 6194.318624951342, 6197.81406557804, 6208.317085120543, 5198.844034678966, 6278.874422511615, 6279.434850863444, 6298.1812364392335, 6310.242770867525, 5845.853853653693, 5919.526437885045, 6065.909011364744, 6146.846328841814, 6155.784547540815], "value": 5782.355777214742, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.7142257490656, 500.4795013186284, 528.9761960711769, 554.6034585271533, 563.2340017576096, 32206.0, 41640.79179604101, 43064.56935430645, 43107.13785724284, 43148.56851431481, 43614.78192609041, 44099.77950110253, 44126.55873441265, 44135.0, 44249.0, 9324.720258392224, 10022.59909603615, 10220.233482488806, 10220.437875916821, 10239.078482936535, 9341.439513629204, 12361.814572781415, 12628.179168354074, 12636.052296077785, 12811.807822882663, 12426.0, 12499.3750312484, 12515.687107822287, 12515.937420312932, 12556.995440364795, 12587.622371328875, 12674.36628168588, 12678.61964141068, 12682.365881705879, 12702.682432939158, 12487.250764954131, 12572.874271257262, 12576.245425274512, 12577.434015469235, 12577.874221257853, 40302.798486007676, 40588.39117413241, 40672.77981660555, 40692.79653601743, 40788.77633670995, 3426.794392336468, 3556.5732112146447, 3706.4810926470313, 3950.3876899080688, 3989.4414781930554, 32144.83927580347, 32563.837180813945, 32703.67296327054, 33011.504827427605, 33548.83225583856, 3250.528673342376, 3298.5876765404323, 3338.2655815720505, 3343.3981883261004, 3348.29685765987, 509270.0, 509940.0, 510716.0, 511574.8842511565, 512290.0, 33920.49119263213, 59121.11318330229, 59585.702071489366, 59659.403405965386, 59848.401515985155, 35200.64799352025, 36419.27161456756, 36430.453543196345, 36487.81756091202, 36495.81752091223, 13442.731145377038, 15789.763153552476, 16053.277602507682, 16054.839451605569, 16090.0, 12310.199837010745, 12630.926371258362, 12634.81047784284, 13446.93276533611, 13563.932180339232, 7564.886526702104, 7621.771346859603, 7808.84382312362, 7981.48120372174, 8044.517328960281, 3304.3721692878275, 3353.8826141084946, 3356.3317162855587, 3378.5607870977105, 3386.610539787907, 984.104464936904, 1024.7233247023262, 1027.8098551767798, 1027.9023492768174, 1053.6312290698195, 25771.48457030849, 30842.228944276125, 30886.0, 31476.055718328487, 31590.0, 981.6711401680517, 1035.8394448860438, 1088.7985722641338, 1109.5672687651822, 1148.133159464599, 12908.16096953695, 13920.05119283301, 15962.840371596136, 16110.275037623334, 16215.919085312264, 694684.0, 701734.0, 708528.7441376767, 710618.0, 715248.0, 59018.40981590215, 59738.402615974155, 59808.40191598115, 59857.0, 59931.70034149889, 1306.405585458614, 1347.636138242669, 1366.1052010932656, 1443.1196969848595, 1449.326063380533, 30509.847450762605, 32151.0, 32376.514352284263, 32787.67212327846, 33015.17462063468, 48853.5114648849, 49378.75310623424, 49415.50584494109, 49546.50453495563, 49630.751846240535, 559675.0, 564371.0, 564637.0, 565473.345266542, 565613.0, 22505.887470563197, 26779.0, 26830.060947866732, 27528.58707119435, 27574.448511030067, 47696.046079078915, 47962.760186198844, 48123.75938120287, 48997.75501122472, 49175.0, 34054.65945340515, 39892.80053599829, 40008.79995600003, 40043.1991360177, 40336.19327613372, 39795.00512487211, 39991.0, 40054.59945400509, 41258.0, 41348.379774302804, 38811.536673282935, 39074.2185156301, 39635.405468918565, 39853.2029359417, 40048.79975600103, 33843.66156338405, 35160.0, 35610.82194589114, 35733.10667233236, 36304.0, 26478.735212647625, 26484.073057442896, 26699.19902402931, 26793.86603066972, 27416.862915685295], "value": 19672.338873912056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.57939238963775, 377.9886603401897, 378.990525236869, 396.142351808335, 402.8630265709658, 16081.542468369298, 17297.394591189295, 20761.896190519063, 20840.583188336223, 21485.462863428424, 20111.798882011175, 20409.4897627559, 20502.384928452135, 20668.0, 21121.788782112173, 5267.051930652481, 5650.124230744241, 5944.227250457435, 6161.753529858823, 6208.286047104596, 6105.908411373811, 6143.784967526138, 6156.722947467352, 6175.62946223228, 6176.876462470748, 4997.5252351026775, 5448.727563621823, 5832.0, 6121.908171377433, 6147.077938309245, 5931.169636250886, 6104.603200791957, 6182.907256391158, 6193.504519638418, 6215.192025036739, 5229.111051121318, 5765.596408251424, 5897.764089436418, 5971.134185543072, 5977.193078934375, 12785.808212876815, 12999.675008124777, 23477.88261058701, 23776.692281924486, 24376.634350484757, 1888.688366419539, 2181.8909054547366, 2204.867707937529, 2342.3090188394463, 2951.837648929308, 9550.713478595653, 9617.134457898752, 9849.90150098497, 9886.159676427513, 10182.643607473703, 1884.1897983866932, 1942.747442832437, 1956.833669138125, 1963.990180049105, 1988.145097608028, 86931.56534217352, 107373.46313268461, 123317.31603663604, 126037.0, 127518.08722869257, 11061.336319820837, 11135.777284454265, 11199.384033878216, 11398.715032124097, 11571.01646360052, 14406.639834004023, 14417.207053611943, 14419.855801442061, 14421.278936053155, 14423.85576144246, 8450.87323690145, 8764.03595604483, 8793.252573531194, 8842.734717958472, 8868.467891926504, 7976.481528700616, 8721.08428614999, 8724.171203735636, 8879.0, 8902.688405905763, 4402.295632698753, 4476.149531588988, 4498.167838949805, 4543.954560454353, 4557.339185818038, 1849.355421746888, 1903.3052935678377, 1927.4676632077533, 1932.120884997323, 1933.9613207735767, 800.4356928365488, 806.9354451643854, 897.8383890899701, 900.1628485508539, 965.4545181972304, 20068.69896951547, 20705.58588828215, 20759.27342543034, 20794.792052079287, 20957.790422095582, 911.6626848066126, 947.3984020147257, 957.4686049242737, 959.2805395953035, 1036.5801850250662, 10032.347897386646, 10669.626563070255, 10714.78570428587, 10738.892611073788, 10747.032767051003, 608166.0, 613083.0, 613497.0, 637339.0, 643972.0, 123934.38032809779, 131899.0, 134957.0, 138414.0, 143377.0, 969.9369540979814, 993.438707130469, 1027.3271007490107, 1027.6095083868083, 1028.6091285311534, 17627.735583966507, 18038.188281527626, 18349.633007340046, 18380.724289135407, 18669.533261668566, 49192.0, 49489.25766113583, 50375.74060648513, 50948.47154585368, 52912.0, 72873.27126728665, 74823.62588187242, 75011.62494187494, 77517.0, 78802.60598696969, 7689.231076892266, 7814.960925195338, 7841.451098423056, 7940.086890007723, 7940.960295198487, 10545.472726363805, 12309.815352769536, 12359.3820308986, 12642.683932901751, 12721.745565088831, 10649.307794993301, 10723.94638026836, 10732.0, 10924.945375273073, 11056.557737690402, 9463.952680236554, 9906.009399060325, 9931.056549627774, 10861.511231994737, 11116.277441966246, 10407.94796026015, 11028.558857645605, 11185.0, 11222.66332010041, 11418.973971897287, 7581.848363032598, 7640.274173953466, 7737.187595302412, 7949.085855126503, 8110.553919534246, 7914.643841027052, 9894.307398482037, 10647.77550581662, 10828.945855270673, 10921.563137474412], "value": 9416.728735591822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.666848290652, 1570.8821838362126, 1598.3047374392138, 1800.6488734696732, 1938.7770406403258, 8280.83438331233, 8831.205191532761, 9047.321450891177, 9322.254219662427, 9346.0, 7724.536527808335, 9213.539323033838, 9218.124278193578, 9352.298577606689, 9373.953130234357, 2455.2511483997373, 2481.7146028206716, 2481.937951551208, 2482.8013758899247, 2483.466054798218, 2419.177479656916, 2492.7382624824404, 2493.9376515587164, 2495.7129930058004, 2496.3634273260295, 2438.4879175373194, 2466.1984854922134, 2483.1184929350093, 2485.1674688979215, 2489.352768280242, 2426.0, 2451.3136321829916, 2461.3600463879343, 2462.544429280571, 2464.950700985979, 2266.9571996881455, 2424.115197952752, 2440.389902524369, 2443.2059580636187, 2452.828302018859, 7849.293563579248, 9231.307651926065, 9310.67412640561, 9313.90686093137, 9324.766880828034, 5455.8363249102595, 5676.432356764331, 5689.487946084831, 5722.570807189436, 5726.7995620153515, 3763.284975854579, 3799.202167544819, 3835.5972622874474, 3884.0, 3893.377059670439, 1111.1999360460457, 1113.6770336602376, 1114.1365441782602, 1128.1482480727082, 1137.7212582917155, 12280.0, 12315.261084334968, 12416.006719462512, 12423.0, 12454.626361209179, 4571.474280457724, 4586.243269860503, 4786.95213047865, 4790.928136077961, 4807.4471435784635, 9583.424994500352, 9617.23062155026, 9621.951890240643, 9623.422594644344, 9633.08485693858, 5482.945170548323, 5489.149181876815, 5494.09347457673, 5496.120620700749, 5505.972470137704, 4378.978105109454, 4646.4191976003, 4786.353842231254, 4815.3258543803895, 5156.510131537498, 3927.7839718815167, 3953.2291203215095, 4034.3141665916864, 4066.6340029397497, 4080.9183816323507, 1025.8615086963164, 1189.339916346436, 1190.0955273991656, 1194.396829601046, 1206.5113628980278, 845.4884794699242, 930.7254359963827, 949.7910459698855, 949.9145076943108, 952.9190018848337, 5985.934852475976, 6058.666773327421, 6166.414190651881, 6187.504999600022, 6194.566380353423, 445.0161666029266, 445.7058341494663, 460.0729529997059, 461.0249322682502, 465.28346346626495, 4083.1629515949157, 4090.079732060263, 4112.239235741397, 4142.440770495945, 4210.936835947463, 10849.403282819521, 11383.88616113845, 11394.25937314072, 11402.429878506042, 11408.771824563628, 11231.438428078563, 11275.54897804095, 11312.773744525064, 11324.433778311051, 11328.71678208035, 8183.386246031571, 8507.70223042203, 8563.100874408346, 8609.096044915319, 8625.482471051757, 6169.598976066542, 6206.379362063757, 6214.564980451506, 6240.469560087444, 6296.496280297657, 10444.112250458797, 10606.151507879196, 10708.3574985498, 10751.462426878781, 10767.407792571485, 9979.800403992025, 10341.069303762397, 10589.205809564159, 10960.671179864617, 10986.890131098588, 6291.842703932438, 7830.09953855314, 7974.481658692166, 8027.919720802717, 8048.396370272136, 8783.868241976503, 8799.824003520022, 8881.644734210558, 8914.643414263357, 8923.955380223057, 7784.883226751716, 7937.523748575104, 7986.520808751494, 7995.560244186626, 8071.23323284287, 7707.0, 7759.456838021284, 7786.065672119382, 7838.490498117604, 7898.2891539761695, 7291.52605080668, 7426.220246874001, 7436.702531898663, 7439.9256007439235, 7441.627918604157, 5141.768620412166, 5203.115470370122, 5319.0691628964005, 5409.187922046001, 5444.945550544602, 4009.6190861868076, 5245.423003469539, 5277.498637629419, 5365.839024829262, 5486.451354864482], "value": 4667.2458087437335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.8471994562826, 298.51193298956207, 305.6622432212406, 310.47374699883704, 314.317930091701, 3991.6407523322896, 4723.1734446471855, 5179.482051794828, 5337.653052551582, 5412.621116521845, 4823.855284341475, 5272.92090618641, 5337.11937530307, 5356.866078348044, 5368.986630013745, 3736.7757934524016, 3979.542352629441, 4129.132882094764, 4138.33786594145, 4143.337066069437, 4162.354835000579, 4178.937315940263, 4187.937180942288, 4189.162167566484, 4214.515330736974, 3999.960000399988, 4066.573009833969, 4130.8967275818195, 4132.2355364257555, 4172.603602657758, 4126.071633882382, 4127.33962565988, 4139.185353959307, 4156.43888075109, 4197.307444271692, 3108.8341871798075, 3440.122768693967, 3586.4082426399614, 3597.2086141048926, 3605.7295702822394, 4295.656347492193, 5215.739213039333, 5257.7108259045735, 5260.631755777097, 5316.362036555638, 4568.223402021665, 4609.787302095013, 4633.907321853544, 4642.605378542828, 4681.719096854165, 5283.28675628789, 5320.76056577455, 5621.297337832771, 5632.887342253173, 5681.034224181899, 3786.9053273668105, 3791.9241615167816, 3814.141818090935, 3817.4464702617965, 3827.158025234444, 5588.8542848715915, 5759.424057594249, 5780.219670344533, 5846.9183201107935, 5951.702414879239, 3158.7788854780406, 3513.631068737797, 3745.606711295329, 3838.251540949544, 3860.652541271299, 3933.331333673282, 3956.030772460708, 3959.6832253419657, 3983.183447393277, 3995.5604883462797, 4097.569755175723, 4569.086182763461, 4600.217962946307, 4601.608863246594, 4621.23749581322, 4674.555917187861, 5268.81559145428, 5285.603579731535, 5696.430356964271, 5709.600327977085, 1321.2799024531653, 1345.9501588760781, 1347.968803865044, 1348.3752078745088, 1358.830146231721, 719.4316489972967, 784.6273020315305, 814.9266566009088, 829.6805729794073, 830.9169083091642, 4001.599840015975, 4034.8789536313957, 4041.3937909313836, 4197.166912334163, 4495.977520112378, 4263.957360426418, 4813.831515896927, 4857.659963802571, 4894.066843596759, 4918.803247870045, 3849.0, 4373.310414095372, 4440.666949978765, 4483.237849565582, 4536.8638940831825, 2269.831037015938, 2391.7682393567325, 2485.6395822605623, 2494.5634513959985, 2539.9586169670347, 4588.247051768912, 4718.693284936468, 5005.299258103868, 5120.48795120485, 5135.563477104488, 4372.125574885035, 4876.439869068697, 4968.453470118284, 5038.883668859088, 5078.267473407042, 4262.0, 4365.890852728708, 4640.628749700083, 4722.197226471577, 4785.521447855187, 4212.736179146183, 4800.4479484859685, 4838.854834354975, 4884.926726099183, 4952.950470495249, 4769.236922092448, 4784.6889952153, 4809.797550612347, 4822.831200907952, 4845.5881250092725, 4516.458025037016, 4786.659735274129, 5091.567216786467, 5110.514501122388, 5155.381354237516, 3364.713999310086, 3366.495025746158, 3418.3163367327134, 3424.520567120655, 3428.674275943781, 4721.945953510234, 4864.635152363516, 4924.8276310328965, 4930.6055515557955, 4958.42978057528, 4325.39444477767, 4499.865004049884, 4538.546145385567, 4620.838270660645, 4842.9757851211925, 3967.4048892666333, 4035.256025902297, 4192.7065105442325, 4213.873583792491, 4826.227803551415, 4146.79266036703, 4322.697411181187, 4388.29787234041, 4597.655175861891, 4692.859214223578, 3832.9808350958065, 3902.9804850975565, 4400.669949753717, 4527.501974782837, 4787.385523929411, 4126.401671757519, 4674.205385084611, 4718.301411491929, 4753.358296630049, 4760.500147484464], "value": 3775.495078351488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.2208037399984, 755.7921571567819, 810.8418858322626, 859.6819176904546, 889.3818795936827, 16276.511704648865, 17352.219150138244, 17389.47831565055, 17622.295108195674, 18030.729539056923, 15736.898417110808, 16110.83889161108, 16151.192440377963, 16153.353865845382, 16172.514824555254, 728.6283995162479, 746.6117618838201, 896.9596368163416, 900.1898291537619, 921.3274309753883, 909.0636644256426, 926.7080869526111, 928.1461055828654, 929.3866048408051, 930.0652843891913, 980.8528720691918, 983.2281658897766, 984.5717113055808, 985.6057576969198, 987.6444479987199, 973.3673112476876, 973.7808992976594, 974.5565767575736, 975.0688092871362, 978.0952618827556, 716.7312257903286, 718.3821913154683, 720.2797202797203, 720.672094197139, 720.989185162223, 15905.363785448568, 16786.580335491588, 16989.660206795917, 17011.659766804594, 17047.744283835753, 11085.612003579836, 13046.217226966317, 13063.86936130636, 13124.934375328157, 13294.0, 12216.755664886741, 12257.693557661041, 12767.680807979781, 13247.138935969131, 13789.0, 4019.537753158395, 4062.580606758087, 4097.549269580344, 4133.7106402551835, 4244.702870799046, 118099.0, 120214.3989280048, 121925.0, 124598.0, 125128.37435812854, 9968.80062398748, 10430.843537346946, 11427.771444571063, 11785.823212651818, 12137.635870923887, 24355.14756983497, 24881.129160479297, 24894.0, 24896.875515622305, 24923.75076249214, 8411.957940210259, 8594.312455003585, 8693.956530217309, 8851.822963540693, 9039.954800225956, 4549.840755573539, 4624.0, 4629.907401851944, 4780.0, 4892.0, 3793.9566619179395, 3928.1554465789422, 3931.941020884689, 3933.5083114610675, 3933.645971862546, 696.4498046543174, 716.1084449859853, 716.5915428205873, 751.898493703354, 755.3579457461224, 488.6603810351771, 580.8693044065136, 633.7528363938068, 701.4073108223542, 703.3002162848, 9209.125133112344, 10058.245631577662, 10181.592736290613, 10186.592536298613, 10210.132138768287, 560.3555910702643, 681.3629256645053, 686.2656957055902, 692.7125243024088, 723.780429975493, 4967.205247160437, 4977.875553111201, 5024.196128619404, 5024.79900803971, 5025.170846810309, 102615.0, 105055.0, 126104.0, 157381.42618573896, 166244.16877915533, 139033.91449128272, 143513.0, 143814.2809285947, 143838.5616143846, 147491.2625436866, 99094.0, 124090.37954810349, 126773.73226267804, 128874.35562822125, 130023.0, 9430.387024843363, 9432.292578056811, 9530.85703714431, 9537.332386732862, 9570.0, 61132.0, 70293.29706703073, 70536.64731676309, 70977.87066388017, 71626.64186679033, 82480.76278855943, 97060.6028788989, 107226.46386768016, 109348.35977460185, 111146.0, 12453.25280483174, 12502.874971250534, 12556.811647825107, 12745.808812868, 12884.291363975071, 13370.331483425984, 13472.663183420102, 13763.518276860263, 14448.422063117778, 14579.635509111933, 11141.554337826396, 11556.422178890854, 11603.187776855877, 11691.707707307385, 12203.572874949334, 12600.369981501071, 12699.42852571655, 13025.869741302844, 13119.67200819949, 13177.93411032977, 12299.200551964093, 12479.812802807783, 12652.620421387373, 12893.290869002294, 12931.28877911724, 9828.655997040069, 10633.946830266108, 11045.33727976324, 11289.37908415045, 11302.886971130183, 10900.727481813017, 11053.557857685924, 11312.717182070513, 11318.660440186808, 11368.090552755595], "value": 8169.2613090316645, "unit": "score"}], "name": "dromaeo_css", "value": 7322.979570848575, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 106.0, 108.0, 141.0, 105.0, 113.0, 135.0, 137.0, 145.0, 107.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 181.0, 183.0, 183.0, 183.0, 184.0, 183.0, 181.0, 184.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 59.0, 59.0, 57.0, 59.0, 82.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 68.0, 94.0, 70.0, 68.0, 68.0, 91.0, 67.0, 69.0, 89.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 86.0, 89.0, 84.0, 116.0, 88.0, 90.0, 85.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 146.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 94.0, 85.0, 84.0, 85.0, 86.0, 84.0, 85.0, 103.0], "value": 87.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 53.0, 54.0, 56.0, 55.0, 55.0, 57.0, 57.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 102.0, 107.0, 91.0, 71.0, 67.0, 68.0, 68.0, 68.0, 70.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 82.0, 82.0, 81.0, 83.0, 85.0, 87.0, 87.0, 94.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 135.0, 135.0, 161.0, 140.0, 144.0, 144.0, 146.0, 134.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 181.0, 137.0, 219.0, 221.0, 210.0, 157.0, 160.0, 159.0, 156.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 65.0, 64.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1438.7999999999997, "alertThreshold": 2.0}]} 11:44:13 INFO - Return code: 0 11:44:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:13 INFO - # TBPL SUCCESS # 11:44:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:44:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:44:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:44:13 INFO - 2016-11-14 11:44:13.613 screenresolution[1673:10191] starting screenresolution argv=screenresolution get 11:44:13 INFO - 2016-11-14 11:44:13.615 screenresolution[1673:10191] Display 0: 1600x1200x32@60 11:44:13 INFO - 2016-11-14 11:44:13.621 screenresolution[1674:10194] starting screenresolution argv=screenresolution list 11:44:13 INFO - Available Modes on Display 0 11:44:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:44:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:44:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:44:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:44:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:44:13 INFO - Intel Iris: 11:44:13 INFO - Chipset Model: Intel Iris 11:44:13 INFO - Type: GPU 11:44:13 INFO - Bus: Built-In 11:44:13 INFO - VRAM (Dynamic, Max): 1536 MB 11:44:13 INFO - Vendor: Intel (0x8086) 11:44:13 INFO - Device ID: 0x0a2e 11:44:13 INFO - Revision ID: 0x0009 11:44:13 INFO - Displays: 11:44:13 INFO - Display: 11:44:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:44:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:44:13 INFO - Display Serial Number: 1600x1200 60 11:44:13 INFO - Main Display: Yes 11:44:13 INFO - Mirror: Off 11:44:13 INFO - Online: Yes 11:44:13 INFO - Rotation: Supported 11:44:13 INFO - Return code: 0 11:44:13 INFO - Running post-action listener: _resource_record_post_action 11:44:13 INFO - [mozharness: 2016-11-14 19:44:13.856711Z] Finished run-tests step (success) 11:44:13 INFO - Running post-run listener: _resource_record_post_run 11:44:13 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 38769664; Write bytes: 495208960; Read time: 382; Write time: 1568 11:44:13 INFO - TinderboxPrint: CPU usage
53.5% 11:44:13 INFO - TinderboxPrint: I/O read bytes / time
38,769,664 / 382 11:44:13 INFO - TinderboxPrint: I/O write bytes / time
495,208,960 / 1,568 11:44:13 INFO - TinderboxPrint: CPU idle
2,225.2 (46.5%) 11:44:13 INFO - TinderboxPrint: CPU system
954.5 (20.0%) 11:44:13 INFO - TinderboxPrint: CPU user
1,602.0 (33.5%) 11:44:13 INFO - TinderboxPrint: Swap in / out
233,521,152 / 0 11:44:13 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192373248; Write bytes: 187439104; Read time: 17603; Write time: 397 11:44:13 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36664320; Write bytes: 296362496; Read time: 357; Write time: 1137 11:44:14 INFO - Running post-run listener: _upload_blobber_files 11:44:14 INFO - Blob upload gear active. 11:44:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:14 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 11:44:14 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:14 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:14 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:15 INFO - (blobuploader) - INFO - Done attempting. 11:44:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:16 INFO - (blobuploader) - INFO - Done attempting. 11:44:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:18 INFO - (blobuploader) - INFO - Done attempting. 11:44:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:18 INFO - Return code: 0 11:44:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54a16dc72d89361367afc2b0bc019f532c0aaa4063134640370dfb620d452123231f2c24c7dc4185e350c194b4a8ca764b121e612479724a8e2ab265b454d646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358a22cc9cbd8167b84d7a9acdb2336660c19171f26143f7ad1c0dfdce6947d8ca896397bffc9b8d69ae745efffce81d446a7f79e2cd1ae52fd2d192258eab12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df631224e7e53370f487223d403771c76e0195227a22082abd927bc902313da8840ccd3da0688f8c29841cbadbbfe8f3b1a97e82a2b63e1e2972c970c1da0b10"} 11:44:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:18 INFO - Contents: 11:44:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54a16dc72d89361367afc2b0bc019f532c0aaa4063134640370dfb620d452123231f2c24c7dc4185e350c194b4a8ca764b121e612479724a8e2ab265b454d646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358a22cc9cbd8167b84d7a9acdb2336660c19171f26143f7ad1c0dfdce6947d8ca896397bffc9b8d69ae745efffce81d446a7f79e2cd1ae52fd2d192258eab12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df631224e7e53370f487223d403771c76e0195227a22082abd927bc902313da8840ccd3da0688f8c29841cbadbbfe8f3b1a97e82a2b63e1e2972c970c1da0b10"} 11:44:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:18 INFO - Copying logs to upload dir... 11:44:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.257655 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-14 11:44:18.994417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:19.001578) ========= 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.SOxvdpDOte/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.8WQxCZjJkA/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-Beta/sha512/54a16dc72d89361367afc2b0bc019f532c0aaa4063134640370dfb620d452123231f2c24c7dc4185e350c194b4a8ca764b121e612479724a8e2ab265b454d646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358a22cc9cbd8167b84d7a9acdb2336660c19171f26143f7ad1c0dfdce6947d8ca896397bffc9b8d69ae745efffce81d446a7f79e2cd1ae52fd2d192258eab12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df631224e7e53370f487223d403771c76e0195227a22082abd927bc902313da8840ccd3da0688f8c29841cbadbbfe8f3b1a97e82a2b63e1e2972c970c1da0b10"} build_url:https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/SnEGpD-WSiimTc4fFB2jpg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54a16dc72d89361367afc2b0bc019f532c0aaa4063134640370dfb620d452123231f2c24c7dc4185e350c194b4a8ca764b121e612479724a8e2ab265b454d646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358a22cc9cbd8167b84d7a9acdb2336660c19171f26143f7ad1c0dfdce6947d8ca896397bffc9b8d69ae745efffce81d446a7f79e2cd1ae52fd2d192258eab12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df631224e7e53370f487223d403771c76e0195227a22082abd927bc902313da8840ccd3da0688f8c29841cbadbbfe8f3b1a97e82a2b63e1e2972c970c1da0b10"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:19.034092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:19.034425) ========= 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.SOxvdpDOte/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.8WQxCZjJkA/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005313 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:19.086918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:44:19.089269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:44:19.089590) ========= ========= Total master_lag: 0.20 =========