builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1487216097.42 results: success (0) buildid: 20170215180719 builduid: d5527cc6891d4a26a79498a8e8ddad2e revision: d956e48d28dfd1b6cc180b92b1bf170f0438569e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.424416) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.424880) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.425152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.449819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.450099) ========= 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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-15 19:34:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.95M=0.002s 2017-02-15 19:34:57 (6.95 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151367 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.628064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.628827) ========= 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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.022283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.678320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:57.678684) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d956e48d28dfd1b6cc180b92b1bf170f0438569e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d956e48d28dfd1b6cc180b92b1bf170f0438569e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-15 19:34:57,760 truncating revision to first 12 chars 2017-02-15 19:34:57,760 Setting DEBUG logging. 2017-02-15 19:34:57,760 attempt 1/10 2017-02-15 19:34:57,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d956e48d28df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 19:34:58,474 unpacking tar archive at: mozilla-aurora-d956e48d28df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973655 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:58.676272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:58.676655) ========= script_repo_revision: d956e48d28dfd1b6cc180b92b1bf170f0438569e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:58.677123) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:58.677421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 19:34:58.697202) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-15 19:34:58.697511) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:34:58 INFO - MultiFileLogger online at 20170215 19:34:58 in /builds/slave/test 19:34:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:34:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:34:58 INFO - {'append_to_log': False, 19:34:58 INFO - 'base_work_dir': '/builds/slave/test', 19:34:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:34:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:34:58 INFO - 'branch': 'Mozilla-Aurora', 19:34:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:34:58 INFO - 'config_files': ('talos/mac_config.py',), 19:34:58 INFO - 'default_actions': ('clobber', 19:34:58 INFO - 'read-buildbot-config', 19:34:58 INFO - 'download-and-extract', 19:34:58 INFO - 'populate-webroot', 19:34:58 INFO - 'create-virtualenv', 19:34:58 INFO - 'install', 19:34:58 INFO - 'run-tests'), 19:34:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:34:58 INFO - 'download_minidump_stackwalk': True, 19:34:58 INFO - 'download_symbols': 'ondemand', 19:34:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:34:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:34:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:34:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:34:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:34:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:34:58 INFO - 'installer_path': 'installer.exe', 19:34:58 INFO - 'log_level': 'info', 19:34:58 INFO - 'log_name': 'talos', 19:34:58 INFO - 'log_to_console': True, 19:34:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:34:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:34:58 INFO - 'opt_config_files': (), 19:34:58 INFO - 'pip_index': False, 19:34:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:58 INFO - 'cmd': ('bash', 19:34:58 INFO - '-c', 19:34:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:58 INFO - 'enabled': True, 19:34:58 INFO - 'halt_on_failure': False, 19:34:58 INFO - 'name': 'check_screen_resolution'},), 19:34:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:58 INFO - 'cmd': ('bash', 19:34:58 INFO - '-c', 19:34:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:58 INFO - 'enabled': True, 19:34:58 INFO - 'halt_on_failure': False, 19:34:58 INFO - 'name': 'check_screen_resolution'},), 19:34:58 INFO - 'run_cmd_checks_enabled': True, 19:34:58 INFO - 'sps_profile': False, 19:34:58 INFO - 'sps_profile_interval': 0, 19:34:58 INFO - 'suite': 'dromaeojs-e10s', 19:34:58 INFO - 'system_bits': '32', 19:34:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:34:58 INFO - 'title': 't-yosemite-r7-0086', 19:34:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:34:58 INFO - 'use_talos_json': True, 19:34:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:34:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:34:58 INFO - 'work_dir': 'build'} 19:34:58 INFO - [mozharness: 2017-02-16 03:34:58.907778Z] Running clobber step. 19:34:58 INFO - Running pre-action listener: _resource_record_pre_action 19:34:58 INFO - Running main action method: clobber 19:34:58 INFO - rmtree: /builds/slave/test/build 19:34:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:35:02 INFO - Running post-action listener: _resource_record_post_action 19:35:02 INFO - [mozharness: 2017-02-16 03:35:02.029093Z] Finished clobber step (success) 19:35:02 INFO - [mozharness: 2017-02-16 03:35:02.029233Z] Running read-buildbot-config step. 19:35:02 INFO - Running pre-action listener: _resource_record_pre_action 19:35:02 INFO - Running main action method: read_buildbot_config 19:35:02 INFO - Using buildbot properties: 19:35:02 INFO - { 19:35:02 INFO - "project": "", 19:35:02 INFO - "product": "firefox", 19:35:02 INFO - "script_repo_revision": "production", 19:35:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:35:02 INFO - "repository": "", 19:35:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:35:02 INFO - "buildid": "20170215180719", 19:35:02 INFO - "pgo_build": "False", 19:35:02 INFO - "basedir": "/builds/slave/test", 19:35:02 INFO - "buildnumber": 2, 19:35:02 INFO - "slavename": "t-yosemite-r7-0086", 19:35:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:35:02 INFO - "platform": "yosemite_r7", 19:35:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:35:02 INFO - "branch": "mozilla-aurora", 19:35:02 INFO - "repo_path": "releases/mozilla-aurora", 19:35:02 INFO - "revision": "d956e48d28dfd1b6cc180b92b1bf170f0438569e", 19:35:02 INFO - "stage_platform": "macosx64", 19:35:02 INFO - "builduid": "d5527cc6891d4a26a79498a8e8ddad2e", 19:35:02 INFO - "slavebuilddir": "test" 19:35:02 INFO - } 19:35:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 19:35:02 INFO - Running post-action listener: _resource_record_post_action 19:35:02 INFO - [mozharness: 2017-02-16 03:35:02.032532Z] Finished read-buildbot-config step (success) 19:35:02 INFO - [mozharness: 2017-02-16 03:35:02.032666Z] Running download-and-extract step. 19:35:02 INFO - Running pre-action listener: _resource_record_pre_action 19:35:02 INFO - Running main action method: download_and_extract 19:35:02 INFO - mkdir: /builds/slave/test/build/tests 19:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:02 INFO - trying https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 19:35:02 INFO - Downloading https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 19:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 19:35:03 INFO - Downloaded 1199 bytes. 19:35:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 19:35:03 INFO - Using the following test package requirements: 19:35:03 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 19:35:03 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 19:35:03 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 19:35:03 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'jsshell-mac.zip'], 19:35:03 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 19:35:03 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 19:35:03 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 19:35:03 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 19:35:03 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 19:35:03 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 19:35:03 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 19:35:03 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:35:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 19:35:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:35:03 INFO - Fetch https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 19:35:04 INFO - Expected file size: 16358341 19:35:04 INFO - Obtained file size: 16358341 19:35:11 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 19:35:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 19:35:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:35:11 INFO - Fetch https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 19:35:12 INFO - Expected file size: 16358341 19:35:12 INFO - Obtained file size: 16358341 19:35:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 19:35:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:35:18 INFO - Fetch https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 19:35:19 INFO - Expected file size: 14403485 19:35:19 INFO - Obtained file size: 14403485 19:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:19 INFO - trying https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:35:19 INFO - Downloading https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 19:35:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 19:35:22 INFO - Downloaded 73946465 bytes. 19:35:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:35:22 INFO - mkdir: /builds/slave/test/properties 19:35:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:35:22 INFO - Writing to file /builds/slave/test/properties/build_url 19:35:22 INFO - Contents: 19:35:22 INFO - build_url:https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 19:35:22 INFO - Running post-action listener: _resource_record_post_action 19:35:22 INFO - Running post-action listener: set_extra_try_arguments 19:35:22 INFO - [mozharness: 2017-02-16 03:35:22.713331Z] Finished download-and-extract step (success) 19:35:22 INFO - [mozharness: 2017-02-16 03:35:22.713459Z] Running populate-webroot step. 19:35:22 INFO - Running pre-action listener: _resource_record_pre_action 19:35:22 INFO - Running main action method: populate_webroot 19:35:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:35:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:35:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:35:22 INFO - '--tppagecycles', 19:35:22 INFO - '7'], 19:35:22 INFO - 'tests': ['tsvgm']}}, 19:35:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:35:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:35:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:35:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:35:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:35:22 INFO - 'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:35:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:35:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:35:22 INFO - 'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['damp', 'tps']}, 19:35:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:35:22 INFO - 'tests': ['damp', 'tps']}, 19:35:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['dromaeo_dom']}, 19:35:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:35:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['basic_compositor_video']}, 19:35:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:35:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['a11yr', 19:35:22 INFO - 'ts_paint', 19:35:22 INFO - 'tpaint', 19:35:22 INFO - 'sessionrestore', 19:35:22 INFO - 'sessionrestore_no_auto_restore', 19:35:22 INFO - 'tabpaint']}, 19:35:22 INFO - 'other-e10s': {'tests': ['a11yr', 19:35:22 INFO - 'ts_paint', 19:35:22 INFO - 'tpaint', 19:35:22 INFO - 'sessionrestore', 19:35:22 INFO - 'sessionrestore_no_auto_restore', 19:35:22 INFO - 'tabpaint']}, 19:35:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:35:22 INFO - 'ts_paint', 19:35:22 INFO - 'tpaint', 19:35:22 INFO - 'sessionrestore', 19:35:22 INFO - 'sessionrestore_no_auto_restore', 19:35:22 INFO - 'tabpaint']}, 19:35:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:35:22 INFO - 'ts_paint', 19:35:22 INFO - 'tpaint', 19:35:22 INFO - 'sessionrestore', 19:35:22 INFO - 'sessionrestore_no_auto_restore', 19:35:22 INFO - 'tabpaint']}, 19:35:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['a11yr', 19:35:22 INFO - 'ts_paint', 19:35:22 INFO - 'tpaint', 19:35:22 INFO - 'sessionrestore', 19:35:22 INFO - 'sessionrestore_no_auto_restore', 19:35:22 INFO - 'tabpaint']}, 19:35:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['a11yr', 19:35:22 INFO - 'ts_paint', 19:35:22 INFO - 'tpaint', 19:35:22 INFO - 'sessionrestore', 19:35:22 INFO - 'sessionrestore_no_auto_restore', 19:35:22 INFO - 'tabpaint']}, 19:35:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['tsvgx', 19:35:22 INFO - 'tsvgr_opacity', 19:35:22 INFO - 'tart', 19:35:22 INFO - 'tscrollx', 19:35:22 INFO - 'cart', 19:35:22 INFO - 'tsvg_static']}, 19:35:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:35:22 INFO - 'tsvgr_opacity', 19:35:22 INFO - 'tart', 19:35:22 INFO - 'tscrollx', 19:35:22 INFO - 'cart', 19:35:22 INFO - 'tsvg_static']}, 19:35:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:35:22 INFO - 'talos_options': ['--disable-e10s'], 19:35:22 INFO - 'tests': ['tp5o']}, 19:35:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:35:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:35:22 INFO - 'talos_options': ['--disable-e10s', 19:35:22 INFO - '--xperf_path', 19:35:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:22 INFO - 'tests': ['tp5n']}, 19:35:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:35:22 INFO - 'talos_options': ['--xperf_path', 19:35:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:35:22 INFO - 'tests': ['tp5n']}}, 19:35:22 INFO - 'talos.zip': {'path': '', 19:35:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:35:22 INFO - Running post-action listener: _resource_record_post_action 19:35:22 INFO - [mozharness: 2017-02-16 03:35:22.731777Z] Finished populate-webroot step (success) 19:35:22 INFO - [mozharness: 2017-02-16 03:35:22.731909Z] Running create-virtualenv step. 19:35:22 INFO - Running pre-action listener: _resource_record_pre_action 19:35:22 INFO - Running main action method: create_virtualenv 19:35:22 INFO - Creating virtualenv /builds/slave/test/build/venv 19:35:22 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 19:35:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:35:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:35:22 INFO - Using real prefix '/tools/python27' 19:35:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:35:23 INFO - Installing distribute.............................................................................................................................................................................................done. 19:35:26 INFO - Installing pip.................done. 19:35:26 INFO - Return code: 0 19:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:35:26 INFO - Reading from file tmpfile_stdout 19:35:26 INFO - Output received: 19:35:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:35:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:35:26 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')]} 19:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:26 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')]} 19:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:26 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:26 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 19:35:26 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 19:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:26 INFO - 'HOME': '/Users/cltbld', 19:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:26 INFO - 'LOGNAME': 'cltbld', 19:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:26 INFO - 'MOZ_NO_REMOTE': '1', 19:35:26 INFO - 'NO_EM_RESTART': '1', 19:35:26 INFO - 'PAGER': '/bin/cat', 19:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:26 INFO - 'PWD': '/builds/slave/test', 19:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:26 INFO - 'SHELL': '/bin/bash', 19:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:26 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:26 INFO - 'USER': 'cltbld', 19:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:26 INFO - 'XPC_FLAGS': '0x0', 19:35:26 INFO - 'XPC_SERVICE_NAME': '0', 19:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:26 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 19:35:26 INFO - Cleaning up... 19:35:27 INFO - Return code: 0 19:35:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:35:27 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')]} 19:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:27 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')]} 19:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:27 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:27 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 19:35:27 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 19:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:27 INFO - 'HOME': '/Users/cltbld', 19:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:27 INFO - 'LOGNAME': 'cltbld', 19:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:27 INFO - 'MOZ_NO_REMOTE': '1', 19:35:27 INFO - 'NO_EM_RESTART': '1', 19:35:27 INFO - 'PAGER': '/bin/cat', 19:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:27 INFO - 'PWD': '/builds/slave/test', 19:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:27 INFO - 'SHELL': '/bin/bash', 19:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:27 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:27 INFO - 'USER': 'cltbld', 19:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:27 INFO - 'XPC_FLAGS': '0x0', 19:35:27 INFO - 'XPC_SERVICE_NAME': '0', 19:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:27 INFO - Downloading/unpacking psutil>=3.1.1 19:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:35:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:35:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:35:30 INFO - Installing collected packages: psutil 19:35:30 INFO - Running setup.py install for psutil 19:35:30 INFO - building 'psutil._psutil_osx' extension 19:35:30 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 19:35:31 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 19:35:31 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 19:35:31 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 19:35:31 INFO - building 'psutil._psutil_posix' extension 19:35:31 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 19:35:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:35:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:35:31 INFO - ^ 19:35:31 INFO - 1 warning generated. 19:35:31 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 19:35:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:35:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:35:31 INFO - Successfully installed psutil 19:35:31 INFO - Cleaning up... 19:35:31 INFO - Return code: 0 19:35:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:35:31 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')]} 19:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:31 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')]} 19:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:31 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:31 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 19:35:31 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 19:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:31 INFO - 'HOME': '/Users/cltbld', 19:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:31 INFO - 'LOGNAME': 'cltbld', 19:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:31 INFO - 'MOZ_NO_REMOTE': '1', 19:35:31 INFO - 'NO_EM_RESTART': '1', 19:35:31 INFO - 'PAGER': '/bin/cat', 19:35:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:31 INFO - 'PWD': '/builds/slave/test', 19:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:31 INFO - 'SHELL': '/bin/bash', 19:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:31 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:31 INFO - 'USER': 'cltbld', 19:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:31 INFO - 'XPC_FLAGS': '0x0', 19:35:31 INFO - 'XPC_SERVICE_NAME': '0', 19:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:35:31 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 19:35:31 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 19:35:31 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 19:35:31 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 19:35:31 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 19:35:31 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 19:35:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:35:34 INFO - Installing collected packages: mozsystemmonitor 19:35:34 INFO - Running setup.py install for mozsystemmonitor 19:35:34 INFO - Successfully installed mozsystemmonitor 19:35:34 INFO - Cleaning up... 19:35:34 INFO - Return code: 0 19:35:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:34 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:34 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 19:35:34 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 19:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:34 INFO - 'HOME': '/Users/cltbld', 19:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:34 INFO - 'LOGNAME': 'cltbld', 19:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:34 INFO - 'MOZ_NO_REMOTE': '1', 19:35:34 INFO - 'NO_EM_RESTART': '1', 19:35:34 INFO - 'PAGER': '/bin/cat', 19:35:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:34 INFO - 'PWD': '/builds/slave/test', 19:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:34 INFO - 'SHELL': '/bin/bash', 19:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:34 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:34 INFO - 'USER': 'cltbld', 19:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:34 INFO - 'XPC_FLAGS': '0x0', 19:35:34 INFO - 'XPC_SERVICE_NAME': '0', 19:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:35 INFO - Downloading/unpacking jsonschema==2.5.1 19:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:35:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:35:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:35:37 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 19:35:37 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 19:35:37 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 19:35:37 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 19:35:37 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 19:35:37 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 19:35:38 INFO - Downloading functools32-3.2.3-2.tar.gz 19:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:35:38 INFO - warning: no files found matching '*.txt' 19:35:38 INFO - no previously-included directories found matching 'build' 19:35:38 INFO - no previously-included directories found matching 'dist' 19:35:38 INFO - no previously-included directories found matching '.git*' 19:35:38 INFO - Installing collected packages: jsonschema, functools32 19:35:38 INFO - Running setup.py install for functools32 19:35:38 INFO - warning: no files found matching '*.txt' 19:35:38 INFO - no previously-included directories found matching 'build' 19:35:38 INFO - no previously-included directories found matching 'dist' 19:35:38 INFO - no previously-included directories found matching '.git*' 19:35:38 INFO - Successfully installed jsonschema functools32 19:35:38 INFO - Cleaning up... 19:35:38 INFO - Return code: 0 19:35:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:38 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:38 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 19:35:38 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 19:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:38 INFO - 'HOME': '/Users/cltbld', 19:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:38 INFO - 'LOGNAME': 'cltbld', 19:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:38 INFO - 'MOZ_NO_REMOTE': '1', 19:35:38 INFO - 'NO_EM_RESTART': '1', 19:35:38 INFO - 'PAGER': '/bin/cat', 19:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:38 INFO - 'PWD': '/builds/slave/test', 19:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:38 INFO - 'SHELL': '/bin/bash', 19:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:38 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:38 INFO - 'USER': 'cltbld', 19:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:38 INFO - 'XPC_FLAGS': '0x0', 19:35:38 INFO - 'XPC_SERVICE_NAME': '0', 19:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:35:38 INFO - Cleaning up... 19:35:38 INFO - Return code: 0 19:35:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:38 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:38 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 19:35:38 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 19:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:38 INFO - 'HOME': '/Users/cltbld', 19:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:38 INFO - 'LOGNAME': 'cltbld', 19:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:38 INFO - 'MOZ_NO_REMOTE': '1', 19:35:38 INFO - 'NO_EM_RESTART': '1', 19:35:38 INFO - 'PAGER': '/bin/cat', 19:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:38 INFO - 'PWD': '/builds/slave/test', 19:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:38 INFO - 'SHELL': '/bin/bash', 19:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:38 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:38 INFO - 'USER': 'cltbld', 19:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:38 INFO - 'XPC_FLAGS': '0x0', 19:35:38 INFO - 'XPC_SERVICE_NAME': '0', 19:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:39 INFO - Downloading/unpacking blobuploader==1.2.4 19:35:39 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 19:35:39 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 19:35:39 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 19:35:39 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 19:35:39 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 19:35:39 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 19:35:41 INFO - Downloading blobuploader-1.2.4.tar.gz 19:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:35:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:35:41 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 19:35:41 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 19:35:41 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 19:35:41 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 19:35:41 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 19:35:41 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 19:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:35:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:35:42 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 19:35:42 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 19:35:42 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 19:35:42 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 19:35:42 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 19:35:42 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 19:35:42 INFO - Downloading docopt-0.6.1.tar.gz 19:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:35:43 INFO - Installing collected packages: blobuploader, requests, docopt 19:35:43 INFO - Running setup.py install for blobuploader 19:35:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:35:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:35:43 INFO - Running setup.py install for requests 19:35:43 INFO - Running setup.py install for docopt 19:35:43 INFO - Successfully installed blobuploader requests docopt 19:35:43 INFO - Cleaning up... 19:35:44 INFO - Return code: 0 19:35:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35:44 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')]} 19:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:44 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')]} 19:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:44 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:44 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 19:35:44 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 19:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:44 INFO - 'HOME': '/Users/cltbld', 19:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:44 INFO - 'LOGNAME': 'cltbld', 19:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:44 INFO - 'MOZ_NO_REMOTE': '1', 19:35:44 INFO - 'NO_EM_RESTART': '1', 19:35:44 INFO - 'PAGER': '/bin/cat', 19:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:44 INFO - 'PWD': '/builds/slave/test', 19:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:44 INFO - 'SHELL': '/bin/bash', 19:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:44 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:44 INFO - 'USER': 'cltbld', 19:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:44 INFO - 'XPC_FLAGS': '0x0', 19:35:44 INFO - 'XPC_SERVICE_NAME': '0', 19:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:35:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-G4cv74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:35:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-lbhTat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:35:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-UflMuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:35:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rBjPoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:35:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rxTp9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:35:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-qYlOb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:35:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rCkv2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-syuToo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-MgOVsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-iZX2AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-g0EHYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-m6oXob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Hugkov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-6SG77w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jxbC0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8RwRda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:35:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-L6h4PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:35:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:35:46 INFO - Running setup.py install for manifestparser 19:35:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:35:46 INFO - Running setup.py install for mozcrash 19:35:46 INFO - Running setup.py install for mozdebug 19:35:46 INFO - Running setup.py install for mozdevice 19:35:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:35:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:35:46 INFO - Running setup.py install for mozfile 19:35:46 INFO - Running setup.py install for mozhttpd 19:35:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:35:46 INFO - Running setup.py install for mozinfo 19:35:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:35:47 INFO - Running setup.py install for mozInstall 19:35:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:35:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:35:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:35:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:35:47 INFO - Running setup.py install for mozleak 19:35:47 INFO - Running setup.py install for mozlog 19:35:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:35:47 INFO - Running setup.py install for moznetwork 19:35:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:35:47 INFO - Running setup.py install for mozprocess 19:35:47 INFO - Running setup.py install for mozprofile 19:35:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:35:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:35:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:35:48 INFO - Running setup.py install for mozrunner 19:35:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:35:48 INFO - Running setup.py install for mozscreenshot 19:35:48 INFO - Running setup.py install for moztest 19:35:48 INFO - Running setup.py install for mozversion 19:35:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:35:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:35:48 INFO - Cleaning up... 19:35:48 INFO - Return code: 0 19:35:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35:48 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')]} 19:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:48 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')]} 19:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:48 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:48 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 19:35:48 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 19:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:48 INFO - 'HOME': '/Users/cltbld', 19:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:48 INFO - 'LOGNAME': 'cltbld', 19:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:48 INFO - 'MOZ_NO_REMOTE': '1', 19:35:48 INFO - 'NO_EM_RESTART': '1', 19:35:48 INFO - 'PAGER': '/bin/cat', 19:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:48 INFO - 'PWD': '/builds/slave/test', 19:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:48 INFO - 'SHELL': '/bin/bash', 19:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:48 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:48 INFO - 'USER': 'cltbld', 19:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:48 INFO - 'XPC_FLAGS': '0x0', 19:35:48 INFO - 'XPC_SERVICE_NAME': '0', 19:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:35:48 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7mwVsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:35:49 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)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-YRzzuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8ZNoK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:35:49 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)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-s9JXxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Z2K8Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:35:49 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)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-GZXQn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:35:49 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)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-JQ9CdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:35:49 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)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-YJQt8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:35:49 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)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-7tpFJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:35:49 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)) 19:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:35:49 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-zz_wWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:35:50 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)) 19:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:35:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-AZoc0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:35:50 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)) 19:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:35:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Vo130B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:35:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-T0Aiba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:35:50 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)) 19:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:35:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-tGqHpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-RiqouK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:35:50 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)) 19:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:35:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-iUxmKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:35:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0cV0fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:35:50 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)) 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:35:50 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)) 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:35:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35: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 19:35:53 INFO - Downloading blessings-1.6.tar.gz 19:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:35:53 INFO - Installing collected packages: blessings 19:35:53 INFO - Running setup.py install for blessings 19:35:53 INFO - Successfully installed blessings 19:35:53 INFO - Cleaning up... 19:35:53 INFO - Return code: 0 19:35:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:35:54 INFO - Reading from file tmpfile_stdout 19:35:54 INFO - Current package versions: 19:35:54 INFO - blessings == 1.6 19:35:54 INFO - blobuploader == 1.2.4 19:35:54 INFO - docopt == 0.6.1 19:35:54 INFO - functools32 == 3.2.3-2 19:35:54 INFO - jsonschema == 2.5.1 19:35:54 INFO - manifestparser == 1.1 19:35:54 INFO - mozInstall == 1.12 19:35:54 INFO - mozcrash == 1.0 19:35:54 INFO - mozdebug == 0.1 19:35:54 INFO - mozdevice == 0.49 19:35:54 INFO - mozfile == 1.2 19:35:54 INFO - mozhttpd == 0.7 19:35:54 INFO - mozinfo == 0.9 19:35:54 INFO - mozleak == 0.1 19:35:54 INFO - mozlog == 3.4 19:35:54 INFO - moznetwork == 0.27 19:35:54 INFO - mozprocess == 0.24 19:35:54 INFO - mozprofile == 0.28 19:35:54 INFO - mozrunner == 6.13 19:35:54 INFO - mozscreenshot == 0.1 19:35:54 INFO - mozsystemmonitor == 0.3 19:35:54 INFO - moztest == 0.8 19:35:54 INFO - mozversion == 1.4 19:35:54 INFO - psutil == 3.1.1 19:35:54 INFO - requests == 1.2.3 19:35:54 INFO - wsgiref == 0.1.2 19:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:35: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')]} 19:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35: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')]} 19:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:55 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:55 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 19:35:55 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 19:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:55 INFO - 'HOME': '/Users/cltbld', 19:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:55 INFO - 'LOGNAME': 'cltbld', 19:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:55 INFO - 'MOZ_NO_REMOTE': '1', 19:35:55 INFO - 'NO_EM_RESTART': '1', 19:35:55 INFO - 'PAGER': '/bin/cat', 19:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:55 INFO - 'PWD': '/builds/slave/test', 19:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:55 INFO - 'SHELL': '/bin/bash', 19:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:55 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:55 INFO - 'USER': 'cltbld', 19:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:55 INFO - 'XPC_FLAGS': '0x0', 19:35:55 INFO - 'XPC_SERVICE_NAME': '0', 19:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 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)) 19:35:55 INFO - Cleaning up... 19:35:55 INFO - Return code: 0 19:35:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:35:55 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')]} 19:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:55 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')]} 19:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:35:55 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 0x10b7cfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab89c86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, '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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 19:35:55 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 19:35:55 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 19:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:55 INFO - 'HOME': '/Users/cltbld', 19:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:55 INFO - 'LOGNAME': 'cltbld', 19:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:55 INFO - 'MOZ_NO_REMOTE': '1', 19:35:55 INFO - 'NO_EM_RESTART': '1', 19:35:55 INFO - 'PAGER': '/bin/cat', 19:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:55 INFO - 'PWD': '/builds/slave/test', 19:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:55 INFO - 'SHELL': '/bin/bash', 19:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:35:55 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:55 INFO - 'USER': 'cltbld', 19:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:55 INFO - 'XPC_FLAGS': '0x0', 19:35:55 INFO - 'XPC_SERVICE_NAME': '0', 19:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:35:55 INFO - Cleaning up... 19:35:55 INFO - Return code: 0 19:35:55 INFO - Running post-action listener: _resource_record_post_action 19:35:55 INFO - Running post-action listener: _start_resource_monitoring 19:35:55 INFO - Starting resource monitoring. 19:35:55 INFO - [mozharness: 2017-02-16 03:35:55.926206Z] Finished create-virtualenv step (success) 19:35:55 INFO - [mozharness: 2017-02-16 03:35:55.927145Z] Running install step. 19:35:55 INFO - Running pre-action listener: _resource_record_pre_action 19:35:55 INFO - Running main action method: install 19:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:35:56 INFO - Reading from file tmpfile_stdout 19:35:56 INFO - Detecting whether we're running mozinstall >=1.0... 19:35:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:35:56 INFO - Reading from file tmpfile_stdout 19:35:56 INFO - Output received: 19:35:56 INFO - Usage: mozinstall [options] installer 19:35:56 INFO - Options: 19:35:56 INFO - -h, --help show this help message and exit 19:35:56 INFO - -d DEST, --destination=DEST 19:35:56 INFO - Directory to install application into. [default: 19:35:56 INFO - "/builds/slave/test"] 19:35:56 INFO - --app=APP Application being installed. [default: firefox] 19:35:56 INFO - mkdir: /builds/slave/test/build/application 19:35:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 19:36:16 INFO - Reading from file tmpfile_stdout 19:36:16 INFO - Output received: 19:36:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:36:16 INFO - Running post-action listener: _resource_record_post_action 19:36:16 INFO - [mozharness: 2017-02-16 03:36:16.486703Z] Finished install step (success) 19:36:16 INFO - [mozharness: 2017-02-16 03:36:16.486838Z] Running run-tests step. 19:36:16 INFO - Running pre-action listener: _resource_record_pre_action 19:36:16 INFO - Running main action method: run_tests 19:36:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:36:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:36:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:36:16 INFO - 2017-02-15 19:36:16.501 screenresolution[2434:74159] starting screenresolution argv=screenresolution get 19:36:16 INFO - 2017-02-15 19:36:16.504 screenresolution[2434:74159] Display 0: 1600x1200x32@60 19:36:16 INFO - 2017-02-15 19:36:16.510 screenresolution[2435:74162] starting screenresolution argv=screenresolution list 19:36:16 INFO - Available Modes on Display 0 19:36:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:36:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:36:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:36:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:36:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:36:16 INFO - Intel Iris: 19:36:16 INFO - Chipset Model: Intel Iris 19:36:16 INFO - Type: GPU 19:36:16 INFO - Bus: Built-In 19:36:16 INFO - VRAM (Dynamic, Max): 1536 MB 19:36:16 INFO - Vendor: Intel (0x8086) 19:36:16 INFO - Device ID: 0x0a2e 19:36:16 INFO - Revision ID: 0x0009 19:36:16 INFO - Displays: 19:36:16 INFO - Display: 19:36:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:36:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:36:16 INFO - Display Serial Number: 1600x1200 60 19:36:16 INFO - Main Display: Yes 19:36:16 INFO - Mirror: Off 19:36:16 INFO - Online: Yes 19:36:16 INFO - Rotation: Supported 19:36:16 INFO - Return code: 0 19:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:36:16 INFO - Python 2.7.3 19:36:16 INFO - Return code: 0 19:36:16 INFO - grabbing minidump binary from tooltool 19:36: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')]} 19:36:16 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 0x10b5add30>, '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 0x10b4d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5a2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:36:16 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 19:36:16 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 19:36:16 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 19:36:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:36:16 INFO - Return code: 0 19:36:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:36:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:36:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:36:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:36:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x8F8Wg8bNN/Render', 19:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:16 INFO - 'HOME': '/Users/cltbld', 19:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:16 INFO - 'LOGNAME': 'cltbld', 19:36:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:36:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:16 INFO - 'MOZ_NO_REMOTE': '1', 19:36:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:36:16 INFO - 'NO_EM_RESTART': '1', 19:36:16 INFO - 'PAGER': '/bin/cat', 19:36:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:16 INFO - 'PWD': '/builds/slave/test', 19:36:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:16 INFO - 'SHELL': '/bin/bash', 19:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3jEApcJ8Kh/Listeners', 19:36:16 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 19:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:16 INFO - 'USER': 'cltbld', 19:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:16 INFO - 'XPC_FLAGS': '0x0', 19:36:16 INFO - 'XPC_SERVICE_NAME': '0', 19:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:36:17 INFO - mozversion application_buildid: 20170215180719 19:36:17 INFO - mozversion application_changeset: d956e48d28dfd1b6cc180b92b1bf170f0438569e 19:36:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:36:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:36:17 INFO - mozversion application_name: Firefox 19:36:17 INFO - mozversion application_remotingname: firefox-dev 19:36:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:36:17 INFO - mozversion application_vendor: Mozilla 19:36:17 INFO - mozversion application_version: 53.0a2 19:36:17 INFO - mozversion platform_buildid: 20170215180719 19:36:17 INFO - mozversion platform_changeset: d956e48d28dfd1b6cc180b92b1bf170f0438569e 19:36:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:36:17 INFO - mozversion platform_version: 53.0a2 19:36:17 INFO - using testdate: 1487216177 19:36:17 INFO - actual date: 1487216177 19:36:17 INFO - starting webserver on 'localhost:52575' 19:36:17 INFO - SUITE-START | Running 2 tests 19:36:17 INFO - TEST-START | dromaeo_css 19:36:17 INFO - operating with platform_type : mac_ 19:36:17 INFO - Initialising browser for dromaeo_css test... 19:36:17 INFO - TEST-INFO | started process 2445 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpHtEsKq/profile http://localhost:52575/getInfo.html) 19:36:20 INFO - PROCESS | 2445 | 2017-02-15 19:36:20.041 plugin-container[2447:74339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 19:36:20 INFO - PROCESS | 2445 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:20 INFO - PROCESS | 2445 | 2017-02-15 19:36:20.043 plugin-container[2447:74339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920f, name = 'com.apple.CFPasteboardClient' 19:36:20 INFO - PROCESS | 2445 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:20 INFO - PROCESS | 2445 | 2017-02-15 19:36:20.043 plugin-container[2447:74339] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:36:20 INFO - PROCESS | 2445 | __metrics Screen width/height:1600/1200 19:36:20 INFO - PROCESS | 2445 | colorDepth:24 19:36:20 INFO - PROCESS | 2445 | Browser inner width/height: 1024/689 19:36:20 INFO - PROCESS | 2445 | __metrics 19:36:20 ERROR - PROCESS | 2445 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 19:36:20 INFO - TEST-INFO | 2445: exit 0 19:36:20 INFO - Browser initialized. 19:36:20 INFO - Running cycle 1/1 for dromaeo_css test... 19:36:20 INFO - TEST-INFO | started process 2448 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpHtEsKq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:36:23 INFO - PROCESS | 2448 | 2017-02-15 19:36:23.397 plugin-container[2449:74467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 19:36:23 INFO - PROCESS | 2448 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:23 INFO - PROCESS | 2448 | 2017-02-15 19:36:23.397 plugin-container[2449:74467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 19:36:23 INFO - PROCESS | 2448 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:36:23 INFO - PROCESS | 2448 | 2017-02-15 19:36:23.397 plugin-container[2449:74467] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:36:33 INFO - PROCESS | 2448 | RSS: Main: 218681344 19:36:33 INFO - PROCESS | 2448 | 19:39:36 INFO - PROCESS | 2448 | Cycle 1(1): loaded http://localhost:52575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52575/tests/dromaeo/cssquery-ext.html) 19:39:38 INFO - PROCESS | 2448 | RSS: Main: 237723648 19:39:38 INFO - PROCESS | 2448 | 19:41:21 INFO - PROCESS | 2448 | ************************* 19:41:21 INFO - PROCESS | 2448 | A coding exception was thrown and uncaught in a Task. 19:41:21 INFO - PROCESS | 2448 | 19:41:21 ERROR - PROCESS | 2448 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:41:21 INFO - PROCESS | 2448 | Full stack: 19:41:21 INFO - PROCESS | 2448 | ************************* 19:42:40 INFO - PROCESS | 2448 | Cycle 1(1): loaded http://localhost:52575/tests/dromaeo/cssquery-ext.html (next: http://localhost:52575/tests/dromaeo/cssquery-jquery.html) 19:42:41 INFO - PROCESS | 2448 | RSS: Main: 245981184 19:42:41 INFO - PROCESS | 2448 | 19:45:43 INFO - PROCESS | 2448 | Cycle 1(1): loaded http://localhost:52575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52575/tests/dromaeo/cssquery-mootools.html) 19:45:43 INFO - PROCESS | 2448 | RSS: Main: 253620224 19:45:43 INFO - PROCESS | 2448 | 19:48:45 INFO - PROCESS | 2448 | Cycle 1(1): loaded http://localhost:52575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52575/tests/dromaeo/cssquery-prototype.html) 19:48:46 INFO - PROCESS | 2448 | RSS: Main: 249982976 19:48:46 INFO - PROCESS | 2448 | 19:51:49 INFO - PROCESS | 2448 | Cycle 1(1): loaded http://localhost:52575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52575/tests/dromaeo/cssquery-yui.html) 19:51:49 INFO - PROCESS | 2448 | RSS: Main: 254005248 19:51:49 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | Cycle 1(1): loaded http://localhost:52575/tests/dromaeo/cssquery-yui.html (next: http://localhost:52575/tests/dromaeo/cssquery-dojo.html) 19:54:52 INFO - PROCESS | 2448 | RSS: Main: 258842624 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | __start_tp_report 19:54:52 INFO - PROCESS | 2448 | _x_x_mozilla_page_load 19:54:52 INFO - PROCESS | 2448 | _x_x_mozilla_page_load_details 19:54:52 INFO - PROCESS | 2448 | |i|pagename|runs| 19:54:52 INFO - PROCESS | 2448 | |0;dojo.html;3344.9498257526143;3348.7488438367127;3361.277325375044;3396.8811091611783;3398.999999999999;5671.971640141799;5701.857453563663;5749.0514065179295;5764.538836893054;5775;5755.25181726376;5808.6224395414265;5850.619709718876;5862.824115276538;5870.882582348361;5267.420583735796;5280.287161233242;5281.70950597717;5295.602829787762;5331.920021199685;5345.732713364336;5347.946520534783;5350.5184533391985;5364.463553644643;5377.5966802489775;4394.494633117184;5178.223266510016;5205.817796377128;5320.122179840322;5337.11937530307;5272.367315922094;5280.709560974164;5306.2571240026045;5335.1730481775385;5395.649282796606;4236.428082208893;5260.026895024433;5275.393329767087;5286.841394758163;5332.866678333034;5590.217369568264;5765.798197063083;5770.538356931435;5884.264466941632;5895.64626122434;6140.631562106288;6164.352742962014;6186.133941248228;6217.751289948396;6267.96866015667;6249.781257656005;6257.217847769029;6257.468115210213;6261.812145635638;6275.278342990523;5913.940860591425;5914.792982245601;5918.674472903946;5932.3177834548715;5964.7912323068485;6178.258608966863;6214.751409943552;6224.968875155686;6225.968870155621;6233.470155036873;6094.960320829449;6141.8891988840705;6189.412005859436;6215;6215.9378406215355;6267.6866156691985;6279.654618995908;6283.963146080845;6289.842753931189;6291.7797877075;5118.283440318359;6127.769884593299;6131.754729810847;6160.7535698571555;6270.592411493239;5084.46613105626;6221.440070393686;6251.437370636664;6260.123582698426;6260.593061450991;4213.367994800805;5011.548960593491;5013.172826483589;5014.423341315795;5041.546260836542;4353.695241333076;4398.560143985575;4437.179121862466;4463.66522510813;4477.104579084196;4877.414710234723;5981.790637327673;5996.340402555716;6001.699915004232;6034.09488576717;5574.1917421973585;6168.599041062316;6239.937600624026;6240.719167637467;6280.371962803683;5741.167530708024;5821.621594596338;5843.912341314884;5854.121881717776;5908.468237858613;5479.205515200353;5492.588055895823;5497.615166938356;5515.972420137874;5524.447555244444;5663.801766938137;6402.6158430494315;6408.519361047846;6416.967915160488;6443.130177426175;6124.533510047256;6152.323244443197;6174.351693072163;6184.381561843959;6211.782587609412;6336.461400780985;6350.936490635219;6403.167588213689;6419.807405777834;6428;6164.291106522807;6207.906881396873;6217.689115544114;6241.469475094668;6241.906371404523;5023.34696489454;6182;6222.097795819672;6261.65560894137;6262.279837818527;6065.636061836304;6130.612163469634;6137.131844484677;6141.516692814182;6187.195664563758;6084.436672495628;6107.947487155137;6111.236095488064;6147.907920654178;6160.106784516131;5808.186853840551;5896.115582662635;5950.672713000827;6003.369646187088;6122.724477398617;6032.819015429544;6067;6124.289394098022;6129.84675383119;6132.998044146438;5973.313068997121;5995.700214989321;6007.699615019319;6008.639481631116;6017.638941663514 19:54:52 INFO - PROCESS | 2448 | |1;ext.html;436.8580211431284;459.6759284704284;501.97490125493715;505.312774626508;525.3669328459205;37457.625423745754;40128;40220.798896005515;40385.39421908674;40401.19197616053;40798;41232.38151427731;41420.37869431954;41455.17089658205;41529.792351038275;8068.959655201745;8336.666533338659;8563.186497282748;9192.999999999984;9427.34008619397;11090.112790976702;11405.885941140607;11407.942960285187;11578.884211157907;11587.536498540048;11448.713782155472;11486.540538378455;11494.36780977046;11513.366764827932;11513.424328783569;11395.601153959613;11444.885551144465;11446.885531144748;11464.770704585862;11471;11260.099192064616;11308.491117899632;11353.772924541463;11371.374574398405;11394.544218231344;39985.600143998476;40235.59764402348;40359.7982010091;40360.59639403598;40587;3895.7857317847506;3913.7651740895353;3944.5069366329208;3964.1278918637854;4001.8599349022934;27078.864605676845;28106.297342566395;28645.57031644527;29032.709672903424;29101.854490727623;3126.890558830453;3178.6503484616674;3268.0686004488607;3308.040668206241;3384.6446123157207;489754;491969;493804;499319.9999999964;499554;57078.85842283131;57202;57212;57445.71277143587;57709.422905771244;59585;60050;60147.39852601506;60149.39850601438;60182.09726854101;15369.001014933994;15786.131762753159;15867.04797712141;15869.285882135331;15885.205739712968;10852.294600850919;11165.162612804072;11939.641810745692;12081.516739330504;12248.693782655504;14392.928035359757;14715.484958026418;17758;17873.642527149645;18029.459116226535;7848.293653571206;7892.171322011221;7902.881456778153;7988.721804511367;8189.894364260867;808.2241048593298;860.9053004169537;874.2830878679422;876.542779963878;916.1662886773138;24733.25800225996;28731.712682873324;29807.85096074549;30270.091897243117;30397.088087357413;929.9581518831669;1007.4408703169664;1030.7577719235974;1069.7111779819404;1160.878107798686;13190.802137967938;13497.527586534425;14841.925790371195;15708.842911570739;15863.12752798584;655844;659189;662198;663514;666854;53365.1995220072;53934.190987135225;53937;54097.72951135219;54222;1394.9372278247504;1428.0432110486;1449.9710005799825;1450.7606244969672;1458.0595515892403;23469.061237550308;27463.17610471689;27910.16269511918;28362.761395574027;28380;44901;46386.53613463822;46395.76802115968;46407.303890441;46486.53513464957;485616;504587;506448;506991;577672;22661.20685776056;24006;24310;25275.620865687397;26481.867590661925;40442.79778601206;40537.1892562153;41166;41582.376264356666;42006.15987680291;31564.895228667807;32971.8459853904;34733.47899781556;35480.64519354773;35734.4639830408;28767.712322876505;32782;34372;34663.65336346705;35155.64844351524;34209;34951.300973980884;35040.82479587586;35164;35182.64817351896;25929;29340.55989160207;31222.375552488367;31667.84166079155;31827.68172318247;23272.65091023602;23642.054317827093;23808.285751427484;23854.284371468882;25144.24567262985 19:54:52 INFO - PROCESS | 2448 | |2;jquery.html;347.8747650845695;389.6726749530396;392.4361564512146;399.90602208481005;423.42414316529533;15816.920915395436;19752.209911603535;20253.886036268;21152.89423552882;21226.257081002168;21243.46891327714;21476.355709328705;21609.3517194484;21609.783902160973;21827.563448731056;5070.340855688773;5810.767569297233;6007.429294217042;6039.818805435844;6068.969655151718;5767.855803604923;5919.49684276837;5925.762969481237;6006.279246490427;6040.909386359208;4994.250862370655;5820.777636696299;5918.4673379395845;5919.319278283009;5922.851928701795;5667.943320566804;5804.709764511778;5887.175795388649;5892.823215303548;5969.701514924236;5234.450382709799;5257.158854583248;5264.447233040514;5271.28837606922;5276.709780962045;20265.696014559795;25887.093951711788;26325.605115923277;26592.60111098335;26645.73354266471;2684.127658510972;2726.6319046928807;2749.4501099780123;2750.188694335176;2757.6010161149425;15600.531984040383;15718.685626287524;15850;15923.840761592352;16524.586885327844;1531.1578631752602;1712.494814029864;1720.423658074534;1725.077083760195;1765.046874687667;124878;126393.10410343853;130185;132317;135187;10204;11297.322160670386;11630.941845290889;11808.17342786014;11819.290842549475;13230.338483075808;13905.652358691113;14944.626384340478;15077.54767356981;15082.321295541728;7201.963990180016;7283.7450689225625;8528.957355213308;8813.647454101763;9086.591103400362;8888.688895888612;8899;8909.376343656011;9050.954745226363;9057.505511590645;5854.736536855852;7456.813579660552;7586.506877052974;7629.7329593463965;7677.270659287359;1732.982670173282;1966.5673551818577;1975.693767466045;1998.8600797944005;2013.8288245499004;970.4468452981732;1021.3709133931368;1047.6280920273346;1049.490996866519;1055.6885718712997;21244.365185515308;22016.165716085252;22267.888660556917;22274.19000219842;22373.88130593464;1008;1016.8678071850612;1041.073444634276;1052.3370276725614;1061.3313612424124;10867;11357.659270221906;11532.308061516336;11659.53361865516;11713.824292635618;766545;768113;769939;773160;790847;132930;135371;136365.3181734105;144381;153058;871.8012732492822;1005.6379703306803;1028.861103750984;1043.5669197283044;1048.7220886465093;20096.799032009494;20486;20894;20917.686234706794;21009;44918;48500;52569.737151313995;61817;62101.1369658911;77512.61243693746;90260;90638.09361906296;91657;91942;8426.241638252586;8433.28317093054;8484;8678.392512524062;8701.869471958053;11357.772844542898;12829.358532073173;12851.614451566467;13185;13186.604401867959;8979.685711000084;9092.954535227282;11284.153688473232;11537.423128843357;11656.88343116558;11305.37820419852;11315.830262546233;11382.715432114263;11569.7107572308;11701.824472633087;11540.711482212677;11574.537018519164;11809.468573914022;11826.704332391759;11907.76184476323;8311.584420779058;8347.624356904076;8722.912770872465;8760.211580957744;8794.736157915273;8362.414630975773;10494.895051049392;11366.43167841588;11390;11753.647390578297 19:54:52 INFO - PROCESS | 2448 | |3;mootools.html;1209.1958847366502;1418.3050305350382;1445.674723187283;1453.077295917093;1462.95611131666;7417;7775.339096176817;8147.348212143029;8566.486010839346;8600.053994060649;7906.44654874159;8288.336933045357;8322.375821813357;8432.45189062712;8453;2304.412374844412;2348.6007378745567;2354.6703461515403;2357.422431504275;2360.834741568091;1965.263026365113;2073.8237249833705;2166.3825809644254;2349.2247558305717;2364.0543782487057;2251.718535183102;2332.0322066342533;2352.505973745507;2353.435175557871;2359.0210062823908;2243.910243590263;2253.335266096514;2266.9118822964906;2267.5238199978025;2291.5073259249257;2309.3880121767743;2321.3500219938446;2369.0168580039262;2381.5475059738596;2384.78536931677;6942.618156001418;8206.548639824807;8251.29863961558;8251.29863961564;8253.711120110767;5113.897722045575;5270.341207349082;5272.182811664198;5278.577713782888;5295.682259064469;3175.7776955613117;3300.4389253826907;3352.430086885211;3529.8941031769086;3540.2565461253166;1203.3983008495752;1216.1547724331592;1248.9875101248963;1264.2288204195434;1269.134372472464;9431.481268530228;10081.798364032751;10889.673309800719;10937.343759374464;10939.781204375868;4271.444712187395;4517.2772356423475;4576.656750743641;4584.129015487047;4599.816007359668;8750.862387889534;8759.605817738217;8808.603612837438;8813.955930220307;8814.074522175208;5157.355330583677;5188.714620695822;5198.2722418861385;5201.349831271091;5205.167173252262;3895.220955808793;4466.307722303049;4677.4854765975715;4758.357621721023;4809.326694262736;3740.2706472238197;3762.1159027628487;3790.4314352847296;3829.5213098362706;3840.4047372657283;1062.675883855416;1109.5561775289948;1125.684808253674;1164.301419148504;1175.3946717440524;871.215905684876;887.8002449448951;894.9573746585155;895.4716717136921;914.2731528434911;5477.397486276506;5597.132444471114;5668.348139963957;5670.234518340054;5763.337216220105;960.7454024683465;973.2311473935512;974.9220062394992;979.177490907641;1011.3628414099071;3649.1242101895355;3678;3715.108373990223;3765.2657731742597;3769.7361184717356;8732.257758090633;10143.949280253551;10144.49277536135;10165.94917025425;10174.593016279267;9974.900250997542;10076;10120.493975301206;10174.338667986558;10211.642592509226;7402.518836275733;7871.84256314882;7911.683532658744;8004.5197288161735;8005.119436861941;5441.564674825925;5533;5671.17767923657;5687.402822703722;5697.202391665087;8902.154295341932;9192;9272.953635231781;9285.48929808867;9334.859977100214;9201.493917834583;9292.16370526656;9432.19826314771;9549.474778887228;9570.56932438028;7103.183133939663;7321.890171647536;7330.596817174894;7335.669894854637;7354.301341372561;7843.56860372685;7886.0536735592095;7901.209879012053;7973.322267607318;7975.4018448615425;6336.429721325103;7156.212816590067;7259;7296.087989001375;7298.708051677873;7106.822329441598;7139.071920650283;7147;7188.065551478275;7265.12818461788;6374.4263016326895;6378.872422551616;6400.423961843457;6449.871002580016;6459;4721.291806229093;4753.762311884461;4812.711237325771;4912.6561140719805;5001.074801161797;4088.4480595120467;4189.973456503176;4703.670743047954;4758.738269395217;4790.137775200497 19:54:52 INFO - PROCESS | 2448 | |4;prototype.html;314.8304050452569;355.5182727404367;359.87584283422245;369.04969703014734;373.9513863197784;4325.286327755921;4802.3107060046395;5268.736563171836;5424.267723857278;5603.4956853883195;5206.505381988705;5296.245952104913;5353.892922141555;5356.758945847437;5410.91883621746;3477.4783782432646;3522.4716292556063;3708.3510385682534;4253;4272.871813845574;3267.950980735291;3866.608021112397;4266.338717498793;4278.272693642073;4301.720388174775;3427.2974040321674;3631.94552081719;4031.3952907064026;4191.476065491814;4191.895202619944;3949.486566746333;4069.04993879438;4222.2188895054205;4243.448351714257;4263.957360426418;3265.657106003859;3646.562412510489;3759.4548790425233;3769.1707824278615;3774.8490060397553;4488.326750987378;5127.513021223878;5174.793008279665;5227.503387178212;5250;4683.929741053887;4904.950950490485;4907.779149938261;4908.116539022974;4945.406551213878;5715.856553792328;5739.33559267816;5757.942420575782;5790.565707571949;5834.329052159013;3936.5276166859876;4085.9591404085877;4128.256913755523;4143.937840932388;4146.253674338618;4670.065986802653;4799.352087468182;5479.917461491174;5520.6750379908935;5992.730327135246;3354.6142193647556;3708.8687950175454;3720.9627903721157;4217.599328063829;4235.576442355801;3579.3736096183065;4160.77257209124;4207.663386929038;4238.87283381499;4305.97847010763;4203.852865149705;4717.174494463455;4866.926996095061;4870;4880.048390563806;5068.315777370081;5366.838994830083;5726.885462290814;5773.451522105393;5943.10853371989;1146.266389510714;1212.5695378140808;1250.1873782041746;1343.798430235453;1406.1633328169723;858.7080392666523;880.6961598248594;933.2114363362947;949.0130264524955;949.4920217683645;4423.535528769497;4961.313153527745;4980.800767969241;5156.226566015052;5176;5141.434442211354;5246.291750613695;5671.971640141773;5692.715364231772;5763.415060858298;4442.88927768058;4722.811087556459;4990.076835785391;5057.142714366371;5257.710825904612;2654.5752679571174;2834.5464725643797;2947.6020737200633;3009.4282086403514;3039.708124047271;5436.91844622331;5738.741756620962;5802.82591522255;6007.189029481052;6074.969625151846;5241.42344342122;5543.974364742536;5838.941610583925;5900.321463031721;5901.645901245939;4938.703677779345;5117.641765076409;5557.527610153021;5937.910931336033;6049.001914684028;5052.949470505395;5409;5741;5745.052066408995;5839.795607153729;4707.7175369477945;4805.8077676892535;5312.840614781563;5576.721163941867;5650.40670729584;5010.574101201439;5952.535598301274;5953.851153721192;5979;5988.940110598838;3576.856925722942;3682.9815850920572;3749.7937613431523;3789.7536660117003;3908.355121404936;5205.973970130277;5493.176023596492;5695.550913107238;5778.624389414675;5874.676892770939;5158.535731784157;5316.627836051439;5326.9200961984825;5698.971505142447;5820.417958204146;4671.953280467152;5136.30659860914;5691.288588926384;5720.3707592165665;5808.593398462067;4873.610111191168;5150.793968241228;5153;5154.814392689627;5311.229871668664;4794.664373493822;5488.38092762644;5562.3047119110115;5790.594658373873;5842.269716285465;5615.550755939434;5633.6619802811965;5634;5651.01107306228;5713.514351280188 19:54:52 INFO - PROCESS | 2448 | |5;yui.html;714.143028365961;717.2540557819864;768.2854944901243;809.7730543783024;817.1991448380585;14516.346764395601;15623.671987881029;16658.416955406563;17296.481105566854;17401.651966960653;16358.100304483249;16506;16520.339186432557;16537.503874883743;16563.420280290193;681.4616453002122;759.5177062565256;835.1147783349653;862.0345213361045;869.3306154261215;697.6337422852991;839.4291881520563;861.5089399042548;878.9516576588285;883.1301168349171;922.2437601167046;925.4956048953303;926.3422969691527;929.2148134826095;931.6133804471136;914.4330515080659;918.76112210825;921.9907800922006;922.5387306346827;923.833709932212;676.3236763236763;687.0930371909081;689.7241103558566;689.8827199376118;690.1752405874981;15322.310496027705;15358.462453814174;15369.923150384177;15429.919905606612;15466.994645348017;13999.160050396908;14225.07537010091;14260.786088208684;14315.355808988621;14327;11462.369569673665;11673.416329183507;11709;11743.588974385855;11786.882131178665;3504.667056629616;3581.1405262737017;3631.7457777955556;3651.5070465487083;3785.1861849702445;93175.06824931732;111408.44295778469;114093.99999999917;114581;115458.42270788593;10330.276880618285;10500.789984200426;10693.518791654395;10811.945940270249;10946.726331841608;22043.228487002878;22124;22571.774282256967;22643.20748773785;22682.88658556697;7387.08504906966;7465.178830328659;7506.662200201004;7660.080790305199;7683.6926522939575;4233.428487154257;4272.5727427257025;4344.022594916181;4346.847860324873;4378.78106094694;3592.497050412944;3655.5796083450746;3656.7440279180732;3669.1560940983723;3694.5751238607368;648.9643069631215;660.6762686283782;670.6814263225027;674.3458844920419;678.5826716569374;653.8953767397194;662.8873091574444;679.9694013769293;683.4839696029466;723.3020135569201;9990.500474976223;9991.950040249752;10058.74853128663;10285.897141028494;10313.329633573794;669.4677731203705;685.6434653979902;699.8040548646387;700.184285307621;700.4049994769367;4177.937330940038;4925.162722337212;4956.876078098005;5002.224655178453;5004.624653150955;80710;86373;89653.55173224091;112807.87192127973;115177.69644607228;92088.53955730179;94295.58556621656;95086.09827803406;95399;96560.55159172618;64910;79545.21591744377;79722.40555188863;82631.7605235922;85997;9415.340926135104;9538.761530961781;9601.951990240004;9621.326507144433;9651.179649729851;43267;51509.742451289;54205;54446.45553544414;54735;57073;67752;76932.61533692296;77140.61429692815;79563.60218198872;13542.390592423562;13652.453901843815;14107.506237281646;14577.92711036438;14703.632409189855;14592.416303348173;14742.484013059491;14819.33313000896;15034.473793417177;15241.00933439323;13085.214887106804;13876.514321998682;14136.858631413554;14197;14279.42882284697;13149.34253287351;13616.86383136156;14267.357968891218;14545.272736362927;14680.04579702316;11451.427428628702;12090;13323.733525329246;13403.769217722878;13570.914326854025;10891.836622450828;11109.111271098454;11220.1023918088;11287.830682539932;11340.773184536429;7768.883466748116;9978.17058622608;10370.170790485918;10599.311044782064;10904.34573925567 19:54:52 INFO - PROCESS | 2448 | __end_tp_report 19:54:52 INFO - PROCESS | 2448 | __start_cc_report 19:54:52 INFO - PROCESS | 2448 | _x_x_mozilla_cycle_collect,380 19:54:52 INFO - PROCESS | 2448 | __end_cc_report 19:54:52 INFO - PROCESS | 2448 | __startTimestamp1487217292937__endTimestamp 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | ------- Summary: start ------- 19:54:52 INFO - PROCESS | 2448 | Number of tests: 6 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | [#0] dojo.html Cycles:165 Average:5748.94 Median:5996.34 stddev:658.46 (11.0%) stddev-sans-first:632.90 19:54:52 INFO - PROCESS | 2448 | Values: 3344.9 3348.7 3361.3 3396.9 3399.0 5672.0 5701.9 5749.1 5764.5 5775.0 5755.3 5808.6 5850.6 5862.8 5870.9 5267.4 5280.3 5281.7 5295.6 5331.9 5345.7 5347.9 5350.5 5364.5 5377.6 4394.5 5178.2 5205.8 5320.1 5337.1 5272.4 5280.7 5306.3 5335.2 5395.6 4236.4 5260.0 5275.4 5286.8 5332.9 5590.2 5765.8 5770.5 5884.3 5895.6 6140.6 6164.4 6186.1 6217.8 6268.0 6249.8 6257.2 6257.5 6261.8 6275.3 5913.9 5914.8 5918.7 5932.3 5964.8 6178.3 6214.8 6225.0 6226.0 6233.5 6095.0 6141.9 6189.4 6215.0 6215.9 6267.7 6279.7 6284.0 6289.8 6291.8 5118.3 6127.8 6131.8 6160.8 6270.6 5084.5 6221.4 6251.4 6260.1 6260.6 4213.4 5011.5 5013.2 5014.4 5041.5 4353.7 4398.6 4437.2 4463.7 4477.1 4877.4 5981.8 5996.3 6001.7 6034.1 5574.2 6168.6 6239.9 6240.7 6280.4 5741.2 5821.6 5843.9 5854.1 5908.5 5479.2 5492.6 5497.6 5516.0 5524.4 5663.8 6402.6 6408.5 6417.0 6443.1 6124.5 6152.3 6174.4 6184.4 6211.8 6336.5 6350.9 6403.2 6419.8 6428.0 6164.3 6207.9 6217.7 6241.5 6241.9 5023.3 6182.0 6222.1 6261.7 6262.3 6065.6 6130.6 6137.1 6141.5 6187.2 6084.4 6107.9 6111.2 6147.9 6160.1 5808.2 5896.1 5950.7 6003.4 6122.7 6032.8 6067.0 6124.3 6129.8 6133.0 5973.3 5995.7 6007.7 6008.6 6017.6 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | [#1] ext.html Cycles:180 Average:68039.59 Median:34698.57 stddev:150554.08 (433.9%) stddev-sans-first:150890.87 19:54:52 INFO - PROCESS | 2448 | Values: 436.9 459.7 502.0 505.3 525.4 37457.6 40128.0 40220.8 40385.4 40401.2 40798.0 41232.4 41420.4 41455.2 41529.8 8069.0 8336.7 8563.2 9193.0 9427.3 11090.1 11405.9 11407.9 11578.9 11587.5 11448.7 11486.5 11494.4 11513.4 11513.4 11395.6 11444.9 11446.9 11464.8 11471.0 11260.1 11308.5 11353.8 11371.4 11394.5 39985.6 40235.6 40359.8 40360.6 40587.0 3895.8 3913.8 3944.5 3964.1 4001.9 27078.9 28106.3 28645.6 29032.7 29101.9 3126.9 3178.7 3268.1 3308.0 3384.6 489754.0 491969.0 493804.0 499320.0 499554.0 57078.9 57202.0 57212.0 57445.7 57709.4 59585.0 60050.0 60147.4 60149.4 60182.1 15369.0 15786.1 15867.0 15869.3 15885.2 10852.3 11165.2 11939.6 12081.5 12248.7 14392.9 14715.5 17758.0 17873.6 18029.5 7848.3 7892.2 7902.9 7988.7 8189.9 808.2 860.9 874.3 876.5 916.2 24733.3 28731.7 29807.9 30270.1 30397.1 930.0 1007.4 1030.8 1069.7 1160.9 13190.8 13497.5 14841.9 15708.8 15863.1 655844.0 659189.0 662198.0 663514.0 666854.0 53365.2 53934.2 53937.0 54097.7 54222.0 1394.9 1428.0 1450.0 1450.8 1458.1 23469.1 27463.2 27910.2 28362.8 28380.0 44901.0 46386.5 46395.8 46407.3 46486.5 485616.0 504587.0 506448.0 506991.0 577672.0 22661.2 24006.0 24310.0 25275.6 26481.9 40442.8 40537.2 41166.0 41582.4 42006.2 31564.9 32971.8 34733.5 35480.6 35734.5 28767.7 32782.0 34372.0 34663.7 35155.6 34209.0 34951.3 35040.8 35164.0 35182.6 25929.0 29340.6 31222.4 31667.8 31827.7 23272.7 23642.1 23808.3 23854.3 25144.2 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | [#2] jquery.html Cycles:180 Average:41262.75 Median:21718.67 stddev:128287.30 (590.7%) stddev-sans-first:128610.39 19:54:52 INFO - PROCESS | 2448 | Values: 347.9 389.7 392.4 399.9 423.4 15816.9 19752.2 20253.9 21152.9 21226.3 21243.5 21476.4 21609.4 21609.8 21827.6 5070.3 5810.8 6007.4 6039.8 6069.0 5767.9 5919.5 5925.8 6006.3 6040.9 4994.3 5820.8 5918.5 5919.3 5922.9 5667.9 5804.7 5887.2 5892.8 5969.7 5234.5 5257.2 5264.4 5271.3 5276.7 20265.7 25887.1 26325.6 26592.6 26645.7 2684.1 2726.6 2749.5 2750.2 2757.6 15600.5 15718.7 15850.0 15923.8 16524.6 1531.2 1712.5 1720.4 1725.1 1765.0 124878.0 126393.1 130185.0 132317.0 135187.0 10204.0 11297.3 11630.9 11808.2 11819.3 13230.3 13905.7 14944.6 15077.5 15082.3 7202.0 7283.7 8529.0 8813.6 9086.6 8888.7 8899.0 8909.4 9051.0 9057.5 5854.7 7456.8 7586.5 7629.7 7677.3 1733.0 1966.6 1975.7 1998.9 2013.8 970.4 1021.4 1047.6 1049.5 1055.7 21244.4 22016.2 22267.9 22274.2 22373.9 1008.0 1016.9 1041.1 1052.3 1061.3 10867.0 11357.7 11532.3 11659.5 11713.8 766545.0 768113.0 769939.0 773160.0 790847.0 132930.0 135371.0 136365.3 144381.0 153058.0 871.8 1005.6 1028.9 1043.6 1048.7 20096.8 20486.0 20894.0 20917.7 21009.0 44918.0 48500.0 52569.7 61817.0 62101.1 77512.6 90260.0 90638.1 91657.0 91942.0 8426.2 8433.3 8484.0 8678.4 8701.9 11357.8 12829.4 12851.6 13185.0 13186.6 8979.7 9093.0 11284.2 11537.4 11656.9 11305.4 11315.8 11382.7 11569.7 11701.8 11540.7 11574.5 11809.5 11826.7 11907.8 8311.6 8347.6 8722.9 8760.2 8794.7 8362.4 10494.9 11366.4 11390.0 11753.6 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | [#3] mootools.html Cycles:180 Average:5387.55 Median:5193.49 stddev:2935.79 (56.5%) stddev-sans-first:2927.22 19:54:52 INFO - PROCESS | 2448 | Values: 1209.2 1418.3 1445.7 1453.1 1463.0 7417.0 7775.3 8147.3 8566.5 8600.1 7906.4 8288.3 8322.4 8432.5 8453.0 2304.4 2348.6 2354.7 2357.4 2360.8 1965.3 2073.8 2166.4 2349.2 2364.1 2251.7 2332.0 2352.5 2353.4 2359.0 2243.9 2253.3 2266.9 2267.5 2291.5 2309.4 2321.4 2369.0 2381.5 2384.8 6942.6 8206.5 8251.3 8251.3 8253.7 5113.9 5270.3 5272.2 5278.6 5295.7 3175.8 3300.4 3352.4 3529.9 3540.3 1203.4 1216.2 1249.0 1264.2 1269.1 9431.5 10081.8 10889.7 10937.3 10939.8 4271.4 4517.3 4576.7 4584.1 4599.8 8750.9 8759.6 8808.6 8814.0 8814.1 5157.4 5188.7 5198.3 5201.3 5205.2 3895.2 4466.3 4677.5 4758.4 4809.3 3740.3 3762.1 3790.4 3829.5 3840.4 1062.7 1109.6 1125.7 1164.3 1175.4 871.2 887.8 895.0 895.5 914.3 5477.4 5597.1 5668.3 5670.2 5763.3 960.7 973.2 974.9 979.2 1011.4 3649.1 3678.0 3715.1 3765.3 3769.7 8732.3 10143.9 10144.5 10165.9 10174.6 9974.9 10076.0 10120.5 10174.3 10211.6 7402.5 7871.8 7911.7 8004.5 8005.1 5441.6 5533.0 5671.2 5687.4 5697.2 8902.2 9192.0 9273.0 9285.5 9334.9 9201.5 9292.2 9432.2 9549.5 9570.6 7103.2 7321.9 7330.6 7335.7 7354.3 7843.6 7886.1 7901.2 7973.3 7975.4 6336.4 7156.2 7259.0 7296.1 7298.7 7106.8 7139.1 7147.0 7188.1 7265.1 6374.4 6378.9 6400.4 6449.9 6459.0 4721.3 4753.8 4812.7 4912.7 5001.1 4088.4 4190.0 4703.7 4758.7 4790.1 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | [#4] prototype.html Cycles:180 Average:4557.62 Median:5092.98 stddev:1381.03 (27.1%) stddev-sans-first:1347.69 19:54:52 INFO - PROCESS | 2448 | Values: 314.8 355.5 359.9 369.0 374.0 4325.3 4802.3 5268.7 5424.3 5603.5 5206.5 5296.2 5353.9 5356.8 5410.9 3477.5 3522.5 3708.4 4253.0 4272.9 3268.0 3866.6 4266.3 4278.3 4301.7 3427.3 3631.9 4031.4 4191.5 4191.9 3949.5 4069.0 4222.2 4243.4 4264.0 3265.7 3646.6 3759.5 3769.2 3774.8 4488.3 5127.5 5174.8 5227.5 5250.0 4683.9 4905.0 4907.8 4908.1 4945.4 5715.9 5739.3 5757.9 5790.6 5834.3 3936.5 4086.0 4128.3 4143.9 4146.3 4670.1 4799.4 5479.9 5520.7 5992.7 3354.6 3708.9 3721.0 4217.6 4235.6 3579.4 4160.8 4207.7 4238.9 4306.0 4203.9 4717.2 4866.9 4870.0 4880.0 5068.3 5366.8 5726.9 5773.5 5943.1 1146.3 1212.6 1250.2 1343.8 1406.2 858.7 880.7 933.2 949.0 949.5 4423.5 4961.3 4980.8 5156.2 5176.0 5141.4 5246.3 5672.0 5692.7 5763.4 4442.9 4722.8 4990.1 5057.1 5257.7 2654.6 2834.5 2947.6 3009.4 3039.7 5436.9 5738.7 5802.8 6007.2 6075.0 5241.4 5544.0 5838.9 5900.3 5901.6 4938.7 5117.6 5557.5 5937.9 6049.0 5052.9 5409.0 5741.0 5745.1 5839.8 4707.7 4805.8 5312.8 5576.7 5650.4 5010.6 5952.5 5953.9 5979.0 5988.9 3576.9 3683.0 3749.8 3789.8 3908.4 5206.0 5493.2 5695.6 5778.6 5874.7 5158.5 5316.6 5326.9 5699.0 5820.4 4672.0 5136.3 5691.3 5720.4 5808.6 4873.6 5150.8 5153.0 5154.8 5311.2 4794.7 5488.4 5562.3 5790.6 5842.3 5615.6 5633.7 5634.0 5651.0 5713.5 19:54:52 INFO - PROCESS | 2448 | 19:54:52 INFO - PROCESS | 2448 | [#5] yui.html Cycles:180 Average:20885.18 Median:23805.51 stddev:30062.46 (126.3%) stddev-sans-first:30108.64 19:54:52 INFO - PROCESS | 2448 | Values: 714.1 717.3 768.3 809.8 817.2 14516.3 15623.7 16658.4 17296.5 17401.7 16358.1 16506.0 16520.3 16537.5 16563.4 681.5 759.5 835.1 862.0 869.3 697.6 839.4 861.5 879.0 883.1 922.2 925.5 926.3 929.2 931.6 914.4 918.8 922.0 922.5 923.8 676.3 687.1 689.7 689.9 690.2 15322.3 15358.5 15369.9 15429.9 15467.0 13999.2 14225.1 14260.8 14315.4 14327.0 11462.4 11673.4 11709.0 11743.6 11786.9 3504.7 3581.1 3631.7 3651.5 3785.2 93175.1 111408.4 114094.0 114581.0 115458.4 10330.3 10500.8 10693.5 10811.9 10946.7 22043.2 22124.0 22571.8 22643.2 22682.9 7387.1 7465.2 7506.7 7660.1 7683.7 4233.4 4272.6 4344.0 4346.8 4378.8 3592.5 3655.6 3656.7 3669.2 3694.6 649.0 660.7 670.7 674.3 678.6 653.9 662.9 680.0 683.5 723.3 9990.5 9992.0 10058.7 10285.9 10313.3 669.5 685.6 699.8 700.2 700.4 4177.9 4925.2 4956.9 5002.2 5004.6 80710.0 86373.0 89653.6 112807.9 115177.7 92088.5 94295.6 95086.1 95399.0 96560.6 64910.0 79545.2 79722.4 82631.8 85997.0 9415.3 9538.8 9602.0 9621.3 9651.2 43267.0 51509.7 54205.0 54446.5 54735.0 57073.0 67752.0 76932.6 77140.6 79563.6 13542.4 13652.5 14107.5 14577.9 14703.6 14592.4 14742.5 14819.3 15034.5 15241.0 13085.2 13876.5 14136.9 14197.0 14279.4 13149.3 13616.9 14267.4 14545.3 14680.0 11451.4 12090.0 13323.7 13403.8 13570.9 10891.8 11109.1 11220.1 11287.8 11340.8 7768.9 9978.2 10370.2 10599.3 10904.3 19:54:52 INFO - PROCESS | 2448 | -------- Summary: end -------- 19:54:52 INFO - PROCESS | 2448 | 19:54:53 INFO - TEST-INFO | 2448: exit 0 19:54:53 INFO - TEST-OK | dromaeo_css | took 1116503ms 19:54:53 INFO - TEST-START | kraken 19:54:53 INFO - operating with platform_type : mac_ 19:54:53 INFO - Initialising browser for kraken test... 19:54:53 INFO - TEST-INFO | started process 2452 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpSLXBpz/profile http://localhost:52575/getInfo.html) 19:54:56 INFO - PROCESS | 2452 | 2017-02-15 19:54:56.505 plugin-container[2453:76386] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 19:54:56 INFO - PROCESS | 2452 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:54:56 INFO - PROCESS | 2452 | 2017-02-15 19:54:56.508 plugin-container[2453:76386] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 19:54:56 INFO - PROCESS | 2452 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:54:56 INFO - PROCESS | 2452 | 2017-02-15 19:54:56.509 plugin-container[2453:76386] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:54:56 INFO - PROCESS | 2452 | __metrics Screen width/height:1600/1200 19:54:56 INFO - PROCESS | 2452 | colorDepth:24 19:54:56 INFO - PROCESS | 2452 | Browser inner width/height: 1024/689 19:54:56 INFO - PROCESS | 2452 | __metrics 19:54:56 ERROR - PROCESS | 2452 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 19:54:57 INFO - TEST-INFO | 2452: exit 0 19:54:57 INFO - Browser initialized. 19:54:57 INFO - Running cycle 1/1 for kraken test... 19:54:57 INFO - TEST-INFO | started process 2454 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpSLXBpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:00 INFO - PROCESS | 2454 | 2017-02-15 19:55:00.071 plugin-container[2455:76510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 19:55:00 INFO - PROCESS | 2454 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:55:00 INFO - PROCESS | 2454 | 2017-02-15 19:55:00.071 plugin-container[2455:76510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 19:55:00 INFO - PROCESS | 2454 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:55:00 INFO - PROCESS | 2454 | 2017-02-15 19:55:00.071 plugin-container[2455:76510] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:55:09 INFO - PROCESS | 2454 | RSS: Main: 218349568 19:55:09 INFO - PROCESS | 2454 | 19:55:13 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52575/tests/kraken/driver.html?testName=audio-beat-detection) 19:55:14 INFO - PROCESS | 2454 | RSS: Main: 232808448 19:55:14 INFO - PROCESS | 2454 | 19:55:16 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52575/tests/kraken/driver.html?testName=audio-dft) 19:55:17 INFO - PROCESS | 2454 | RSS: Main: 241770496 19:55:17 INFO - PROCESS | 2454 | 19:55:20 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52575/tests/kraken/driver.html?testName=audio-fft) 19:55:21 INFO - PROCESS | 2454 | RSS: Main: 244674560 19:55:21 INFO - PROCESS | 2454 | 19:55:22 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52575/tests/kraken/driver.html?testName=audio-oscillator) 19:55:23 INFO - PROCESS | 2454 | RSS: Main: 246104064 19:55:23 INFO - PROCESS | 2454 | 19:55:25 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:55:26 INFO - PROCESS | 2454 | RSS: Main: 246132736 19:55:26 INFO - PROCESS | 2454 | 19:55:29 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52575/tests/kraken/driver.html?testName=imaging-darkroom) 19:55:29 INFO - PROCESS | 2454 | RSS: Main: 250200064 19:55:29 INFO - PROCESS | 2454 | 19:55:33 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52575/tests/kraken/driver.html?testName=imaging-desaturate) 19:55:33 INFO - PROCESS | 2454 | RSS: Main: 249098240 19:55:33 INFO - PROCESS | 2454 | 19:55:36 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52575/tests/kraken/driver.html?testName=json-parse-financial) 19:55:37 INFO - PROCESS | 2454 | RSS: Main: 249618432 19:55:37 INFO - PROCESS | 2454 | 19:55:38 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:55:39 INFO - PROCESS | 2454 | RSS: Main: 248897536 19:55:39 INFO - PROCESS | 2454 | 19:55:41 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:55:42 INFO - PROCESS | 2454 | RSS: Main: 248958976 19:55:42 INFO - PROCESS | 2454 | 19:55:44 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:55:45 INFO - PROCESS | 2454 | RSS: Main: 248975360 19:55:45 INFO - PROCESS | 2454 | 19:55:47 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:55:48 INFO - PROCESS | 2454 | RSS: Main: 249245696 19:55:48 INFO - PROCESS | 2454 | 19:55:51 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:55:52 INFO - PROCESS | 2454 | RSS: Main: 249032704 19:55:52 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | Cycle 1(1): loaded http://localhost:52575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52575/tests/kraken/driver.html?testName=ai-astar) 19:55:54 INFO - PROCESS | 2454 | RSS: Main: 251031552 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | __start_tp_report 19:55:54 INFO - PROCESS | 2454 | _x_x_mozilla_page_load 19:55:54 INFO - PROCESS | 2454 | _x_x_mozilla_page_load_details 19:55:54 INFO - PROCESS | 2454 | |i|pagename|runs| 19:55:54 INFO - PROCESS | 2454 | |0;ai-astar;106;123;176;103;179;175;166;119;119;119 19:55:54 INFO - PROCESS | 2454 | |1;audio-beat-detection;145;113;111;151;112;117;131;114;134;114 19:55:54 INFO - PROCESS | 2454 | |2;audio-dft;198;197;198;200;201;197;197;199;197;198 19:55:54 INFO - PROCESS | 2454 | |3;audio-fft;82;58;60;89;61;59;59;58;69;59 19:55:54 INFO - PROCESS | 2454 | |4;audio-oscillator;82;72;84;73;68;70;83;74;95;113 19:55:54 INFO - PROCESS | 2454 | |5;imaging-gaussian-blur;89;90;89;115;103;118;138;109;89;85 19:55:54 INFO - PROCESS | 2454 | |6;imaging-darkroom;99;100;145;113;99;99;121;173;121;171 19:55:54 INFO - PROCESS | 2454 | |7;imaging-desaturate;142;145;93;94;93;92;91;92;92;93 19:55:54 INFO - PROCESS | 2454 | |8;json-parse-financial;56;56;56;57;60;60;58;58;60;58 19:55:54 INFO - PROCESS | 2454 | |9;json-stringify-tinderbox;73;70;76;77;76;71;71;71;77;89 19:55:54 INFO - PROCESS | 2454 | |10;stanford-crypto-aes;84;76;86;73;97;103;104;78;103;95 19:55:54 INFO - PROCESS | 2454 | |11;stanford-crypto-ccm;138;139;136;137;140;133;161;163;204;186 19:55:54 INFO - PROCESS | 2454 | |12;stanford-crypto-pbkdf2;172;177;173;170;213;235;177;158;190;166 19:55:54 INFO - PROCESS | 2454 | |13;stanford-crypto-sha256-iterative;68;69;66;66;67;66;65;67;67;68 19:55:54 INFO - PROCESS | 2454 | __end_tp_report 19:55:54 INFO - PROCESS | 2454 | __start_cc_report 19:55:54 INFO - PROCESS | 2454 | _x_x_mozilla_cycle_collect,984 19:55:54 INFO - PROCESS | 2454 | __end_cc_report 19:55:54 INFO - PROCESS | 2454 | __startTimestamp1487217354340__endTimestamp 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | ------- Summary: start ------- 19:55:54 INFO - PROCESS | 2454 | Number of tests: 14 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#0] ai-astar Cycles:10 Average:138.50 Median:144.50 stddev:31.33 (21.7%) stddev-sans-first:30.94 19:55:54 INFO - PROCESS | 2454 | Values: 106.0 123.0 176.0 103.0 179.0 175.0 166.0 119.0 119.0 119.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:124.00 stddev:14.91 (12.0%) stddev-sans-first:13.79 19:55:54 INFO - PROCESS | 2454 | Values: 145.0 113.0 111.0 151.0 112.0 117.0 131.0 114.0 134.0 114.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#2] audio-dft Cycles:10 Average:198.20 Median:198.00 stddev:1.40 (0.7%) stddev-sans-first:1.48 19:55:54 INFO - PROCESS | 2454 | Values: 198.0 197.0 198.0 200.0 201.0 197.0 197.0 199.0 197.0 198.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.50 stddev:11.19 (18.5%) stddev-sans-first:10.13 19:55:54 INFO - PROCESS | 2454 | Values: 82.0 58.0 60.0 89.0 61.0 59.0 59.0 58.0 69.0 59.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:78.00 stddev:13.81 (17.7%) stddev-sans-first:14.65 19:55:54 INFO - PROCESS | 2454 | Values: 82.0 72.0 84.0 73.0 68.0 70.0 83.0 74.0 95.0 113.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#5] imaging-gaussian-blur Cycles:10 Average:102.50 Median:87.00 stddev:17.35 (19.9%) stddev-sans-first:17.70 19:55:54 INFO - PROCESS | 2454 | Values: 89.0 90.0 89.0 115.0 103.0 118.0 138.0 109.0 89.0 85.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#6] imaging-darkroom Cycles:10 Average:124.10 Median:172.00 stddev:29.14 (16.9%) stddev-sans-first:29.46 19:55:54 INFO - PROCESS | 2454 | Values: 99.0 100.0 145.0 113.0 99.0 99.0 121.0 173.0 121.0 171.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#7] imaging-desaturate Cycles:10 Average:102.70 Median:92.50 stddev:21.53 (23.3%) stddev-sans-first:17.52 19:55:54 INFO - PROCESS | 2454 | Values: 142.0 145.0 93.0 94.0 93.0 92.0 91.0 92.0 92.0 93.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:1.66 (2.9%) stddev-sans-first:1.62 19:55:54 INFO - PROCESS | 2454 | Values: 56.0 56.0 56.0 57.0 60.0 60.0 58.0 58.0 60.0 58.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:76.00 stddev:5.61 (7.4%) stddev-sans-first:5.89 19:55:54 INFO - PROCESS | 2454 | Values: 73.0 70.0 76.0 77.0 76.0 71.0 71.0 71.0 77.0 89.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:81.00 stddev:11.97 (14.8%) stddev-sans-first:12.50 19:55:54 INFO - PROCESS | 2454 | Values: 84.0 76.0 86.0 73.0 97.0 103.0 104.0 78.0 103.0 95.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:150.50 stddev:24.46 (16.3%) stddev-sans-first:25.27 19:55:54 INFO - PROCESS | 2454 | Values: 138.0 139.0 136.0 137.0 140.0 133.0 161.0 163.0 204.0 186.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:177.00 stddev:23.64 (13.4%) stddev-sans-first:24.73 19:55:54 INFO - PROCESS | 2454 | Values: 172.0 177.0 173.0 170.0 213.0 235.0 177.0 158.0 190.0 166.0 19:55:54 INFO - PROCESS | 2454 | 19:55:54 INFO - PROCESS | 2454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 19:55:54 INFO - PROCESS | 2454 | Values: 68.0 69.0 66.0 66.0 67.0 66.0 65.0 67.0 67.0 68.0 19:55:54 INFO - PROCESS | 2454 | -------- Summary: end -------- 19:55:54 INFO - PROCESS | 2454 | 19:55:55 INFO - TEST-INFO | 2454: exit 0 19:55:55 INFO - TEST-OK | kraken | took 61649ms 19:55:55 INFO - SUITE-END | took 1178s 19:55:55 INFO - Completed test suite (00:19:38) 19:55:55 INFO - javascript benchmark 19:55:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7329.825874810566, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.9498257526143, 3348.7488438367127, 3361.277325375044, 3396.8811091611783, 3398.999999999999, 5671.971640141799, 5701.857453563663, 5749.0514065179295, 5764.538836893054, 5775.0, 5755.25181726376, 5808.6224395414265, 5850.619709718876, 5862.824115276538, 5870.882582348361, 5267.420583735796, 5280.287161233242, 5281.70950597717, 5295.602829787762, 5331.920021199685, 5345.732713364336, 5347.946520534783, 5350.5184533391985, 5364.463553644643, 5377.5966802489775, 4394.494633117184, 5178.223266510016, 5205.817796377128, 5320.122179840322, 5337.11937530307, 5272.367315922094, 5280.709560974164, 5306.2571240026045, 5335.1730481775385, 5395.649282796606, 4236.428082208893, 5260.026895024433, 5275.393329767087, 5286.841394758163, 5332.866678333034, 5590.217369568264, 5765.798197063083, 5770.538356931435, 5884.264466941632, 5895.64626122434, 6140.631562106288, 6164.352742962014, 6186.133941248228, 6217.751289948396, 6267.96866015667, 6249.781257656005, 6257.217847769029, 6257.468115210213, 6261.812145635638, 6275.278342990523, 5913.940860591425, 5914.792982245601, 5918.674472903946, 5932.3177834548715, 5964.7912323068485, 6178.258608966863, 6214.751409943552, 6224.968875155686, 6225.968870155621, 6233.470155036873, 6094.960320829449, 6141.8891988840705, 6189.412005859436, 6215.0, 6215.9378406215355, 6267.6866156691985, 6279.654618995908, 6283.963146080845, 6289.842753931189, 6291.7797877075, 5118.283440318359, 6127.769884593299, 6131.754729810847, 6160.7535698571555, 6270.592411493239, 5084.46613105626, 6221.440070393686, 6251.437370636664, 6260.123582698426, 6260.593061450991, 4213.367994800805, 5011.548960593491, 5013.172826483589, 5014.423341315795, 5041.546260836542, 4353.695241333076, 4398.560143985575, 4437.179121862466, 4463.66522510813, 4477.104579084196, 4877.414710234723, 5981.790637327673, 5996.340402555716, 6001.699915004232, 6034.09488576717, 5574.1917421973585, 6168.599041062316, 6239.937600624026, 6240.719167637467, 6280.371962803683, 5741.167530708024, 5821.621594596338, 5843.912341314884, 5854.121881717776, 5908.468237858613, 5479.205515200353, 5492.588055895823, 5497.615166938356, 5515.972420137874, 5524.447555244444, 5663.801766938137, 6402.6158430494315, 6408.519361047846, 6416.967915160488, 6443.130177426175, 6124.533510047256, 6152.323244443197, 6174.351693072163, 6184.381561843959, 6211.782587609412, 6336.461400780985, 6350.936490635219, 6403.167588213689, 6419.807405777834, 6428.0, 6164.291106522807, 6207.906881396873, 6217.689115544114, 6241.469475094668, 6241.906371404523, 5023.34696489454, 6182.0, 6222.097795819672, 6261.65560894137, 6262.279837818527, 6065.636061836304, 6130.612163469634, 6137.131844484677, 6141.516692814182, 6187.195664563758, 6084.436672495628, 6107.947487155137, 6111.236095488064, 6147.907920654178, 6160.106784516131, 5808.186853840551, 5896.115582662635, 5950.672713000827, 6003.369646187088, 6122.724477398617, 6032.819015429544, 6067.0, 6124.289394098022, 6129.84675383119, 6132.998044146438, 5973.313068997121, 5995.700214989321, 6007.699615019319, 6008.639481631116, 6017.638941663514], "value": 5708.414006437323, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.8580211431284, 459.6759284704284, 501.97490125493715, 505.312774626508, 525.3669328459205, 37457.625423745754, 40128.0, 40220.798896005515, 40385.39421908674, 40401.19197616053, 40798.0, 41232.38151427731, 41420.37869431954, 41455.17089658205, 41529.792351038275, 8068.959655201745, 8336.666533338659, 8563.186497282748, 9192.999999999984, 9427.34008619397, 11090.112790976702, 11405.885941140607, 11407.942960285187, 11578.884211157907, 11587.536498540048, 11448.713782155472, 11486.540538378455, 11494.36780977046, 11513.366764827932, 11513.424328783569, 11395.601153959613, 11444.885551144465, 11446.885531144748, 11464.770704585862, 11471.0, 11260.099192064616, 11308.491117899632, 11353.772924541463, 11371.374574398405, 11394.544218231344, 39985.600143998476, 40235.59764402348, 40359.7982010091, 40360.59639403598, 40587.0, 3895.7857317847506, 3913.7651740895353, 3944.5069366329208, 3964.1278918637854, 4001.8599349022934, 27078.864605676845, 28106.297342566395, 28645.57031644527, 29032.709672903424, 29101.854490727623, 3126.890558830453, 3178.6503484616674, 3268.0686004488607, 3308.040668206241, 3384.6446123157207, 489754.0, 491969.0, 493804.0, 499319.9999999964, 499554.0, 57078.85842283131, 57202.0, 57212.0, 57445.71277143587, 57709.422905771244, 59585.0, 60050.0, 60147.39852601506, 60149.39850601438, 60182.09726854101, 15369.001014933994, 15786.131762753159, 15867.04797712141, 15869.285882135331, 15885.205739712968, 10852.294600850919, 11165.162612804072, 11939.641810745692, 12081.516739330504, 12248.693782655504, 14392.928035359757, 14715.484958026418, 17758.0, 17873.642527149645, 18029.459116226535, 7848.293653571206, 7892.171322011221, 7902.881456778153, 7988.721804511367, 8189.894364260867, 808.2241048593298, 860.9053004169537, 874.2830878679422, 876.542779963878, 916.1662886773138, 24733.25800225996, 28731.712682873324, 29807.85096074549, 30270.091897243117, 30397.088087357413, 929.9581518831669, 1007.4408703169664, 1030.7577719235974, 1069.7111779819404, 1160.878107798686, 13190.802137967938, 13497.527586534425, 14841.925790371195, 15708.842911570739, 15863.12752798584, 655844.0, 659189.0, 662198.0, 663514.0, 666854.0, 53365.1995220072, 53934.190987135225, 53937.0, 54097.72951135219, 54222.0, 1394.9372278247504, 1428.0432110486, 1449.9710005799825, 1450.7606244969672, 1458.0595515892403, 23469.061237550308, 27463.17610471689, 27910.16269511918, 28362.761395574027, 28380.0, 44901.0, 46386.53613463822, 46395.76802115968, 46407.303890441, 46486.53513464957, 485616.0, 504587.0, 506448.0, 506991.0, 577672.0, 22661.20685776056, 24006.0, 24310.0, 25275.620865687397, 26481.867590661925, 40442.79778601206, 40537.1892562153, 41166.0, 41582.376264356666, 42006.15987680291, 31564.895228667807, 32971.8459853904, 34733.47899781556, 35480.64519354773, 35734.4639830408, 28767.712322876505, 32782.0, 34372.0, 34663.65336346705, 35155.64844351524, 34209.0, 34951.300973980884, 35040.82479587586, 35164.0, 35182.64817351896, 25929.0, 29340.55989160207, 31222.375552488367, 31667.84166079155, 31827.68172318247, 23272.65091023602, 23642.054317827093, 23808.285751427484, 23854.284371468882, 25144.24567262985], "value": 19463.954521432097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.8747650845695, 389.6726749530396, 392.4361564512146, 399.90602208481005, 423.42414316529533, 15816.920915395436, 19752.209911603535, 20253.886036268, 21152.89423552882, 21226.257081002168, 21243.46891327714, 21476.355709328705, 21609.3517194484, 21609.783902160973, 21827.563448731056, 5070.340855688773, 5810.767569297233, 6007.429294217042, 6039.818805435844, 6068.969655151718, 5767.855803604923, 5919.49684276837, 5925.762969481237, 6006.279246490427, 6040.909386359208, 4994.250862370655, 5820.777636696299, 5918.4673379395845, 5919.319278283009, 5922.851928701795, 5667.943320566804, 5804.709764511778, 5887.175795388649, 5892.823215303548, 5969.701514924236, 5234.450382709799, 5257.158854583248, 5264.447233040514, 5271.28837606922, 5276.709780962045, 20265.696014559795, 25887.093951711788, 26325.605115923277, 26592.60111098335, 26645.73354266471, 2684.127658510972, 2726.6319046928807, 2749.4501099780123, 2750.188694335176, 2757.6010161149425, 15600.531984040383, 15718.685626287524, 15850.0, 15923.840761592352, 16524.586885327844, 1531.1578631752602, 1712.494814029864, 1720.423658074534, 1725.077083760195, 1765.046874687667, 124878.0, 126393.10410343853, 130185.0, 132317.0, 135187.0, 10204.0, 11297.322160670386, 11630.941845290889, 11808.17342786014, 11819.290842549475, 13230.338483075808, 13905.652358691113, 14944.626384340478, 15077.54767356981, 15082.321295541728, 7201.963990180016, 7283.7450689225625, 8528.957355213308, 8813.647454101763, 9086.591103400362, 8888.688895888612, 8899.0, 8909.376343656011, 9050.954745226363, 9057.505511590645, 5854.736536855852, 7456.813579660552, 7586.506877052974, 7629.7329593463965, 7677.270659287359, 1732.982670173282, 1966.5673551818577, 1975.693767466045, 1998.8600797944005, 2013.8288245499004, 970.4468452981732, 1021.3709133931368, 1047.6280920273346, 1049.490996866519, 1055.6885718712997, 21244.365185515308, 22016.165716085252, 22267.888660556917, 22274.19000219842, 22373.88130593464, 1008.0, 1016.8678071850612, 1041.073444634276, 1052.3370276725614, 1061.3313612424124, 10867.0, 11357.659270221906, 11532.308061516336, 11659.53361865516, 11713.824292635618, 766545.0, 768113.0, 769939.0, 773160.0, 790847.0, 132930.0, 135371.0, 136365.3181734105, 144381.0, 153058.0, 871.8012732492822, 1005.6379703306803, 1028.861103750984, 1043.5669197283044, 1048.7220886465093, 20096.799032009494, 20486.0, 20894.0, 20917.686234706794, 21009.0, 44918.0, 48500.0, 52569.737151313995, 61817.0, 62101.1369658911, 77512.61243693746, 90260.0, 90638.09361906296, 91657.0, 91942.0, 8426.241638252586, 8433.28317093054, 8484.0, 8678.392512524062, 8701.869471958053, 11357.772844542898, 12829.358532073173, 12851.614451566467, 13185.0, 13186.604401867959, 8979.685711000084, 9092.954535227282, 11284.153688473232, 11537.423128843357, 11656.88343116558, 11305.37820419852, 11315.830262546233, 11382.715432114263, 11569.7107572308, 11701.824472633087, 11540.711482212677, 11574.537018519164, 11809.468573914022, 11826.704332391759, 11907.76184476323, 8311.584420779058, 8347.624356904076, 8722.912770872465, 8760.211580957744, 8794.736157915273, 8362.414630975773, 10494.895051049392, 11366.43167841588, 11390.0, 11753.647390578297], "value": 10139.20680867062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.1958847366502, 1418.3050305350382, 1445.674723187283, 1453.077295917093, 1462.95611131666, 7417.0, 7775.339096176817, 8147.348212143029, 8566.486010839346, 8600.053994060649, 7906.44654874159, 8288.336933045357, 8322.375821813357, 8432.45189062712, 8453.0, 2304.412374844412, 2348.6007378745567, 2354.6703461515403, 2357.422431504275, 2360.834741568091, 1965.263026365113, 2073.8237249833705, 2166.3825809644254, 2349.2247558305717, 2364.0543782487057, 2251.718535183102, 2332.0322066342533, 2352.505973745507, 2353.435175557871, 2359.0210062823908, 2243.910243590263, 2253.335266096514, 2266.9118822964906, 2267.5238199978025, 2291.5073259249257, 2309.3880121767743, 2321.3500219938446, 2369.0168580039262, 2381.5475059738596, 2384.78536931677, 6942.618156001418, 8206.548639824807, 8251.29863961558, 8251.29863961564, 8253.711120110767, 5113.897722045575, 5270.341207349082, 5272.182811664198, 5278.577713782888, 5295.682259064469, 3175.7776955613117, 3300.4389253826907, 3352.430086885211, 3529.8941031769086, 3540.2565461253166, 1203.3983008495752, 1216.1547724331592, 1248.9875101248963, 1264.2288204195434, 1269.134372472464, 9431.481268530228, 10081.798364032751, 10889.673309800719, 10937.343759374464, 10939.781204375868, 4271.444712187395, 4517.2772356423475, 4576.656750743641, 4584.129015487047, 4599.816007359668, 8750.862387889534, 8759.605817738217, 8808.603612837438, 8813.955930220307, 8814.074522175208, 5157.355330583677, 5188.714620695822, 5198.2722418861385, 5201.349831271091, 5205.167173252262, 3895.220955808793, 4466.307722303049, 4677.4854765975715, 4758.357621721023, 4809.326694262736, 3740.2706472238197, 3762.1159027628487, 3790.4314352847296, 3829.5213098362706, 3840.4047372657283, 1062.675883855416, 1109.5561775289948, 1125.684808253674, 1164.301419148504, 1175.3946717440524, 871.215905684876, 887.8002449448951, 894.9573746585155, 895.4716717136921, 914.2731528434911, 5477.397486276506, 5597.132444471114, 5668.348139963957, 5670.234518340054, 5763.337216220105, 960.7454024683465, 973.2311473935512, 974.9220062394992, 979.177490907641, 1011.3628414099071, 3649.1242101895355, 3678.0, 3715.108373990223, 3765.2657731742597, 3769.7361184717356, 8732.257758090633, 10143.949280253551, 10144.49277536135, 10165.94917025425, 10174.593016279267, 9974.900250997542, 10076.0, 10120.493975301206, 10174.338667986558, 10211.642592509226, 7402.518836275733, 7871.84256314882, 7911.683532658744, 8004.5197288161735, 8005.119436861941, 5441.564674825925, 5533.0, 5671.17767923657, 5687.402822703722, 5697.202391665087, 8902.154295341932, 9192.0, 9272.953635231781, 9285.48929808867, 9334.859977100214, 9201.493917834583, 9292.16370526656, 9432.19826314771, 9549.474778887228, 9570.56932438028, 7103.183133939663, 7321.890171647536, 7330.596817174894, 7335.669894854637, 7354.301341372561, 7843.56860372685, 7886.0536735592095, 7901.209879012053, 7973.322267607318, 7975.4018448615425, 6336.429721325103, 7156.212816590067, 7259.0, 7296.087989001375, 7298.708051677873, 7106.822329441598, 7139.071920650283, 7147.0, 7188.065551478275, 7265.12818461788, 6374.4263016326895, 6378.872422551616, 6400.423961843457, 6449.871002580016, 6459.0, 4721.291806229093, 4753.762311884461, 4812.711237325771, 4912.6561140719805, 5001.074801161797, 4088.4480595120467, 4189.973456503176, 4703.670743047954, 4758.738269395217, 4790.137775200497], "value": 4380.233505415174, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.8304050452569, 355.5182727404367, 359.87584283422245, 369.04969703014734, 373.9513863197784, 4325.286327755921, 4802.3107060046395, 5268.736563171836, 5424.267723857278, 5603.4956853883195, 5206.505381988705, 5296.245952104913, 5353.892922141555, 5356.758945847437, 5410.91883621746, 3477.4783782432646, 3522.4716292556063, 3708.3510385682534, 4253.0, 4272.871813845574, 3267.950980735291, 3866.608021112397, 4266.338717498793, 4278.272693642073, 4301.720388174775, 3427.2974040321674, 3631.94552081719, 4031.3952907064026, 4191.476065491814, 4191.895202619944, 3949.486566746333, 4069.04993879438, 4222.2188895054205, 4243.448351714257, 4263.957360426418, 3265.657106003859, 3646.562412510489, 3759.4548790425233, 3769.1707824278615, 3774.8490060397553, 4488.326750987378, 5127.513021223878, 5174.793008279665, 5227.503387178212, 5250.0, 4683.929741053887, 4904.950950490485, 4907.779149938261, 4908.116539022974, 4945.406551213878, 5715.856553792328, 5739.33559267816, 5757.942420575782, 5790.565707571949, 5834.329052159013, 3936.5276166859876, 4085.9591404085877, 4128.256913755523, 4143.937840932388, 4146.253674338618, 4670.065986802653, 4799.352087468182, 5479.917461491174, 5520.6750379908935, 5992.730327135246, 3354.6142193647556, 3708.8687950175454, 3720.9627903721157, 4217.599328063829, 4235.576442355801, 3579.3736096183065, 4160.77257209124, 4207.663386929038, 4238.87283381499, 4305.97847010763, 4203.852865149705, 4717.174494463455, 4866.926996095061, 4870.0, 4880.048390563806, 5068.315777370081, 5366.838994830083, 5726.885462290814, 5773.451522105393, 5943.10853371989, 1146.266389510714, 1212.5695378140808, 1250.1873782041746, 1343.798430235453, 1406.1633328169723, 858.7080392666523, 880.6961598248594, 933.2114363362947, 949.0130264524955, 949.4920217683645, 4423.535528769497, 4961.313153527745, 4980.800767969241, 5156.226566015052, 5176.0, 5141.434442211354, 5246.291750613695, 5671.971640141773, 5692.715364231772, 5763.415060858298, 4442.88927768058, 4722.811087556459, 4990.076835785391, 5057.142714366371, 5257.710825904612, 2654.5752679571174, 2834.5464725643797, 2947.6020737200633, 3009.4282086403514, 3039.708124047271, 5436.91844622331, 5738.741756620962, 5802.82591522255, 6007.189029481052, 6074.969625151846, 5241.42344342122, 5543.974364742536, 5838.941610583925, 5900.321463031721, 5901.645901245939, 4938.703677779345, 5117.641765076409, 5557.527610153021, 5937.910931336033, 6049.001914684028, 5052.949470505395, 5409.0, 5741.0, 5745.052066408995, 5839.795607153729, 4707.7175369477945, 4805.8077676892535, 5312.840614781563, 5576.721163941867, 5650.40670729584, 5010.574101201439, 5952.535598301274, 5953.851153721192, 5979.0, 5988.940110598838, 3576.856925722942, 3682.9815850920572, 3749.7937613431523, 3789.7536660117003, 3908.355121404936, 5205.973970130277, 5493.176023596492, 5695.550913107238, 5778.624389414675, 5874.676892770939, 5158.535731784157, 5316.627836051439, 5326.9200961984825, 5698.971505142447, 5820.417958204146, 4671.953280467152, 5136.30659860914, 5691.288588926384, 5720.3707592165665, 5808.593398462067, 4873.610111191168, 5150.793968241228, 5153.0, 5154.814392689627, 5311.229871668664, 4794.664373493822, 5488.38092762644, 5562.3047119110115, 5790.594658373873, 5842.269716285465, 5615.550755939434, 5633.6619802811965, 5634.0, 5651.01107306228, 5713.514351280188], "value": 4130.198537809654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.143028365961, 717.2540557819864, 768.2854944901243, 809.7730543783024, 817.1991448380585, 14516.346764395601, 15623.671987881029, 16658.416955406563, 17296.481105566854, 17401.651966960653, 16358.100304483249, 16506.0, 16520.339186432557, 16537.503874883743, 16563.420280290193, 681.4616453002122, 759.5177062565256, 835.1147783349653, 862.0345213361045, 869.3306154261215, 697.6337422852991, 839.4291881520563, 861.5089399042548, 878.9516576588285, 883.1301168349171, 922.2437601167046, 925.4956048953303, 926.3422969691527, 929.2148134826095, 931.6133804471136, 914.4330515080659, 918.76112210825, 921.9907800922006, 922.5387306346827, 923.833709932212, 676.3236763236763, 687.0930371909081, 689.7241103558566, 689.8827199376118, 690.1752405874981, 15322.310496027705, 15358.462453814174, 15369.923150384177, 15429.919905606612, 15466.994645348017, 13999.160050396908, 14225.07537010091, 14260.786088208684, 14315.355808988621, 14327.0, 11462.369569673665, 11673.416329183507, 11709.0, 11743.588974385855, 11786.882131178665, 3504.667056629616, 3581.1405262737017, 3631.7457777955556, 3651.5070465487083, 3785.1861849702445, 93175.06824931732, 111408.44295778469, 114093.99999999917, 114581.0, 115458.42270788593, 10330.276880618285, 10500.789984200426, 10693.518791654395, 10811.945940270249, 10946.726331841608, 22043.228487002878, 22124.0, 22571.774282256967, 22643.20748773785, 22682.88658556697, 7387.08504906966, 7465.178830328659, 7506.662200201004, 7660.080790305199, 7683.6926522939575, 4233.428487154257, 4272.5727427257025, 4344.022594916181, 4346.847860324873, 4378.78106094694, 3592.497050412944, 3655.5796083450746, 3656.7440279180732, 3669.1560940983723, 3694.5751238607368, 648.9643069631215, 660.6762686283782, 670.6814263225027, 674.3458844920419, 678.5826716569374, 653.8953767397194, 662.8873091574444, 679.9694013769293, 683.4839696029466, 723.3020135569201, 9990.500474976223, 9991.950040249752, 10058.74853128663, 10285.897141028494, 10313.329633573794, 669.4677731203705, 685.6434653979902, 699.8040548646387, 700.184285307621, 700.4049994769367, 4177.937330940038, 4925.162722337212, 4956.876078098005, 5002.224655178453, 5004.624653150955, 80710.0, 86373.0, 89653.55173224091, 112807.87192127973, 115177.69644607228, 92088.53955730179, 94295.58556621656, 95086.09827803406, 95399.0, 96560.55159172618, 64910.0, 79545.21591744377, 79722.40555188863, 82631.7605235922, 85997.0, 9415.340926135104, 9538.761530961781, 9601.951990240004, 9621.326507144433, 9651.179649729851, 43267.0, 51509.742451289, 54205.0, 54446.45553544414, 54735.0, 57073.0, 67752.0, 76932.61533692296, 77140.61429692815, 79563.60218198872, 13542.390592423562, 13652.453901843815, 14107.506237281646, 14577.92711036438, 14703.632409189855, 14592.416303348173, 14742.484013059491, 14819.33313000896, 15034.473793417177, 15241.00933439323, 13085.214887106804, 13876.514321998682, 14136.858631413554, 14197.0, 14279.42882284697, 13149.34253287351, 13616.86383136156, 14267.357968891218, 14545.272736362927, 14680.04579702316, 11451.427428628702, 12090.0, 13323.733525329246, 13403.769217722878, 13570.914326854025, 10891.836622450828, 11109.111271098454, 11220.1023918088, 11287.830682539932, 11340.773184536429, 7768.883466748116, 9978.17058622608, 10370.170790485918, 10599.311044782064, 10904.34573925567], "value": 7608.44908092722, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 123.0, 176.0, 103.0, 179.0, 175.0, 166.0, 119.0, 119.0, 119.0], "value": 138.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 111.0, 151.0, 112.0, 117.0, 131.0, 114.0, 134.0, 114.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 198.0, 200.0, 201.0, 197.0, 197.0, 199.0, 197.0, 198.0], "value": 198.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 89.0, 61.0, 59.0, 59.0, 58.0, 69.0, 59.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 84.0, 73.0, 68.0, 70.0, 83.0, 74.0, 95.0, 113.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 115.0, 103.0, 118.0, 138.0, 109.0, 89.0, 85.0], "value": 102.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 145.0, 113.0, 99.0, 99.0, 121.0, 173.0, 121.0, 171.0], "value": 124.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 145.0, 93.0, 94.0, 93.0, 92.0, 91.0, 92.0, 92.0, 93.0], "value": 102.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 60.0, 60.0, 58.0, 58.0, 60.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 76.0, 77.0, 76.0, 71.0, 71.0, 71.0, 77.0, 89.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 86.0, 73.0, 97.0, 103.0, 104.0, 78.0, 103.0, 95.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 136.0, 137.0, 140.0, 133.0, 161.0, 163.0, 204.0, 186.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 173.0, 170.0, 213.0, 235.0, 177.0, 158.0, 190.0, 166.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0, 67.0, 68.0], "value": 66.9, "unit": "score"}]}]} 19:55:55 INFO - Return code: 0 19:55:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:55:55 ERROR - # TBPL SUCCESS # 19:55:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:55:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:55:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:55:55 INFO - 2017-02-15 19:55:55.677 screenresolution[2459:76905] starting screenresolution argv=screenresolution get 19:55:55 INFO - 2017-02-15 19:55:55.680 screenresolution[2459:76905] Display 0: 1600x1200x32@60 19:55:55 INFO - 2017-02-15 19:55:55.686 screenresolution[2460:76908] starting screenresolution argv=screenresolution list 19:55:55 INFO - Available Modes on Display 0 19:55:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:55:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:55:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:55:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:55:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:55:55 INFO - Intel Iris: 19:55:55 INFO - Chipset Model: Intel Iris 19:55:55 INFO - Type: GPU 19:55:55 INFO - Bus: Built-In 19:55:55 INFO - VRAM (Dynamic, Max): 1536 MB 19:55:55 INFO - Vendor: Intel (0x8086) 19:55:55 INFO - Device ID: 0x0a2e 19:55:55 INFO - Revision ID: 0x0009 19:55:55 INFO - Displays: 19:55:55 INFO - Display: 19:55:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:55:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:55:55 INFO - Display Serial Number: 1600x1200 60 19:55:55 INFO - Main Display: Yes 19:55:55 INFO - Mirror: Off 19:55:55 INFO - Online: Yes 19:55:55 INFO - Rotation: Supported 19:55:55 INFO - Return code: 0 19:55:55 INFO - Running post-action listener: _resource_record_post_action 19:55:55 INFO - [mozharness: 2017-02-16 03:55:55.922510Z] Finished run-tests step (success) 19:55:55 INFO - Running post-run listener: _resource_record_post_run 19:55:55 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 364544; Write bytes: 511883264; Read time: 4; Write time: 1712 19:55:55 INFO - TinderboxPrint: CPU usage
54.3% 19:55:55 INFO - TinderboxPrint: I/O read bytes / time
364,544 / 4 19:55:55 INFO - TinderboxPrint: I/O write bytes / time
511,883,264 / 1,712 19:55:55 INFO - TinderboxPrint: CPU idle
2,191.4 (45.7%) 19:55:55 INFO - TinderboxPrint: CPU system
964.0 (20.1%) 19:55:55 INFO - TinderboxPrint: CPU user
1,642.3 (34.2%) 19:55:55 INFO - TinderboxPrint: Swap in / out
207,552,512 / 0 19:55:55 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201091584; Write bytes: 198918144; Read time: 15804; Write time: 390 19:55:55 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 364544; Write bytes: 302278656; Read time: 4; Write time: 1293 19:55:56 INFO - Running post-run listener: _upload_blobber_files 19:55:56 INFO - Blob upload gear active. 19:55:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:55:56 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 19:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:55:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:57 INFO - (blobuploader) - INFO - Done attempting. 19:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:59 INFO - (blobuploader) - INFO - Done attempting. 19:55:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:55:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:56:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:00 INFO - (blobuploader) - INFO - Done attempting. 19:56:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:56:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:56:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:02 INFO - (blobuploader) - INFO - Done attempting. 19:56:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:02 INFO - Return code: 0 19:56:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:56:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c079f7e9bf4753a012b0f71f04eb265d08dd63764989b374700bee0a03fdee9f95e3c0afcab647c55eced1d7d40a229a08ceb7451fa07c2f4bb99d20ff7e4c24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed706c42d7c35bda49323985e4ef59248b0eb0d654c0905b2d42c6939cc27d74e71176d234ea9a6bbeff9b9b9e21e2900f4db300f345f09df45266ecdc182bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24ff36da61093456890fcb2d4694356d75f8f0aa863878fbbc7d3efae9e8b17eaa6760f5757d10fff9c61dc4663347202a578304e8158b8ea0cff282b603f9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e17a96c95b628f93abb80776275749d84a2dfc8475f6cbf1fdd4a18672af1ee54879d088159cf55d69f17c2f1df22fb48c2f33b7d63cfb2f241b09d8306a2d96"} 19:56:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:56:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:56:02 INFO - Contents: 19:56:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c079f7e9bf4753a012b0f71f04eb265d08dd63764989b374700bee0a03fdee9f95e3c0afcab647c55eced1d7d40a229a08ceb7451fa07c2f4bb99d20ff7e4c24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed706c42d7c35bda49323985e4ef59248b0eb0d654c0905b2d42c6939cc27d74e71176d234ea9a6bbeff9b9b9e21e2900f4db300f345f09df45266ecdc182bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24ff36da61093456890fcb2d4694356d75f8f0aa863878fbbc7d3efae9e8b17eaa6760f5757d10fff9c61dc4663347202a578304e8158b8ea0cff282b603f9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e17a96c95b628f93abb80776275749d84a2dfc8475f6cbf1fdd4a18672af1ee54879d088159cf55d69f17c2f1df22fb48c2f33b7d63cfb2f241b09d8306a2d96"} 19:56:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:02 INFO - Copying logs to upload dir... 19:56:02 INFO - mkdir: /builds/slave/test/build/upload/logs 19:56:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.025824 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-15 19:56:02.772403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 19:56:02.776072) ========= 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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c079f7e9bf4753a012b0f71f04eb265d08dd63764989b374700bee0a03fdee9f95e3c0afcab647c55eced1d7d40a229a08ceb7451fa07c2f4bb99d20ff7e4c24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed706c42d7c35bda49323985e4ef59248b0eb0d654c0905b2d42c6939cc27d74e71176d234ea9a6bbeff9b9b9e21e2900f4db300f345f09df45266ecdc182bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24ff36da61093456890fcb2d4694356d75f8f0aa863878fbbc7d3efae9e8b17eaa6760f5757d10fff9c61dc4663347202a578304e8158b8ea0cff282b603f9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e17a96c95b628f93abb80776275749d84a2dfc8475f6cbf1fdd4a18672af1ee54879d088159cf55d69f17c2f1df22fb48c2f33b7d63cfb2f241b09d8306a2d96"} build_url:https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/cZq-1URVQDCdaHRiTJDItA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c079f7e9bf4753a012b0f71f04eb265d08dd63764989b374700bee0a03fdee9f95e3c0afcab647c55eced1d7d40a229a08ceb7451fa07c2f4bb99d20ff7e4c24", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed706c42d7c35bda49323985e4ef59248b0eb0d654c0905b2d42c6939cc27d74e71176d234ea9a6bbeff9b9b9e21e2900f4db300f345f09df45266ecdc182bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24ff36da61093456890fcb2d4694356d75f8f0aa863878fbbc7d3efae9e8b17eaa6760f5757d10fff9c61dc4663347202a578304e8158b8ea0cff282b603f9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e17a96c95b628f93abb80776275749d84a2dfc8475f6cbf1fdd4a18672af1ee54879d088159cf55d69f17c2f1df22fb48c2f33b7d63cfb2f241b09d8306a2d96"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 19:56:02.811914) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:56:02.812326) ========= 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.x8F8Wg8bNN/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.3jEApcJ8Kh/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005344 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 19:56:02.863018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 19:56:02.863407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 19:56:02.863780) ========= ========= Total master_lag: 0.20 =========