builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0191 starttime: 1490119758.97 results: success (0) buildid: 20170321090724 builduid: 8c6b9db6fa9b42fb88cfb1ddf16e483b revision: 5615e41108d83fcb8ec18bf95c97cf48cb724168 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:18.968513) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:18.968972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:18.969249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:18.994161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:18.994458) ========= 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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-21 11:09:18-- 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% 8.24M=0.001s 2017-03-21 11:09:19 (8.24 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133088 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:19.150736) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:19.151060) ========= 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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.020025 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:19.199770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 11:09:19.200126) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5615e41108d83fcb8ec18bf95c97cf48cb724168 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5615e41108d83fcb8ec18bf95c97cf48cb724168 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ajaVHrkUx6/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.n6CYNSUUdp/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-03-21 11:09:19,229 truncating revision to first 12 chars 2017-03-21 11:09:19,229 Setting DEBUG logging. 2017-03-21 11:09:19,229 attempt 1/10 2017-03-21 11:09:19,229 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5615e41108d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 11:09:20,856 unpacking tar archive at: mozilla-beta-5615e41108d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.874731 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 11:09:21.098250) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:21.098567) ========= script_repo_revision: 5615e41108d83fcb8ec18bf95c97cf48cb724168 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:21.098974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:21.099251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 11:09:21.118989) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-21 11:09:21.119327) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ajaVHrkUx6/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.n6CYNSUUdp/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:09:21 INFO - MultiFileLogger online at 20170321 11:09:21 in /builds/slave/test 11:09:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:09:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:09:21 INFO - {'append_to_log': False, 11:09:21 INFO - 'base_work_dir': '/builds/slave/test', 11:09:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:09:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:09:21 INFO - 'branch': 'Mozilla-Beta', 11:09:21 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:21 INFO - 'config_files': ('talos/mac_config.py',), 11:09:21 INFO - 'default_actions': ('clobber', 11:09:21 INFO - 'read-buildbot-config', 11:09:21 INFO - 'download-and-extract', 11:09:21 INFO - 'populate-webroot', 11:09:21 INFO - 'create-virtualenv', 11:09:21 INFO - 'install', 11:09:21 INFO - 'run-tests'), 11:09:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:21 INFO - 'download_minidump_stackwalk': True, 11:09:21 INFO - 'download_symbols': 'ondemand', 11:09:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:21 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:21 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:21 INFO - 'installer_path': 'installer.exe', 11:09:21 INFO - 'log_level': 'info', 11:09:21 INFO - 'log_name': 'talos', 11:09:21 INFO - 'log_to_console': True, 11:09:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:09:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:09:21 INFO - 'opt_config_files': (), 11:09:21 INFO - 'pip_index': False, 11:09:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:09:21 INFO - 'cmd': ('bash', 11:09:21 INFO - '-c', 11:09:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:09:21 INFO - 'enabled': True, 11:09:21 INFO - 'halt_on_failure': False, 11:09:21 INFO - 'name': 'check_screen_resolution'},), 11:09:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:09:21 INFO - 'cmd': ('bash', 11:09:21 INFO - '-c', 11:09:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:09:21 INFO - 'enabled': True, 11:09:21 INFO - 'halt_on_failure': False, 11:09:21 INFO - 'name': 'check_screen_resolution'},), 11:09:21 INFO - 'run_cmd_checks_enabled': True, 11:09:21 INFO - 'sps_profile': False, 11:09:21 INFO - 'sps_profile_interval': 0, 11:09:21 INFO - 'suite': 'dromaeojs-e10s', 11:09:21 INFO - 'system_bits': '32', 11:09:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:21 INFO - 'title': 't-yosemite-r7-0191', 11:09:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:21 INFO - 'use_talos_json': True, 11:09:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:09:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:21 INFO - 'work_dir': 'build'} 11:09:21 INFO - [mozharness: 2017-03-21 18:09:21.274989Z] Running clobber step. 11:09:21 INFO - Running pre-action listener: _resource_record_pre_action 11:09:21 INFO - Running main action method: clobber 11:09:21 INFO - rmtree: /builds/slave/test/build 11:09:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:09:23 INFO - Running post-action listener: _resource_record_post_action 11:09:23 INFO - [mozharness: 2017-03-21 18:09:23.376287Z] Finished clobber step (success) 11:09:23 INFO - [mozharness: 2017-03-21 18:09:23.376551Z] Running read-buildbot-config step. 11:09:23 INFO - Running pre-action listener: _resource_record_pre_action 11:09:23 INFO - Running main action method: read_buildbot_config 11:09:23 INFO - Using buildbot properties: 11:09:23 INFO - { 11:09:23 INFO - "project": "", 11:09:23 INFO - "product": "firefox", 11:09:23 INFO - "script_repo_revision": "production", 11:09:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:09:23 INFO - "repository": "", 11:09:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:09:23 INFO - "buildid": "20170321090724", 11:09:23 INFO - "pgo_build": "False", 11:09:23 INFO - "basedir": "/builds/slave/test", 11:09:23 INFO - "buildnumber": 11, 11:09:23 INFO - "slavename": "t-yosemite-r7-0191", 11:09:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:09:23 INFO - "platform": "yosemite_r7", 11:09:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:09:23 INFO - "branch": "mozilla-beta", 11:09:23 INFO - "repo_path": "releases/mozilla-beta", 11:09:23 INFO - "revision": "5615e41108d83fcb8ec18bf95c97cf48cb724168", 11:09:23 INFO - "stage_platform": "macosx64", 11:09:23 INFO - "builduid": "8c6b9db6fa9b42fb88cfb1ddf16e483b", 11:09:23 INFO - "slavebuilddir": "test" 11:09:23 INFO - } 11:09:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 11:09:23 INFO - Running post-action listener: _resource_record_post_action 11:09:23 INFO - [mozharness: 2017-03-21 18:09:23.382083Z] Finished read-buildbot-config step (success) 11:09:23 INFO - [mozharness: 2017-03-21 18:09:23.382315Z] Running download-and-extract step. 11:09:23 INFO - Running pre-action listener: _resource_record_pre_action 11:09:23 INFO - Running main action method: download_and_extract 11:09:23 INFO - mkdir: /builds/slave/test/build/tests 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:23 INFO - trying https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 11:09:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 11:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 11:09:23 INFO - Downloaded 1165 bytes. 11:09:23 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 11:09:23 INFO - Using the following test package requirements: 11:09:23 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:09:23 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:09:23 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 11:09:23 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:09:23 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 11:09:23 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:09:23 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:09:23 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 11:09:23 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:09:23 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:09:23 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 11:09:23 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:09:23 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 11:09:23 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:09:23 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 11:09:23 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:09:23 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 11:09:23 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 11:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:09:24 INFO - Expected file size: 16108236 11:09:24 INFO - Obtained file size: 16108236 11:09:31 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:09:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:09:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:09:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:09:32 INFO - Expected file size: 16108236 11:09:32 INFO - Obtained file size: 16108236 11:09:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 11:09:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 11:09:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 11:09:39 INFO - Expected file size: 14403663 11:09:39 INFO - Obtained file size: 14403663 11:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:40 INFO - trying https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:09:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 11:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 11:09:41 INFO - Downloaded 58737115 bytes. 11:09:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:09:41 INFO - mkdir: /builds/slave/test/properties 11:09:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:41 INFO - Contents: 11:09:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:09:42 INFO - Running post-action listener: _resource_record_post_action 11:09:42 INFO - Running post-action listener: set_extra_try_arguments 11:09:42 INFO - [mozharness: 2017-03-21 18:09:42.569914Z] Finished download-and-extract step (success) 11:09:42 INFO - [mozharness: 2017-03-21 18:09:42.570054Z] Running populate-webroot step. 11:09:42 INFO - Running pre-action listener: _resource_record_pre_action 11:09:42 INFO - Running main action method: populate_webroot 11:09:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:42 INFO - '--tppagecycles', 11:09:42 INFO - '7'], 11:09:42 INFO - 'tests': ['tsvgm']}}, 11:09:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:09:42 INFO - 'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:09:42 INFO - 'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['damp', 'tps']}, 11:09:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:09:42 INFO - 'tests': ['damp', 'tps']}, 11:09:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['dromaeo_dom']}, 11:09:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['basic_compositor_video']}, 11:09:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:09:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['a11yr', 11:09:42 INFO - 'ts_paint', 11:09:42 INFO - 'tpaint', 11:09:42 INFO - 'sessionrestore', 11:09:42 INFO - 'sessionrestore_no_auto_restore', 11:09:42 INFO - 'tabpaint']}, 11:09:42 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:42 INFO - 'ts_paint', 11:09:42 INFO - 'tpaint', 11:09:42 INFO - 'sessionrestore', 11:09:42 INFO - 'sessionrestore_no_auto_restore', 11:09:42 INFO - 'tabpaint']}, 11:09:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:09:42 INFO - 'ts_paint', 11:09:42 INFO - 'tpaint', 11:09:42 INFO - 'sessionrestore', 11:09:42 INFO - 'sessionrestore_no_auto_restore', 11:09:42 INFO - 'tabpaint']}, 11:09:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:09:42 INFO - 'ts_paint', 11:09:42 INFO - 'tpaint', 11:09:42 INFO - 'sessionrestore', 11:09:42 INFO - 'sessionrestore_no_auto_restore', 11:09:42 INFO - 'tabpaint']}, 11:09:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['a11yr', 11:09:42 INFO - 'ts_paint', 11:09:42 INFO - 'tpaint', 11:09:42 INFO - 'sessionrestore', 11:09:42 INFO - 'sessionrestore_no_auto_restore', 11:09:42 INFO - 'tabpaint']}, 11:09:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['a11yr', 11:09:42 INFO - 'ts_paint', 11:09:42 INFO - 'tpaint', 11:09:42 INFO - 'sessionrestore', 11:09:42 INFO - 'sessionrestore_no_auto_restore', 11:09:42 INFO - 'tabpaint']}, 11:09:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['tsvgx', 11:09:42 INFO - 'tsvgr_opacity', 11:09:42 INFO - 'tart', 11:09:42 INFO - 'tscrollx', 11:09:42 INFO - 'cart', 11:09:42 INFO - 'tsvg_static']}, 11:09:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:42 INFO - 'tsvgr_opacity', 11:09:42 INFO - 'tart', 11:09:42 INFO - 'tscrollx', 11:09:42 INFO - 'cart', 11:09:42 INFO - 'tsvg_static']}, 11:09:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:09:42 INFO - 'talos_options': ['--disable-e10s'], 11:09:42 INFO - 'tests': ['tp5o']}, 11:09:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:09:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:09:42 INFO - 'talos_options': ['--disable-e10s', 11:09:42 INFO - '--xperf_path', 11:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:42 INFO - 'tests': ['tp5n']}, 11:09:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:09:42 INFO - 'talos_options': ['--xperf_path', 11:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:42 INFO - 'tests': ['tp5n']}}, 11:09:42 INFO - 'talos.zip': {'path': '', 11:09:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:42 INFO - Running post-action listener: _resource_record_post_action 11:09:42 INFO - [mozharness: 2017-03-21 18:09:42.589839Z] Finished populate-webroot step (success) 11:09:42 INFO - [mozharness: 2017-03-21 18:09:42.589966Z] Running create-virtualenv step. 11:09:42 INFO - Running pre-action listener: _resource_record_pre_action 11:09:42 INFO - Running main action method: create_virtualenv 11:09:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:09:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:42 INFO - Using real prefix '/tools/python27' 11:09:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:46 INFO - Installing pip.................done. 11:09:46 INFO - Return code: 0 11:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:09:46 INFO - Reading from file tmpfile_stdout 11:09:46 INFO - Output received: 11:09:46 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) 11:09:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:46 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:46 INFO - 'HOME': '/Users/cltbld', 11:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:46 INFO - 'LOGNAME': 'cltbld', 11:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:46 INFO - 'MOZ_NO_REMOTE': '1', 11:09:46 INFO - 'NO_EM_RESTART': '1', 11:09:46 INFO - 'PAGER': '/bin/cat', 11:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:46 INFO - 'PWD': '/builds/slave/test', 11:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:46 INFO - 'SHELL': '/bin/bash', 11:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:09:46 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:46 INFO - 'USER': 'cltbld', 11:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:46 INFO - 'XPC_FLAGS': '0x0', 11:09:46 INFO - 'XPC_SERVICE_NAME': '0', 11:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:09:46 INFO - Cleaning up... 11:09:46 INFO - Return code: 0 11:09:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:46 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:46 INFO - 'HOME': '/Users/cltbld', 11:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:46 INFO - 'LOGNAME': 'cltbld', 11:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:46 INFO - 'MOZ_NO_REMOTE': '1', 11:09:46 INFO - 'NO_EM_RESTART': '1', 11:09:46 INFO - 'PAGER': '/bin/cat', 11:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:46 INFO - 'PWD': '/builds/slave/test', 11:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:46 INFO - 'SHELL': '/bin/bash', 11:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:09:46 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:46 INFO - 'USER': 'cltbld', 11:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:46 INFO - 'XPC_FLAGS': '0x0', 11:09:46 INFO - 'XPC_SERVICE_NAME': '0', 11:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:47 INFO - Downloading/unpacking psutil>=3.1.1 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:50 INFO - Installing collected packages: psutil 11:09:50 INFO - Running setup.py install for psutil 11:09:50 INFO - building 'psutil._psutil_osx' extension 11:09:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:09:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:09:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:09:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:09:51 INFO - building 'psutil._psutil_posix' extension 11:09:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:09:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:09:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:09:51 INFO - ^ 11:09:51 INFO - 1 warning generated. 11:09:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:09:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:51 INFO - Successfully installed psutil 11:09:51 INFO - Cleaning up... 11:09:51 INFO - Return code: 0 11:09:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:51 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:09:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:09:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:51 INFO - 'HOME': '/Users/cltbld', 11:09:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:51 INFO - 'LOGNAME': 'cltbld', 11:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:51 INFO - 'MOZ_NO_REMOTE': '1', 11:09:51 INFO - 'NO_EM_RESTART': '1', 11:09:51 INFO - 'PAGER': '/bin/cat', 11:09:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:51 INFO - 'PWD': '/builds/slave/test', 11:09:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:51 INFO - 'SHELL': '/bin/bash', 11:09:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:09:51 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:09:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:51 INFO - 'USER': 'cltbld', 11:09:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:51 INFO - 'XPC_FLAGS': '0x0', 11:09:51 INFO - 'XPC_SERVICE_NAME': '0', 11:09:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:54 INFO - Installing collected packages: mozsystemmonitor 11:09:54 INFO - Running setup.py install for mozsystemmonitor 11:09:54 INFO - Successfully installed mozsystemmonitor 11:09:54 INFO - Cleaning up... 11:09:54 INFO - Return code: 0 11:09:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:54 INFO - 'HOME': '/Users/cltbld', 11:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:54 INFO - 'LOGNAME': 'cltbld', 11:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:54 INFO - 'MOZ_NO_REMOTE': '1', 11:09:54 INFO - 'NO_EM_RESTART': '1', 11:09:54 INFO - 'PAGER': '/bin/cat', 11:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:54 INFO - 'PWD': '/builds/slave/test', 11:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:54 INFO - 'SHELL': '/bin/bash', 11:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:09:54 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:54 INFO - 'USER': 'cltbld', 11:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:54 INFO - 'XPC_FLAGS': '0x0', 11:09:54 INFO - 'XPC_SERVICE_NAME': '0', 11:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:58 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:58 INFO - warning: no files found matching '*.txt' 11:09:58 INFO - no previously-included directories found matching 'build' 11:09:58 INFO - no previously-included directories found matching 'dist' 11:09:58 INFO - no previously-included directories found matching '.git*' 11:09:58 INFO - Installing collected packages: jsonschema, functools32 11:09:58 INFO - Running setup.py install for functools32 11:09:58 INFO - warning: no files found matching '*.txt' 11:09:58 INFO - no previously-included directories found matching 'build' 11:09:58 INFO - no previously-included directories found matching 'dist' 11:09:58 INFO - no previously-included directories found matching '.git*' 11:09:58 INFO - Successfully installed jsonschema functools32 11:09:58 INFO - Cleaning up... 11:09:58 INFO - Return code: 0 11:09:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:58 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:58 INFO - 'HOME': '/Users/cltbld', 11:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:58 INFO - 'LOGNAME': 'cltbld', 11:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:58 INFO - 'MOZ_NO_REMOTE': '1', 11:09:58 INFO - 'NO_EM_RESTART': '1', 11:09:58 INFO - 'PAGER': '/bin/cat', 11:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:58 INFO - 'PWD': '/builds/slave/test', 11:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:58 INFO - 'SHELL': '/bin/bash', 11:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:09:58 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:58 INFO - 'USER': 'cltbld', 11:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:58 INFO - 'XPC_FLAGS': '0x0', 11:09:58 INFO - 'XPC_SERVICE_NAME': '0', 11:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:09:58 INFO - Cleaning up... 11:09:58 INFO - Return code: 0 11:09:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:58 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:58 INFO - 'HOME': '/Users/cltbld', 11:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:58 INFO - 'LOGNAME': 'cltbld', 11:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:58 INFO - 'MOZ_NO_REMOTE': '1', 11:09:58 INFO - 'NO_EM_RESTART': '1', 11:09:58 INFO - 'PAGER': '/bin/cat', 11:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:58 INFO - 'PWD': '/builds/slave/test', 11:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:58 INFO - 'SHELL': '/bin/bash', 11:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:09:58 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:58 INFO - 'USER': 'cltbld', 11:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:58 INFO - 'XPC_FLAGS': '0x0', 11:09:58 INFO - 'XPC_SERVICE_NAME': '0', 11:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:10:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:10:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:02 INFO - Downloading docopt-0.6.1.tar.gz 11:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:10:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:10:02 INFO - Running setup.py install for blobuploader 11:10:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:10:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:10:03 INFO - Running setup.py install for requests 11:10:03 INFO - Running setup.py install for docopt 11:10:03 INFO - Successfully installed blobuploader requests docopt 11:10:03 INFO - Cleaning up... 11:10:03 INFO - Return code: 0 11:10:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:03 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:03 INFO - 'HOME': '/Users/cltbld', 11:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:03 INFO - 'LOGNAME': 'cltbld', 11:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:03 INFO - 'MOZ_NO_REMOTE': '1', 11:10:03 INFO - 'NO_EM_RESTART': '1', 11:10:03 INFO - 'PAGER': '/bin/cat', 11:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:03 INFO - 'PWD': '/builds/slave/test', 11:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:03 INFO - 'SHELL': '/bin/bash', 11:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:10:03 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:03 INFO - 'USER': 'cltbld', 11:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:03 INFO - 'XPC_FLAGS': '0x0', 11:10:03 INFO - 'XPC_SERVICE_NAME': '0', 11:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-52qzZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-PNQrSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-DLiH4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-XjB17A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-JAhOVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-i5T3Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-IahrQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-brlgF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:10:04 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-BALt8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8nrRme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Mib3cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-k_S3nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-smiZaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-v8DuwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-y0ogmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-oBIpvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:10:05 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Xd3Avh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:10:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:10:05 INFO - Running setup.py install for manifestparser 11:10:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:10:06 INFO - Running setup.py install for mozcrash 11:10:06 INFO - Running setup.py install for mozdebug 11:10:06 INFO - Running setup.py install for mozdevice 11:10:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:10:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:10:06 INFO - Running setup.py install for mozfile 11:10:06 INFO - Running setup.py install for mozhttpd 11:10:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:10:06 INFO - Running setup.py install for mozinfo 11:10:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:10:06 INFO - Running setup.py install for mozInstall 11:10:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozleak 11:10:07 INFO - Running setup.py install for mozlog 11:10:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for moznetwork 11:10:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozprocess 11:10:07 INFO - Running setup.py install for mozprofile 11:10:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozrunner 11:10:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozscreenshot 11:10:08 INFO - Running setup.py install for moztest 11:10:08 INFO - Running setup.py install for mozversion 11:10:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:10:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:10:08 INFO - Cleaning up... 11:10:08 INFO - Return code: 0 11:10:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:08 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:08 INFO - 'HOME': '/Users/cltbld', 11:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:08 INFO - 'LOGNAME': 'cltbld', 11:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:08 INFO - 'MOZ_NO_REMOTE': '1', 11:10:08 INFO - 'NO_EM_RESTART': '1', 11:10:08 INFO - 'PAGER': '/bin/cat', 11:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:08 INFO - 'PWD': '/builds/slave/test', 11:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:08 INFO - 'SHELL': '/bin/bash', 11:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:10:08 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:08 INFO - 'USER': 'cltbld', 11:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:08 INFO - 'XPC_FLAGS': '0x0', 11:10:08 INFO - 'XPC_SERVICE_NAME': '0', 11:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:10:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-svgEDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:10:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-JPD41R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:10:08 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)) 11:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:10:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hbkLUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5euzGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:10:09 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)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1nFFtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-suTZcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-7jH1ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-aZaMzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-aXbmkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EDutKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-t1Lo9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:10:09 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-RDRfuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:10:10 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-biRKat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:10:10 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-KFvywa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:10 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-eMyQ0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:10:10 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-4fK8rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:10:10 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-lNMkYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:10:10 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)) 11:10:10 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)) 11:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:10:10 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)) 11:10:10 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)) 11:10:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:13 INFO - Downloading blessings-1.6.tar.gz 11:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:10:13 INFO - Installing collected packages: blessings 11:10:13 INFO - Running setup.py install for blessings 11:10:13 INFO - Successfully installed blessings 11:10:13 INFO - Cleaning up... 11:10:13 INFO - Return code: 0 11:10:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:10:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:13 INFO - Reading from file tmpfile_stdout 11:10:13 INFO - Current package versions: 11:10:13 INFO - blessings == 1.6 11:10:13 INFO - blobuploader == 1.2.4 11:10:13 INFO - docopt == 0.6.1 11:10:13 INFO - functools32 == 3.2.3-2 11:10:13 INFO - jsonschema == 2.5.1 11:10:13 INFO - manifestparser == 1.1 11:10:13 INFO - mozInstall == 1.12 11:10:13 INFO - mozcrash == 1.0 11:10:13 INFO - mozdebug == 0.1 11:10:13 INFO - mozdevice == 0.49 11:10:13 INFO - mozfile == 1.2 11:10:13 INFO - mozhttpd == 0.7 11:10:13 INFO - mozinfo == 0.9 11:10:13 INFO - mozleak == 0.1 11:10:13 INFO - mozlog == 3.4 11:10:13 INFO - moznetwork == 0.27 11:10:13 INFO - mozprocess == 0.24 11:10:13 INFO - mozprofile == 0.28 11:10:13 INFO - mozrunner == 6.13 11:10:13 INFO - mozscreenshot == 0.1 11:10:13 INFO - mozsystemmonitor == 0.3 11:10:13 INFO - moztest == 0.8 11:10:13 INFO - mozversion == 1.4 11:10:13 INFO - psutil == 3.1.1 11:10:13 INFO - requests == 1.2.3 11:10:13 INFO - wsgiref == 0.1.2 11:10:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:13 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:13 INFO - 'HOME': '/Users/cltbld', 11:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:13 INFO - 'LOGNAME': 'cltbld', 11:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:13 INFO - 'MOZ_NO_REMOTE': '1', 11:10:13 INFO - 'NO_EM_RESTART': '1', 11:10:13 INFO - 'PAGER': '/bin/cat', 11:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:13 INFO - 'PWD': '/builds/slave/test', 11:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:13 INFO - 'SHELL': '/bin/bash', 11:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:10:13 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:13 INFO - 'USER': 'cltbld', 11:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:13 INFO - 'XPC_FLAGS': '0x0', 11:10:13 INFO - 'XPC_SERVICE_NAME': '0', 11:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:10:14 INFO - Cleaning up... 11:10:14 INFO - Return code: 0 11:10:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:14 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 0x10e7cab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7cd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea28470280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, '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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:14 INFO - 'HOME': '/Users/cltbld', 11:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:14 INFO - 'LOGNAME': 'cltbld', 11:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:14 INFO - 'MOZ_NO_REMOTE': '1', 11:10:14 INFO - 'NO_EM_RESTART': '1', 11:10:14 INFO - 'PAGER': '/bin/cat', 11:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:14 INFO - 'PWD': '/builds/slave/test', 11:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:14 INFO - 'SHELL': '/bin/bash', 11:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:10:14 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:14 INFO - 'USER': 'cltbld', 11:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:14 INFO - 'XPC_FLAGS': '0x0', 11:10:14 INFO - 'XPC_SERVICE_NAME': '0', 11:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:10:14 INFO - Cleaning up... 11:10:14 INFO - Return code: 0 11:10:14 INFO - Running post-action listener: _resource_record_post_action 11:10:14 INFO - Running post-action listener: _start_resource_monitoring 11:10:14 INFO - Starting resource monitoring. 11:10:14 INFO - [mozharness: 2017-03-21 18:10:14.420206Z] Finished create-virtualenv step (success) 11:10:14 INFO - [mozharness: 2017-03-21 18:10:14.421347Z] Running install step. 11:10:14 INFO - Running pre-action listener: _resource_record_pre_action 11:10:14 INFO - Running main action method: install 11:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:14 INFO - Reading from file tmpfile_stdout 11:10:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:10:14 INFO - Reading from file tmpfile_stdout 11:10:14 INFO - Output received: 11:10:14 INFO - Usage: mozinstall [options] installer 11:10:14 INFO - Options: 11:10:14 INFO - -h, --help show this help message and exit 11:10:14 INFO - -d DEST, --destination=DEST 11:10:14 INFO - Directory to install application into. [default: 11:10:14 INFO - "/builds/slave/test"] 11:10:14 INFO - --app=APP Application being installed. [default: firefox] 11:10:14 INFO - mkdir: /builds/slave/test/build/application 11:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:10:29 INFO - Reading from file tmpfile_stdout 11:10:29 INFO - Output received: 11:10:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:10:29 INFO - Running post-action listener: _resource_record_post_action 11:10:29 INFO - [mozharness: 2017-03-21 18:10:29.289594Z] Finished install step (success) 11:10:29 INFO - [mozharness: 2017-03-21 18:10:29.289741Z] Running run-tests step. 11:10:29 INFO - Running pre-action listener: _resource_record_pre_action 11:10:29 INFO - Running main action method: run_tests 11:10:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:10:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:10:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:10:29 INFO - 2017-03-21 11:10:29.304 screenresolution[1954:10838] starting screenresolution argv=screenresolution get 11:10:29 INFO - 2017-03-21 11:10:29.307 screenresolution[1954:10838] Display 0: 1600x1200x32@60 11:10:29 INFO - 2017-03-21 11:10:29.313 screenresolution[1955:10840] starting screenresolution argv=screenresolution list 11:10:29 INFO - Available Modes on Display 0 11:10:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:10:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:10:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:10:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:10:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:10:29 INFO - Intel Iris: 11:10:29 INFO - Chipset Model: Intel Iris 11:10:29 INFO - Type: GPU 11:10:29 INFO - Bus: Built-In 11:10:29 INFO - VRAM (Dynamic, Max): 1536 MB 11:10:29 INFO - Vendor: Intel (0x8086) 11:10:29 INFO - Device ID: 0x0a2e 11:10:29 INFO - Revision ID: 0x0009 11:10:29 INFO - Displays: 11:10:29 INFO - Display: 11:10:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:10:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:10:29 INFO - Display Serial Number: 1600x1200 60 11:10:29 INFO - Main Display: Yes 11:10:29 INFO - Mirror: Off 11:10:29 INFO - Online: Yes 11:10:29 INFO - Rotation: Supported 11:10:29 INFO - Return code: 0 11:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:29 INFO - Python 2.7.3 11:10:29 INFO - Return code: 0 11:10:29 INFO - grabbing minidump binary from tooltool 11:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:29 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 0x10e5a8d30>, '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 0x10e4cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e59dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:10:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:10:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:10:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:29 INFO - Return code: 0 11:10:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:10:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:10:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 11:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 11:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ajaVHrkUx6/Render', 11:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:29 INFO - 'HOME': '/Users/cltbld', 11:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:29 INFO - 'LOGNAME': 'cltbld', 11:10:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:29 INFO - 'MOZ_NO_REMOTE': '1', 11:10:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:29 INFO - 'NO_EM_RESTART': '1', 11:10:29 INFO - 'PAGER': '/bin/cat', 11:10:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:29 INFO - 'PWD': '/builds/slave/test', 11:10:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:29 INFO - 'SHELL': '/bin/bash', 11:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n6CYNSUUdp/Listeners', 11:10:29 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 11:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:29 INFO - 'USER': 'cltbld', 11:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:29 INFO - 'XPC_FLAGS': '0x0', 11:10:29 INFO - 'XPC_SERVICE_NAME': '0', 11:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 11:10:29 INFO - mozversion application_buildid: 20170321090724 11:10:29 INFO - mozversion application_changeset: 5615e41108d83fcb8ec18bf95c97cf48cb724168 11:10:29 INFO - mozversion application_display_name: Firefox 11:10:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:29 INFO - mozversion application_name: Firefox 11:10:29 INFO - mozversion application_remotingname: firefox 11:10:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:10:29 INFO - mozversion application_vendor: Mozilla 11:10:29 INFO - mozversion application_version: 53.0 11:10:29 INFO - mozversion platform_buildid: 20170321090724 11:10:29 INFO - mozversion platform_changeset: 5615e41108d83fcb8ec18bf95c97cf48cb724168 11:10:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:10:29 INFO - mozversion platform_version: 53.0 11:10:29 INFO - using testdate: 1490119829 11:10:29 INFO - actual date: 1490119829 11:10:29 INFO - starting webserver on 'localhost:49333' 11:10:29 INFO - SUITE-START | Running 2 tests 11:10:29 INFO - TEST-START | dromaeo_css 11:10:29 INFO - operating with platform_type : mac_ 11:10:29 INFO - Initialising browser for dromaeo_css test... 11:10:29 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp63DLrj/profile http://localhost:49333/getInfo.html) 11:10:32 INFO - PROCESS | 1965 | 2017-03-21 11:10:32.469 plugin-container[1967:10991] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 11:10:32 INFO - PROCESS | 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:32 INFO - PROCESS | 1965 | 2017-03-21 11:10:32.470 plugin-container[1967:10991] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 11:10:32 INFO - PROCESS | 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:32 INFO - PROCESS | 1965 | 2017-03-21 11:10:32.470 plugin-container[1967:10991] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:10:32 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 11:10:32 INFO - PROCESS | 1965 | colorDepth:24 11:10:32 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 11:10:32 INFO - PROCESS | 1965 | __metrics 11:10:32 ERROR - PROCESS | 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 11:10:33 INFO - TEST-INFO | 1965: exit 0 11:10:33 INFO - Browser initialized. 11:10:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:10:33 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmp63DLrj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:35 INFO - PROCESS | 1968 | 2017-03-21 11:10:35.378 plugin-container[1969:11131] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 11:10:35 INFO - PROCESS | 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:35 INFO - PROCESS | 1968 | 2017-03-21 11:10:35.378 plugin-container[1969:11131] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 11:10:35 INFO - PROCESS | 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:35 INFO - PROCESS | 1968 | 2017-03-21 11:10:35.378 plugin-container[1969:11131] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:10:45 INFO - PROCESS | 1968 | RSS: Main: 172847104 11:10:45 INFO - PROCESS | 1968 | 11:13:46 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49333/tests/dromaeo/cssquery-ext.html) 11:13:48 INFO - PROCESS | 1968 | RSS: Main: 192434176 11:13:48 INFO - PROCESS | 1968 | 11:16:50 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49333/tests/dromaeo/cssquery-ext.html (next: http://localhost:49333/tests/dromaeo/cssquery-jquery.html) 11:16:51 INFO - PROCESS | 1968 | RSS: Main: 205590528 11:16:51 INFO - PROCESS | 1968 | 11:19:53 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49333/tests/dromaeo/cssquery-mootools.html) 11:19:53 INFO - PROCESS | 1968 | RSS: Main: 209539072 11:19:53 INFO - PROCESS | 1968 | 11:22:55 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49333/tests/dromaeo/cssquery-prototype.html) 11:22:56 INFO - PROCESS | 1968 | RSS: Main: 212582400 11:22:56 INFO - PROCESS | 1968 | 11:25:59 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49333/tests/dromaeo/cssquery-yui.html) 11:25:59 INFO - PROCESS | 1968 | RSS: Main: 213790720 11:25:59 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49333/tests/dromaeo/cssquery-yui.html (next: http://localhost:49333/tests/dromaeo/cssquery-dojo.html) 11:29:02 INFO - PROCESS | 1968 | RSS: Main: 214142976 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | __start_tp_report 11:29:02 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 11:29:02 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 11:29:02 INFO - PROCESS | 1968 | |i|pagename|runs| 11:29:02 INFO - PROCESS | 1968 | |0;dojo.html;3117.5791268178796;3505.5618047744033;3548.7870727756335;3562.8040457774814;3563.55455568054;5891.734871930763;5895.675737834417;5958.821235362941;5986.431289027546;5997.070454079614;5548.195511650818;5937.732802023908;6025.15647809307;6037.969810150954;6038.939610603893;4681.625469962411;5312;5349.438308977559;5389.73051347433;5400.486953739408;5408.891177308642;5425.674459532421;5429.6742195468205;5437.429069947658;5449.945500544984;5265.76304066318;5266.3943646480575;5414.702191379492;5426.294581704373;5451.563874890019;5332.840014799582;5374.435684253156;5409.810656626999;5439.510444060014;5477.1510415885605;5250.842474725764;5357.08929481989;5358.383785864637;5364.8122315718765;5398.541124004464;5534.806281780158;5798.3911689272445;5942.554308426842;6056.757729690807;6186.876262474725;5678.346990096151;5931.555133365015;6244.406781355764;6311.431971122621;6347.777827776052;6418.454431373339;6427.325130861239;6431;6439.162908821823;6440.033994900802;6075.422834830684;6129.325774164839;6139.140520327113;6140.048292514667;6147.170132032164;6325.082862984841;6354.459870910932;6411.070394792729;6437;6463.321351258144;6254.061890716429;6278;6291.622502649856;6302.779402720975;6306.873862522724;6397.424231819158;6416.4225219729515;6434.581752186093;6436.839079022968;6448.065030570541;6108.645631960618;6140.166841500592;6184.072389141665;6194.101855231056;6260.874782504325;6254.3745625437095;6310.305866354697;6321.367863213642;6332.525060620472;6348.079528468346;5106.923396149061;5113.284140220372;5117.565006974449;5119.539241468286;5122.769475373617;4503.144402563568;4522.977385113119;4575.885602859955;4622.745748983838;4633.281841314534;5972.85067873298;6117.327094019654;6121.326654068049;6136.243373036893;6147.354527774609;6334.3032266450655;6392.264889537762;6412.3267056959285;6417.486601071903;6423.871522569522;5918.260217472816;5996.610220335664;6066.3630318815885;6089.147519347295;6119.4798442132915;5629.352624448159;5635.0702134147405;5637.9718101409235;5641.830745077655;5645.266115404971;6556.409923106943;6563.573367731082;6573.375529324707;6577.473802095917;6581.539292249497;6144.986077297374;6219.253689557101;6230.657313847601;6292;6388.552801303864;6591.835204119743;6595.406413422815;6600.174978127734;6604.306547812603;6649.73401063952;6320.810375688737;6335.683215839282;6347.39699728525;6352.587081839851;6361.300256971637;6180.7527698891545;6211.534134939988;6294.276158241678;6340.587861788969;6383.6808159592765;6119.624418755002;6176.6911654418;6209.751609935552;6238.251409830849;6252.843678908063;6240.843978900564;6244.344343843831;6250.687465626791;6256.749730010931;6265.655388953652;6028.788992385245;6112.473085128157;6119.143319935123;6176.66028368426;6234.875302493834;6162.26052873658;6162.445379915829;6196.738190560322;6230.43926046658;6255.874882502416;6108.694565271808;6203.7828675996125;6205.5345849060595;6227.844303892439;6230.127782110418 11:29:02 INFO - PROCESS | 1968 | |1;ext.html;486.81744345870277;493.38080708710606;493.63224397823615;503.7934446876781;516.3313509005837;39609.00977475564;42682.786586067064;42711;42799.78600106995;42801.78599107008;34589.481157782655;35935.82032089836;44184.558154418526;44904;45070.7746461268;9636.180924621398;9897.90102098977;9929.801403971916;11741.354225517593;12170.574029908956;12110.515579376814;12135;12220.633380998584;12223.511059557606;12231.08266879983;11919.40402979852;11924.28454292741;11939.7612047759;12138.635840924742;12204.694882627917;10149;11927.70180745484;12002.399880005965;12048.698782530419;12222.694432639166;10163.59345626174;11722.531098756039;11734.706632334175;11932.940335298355;11964;39812.60187398118;40135.59864401348;40199.196016079804;40226.39660405096;40255.396169057196;3468.9653103469145;4042.898927526806;4140.15126898985;4155.376693495969;4196.58034196581;29499.852500737572;29616;29622.25944351387;30076;31223.594938227834;3005.7294843463974;3260.1849537615594;3265.248992731685;3268.983655081733;3269.9836500817582;518516;520707;522755;524851.9999999962;526473;59351.70324148352;60529.09206361908;60564.39435605676;60967.08549371763;60996.39003609996;63499.682501587195;63730.36269637337;63760.36239637637;64104.679476602316;64207.67896160489;17007.23467443943;17178.484645460405;17436.65126697459;17470.650586988442;17471.126443677764;12184.939075304566;12487.687807804878;12983.35083245834;13254.933725331312;13270.800937985938;19311.806881931283;19446.80553194478;19485.51286217856;19520.31678891232;19536.511587210432;7697.383549454566;8137.75586732399;8202.58987050645;8220.588970551567;8270.007599088149;896.1620884473039;896.2158111652304;901.324006994754;919.632147141149;934.8691183234353;31963.88126415611;32382;32553;32600.184995375304;33106.83446582752;1054.1830081686753;1080.8432777247256;1094.8029354716227;1130.112861403794;1243.757467293869;15618.843811561967;16509.91745041267;16562.089085100193;17061.135153956973;17156.571085722706;642157;647158;661510;662524;666060;57678;58024;58408.70795645995;58447;58461.83076338535;1428.3215472650409;1446.9638259043609;1468.6475245940896;1494.1334026264958;1499.6400863792612;25428;30680.232994175323;30720;31037.224069398446;31388.843055784575;51035.72410689762;51339.48660513347;51936.74031629818;52015.2197717027;52024.479755201966;605374;606167;609469;610122;610176;24780.752192478565;25192.748072519775;26630.40217586951;26814.731852681223;27134.592981104903;38046.61953380542;44899.551004489535;45740.31389529093;46980.7650961743;47236.29145562751;30126.397472050874;36158.457623135146;37739;38395.398393610914;38952;37137.07157321089;37298.881033569036;38033;38209.235815282984;38978.4153237696;32898.17754556155;35058.298834023684;37521.62478375291;37638;37845.62154378421;30905.845470772503;31773.523397149525;33298.500522492664;33512.83243583766;33686.326273473904;21495.817730025;23494.29517114489;23837.761622383554;24307.27078187657;25337.366565836 11:29:02 INFO - PROCESS | 1968 | |2;jquery.html;398.4222876828596;399.8105635733693;404.36312807328454;411.8661435033614;435.8735966569695;21092.57814843704;22222.777772222253;22323.776762232374;22414.66378004329;22613.434664133405;22520.88739556304;22637.773622263772;22903.42741431465;22952.540949181006;23111;5889.2049573307695;6099.451049405553;6100.816975490742;6108.297545782248;6116.724747386378;5282.260483532308;6651.467882569383;6699.497537684669;6787.830304242384;6793.354631310018;6509.479241660656;6617.106690596756;6728.158980127484;6728.730850765988;6743.696533655997;6613.041109039186;6623.337666233387;6674.998750187462;6683.565568238049;6692.866142677143;5686.402927692574;5840.678762668052;5895.882082358372;5908.97045514774;5923.407659234085;27085.86457067722;27251.591226131426;27477.587836182473;27710.3072423189;27759.306017349525;2726.5228584997544;2804.733550312717;2809.3257618171697;2823.167165686107;2832.9716702832916;16275.186240688037;16343.754843677354;16578.917105414515;16673.749893751603;16796.412125575545;1844.5849683821168;1883.133758471105;1884.9246030158777;1887.282832523646;1891.527118220445;134456;136170;137230.62769372278;137399.999999999;138207;11510.597129100608;11565.248258863146;11661.708457288636;11733.237339573072;11866.76266474683;12549.874501255053;14551.563453096423;14595.708085838223;14890.553283401516;14965.326560304813;8919.794265421404;9204.677836275698;9228.354015219005;9369.250459963187;9455;9305.162535371848;9307.255419566418;9387.6714315;9510.239180865652;9564.995675454116;6344.365563443619;7237.565746055254;7299.598522081336;7429.33136017761;7447.329740323397;1665.900045997244;1746.7598005416044;1849.9177980881336;1950.9902450487941;1966.9409917702492;1056.5773690523852;1062.7715041266165;1081.8755843078147;1085.1644233939821;1120.7926533591312;19034.619307614048;22794.860256987085;23029.424264393525;23260.534789304118;23547.41131471727;966.4925913895121;1096.3644002867022;1107.2470719910539;1116.9497372618252;1145.7765735681628;9824.459654718916;11153.051990580729;11351.035162011322;11422.74349821519;12280.815787763191;739381;757279;772497;772763;783294;132540;144203;144825;150838;151549;1059.2691043180182;1065.536491626145;1086.9728256793644;1087.717193529688;1093.4478088565384;19352.612947740683;20252.319405275775;20417.59164816725;20450;20549.89725051425;56162;56589.71705141448;59251;60646;61054.084188738096;68843.31156688368;84520.57739711262;85023.57488212519;85167.57416212879;86906;8442.915570844212;8458.450200736932;8483.024452188078;8534.359923005924;8560.988167780692;13193.010524210531;13472.595822125351;13784.655383615489;14019.439222430989;14149.575512734635;11558.651573578803;11659.825102623638;11817.82273265919;11849.348285844362;11904.821427678766;10096.34373765703;10418.426986515815;10802.973717496825;11427.428628568705;11918.225315354473;11580.073594112282;11905.52377904874;12017.278963262232;12042.698932526757;12172.45223964906;8435.957820211106;8618.181272779077;10439.843402348819;13071.085024048225;13373.197608143542;10923.399213043358;11980.64058078259;12030.398480076135;12275.140740148105;12466.75066498683 11:29:02 INFO - PROCESS | 1968 | |3;mootools.html;1448.6305991972044;1471.4849802569095;1475.8966872318942;1485.3019081031914;1491.970160596788;6798.320167983199;7684.96157519213;7897.328727058192;8634.352423568225;8661.220490155885;8017.278444939954;8314.958425207866;8335.166483351662;8477.15228477152;8501.894753682012;2378.3697320210117;2405.386626410263;2407.723111842143;2408.1330720940446;2417.190241269177;2376.2633583589054;2402.627592723131;2412.758724127582;2415.6014257647466;2424.2000139953775;2376.762323767618;2393.628987506939;2404.519096180762;2404.5431368040104;2407.7712617301327;2349.4596242864236;2365.503244318695;2370.111208296889;2392.9760702392928;2396.3769419950936;2363.7045369328835;2369.407648087978;2422.9757702422926;2431.963520547193;2434.379233295516;8489.66041358345;8514.616842242052;8551.315894728468;8557.914420855774;8572.742817715478;5130.204818253177;5259.184826351883;5284.154535274338;5292.894142117175;5299.8410047698635;3477.3566890125408;3484.233468636896;3511.490833829106;3512.0341905975806;3574.267275208576;1162.5001249462728;1163.145088360063;1194.9342786146758;1207.3600991474532;1218.62222710959;10762.192835537287;10907.890921090768;10940.945295273552;10945.343279403261;11015.669529914196;4471.28459446487;4605.8848528786375;4756.667033307635;4809.422869255712;4823;8503.872441913376;9647.035296470296;9662.75843103928;9668.323217374716;9703.417794932328;5317.813876514303;5333.066713325153;5349.277847490617;5364.544013758874;5366.168243922199;4418.491873434532;4449.443819522559;4833.564979151894;4843.685160464559;4866.902661946741;3879.922401551953;3977.7215594908657;4007.859724909614;4059.2084543513733;4076.8369265229653;1172.2380452705638;1318.53851152096;1324.6025443157368;1326.9251905956207;1331.3542931678128;923.5474617437408;929.7695485540897;934.2572654739498;944.0653752784693;981.9361741486781;5576.804811831647;5577.2191893135;5716.885662286731;5794.015017447045;5799.797007104731;577.890200861835;594.1770647653032;595.1578516399333;598.1058317814808;601.3595520770454;3214.1964508872784;3439.9828000860334;3592.263585964871;3592.9101772455374;3594.946075808865;8829.33779966505;9785.951070244602;10136.341137826017;10138.898611013943;10174.694759157237;8481.787955301043;9448.57481413338;9498.667546635834;9890.950545247371;10117.342372745748;7768.53388796674;7923.524588524707;7931.286184243446;7940.682372705027;8003.19968003195;5791.913121303268;5796.159556864147;5823.941760582509;5971.526823240903;6067.939320606737;9357.157855793012;9429.434233945985;9463.337566370288;9468.384555003902;9510.286728495252;8930.285577153942;9178.724638260863;9196.172344489029;9463.432194068379;9464.905350946403;6705.262421133769;6944.687489063105;7001.719931202899;7268.672909719181;7428;7843.882341764992;8038.87941680887;8047.913531673149;8067.3949453792375;8077.636506357346;6700.731970721116;7237.059182306477;7297.781066568012;7349.375303099297;7495.925040749523;6846.657667116724;7179.210286868545;7194.640267986475;7327.0841144856895;7338.449616278694;6470.38531339522;6484.610923344614;6528.967355163194;6532.379423954717;6539.7384104637185;5012.523810238022;5032.572231360376;5045.1927691570645;5093.23601459784;5191.766370513412;4657.93013104797;5116.360454943132;5153.819616313411;5248.239005344128;5272.6309158358545 11:29:02 INFO - PROCESS | 1968 | |4;prototype.html;317.6696235914648;366.76343758275914;376.77770115631773;383.9040239940015;385.0450881813105;5364.91952620711;5488.259085023521;5548.41998470711;5615.21387005819;5655.632383895044;5303.443138470463;5447.564194864412;5505.724713764316;5524.33707955046;5527.364353099385;3704.499677630564;4307.640040768206;4353.28170851809;4355.237833379162;4358.215521206182;3881.8253178606888;3909.3354129798004;4115.753054816706;4153.77463648223;4348.239058164809;4126.698641087119;4128.21563902859;4136.875893723193;4138.172365526892;4148.1333399970135;3233.9029829105166;3905.9609403905883;4152.68854835887;4168.687348448848;4207.957920420818;2792.45547118312;3602.3335682898746;3622.166901612644;3624.169794253885;3693.759905606127;4541.591256786872;4972.229304457815;5082;5406.567474602022;5489.945100548984;4615.26155815068;4686.148971156408;4825.951740482586;4870.586000189988;4872.488388719169;5900.675462849542;5915.911261331084;5925.429761113309;5926.614770039933;5956;3127.545691253578;3759.9624003759886;3880.3597406427907;3944.349182384903;4009.4787677602017;5361.571074314045;5950.750342428052;6064.423879731418;6110.236220472441;6367.694622602356;3270.705636492727;3425.400554902882;4043.3126368516832;4048.9797551012643;4052.9392059119136;3651.123730304708;3968.7023473239046;4021.738586991836;4086.8569600063856;4113.547509773923;4775.331453596499;4791.257355109963;4809.470958194595;4822.445418776815;4823.493533178966;5202.3497062867145;5922.851928701817;5974.0882917466;5979.5814292999075;5982.1325907744;1153.6423708650345;1179.9705007374885;1199.4962115911337;1316.2628927800463;1328.8405391353099;770.6532060572765;821.3675469888153;858.6651206029653;874.4272501511521;905.2712566384124;4910.183232204107;5265.104932161542;5284.286621306152;5288.8413347599635;5307.681539107589;5249.396319423239;5388.622796404214;5396.595255355864;5732.197492351074;5864.736086876101;4731.243001119804;4932.580730637864;4941.357623508921;5312.495312945264;5344.85085706575;2639.746120592703;2830;2866.48076519445;2868.655761308656;2965.760850557815;5090.9236361454605;5788.5369170466265;5788.88422231553;5940.554478402516;5966.284045914518;5322;5545.057340252167;5625.859353516113;5645.689487078168;5931.525477961753;5162.896742065138;5587.675333176753;5638.643288875666;5897.469227769521;5983.940160598426;4560.192239480071;5413.621046526863;5626.662400255997;5745.242283703762;5782.496550896713;4911.877203069952;5406.324039547752;5425.159100339453;5598.608097433141;5647.774089036557;5519.5989744461285;5999.740054588586;6005.459508644243;6019.337872834072;6019.578629495893;3305.4545999909747;3544.1494041430387;3823.1589050408866;3884.4561761354;3890.47478590398;4680.46174689915;5409.377921539073;5536.252605898152;5701.4298570142655;5853.882922341444;5445.918311225414;5780.369931680991;5883.235179426647;5892.5285977122585;5911.349751527415;4936.284238785428;5902.232709747877;5909.320428150646;5909.911351329648;5919.8096704219715;5176.818811341585;5488.862778430571;5605.066252143004;5756.481916627524;5793.681347525927;5062.35473471116;5642.153676948491;5881.264841894763;5909.218100415824;5956.37458066914;5025.698458092526;5422.240886276003;5727.284089488814;5775.513262400652;5792.567121808935 11:29:02 INFO - PROCESS | 1968 | |5;yui.html;714.5034201230147;747.4282174136783;791.5883740454964;835.2507484104011;878.178902725951;15412.460563880266;15907.52277431676;16382.918085409556;16524.75212871808;16537.503874883743;15086.924565377185;15163.54509364718;15361.615959601015;15387.23063846806;15402.537923862274;736.3225832234331;749.9875168522506;886.7029545102382;914.8033172867832;918.9569838233587;881.7134431309818;889.253027456936;891.8350105230553;902.2421166220373;916.6470908700131;965.8309795785744;972.1736523954653;975.4829940131741;978.8776402949632;980.4705459052103;922.7416323429451;958.4919992404037;963.7253382785907;969.699393188114;972.6887396033308;690.9585424874524;710.2152121905324;717.4117223876424;720.9711611535532;728.5992704012825;15502.534923952187;15835.604109897346;15958.76061859073;16060.839391606169;16264.593385165348;14897.187168005426;14974;15208.16355100469;15288.312025958858;15360.692786144215;11738.36782218044;11808.527658893634;11834.526618935231;11880.287182769061;12469.251844889335;3492.6856582907662;3834.865779697725;3866.3233934061427;3943.38877473992;3950.2889479893606;106995.46502267517;109767;110985;112056.43971780171;113873;11636.534538618529;11694.676481676272;11775.587854425054;11800.40997950099;11917.284962902253;24572.754272457405;24982.750172498407;24985.5002899941;25060.373490662514;25064.87467562687;8209.79475513117;8214.301784348278;8238.423310368336;8238.711645092393;8347;4371.650267978554;4379.255526560492;4476;4521.095780843844;4553.749543775058;3674.0998455378067;3704.7036237101506;3786.5077539919635;3787.16682329887;3799.4870692456716;645.9709313080923;663.5952069237761;672.9798106056826;673.1316601584;686.0018672831019;684.2063206680227;695.6139342664869;720.9783706488814;730.7990302666702;750.4671683104948;8473.576321183917;10615.84076238857;10873.565057397775;10878.238523303451;10943.83584246237;723.2514347650157;727.3635568877232;730.2441972558377;737.3732327521564;743.0897150990102;4990.476000020019;5198.740062996911;5260.473952604709;5268.9736551317;5281.815136470205;86386;89721.10278897127;108458;111646;111730.44134779274;80107.59946200348;80136.59931700304;84283.5785821067;85835.57082214674;98306.5084674572;75354.62322688352;78058.6097069511;78343;79711;79904.60047699725;11123.666290011313;11157.497912594115;11254.38100904458;11343.319400835977;11525.193236473366;36689.81655091707;51328.48671513237;52900;53213.4678653224;53778.462215377345;72661.91007135002;72753;73756;74854.25145748691;75364.62317688376;12019.81970270464;13713.245771482665;13856.792148117585;14007.649808754863;14167.433302667778;13972.79040814409;15003.324850381978;15213.315400806769;15575.922120389325;15635.374585016472;11344.716382090513;14076.78884816749;14323.641908952359;14672.899532535315;14959.775603366175;13494.190348579117;14111;14119.717605648035;14172.716545669235;14258.928705356408;13534.59396218115;13824.93087534596;14048.859511404755;14227.359768810222;14547.27263636835;11244;11302.830457543309;11487.13846461502;11721.472533736172;11772.175947683923;10082.949585252027;10276.383416995004;11236.988671019648;11513;11545 11:29:02 INFO - PROCESS | 1968 | __end_tp_report 11:29:02 INFO - PROCESS | 1968 | __start_cc_report 11:29:02 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,369 11:29:02 INFO - PROCESS | 1968 | __end_cc_report 11:29:02 INFO - PROCESS | 1968 | __startTimestamp1490120942770__endTimestamp 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | ------- Summary: start ------- 11:29:02 INFO - PROCESS | 1968 | Number of tests: 6 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | [#0] dojo.html Cycles:165 Average:5914.08 Median:6147.17 stddev:646.15 (10.5%) stddev-sans-first:609.75 11:29:02 INFO - PROCESS | 1968 | Values: 3117.6 3505.6 3548.8 3562.8 3563.6 5891.7 5895.7 5958.8 5986.4 5997.1 5548.2 5937.7 6025.2 6038.0 6038.9 4681.6 5312.0 5349.4 5389.7 5400.5 5408.9 5425.7 5429.7 5437.4 5449.9 5265.8 5266.4 5414.7 5426.3 5451.6 5332.8 5374.4 5409.8 5439.5 5477.2 5250.8 5357.1 5358.4 5364.8 5398.5 5534.8 5798.4 5942.6 6056.8 6186.9 5678.3 5931.6 6244.4 6311.4 6347.8 6418.5 6427.3 6431.0 6439.2 6440.0 6075.4 6129.3 6139.1 6140.0 6147.2 6325.1 6354.5 6411.1 6437.0 6463.3 6254.1 6278.0 6291.6 6302.8 6306.9 6397.4 6416.4 6434.6 6436.8 6448.1 6108.6 6140.2 6184.1 6194.1 6260.9 6254.4 6310.3 6321.4 6332.5 6348.1 5106.9 5113.3 5117.6 5119.5 5122.8 4503.1 4523.0 4575.9 4622.7 4633.3 5972.9 6117.3 6121.3 6136.2 6147.4 6334.3 6392.3 6412.3 6417.5 6423.9 5918.3 5996.6 6066.4 6089.1 6119.5 5629.4 5635.1 5638.0 5641.8 5645.3 6556.4 6563.6 6573.4 6577.5 6581.5 6145.0 6219.3 6230.7 6292.0 6388.6 6591.8 6595.4 6600.2 6604.3 6649.7 6320.8 6335.7 6347.4 6352.6 6361.3 6180.8 6211.5 6294.3 6340.6 6383.7 6119.6 6176.7 6209.8 6238.3 6252.8 6240.8 6244.3 6250.7 6256.7 6265.7 6028.8 6112.5 6119.1 6176.7 6234.9 6162.3 6162.4 6196.7 6230.4 6255.9 6108.7 6203.8 6205.5 6227.8 6230.1 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | [#1] ext.html Cycles:180 Average:72710.26 Median:19263.63 stddev:159882.07 (830.0%) stddev-sans-first:160238.62 11:29:02 INFO - PROCESS | 1968 | Values: 486.8 493.4 493.6 503.8 516.3 39609.0 42682.8 42711.0 42799.8 42801.8 34589.5 35935.8 44184.6 44904.0 45070.8 9636.2 9897.9 9929.8 11741.4 12170.6 12110.5 12135.0 12220.6 12223.5 12231.1 11919.4 11924.3 11939.8 12138.6 12204.7 10149.0 11927.7 12002.4 12048.7 12222.7 10163.6 11722.5 11734.7 11932.9 11964.0 39812.6 40135.6 40199.2 40226.4 40255.4 3469.0 4042.9 4140.2 4155.4 4196.6 29499.9 29616.0 29622.3 30076.0 31223.6 3005.7 3260.2 3265.2 3269.0 3270.0 518516.0 520707.0 522755.0 524852.0 526473.0 59351.7 60529.1 60564.4 60967.1 60996.4 63499.7 63730.4 63760.4 64104.7 64207.7 17007.2 17178.5 17436.7 17470.7 17471.1 12184.9 12487.7 12983.4 13254.9 13270.8 19311.8 19446.8 19485.5 19520.3 19536.5 7697.4 8137.8 8202.6 8220.6 8270.0 896.2 896.2 901.3 919.6 934.9 31963.9 32382.0 32553.0 32600.2 33106.8 1054.2 1080.8 1094.8 1130.1 1243.8 15618.8 16509.9 16562.1 17061.1 17156.6 642157.0 647158.0 661510.0 662524.0 666060.0 57678.0 58024.0 58408.7 58447.0 58461.8 1428.3 1447.0 1468.6 1494.1 1499.6 25428.0 30680.2 30720.0 31037.2 31388.8 51035.7 51339.5 51936.7 52015.2 52024.5 605374.0 606167.0 609469.0 610122.0 610176.0 24780.8 25192.7 26630.4 26814.7 27134.6 38046.6 44899.6 45740.3 46980.8 47236.3 30126.4 36158.5 37739.0 38395.4 38952.0 37137.1 37298.9 38033.0 38209.2 38978.4 32898.2 35058.3 37521.6 37638.0 37845.6 30905.8 31773.5 33298.5 33512.8 33686.3 21495.8 23494.3 23837.8 24307.3 25337.4 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | [#2] jquery.html Cycles:180 Average:41757.23 Median:22467.78 stddev:127006.21 (565.3%) stddev-sans-first:127324.52 11:29:02 INFO - PROCESS | 1968 | Values: 398.4 399.8 404.4 411.9 435.9 21092.6 22222.8 22323.8 22414.7 22613.4 22520.9 22637.8 22903.4 22952.5 23111.0 5889.2 6099.5 6100.8 6108.3 6116.7 5282.3 6651.5 6699.5 6787.8 6793.4 6509.5 6617.1 6728.2 6728.7 6743.7 6613.0 6623.3 6675.0 6683.6 6692.9 5686.4 5840.7 5895.9 5909.0 5923.4 27085.9 27251.6 27477.6 27710.3 27759.3 2726.5 2804.7 2809.3 2823.2 2833.0 16275.2 16343.8 16578.9 16673.7 16796.4 1844.6 1883.1 1884.9 1887.3 1891.5 134456.0 136170.0 137230.6 137400.0 138207.0 11510.6 11565.2 11661.7 11733.2 11866.8 12549.9 14551.6 14595.7 14890.6 14965.3 8919.8 9204.7 9228.4 9369.3 9455.0 9305.2 9307.3 9387.7 9510.2 9565.0 6344.4 7237.6 7299.6 7429.3 7447.3 1665.9 1746.8 1849.9 1951.0 1966.9 1056.6 1062.8 1081.9 1085.2 1120.8 19034.6 22794.9 23029.4 23260.5 23547.4 966.5 1096.4 1107.2 1116.9 1145.8 9824.5 11153.1 11351.0 11422.7 12280.8 739381.0 757279.0 772497.0 772763.0 783294.0 132540.0 144203.0 144825.0 150838.0 151549.0 1059.3 1065.5 1087.0 1087.7 1093.4 19352.6 20252.3 20417.6 20450.0 20549.9 56162.0 56589.7 59251.0 60646.0 61054.1 68843.3 84520.6 85023.6 85167.6 86906.0 8442.9 8458.5 8483.0 8534.4 8561.0 13193.0 13472.6 13784.7 14019.4 14149.6 11558.7 11659.8 11817.8 11849.3 11904.8 10096.3 10418.4 10803.0 11427.4 11918.2 11580.1 11905.5 12017.3 12042.7 12172.5 8436.0 8618.2 10439.8 13071.1 13373.2 10923.4 11980.6 12030.4 12275.1 12466.8 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | [#3] mootools.html Cycles:180 Average:5479.24 Median:5341.17 stddev:2956.00 (55.3%) stddev-sans-first:2948.78 11:29:02 INFO - PROCESS | 1968 | Values: 1448.6 1471.5 1475.9 1485.3 1492.0 6798.3 7685.0 7897.3 8634.4 8661.2 8017.3 8315.0 8335.2 8477.2 8501.9 2378.4 2405.4 2407.7 2408.1 2417.2 2376.3 2402.6 2412.8 2415.6 2424.2 2376.8 2393.6 2404.5 2404.5 2407.8 2349.5 2365.5 2370.1 2393.0 2396.4 2363.7 2369.4 2423.0 2432.0 2434.4 8489.7 8514.6 8551.3 8557.9 8572.7 5130.2 5259.2 5284.2 5292.9 5299.8 3477.4 3484.2 3511.5 3512.0 3574.3 1162.5 1163.1 1194.9 1207.4 1218.6 10762.2 10907.9 10940.9 10945.3 11015.7 4471.3 4605.9 4756.7 4809.4 4823.0 8503.9 9647.0 9662.8 9668.3 9703.4 5317.8 5333.1 5349.3 5364.5 5366.2 4418.5 4449.4 4833.6 4843.7 4866.9 3879.9 3977.7 4007.9 4059.2 4076.8 1172.2 1318.5 1324.6 1326.9 1331.4 923.5 929.8 934.3 944.1 981.9 5576.8 5577.2 5716.9 5794.0 5799.8 577.9 594.2 595.2 598.1 601.4 3214.2 3440.0 3592.3 3592.9 3594.9 8829.3 9786.0 10136.3 10138.9 10174.7 8481.8 9448.6 9498.7 9891.0 10117.3 7768.5 7923.5 7931.3 7940.7 8003.2 5791.9 5796.2 5823.9 5971.5 6067.9 9357.2 9429.4 9463.3 9468.4 9510.3 8930.3 9178.7 9196.2 9463.4 9464.9 6705.3 6944.7 7001.7 7268.7 7428.0 7843.9 8038.9 8047.9 8067.4 8077.6 6700.7 7237.1 7297.8 7349.4 7495.9 6846.7 7179.2 7194.6 7327.1 7338.4 6470.4 6484.6 6529.0 6532.4 6539.7 5012.5 5032.6 5045.2 5093.2 5191.8 4657.9 5116.4 5153.8 5248.2 5272.6 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | [#4] prototype.html Cycles:180 Average:4636.52 Median:5296.14 stddev:1446.99 (27.3%) stddev-sans-first:1414.27 11:29:02 INFO - PROCESS | 1968 | Values: 317.7 366.8 376.8 383.9 385.0 5364.9 5488.3 5548.4 5615.2 5655.6 5303.4 5447.6 5505.7 5524.3 5527.4 3704.5 4307.6 4353.3 4355.2 4358.2 3881.8 3909.3 4115.8 4153.8 4348.2 4126.7 4128.2 4136.9 4138.2 4148.1 3233.9 3906.0 4152.7 4168.7 4208.0 2792.5 3602.3 3622.2 3624.2 3693.8 4541.6 4972.2 5082.0 5406.6 5489.9 4615.3 4686.1 4826.0 4870.6 4872.5 5900.7 5915.9 5925.4 5926.6 5956.0 3127.5 3760.0 3880.4 3944.3 4009.5 5361.6 5950.8 6064.4 6110.2 6367.7 3270.7 3425.4 4043.3 4049.0 4052.9 3651.1 3968.7 4021.7 4086.9 4113.5 4775.3 4791.3 4809.5 4822.4 4823.5 5202.3 5922.9 5974.1 5979.6 5982.1 1153.6 1180.0 1199.5 1316.3 1328.8 770.7 821.4 858.7 874.4 905.3 4910.2 5265.1 5284.3 5288.8 5307.7 5249.4 5388.6 5396.6 5732.2 5864.7 4731.2 4932.6 4941.4 5312.5 5344.9 2639.7 2830.0 2866.5 2868.7 2965.8 5090.9 5788.5 5788.9 5940.6 5966.3 5322.0 5545.1 5625.9 5645.7 5931.5 5162.9 5587.7 5638.6 5897.5 5983.9 4560.2 5413.6 5626.7 5745.2 5782.5 4911.9 5406.3 5425.2 5598.6 5647.8 5519.6 5999.7 6005.5 6019.3 6019.6 3305.5 3544.1 3823.2 3884.5 3890.5 4680.5 5409.4 5536.3 5701.4 5853.9 5445.9 5780.4 5883.2 5892.5 5911.3 4936.3 5902.2 5909.3 5909.9 5919.8 5176.8 5488.9 5605.1 5756.5 5793.7 5062.4 5642.2 5881.3 5909.2 5956.4 5025.7 5422.2 5727.3 5775.5 5792.6 11:29:02 INFO - PROCESS | 1968 | 11:29:02 INFO - PROCESS | 1968 | [#5] yui.html Cycles:180 Average:21065.62 Median:3745.61 stddev:29775.57 (794.9%) stddev-sans-first:29819.88 11:29:02 INFO - PROCESS | 1968 | Values: 714.5 747.4 791.6 835.3 878.2 15412.5 15907.5 16382.9 16524.8 16537.5 15086.9 15163.5 15361.6 15387.2 15402.5 736.3 750.0 886.7 914.8 919.0 881.7 889.3 891.8 902.2 916.6 965.8 972.2 975.5 978.9 980.5 922.7 958.5 963.7 969.7 972.7 691.0 710.2 717.4 721.0 728.6 15502.5 15835.6 15958.8 16060.8 16264.6 14897.2 14974.0 15208.2 15288.3 15360.7 11738.4 11808.5 11834.5 11880.3 12469.3 3492.7 3834.9 3866.3 3943.4 3950.3 106995.5 109767.0 110985.0 112056.4 113873.0 11636.5 11694.7 11775.6 11800.4 11917.3 24572.8 24982.8 24985.5 25060.4 25064.9 8209.8 8214.3 8238.4 8238.7 8347.0 4371.7 4379.3 4476.0 4521.1 4553.7 3674.1 3704.7 3786.5 3787.2 3799.5 646.0 663.6 673.0 673.1 686.0 684.2 695.6 721.0 730.8 750.5 8473.6 10615.8 10873.6 10878.2 10943.8 723.3 727.4 730.2 737.4 743.1 4990.5 5198.7 5260.5 5269.0 5281.8 86386.0 89721.1 108458.0 111646.0 111730.4 80107.6 80136.6 84283.6 85835.6 98306.5 75354.6 78058.6 78343.0 79711.0 79904.6 11123.7 11157.5 11254.4 11343.3 11525.2 36689.8 51328.5 52900.0 53213.5 53778.5 72661.9 72753.0 73756.0 74854.3 75364.6 12019.8 13713.2 13856.8 14007.6 14167.4 13972.8 15003.3 15213.3 15575.9 15635.4 11344.7 14076.8 14323.6 14672.9 14959.8 13494.2 14111.0 14119.7 14172.7 14258.9 13534.6 13824.9 14048.9 14227.4 14547.3 11244.0 11302.8 11487.1 11721.5 11772.2 10082.9 10276.4 11237.0 11513.0 11545.0 11:29:02 INFO - PROCESS | 1968 | -------- Summary: end -------- 11:29:02 INFO - PROCESS | 1968 | 11:29:03 INFO - TEST-INFO | 1968: exit 0 11:29:03 INFO - TEST-OK | dromaeo_css | took 1113440ms 11:29:03 INFO - TEST-START | kraken 11:29:03 INFO - operating with platform_type : mac_ 11:29:03 INFO - Initialising browser for kraken test... 11:29:03 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpC9dacd/profile http://localhost:49333/getInfo.html) 11:29:05 INFO - PROCESS | 1972 | 2017-03-21 11:29:05.882 plugin-container[1974:13004] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 11:29:05 INFO - PROCESS | 1972 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:29:05 INFO - PROCESS | 1972 | 2017-03-21 11:29:05.883 plugin-container[1974:13004] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x442b, name = 'com.apple.CFPasteboardClient' 11:29:05 INFO - PROCESS | 1972 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:29:05 INFO - PROCESS | 1972 | 2017-03-21 11:29:05.883 plugin-container[1974:13004] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:29:05 INFO - PROCESS | 1972 | __metrics Screen width/height:1600/1200 11:29:05 INFO - PROCESS | 1972 | colorDepth:24 11:29:05 INFO - PROCESS | 1972 | Browser inner width/height: 1024/689 11:29:05 INFO - PROCESS | 1972 | __metrics 11:29:06 ERROR - PROCESS | 1972 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 11:29:06 INFO - TEST-INFO | 1972: exit 0 11:29:06 INFO - Browser initialized. 11:29:06 INFO - Running cycle 1/1 for kraken test... 11:29:06 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpC9dacd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:08 INFO - PROCESS | 1975 | 2017-03-21 11:29:08.878 plugin-container[1976:13126] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 11:29:08 INFO - PROCESS | 1975 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:29:08 INFO - PROCESS | 1975 | 2017-03-21 11:29:08.878 plugin-container[1976:13126] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8517, name = 'com.apple.CFPasteboardClient' 11:29:08 INFO - PROCESS | 1975 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:29:08 INFO - PROCESS | 1975 | 2017-03-21 11:29:08.878 plugin-container[1976:13126] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:29:18 INFO - PROCESS | 1975 | RSS: Main: 172814336 11:29:18 INFO - PROCESS | 1975 | 11:29:21 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49333/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:22 INFO - PROCESS | 1975 | RSS: Main: 185970688 11:29:22 INFO - PROCESS | 1975 | 11:29:25 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49333/tests/kraken/driver.html?testName=audio-dft) 11:29:25 INFO - PROCESS | 1975 | RSS: Main: 193957888 11:29:25 INFO - PROCESS | 1975 | 11:29:29 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49333/tests/kraken/driver.html?testName=audio-fft) 11:29:30 INFO - PROCESS | 1975 | RSS: Main: 195760128 11:29:30 INFO - PROCESS | 1975 | 11:29:31 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49333/tests/kraken/driver.html?testName=audio-oscillator) 11:29:32 INFO - PROCESS | 1975 | RSS: Main: 198430720 11:29:32 INFO - PROCESS | 1975 | 11:29:34 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:35 INFO - PROCESS | 1975 | RSS: Main: 198758400 11:29:35 INFO - PROCESS | 1975 | 11:29:37 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49333/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:38 INFO - PROCESS | 1975 | RSS: Main: 202768384 11:29:38 INFO - PROCESS | 1975 | 11:29:41 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49333/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:42 INFO - PROCESS | 1975 | RSS: Main: 202420224 11:29:42 INFO - PROCESS | 1975 | 11:29:45 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49333/tests/kraken/driver.html?testName=json-parse-financial) 11:29:45 INFO - PROCESS | 1975 | RSS: Main: 202694656 11:29:45 INFO - PROCESS | 1975 | 11:29:47 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:48 INFO - PROCESS | 1975 | RSS: Main: 201867264 11:29:48 INFO - PROCESS | 1975 | 11:29:49 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:50 INFO - PROCESS | 1975 | RSS: Main: 201854976 11:29:50 INFO - PROCESS | 1975 | 11:29:52 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:53 INFO - PROCESS | 1975 | RSS: Main: 201809920 11:29:53 INFO - PROCESS | 1975 | 11:29:56 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:56 INFO - PROCESS | 1975 | RSS: Main: 202219520 11:29:56 INFO - PROCESS | 1975 | 11:29:59 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:30:00 INFO - PROCESS | 1975 | RSS: Main: 202276864 11:30:00 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49333/tests/kraken/driver.html?testName=ai-astar) 11:30:02 INFO - PROCESS | 1975 | RSS: Main: 204152832 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | __start_tp_report 11:30:02 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 11:30:02 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 11:30:02 INFO - PROCESS | 1975 | |i|pagename|runs| 11:30:02 INFO - PROCESS | 1975 | |0;ai-astar;100;111;118;119;117;146;176;153;116;118 11:30:02 INFO - PROCESS | 1975 | |1;audio-beat-detection;140;114;114;128;94;128;142;142;140;111 11:30:02 INFO - PROCESS | 1975 | |2;audio-dft;228;262;196;198;192;255;285;192;283;276 11:30:02 INFO - PROCESS | 1975 | |3;audio-fft;82;59;58;86;73;52;83;78;91;51 11:30:02 INFO - PROCESS | 1975 | |4;audio-oscillator;85;71;85;73;70;71;81;72;97;109 11:30:02 INFO - PROCESS | 1975 | |5;imaging-gaussian-blur;90;87;89;88;90;101;90;88;89;86 11:30:02 INFO - PROCESS | 1975 | |6;imaging-darkroom;95;105;153;113;95;95;95;95;94;96 11:30:02 INFO - PROCESS | 1975 | |7;imaging-desaturate;111;122;89;92;93;134;147;91;93;90 11:30:02 INFO - PROCESS | 1975 | |8;json-parse-financial;59;56;59;60;62;60;62;62;60;59 11:30:02 INFO - PROCESS | 1975 | |9;json-stringify-tinderbox;68;76;78;77;71;70;69;68;74;71 11:30:02 INFO - PROCESS | 1975 | |10;stanford-crypto-aes;79;103;71;91;103;101;104;82;86;83 11:30:02 INFO - PROCESS | 1975 | |11;stanford-crypto-ccm;168;147;127;129;135;137;136;139;178;142 11:30:02 INFO - PROCESS | 1975 | |12;stanford-crypto-pbkdf2;169;173;163;164;168;162;164;175;226;195 11:30:02 INFO - PROCESS | 1975 | |13;stanford-crypto-sha256-iterative;67;64;66;62;64;65;65;64;64;63 11:30:02 INFO - PROCESS | 1975 | __end_tp_report 11:30:02 INFO - PROCESS | 1975 | __start_cc_report 11:30:02 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,941 11:30:02 INFO - PROCESS | 1975 | __end_cc_report 11:30:02 INFO - PROCESS | 1975 | __startTimestamp1490121002391__endTimestamp 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | ------- Summary: start ------- 11:30:02 INFO - PROCESS | 1975 | Number of tests: 14 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#0] ai-astar Cycles:10 Average:127.40 Median:118.50 stddev:23.26 (19.6%) stddev-sans-first:22.46 11:30:02 INFO - PROCESS | 1975 | Values: 100.0 111.0 118.0 119.0 117.0 146.0 176.0 153.0 116.0 118.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:140.00 stddev:16.48 (11.8%) stddev-sans-first:16.60 11:30:02 INFO - PROCESS | 1975 | Values: 140.0 114.0 114.0 128.0 94.0 128.0 142.0 142.0 140.0 111.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#2] audio-dft Cycles:10 Average:236.70 Median:258.50 stddev:39.75 (15.4%) stddev-sans-first:42.04 11:30:02 INFO - PROCESS | 1975 | Values: 228.0 262.0 196.0 198.0 192.0 255.0 285.0 192.0 283.0 276.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#3] audio-fft Cycles:10 Average:71.30 Median:80.00 stddev:14.97 (18.7%) stddev-sans-first:15.37 11:30:02 INFO - PROCESS | 1975 | Values: 82.0 59.0 58.0 86.0 73.0 52.0 83.0 78.0 91.0 51.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:77.00 stddev:13.07 (17.0%) stddev-sans-first:13.79 11:30:02 INFO - PROCESS | 1975 | Values: 85.0 71.0 85.0 73.0 70.0 71.0 81.0 72.0 97.0 109.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:89.00 stddev:4.16 (4.7%) stddev-sans-first:4.41 11:30:02 INFO - PROCESS | 1975 | Values: 90.0 87.0 89.0 88.0 90.0 101.0 90.0 88.0 89.0 86.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:95.00 stddev:18.41 (19.4%) stddev-sans-first:19.26 11:30:02 INFO - PROCESS | 1975 | Values: 95.0 105.0 153.0 113.0 95.0 95.0 95.0 95.0 94.0 96.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#7] imaging-desaturate Cycles:10 Average:106.20 Median:90.50 stddev:21.21 (23.4%) stddev-sans-first:22.43 11:30:02 INFO - PROCESS | 1975 | Values: 111.0 122.0 89.0 92.0 93.0 134.0 147.0 91.0 93.0 90.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:1.85 (3.1%) stddev-sans-first:1.94 11:30:02 INFO - PROCESS | 1975 | Values: 59.0 56.0 59.0 60.0 62.0 60.0 62.0 62.0 60.0 59.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.50 stddev:3.77 (5.2%) stddev-sans-first:3.67 11:30:02 INFO - PROCESS | 1975 | Values: 68.0 76.0 78.0 77.0 71.0 70.0 69.0 68.0 74.0 71.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:80.50 stddev:11.86 (14.7%) stddev-sans-first:11.85 11:30:02 INFO - PROCESS | 1975 | Values: 79.0 103.0 71.0 91.0 103.0 101.0 104.0 82.0 86.0 83.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:140.50 stddev:16.59 (11.8%) stddev-sans-first:15.11 11:30:02 INFO - PROCESS | 1975 | Values: 168.0 147.0 127.0 129.0 135.0 137.0 136.0 139.0 178.0 142.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:171.00 stddev:20.10 (11.8%) stddev-sans-first:21.17 11:30:02 INFO - PROCESS | 1975 | Values: 169.0 173.0 163.0 164.0 168.0 162.0 164.0 175.0 226.0 195.0 11:30:02 INFO - PROCESS | 1975 | 11:30:02 INFO - PROCESS | 1975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.43 (2.2%) stddev-sans-first:1.17 11:30:02 INFO - PROCESS | 1975 | Values: 67.0 64.0 66.0 62.0 64.0 65.0 65.0 64.0 64.0 63.0 11:30:02 INFO - PROCESS | 1975 | -------- Summary: end -------- 11:30:02 INFO - PROCESS | 1975 | 11:30:03 INFO - TEST-INFO | 1975: exit 0 11:30:03 INFO - TEST-OK | kraken | took 59917ms 11:30:03 INFO - SUITE-END | took 1173s 11:30:03 INFO - Completed test suite (00:19:33) 11:30:03 INFO - javascript benchmark 11:30:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7579.643925459671, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.5791268178796, 3505.5618047744033, 3548.7870727756335, 3562.8040457774814, 3563.55455568054, 5891.734871930763, 5895.675737834417, 5958.821235362941, 5986.431289027546, 5997.070454079614, 5548.195511650818, 5937.732802023908, 6025.15647809307, 6037.969810150954, 6038.939610603893, 4681.625469962411, 5312.0, 5349.438308977559, 5389.73051347433, 5400.486953739408, 5408.891177308642, 5425.674459532421, 5429.6742195468205, 5437.429069947658, 5449.945500544984, 5265.76304066318, 5266.3943646480575, 5414.702191379492, 5426.294581704373, 5451.563874890019, 5332.840014799582, 5374.435684253156, 5409.810656626999, 5439.510444060014, 5477.1510415885605, 5250.842474725764, 5357.08929481989, 5358.383785864637, 5364.8122315718765, 5398.541124004464, 5534.806281780158, 5798.3911689272445, 5942.554308426842, 6056.757729690807, 6186.876262474725, 5678.346990096151, 5931.555133365015, 6244.406781355764, 6311.431971122621, 6347.777827776052, 6418.454431373339, 6427.325130861239, 6431.0, 6439.162908821823, 6440.033994900802, 6075.422834830684, 6129.325774164839, 6139.140520327113, 6140.048292514667, 6147.170132032164, 6325.082862984841, 6354.459870910932, 6411.070394792729, 6437.0, 6463.321351258144, 6254.061890716429, 6278.0, 6291.622502649856, 6302.779402720975, 6306.873862522724, 6397.424231819158, 6416.4225219729515, 6434.581752186093, 6436.839079022968, 6448.065030570541, 6108.645631960618, 6140.166841500592, 6184.072389141665, 6194.101855231056, 6260.874782504325, 6254.3745625437095, 6310.305866354697, 6321.367863213642, 6332.525060620472, 6348.079528468346, 5106.923396149061, 5113.284140220372, 5117.565006974449, 5119.539241468286, 5122.769475373617, 4503.144402563568, 4522.977385113119, 4575.885602859955, 4622.745748983838, 4633.281841314534, 5972.85067873298, 6117.327094019654, 6121.326654068049, 6136.243373036893, 6147.354527774609, 6334.3032266450655, 6392.264889537762, 6412.3267056959285, 6417.486601071903, 6423.871522569522, 5918.260217472816, 5996.610220335664, 6066.3630318815885, 6089.147519347295, 6119.4798442132915, 5629.352624448159, 5635.0702134147405, 5637.9718101409235, 5641.830745077655, 5645.266115404971, 6556.409923106943, 6563.573367731082, 6573.375529324707, 6577.473802095917, 6581.539292249497, 6144.986077297374, 6219.253689557101, 6230.657313847601, 6292.0, 6388.552801303864, 6591.835204119743, 6595.406413422815, 6600.174978127734, 6604.306547812603, 6649.73401063952, 6320.810375688737, 6335.683215839282, 6347.39699728525, 6352.587081839851, 6361.300256971637, 6180.7527698891545, 6211.534134939988, 6294.276158241678, 6340.587861788969, 6383.6808159592765, 6119.624418755002, 6176.6911654418, 6209.751609935552, 6238.251409830849, 6252.843678908063, 6240.843978900564, 6244.344343843831, 6250.687465626791, 6256.749730010931, 6265.655388953652, 6028.788992385245, 6112.473085128157, 6119.143319935123, 6176.66028368426, 6234.875302493834, 6162.26052873658, 6162.445379915829, 6196.738190560322, 6230.43926046658, 6255.874882502416, 6108.694565271808, 6203.7828675996125, 6205.5345849060595, 6227.844303892439, 6230.127782110418], "value": 5872.80143821136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.81744345870277, 493.38080708710606, 493.63224397823615, 503.7934446876781, 516.3313509005837, 39609.00977475564, 42682.786586067064, 42711.0, 42799.78600106995, 42801.78599107008, 34589.481157782655, 35935.82032089836, 44184.558154418526, 44904.0, 45070.7746461268, 9636.180924621398, 9897.90102098977, 9929.801403971916, 11741.354225517593, 12170.574029908956, 12110.515579376814, 12135.0, 12220.633380998584, 12223.511059557606, 12231.08266879983, 11919.40402979852, 11924.28454292741, 11939.7612047759, 12138.635840924742, 12204.694882627917, 10149.0, 11927.70180745484, 12002.399880005965, 12048.698782530419, 12222.694432639166, 10163.59345626174, 11722.531098756039, 11734.706632334175, 11932.940335298355, 11964.0, 39812.60187398118, 40135.59864401348, 40199.196016079804, 40226.39660405096, 40255.396169057196, 3468.9653103469145, 4042.898927526806, 4140.15126898985, 4155.376693495969, 4196.58034196581, 29499.852500737572, 29616.0, 29622.25944351387, 30076.0, 31223.594938227834, 3005.7294843463974, 3260.1849537615594, 3265.248992731685, 3268.983655081733, 3269.9836500817582, 518516.0, 520707.0, 522755.0, 524851.9999999962, 526473.0, 59351.70324148352, 60529.09206361908, 60564.39435605676, 60967.08549371763, 60996.39003609996, 63499.682501587195, 63730.36269637337, 63760.36239637637, 64104.679476602316, 64207.67896160489, 17007.23467443943, 17178.484645460405, 17436.65126697459, 17470.650586988442, 17471.126443677764, 12184.939075304566, 12487.687807804878, 12983.35083245834, 13254.933725331312, 13270.800937985938, 19311.806881931283, 19446.80553194478, 19485.51286217856, 19520.31678891232, 19536.511587210432, 7697.383549454566, 8137.75586732399, 8202.58987050645, 8220.588970551567, 8270.007599088149, 896.1620884473039, 896.2158111652304, 901.324006994754, 919.632147141149, 934.8691183234353, 31963.88126415611, 32382.0, 32553.0, 32600.184995375304, 33106.83446582752, 1054.1830081686753, 1080.8432777247256, 1094.8029354716227, 1130.112861403794, 1243.757467293869, 15618.843811561967, 16509.91745041267, 16562.089085100193, 17061.135153956973, 17156.571085722706, 642157.0, 647158.0, 661510.0, 662524.0, 666060.0, 57678.0, 58024.0, 58408.70795645995, 58447.0, 58461.83076338535, 1428.3215472650409, 1446.9638259043609, 1468.6475245940896, 1494.1334026264958, 1499.6400863792612, 25428.0, 30680.232994175323, 30720.0, 31037.224069398446, 31388.843055784575, 51035.72410689762, 51339.48660513347, 51936.74031629818, 52015.2197717027, 52024.479755201966, 605374.0, 606167.0, 609469.0, 610122.0, 610176.0, 24780.752192478565, 25192.748072519775, 26630.40217586951, 26814.731852681223, 27134.592981104903, 38046.61953380542, 44899.551004489535, 45740.31389529093, 46980.7650961743, 47236.29145562751, 30126.397472050874, 36158.457623135146, 37739.0, 38395.398393610914, 38952.0, 37137.07157321089, 37298.881033569036, 38033.0, 38209.235815282984, 38978.4153237696, 32898.17754556155, 35058.298834023684, 37521.62478375291, 37638.0, 37845.62154378421, 30905.845470772503, 31773.523397149525, 33298.500522492664, 33512.83243583766, 33686.326273473904, 21495.817730025, 23494.29517114489, 23837.761622383554, 24307.27078187657, 25337.366565836], "value": 20747.525242545966, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.4222876828596, 399.8105635733693, 404.36312807328454, 411.8661435033614, 435.8735966569695, 21092.57814843704, 22222.777772222253, 22323.776762232374, 22414.66378004329, 22613.434664133405, 22520.88739556304, 22637.773622263772, 22903.42741431465, 22952.540949181006, 23111.0, 5889.2049573307695, 6099.451049405553, 6100.816975490742, 6108.297545782248, 6116.724747386378, 5282.260483532308, 6651.467882569383, 6699.497537684669, 6787.830304242384, 6793.354631310018, 6509.479241660656, 6617.106690596756, 6728.158980127484, 6728.730850765988, 6743.696533655997, 6613.041109039186, 6623.337666233387, 6674.998750187462, 6683.565568238049, 6692.866142677143, 5686.402927692574, 5840.678762668052, 5895.882082358372, 5908.97045514774, 5923.407659234085, 27085.86457067722, 27251.591226131426, 27477.587836182473, 27710.3072423189, 27759.306017349525, 2726.5228584997544, 2804.733550312717, 2809.3257618171697, 2823.167165686107, 2832.9716702832916, 16275.186240688037, 16343.754843677354, 16578.917105414515, 16673.749893751603, 16796.412125575545, 1844.5849683821168, 1883.133758471105, 1884.9246030158777, 1887.282832523646, 1891.527118220445, 134456.0, 136170.0, 137230.62769372278, 137399.999999999, 138207.0, 11510.597129100608, 11565.248258863146, 11661.708457288636, 11733.237339573072, 11866.76266474683, 12549.874501255053, 14551.563453096423, 14595.708085838223, 14890.553283401516, 14965.326560304813, 8919.794265421404, 9204.677836275698, 9228.354015219005, 9369.250459963187, 9455.0, 9305.162535371848, 9307.255419566418, 9387.6714315, 9510.239180865652, 9564.995675454116, 6344.365563443619, 7237.565746055254, 7299.598522081336, 7429.33136017761, 7447.329740323397, 1665.900045997244, 1746.7598005416044, 1849.9177980881336, 1950.9902450487941, 1966.9409917702492, 1056.5773690523852, 1062.7715041266165, 1081.8755843078147, 1085.1644233939821, 1120.7926533591312, 19034.619307614048, 22794.860256987085, 23029.424264393525, 23260.534789304118, 23547.41131471727, 966.4925913895121, 1096.3644002867022, 1107.2470719910539, 1116.9497372618252, 1145.7765735681628, 9824.459654718916, 11153.051990580729, 11351.035162011322, 11422.74349821519, 12280.815787763191, 739381.0, 757279.0, 772497.0, 772763.0, 783294.0, 132540.0, 144203.0, 144825.0, 150838.0, 151549.0, 1059.2691043180182, 1065.536491626145, 1086.9728256793644, 1087.717193529688, 1093.4478088565384, 19352.612947740683, 20252.319405275775, 20417.59164816725, 20450.0, 20549.89725051425, 56162.0, 56589.71705141448, 59251.0, 60646.0, 61054.084188738096, 68843.31156688368, 84520.57739711262, 85023.57488212519, 85167.57416212879, 86906.0, 8442.915570844212, 8458.450200736932, 8483.024452188078, 8534.359923005924, 8560.988167780692, 13193.010524210531, 13472.595822125351, 13784.655383615489, 14019.439222430989, 14149.575512734635, 11558.651573578803, 11659.825102623638, 11817.82273265919, 11849.348285844362, 11904.821427678766, 10096.34373765703, 10418.426986515815, 10802.973717496825, 11427.428628568705, 11918.225315354473, 11580.073594112282, 11905.52377904874, 12017.278963262232, 12042.698932526757, 12172.45223964906, 8435.957820211106, 8618.181272779077, 10439.843402348819, 13071.085024048225, 13373.197608143542, 10923.399213043358, 11980.64058078259, 12030.398480076135, 12275.140740148105, 12466.75066498683], "value": 10671.277099115556, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.6305991972044, 1471.4849802569095, 1475.8966872318942, 1485.3019081031914, 1491.970160596788, 6798.320167983199, 7684.96157519213, 7897.328727058192, 8634.352423568225, 8661.220490155885, 8017.278444939954, 8314.958425207866, 8335.166483351662, 8477.15228477152, 8501.894753682012, 2378.3697320210117, 2405.386626410263, 2407.723111842143, 2408.1330720940446, 2417.190241269177, 2376.2633583589054, 2402.627592723131, 2412.758724127582, 2415.6014257647466, 2424.2000139953775, 2376.762323767618, 2393.628987506939, 2404.519096180762, 2404.5431368040104, 2407.7712617301327, 2349.4596242864236, 2365.503244318695, 2370.111208296889, 2392.9760702392928, 2396.3769419950936, 2363.7045369328835, 2369.407648087978, 2422.9757702422926, 2431.963520547193, 2434.379233295516, 8489.66041358345, 8514.616842242052, 8551.315894728468, 8557.914420855774, 8572.742817715478, 5130.204818253177, 5259.184826351883, 5284.154535274338, 5292.894142117175, 5299.8410047698635, 3477.3566890125408, 3484.233468636896, 3511.490833829106, 3512.0341905975806, 3574.267275208576, 1162.5001249462728, 1163.145088360063, 1194.9342786146758, 1207.3600991474532, 1218.62222710959, 10762.192835537287, 10907.890921090768, 10940.945295273552, 10945.343279403261, 11015.669529914196, 4471.28459446487, 4605.8848528786375, 4756.667033307635, 4809.422869255712, 4823.0, 8503.872441913376, 9647.035296470296, 9662.75843103928, 9668.323217374716, 9703.417794932328, 5317.813876514303, 5333.066713325153, 5349.277847490617, 5364.544013758874, 5366.168243922199, 4418.491873434532, 4449.443819522559, 4833.564979151894, 4843.685160464559, 4866.902661946741, 3879.922401551953, 3977.7215594908657, 4007.859724909614, 4059.2084543513733, 4076.8369265229653, 1172.2380452705638, 1318.53851152096, 1324.6025443157368, 1326.9251905956207, 1331.3542931678128, 923.5474617437408, 929.7695485540897, 934.2572654739498, 944.0653752784693, 981.9361741486781, 5576.804811831647, 5577.2191893135, 5716.885662286731, 5794.015017447045, 5799.797007104731, 577.890200861835, 594.1770647653032, 595.1578516399333, 598.1058317814808, 601.3595520770454, 3214.1964508872784, 3439.9828000860334, 3592.263585964871, 3592.9101772455374, 3594.946075808865, 8829.33779966505, 9785.951070244602, 10136.341137826017, 10138.898611013943, 10174.694759157237, 8481.787955301043, 9448.57481413338, 9498.667546635834, 9890.950545247371, 10117.342372745748, 7768.53388796674, 7923.524588524707, 7931.286184243446, 7940.682372705027, 8003.19968003195, 5791.913121303268, 5796.159556864147, 5823.941760582509, 5971.526823240903, 6067.939320606737, 9357.157855793012, 9429.434233945985, 9463.337566370288, 9468.384555003902, 9510.286728495252, 8930.285577153942, 9178.724638260863, 9196.172344489029, 9463.432194068379, 9464.905350946403, 6705.262421133769, 6944.687489063105, 7001.719931202899, 7268.672909719181, 7428.0, 7843.882341764992, 8038.87941680887, 8047.913531673149, 8067.3949453792375, 8077.636506357346, 6700.731970721116, 7237.059182306477, 7297.781066568012, 7349.375303099297, 7495.925040749523, 6846.657667116724, 7179.210286868545, 7194.640267986475, 7327.0841144856895, 7338.449616278694, 6470.38531339522, 6484.610923344614, 6528.967355163194, 6532.379423954717, 6539.7384104637185, 5012.523810238022, 5032.572231360376, 5045.1927691570645, 5093.23601459784, 5191.766370513412, 4657.93013104797, 5116.360454943132, 5153.819616313411, 5248.239005344128, 5272.6309158358545], "value": 4431.55024665332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.6696235914648, 366.76343758275914, 376.77770115631773, 383.9040239940015, 385.0450881813105, 5364.91952620711, 5488.259085023521, 5548.41998470711, 5615.21387005819, 5655.632383895044, 5303.443138470463, 5447.564194864412, 5505.724713764316, 5524.33707955046, 5527.364353099385, 3704.499677630564, 4307.640040768206, 4353.28170851809, 4355.237833379162, 4358.215521206182, 3881.8253178606888, 3909.3354129798004, 4115.753054816706, 4153.77463648223, 4348.239058164809, 4126.698641087119, 4128.21563902859, 4136.875893723193, 4138.172365526892, 4148.1333399970135, 3233.9029829105166, 3905.9609403905883, 4152.68854835887, 4168.687348448848, 4207.957920420818, 2792.45547118312, 3602.3335682898746, 3622.166901612644, 3624.169794253885, 3693.759905606127, 4541.591256786872, 4972.229304457815, 5082.0, 5406.567474602022, 5489.945100548984, 4615.26155815068, 4686.148971156408, 4825.951740482586, 4870.586000189988, 4872.488388719169, 5900.675462849542, 5915.911261331084, 5925.429761113309, 5926.614770039933, 5956.0, 3127.545691253578, 3759.9624003759886, 3880.3597406427907, 3944.349182384903, 4009.4787677602017, 5361.571074314045, 5950.750342428052, 6064.423879731418, 6110.236220472441, 6367.694622602356, 3270.705636492727, 3425.400554902882, 4043.3126368516832, 4048.9797551012643, 4052.9392059119136, 3651.123730304708, 3968.7023473239046, 4021.738586991836, 4086.8569600063856, 4113.547509773923, 4775.331453596499, 4791.257355109963, 4809.470958194595, 4822.445418776815, 4823.493533178966, 5202.3497062867145, 5922.851928701817, 5974.0882917466, 5979.5814292999075, 5982.1325907744, 1153.6423708650345, 1179.9705007374885, 1199.4962115911337, 1316.2628927800463, 1328.8405391353099, 770.6532060572765, 821.3675469888153, 858.6651206029653, 874.4272501511521, 905.2712566384124, 4910.183232204107, 5265.104932161542, 5284.286621306152, 5288.8413347599635, 5307.681539107589, 5249.396319423239, 5388.622796404214, 5396.595255355864, 5732.197492351074, 5864.736086876101, 4731.243001119804, 4932.580730637864, 4941.357623508921, 5312.495312945264, 5344.85085706575, 2639.746120592703, 2830.0, 2866.48076519445, 2868.655761308656, 2965.760850557815, 5090.9236361454605, 5788.5369170466265, 5788.88422231553, 5940.554478402516, 5966.284045914518, 5322.0, 5545.057340252167, 5625.859353516113, 5645.689487078168, 5931.525477961753, 5162.896742065138, 5587.675333176753, 5638.643288875666, 5897.469227769521, 5983.940160598426, 4560.192239480071, 5413.621046526863, 5626.662400255997, 5745.242283703762, 5782.496550896713, 4911.877203069952, 5406.324039547752, 5425.159100339453, 5598.608097433141, 5647.774089036557, 5519.5989744461285, 5999.740054588586, 6005.459508644243, 6019.337872834072, 6019.578629495893, 3305.4545999909747, 3544.1494041430387, 3823.1589050408866, 3884.4561761354, 3890.47478590398, 4680.46174689915, 5409.377921539073, 5536.252605898152, 5701.4298570142655, 5853.882922341444, 5445.918311225414, 5780.369931680991, 5883.235179426647, 5892.5285977122585, 5911.349751527415, 4936.284238785428, 5902.232709747877, 5909.320428150646, 5909.911351329648, 5919.8096704219715, 5176.818811341585, 5488.862778430571, 5605.066252143004, 5756.481916627524, 5793.681347525927, 5062.35473471116, 5642.153676948491, 5881.264841894763, 5909.218100415824, 5956.37458066914, 5025.698458092526, 5422.240886276003, 5727.284089488814, 5775.513262400652, 5792.567121808935], "value": 4179.193424300507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.5034201230147, 747.4282174136783, 791.5883740454964, 835.2507484104011, 878.178902725951, 15412.460563880266, 15907.52277431676, 16382.918085409556, 16524.75212871808, 16537.503874883743, 15086.924565377185, 15163.54509364718, 15361.615959601015, 15387.23063846806, 15402.537923862274, 736.3225832234331, 749.9875168522506, 886.7029545102382, 914.8033172867832, 918.9569838233587, 881.7134431309818, 889.253027456936, 891.8350105230553, 902.2421166220373, 916.6470908700131, 965.8309795785744, 972.1736523954653, 975.4829940131741, 978.8776402949632, 980.4705459052103, 922.7416323429451, 958.4919992404037, 963.7253382785907, 969.699393188114, 972.6887396033308, 690.9585424874524, 710.2152121905324, 717.4117223876424, 720.9711611535532, 728.5992704012825, 15502.534923952187, 15835.604109897346, 15958.76061859073, 16060.839391606169, 16264.593385165348, 14897.187168005426, 14974.0, 15208.16355100469, 15288.312025958858, 15360.692786144215, 11738.36782218044, 11808.527658893634, 11834.526618935231, 11880.287182769061, 12469.251844889335, 3492.6856582907662, 3834.865779697725, 3866.3233934061427, 3943.38877473992, 3950.2889479893606, 106995.46502267517, 109767.0, 110985.0, 112056.43971780171, 113873.0, 11636.534538618529, 11694.676481676272, 11775.587854425054, 11800.40997950099, 11917.284962902253, 24572.754272457405, 24982.750172498407, 24985.5002899941, 25060.373490662514, 25064.87467562687, 8209.79475513117, 8214.301784348278, 8238.423310368336, 8238.711645092393, 8347.0, 4371.650267978554, 4379.255526560492, 4476.0, 4521.095780843844, 4553.749543775058, 3674.0998455378067, 3704.7036237101506, 3786.5077539919635, 3787.16682329887, 3799.4870692456716, 645.9709313080923, 663.5952069237761, 672.9798106056826, 673.1316601584, 686.0018672831019, 684.2063206680227, 695.6139342664869, 720.9783706488814, 730.7990302666702, 750.4671683104948, 8473.576321183917, 10615.84076238857, 10873.565057397775, 10878.238523303451, 10943.83584246237, 723.2514347650157, 727.3635568877232, 730.2441972558377, 737.3732327521564, 743.0897150990102, 4990.476000020019, 5198.740062996911, 5260.473952604709, 5268.9736551317, 5281.815136470205, 86386.0, 89721.10278897127, 108458.0, 111646.0, 111730.44134779274, 80107.59946200348, 80136.59931700304, 84283.5785821067, 85835.57082214674, 98306.5084674572, 75354.62322688352, 78058.6097069511, 78343.0, 79711.0, 79904.60047699725, 11123.666290011313, 11157.497912594115, 11254.38100904458, 11343.319400835977, 11525.193236473366, 36689.81655091707, 51328.48671513237, 52900.0, 53213.4678653224, 53778.462215377345, 72661.91007135002, 72753.0, 73756.0, 74854.25145748691, 75364.62317688376, 12019.81970270464, 13713.245771482665, 13856.792148117585, 14007.649808754863, 14167.433302667778, 13972.79040814409, 15003.324850381978, 15213.315400806769, 15575.922120389325, 15635.374585016472, 11344.716382090513, 14076.78884816749, 14323.641908952359, 14672.899532535315, 14959.775603366175, 13494.190348579117, 14111.0, 14119.717605648035, 14172.716545669235, 14258.928705356408, 13534.59396218115, 13824.93087534596, 14048.859511404755, 14227.359768810222, 14547.27263636835, 11244.0, 11302.830457543309, 11487.13846461502, 11721.472533736172, 11772.175947683923, 10082.949585252027, 10276.383416995004, 11236.988671019648, 11513.0, 11545.0], "value": 7873.499377834539, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 118.0, 119.0, 117.0, 146.0, 176.0, 153.0, 116.0, 118.0], "value": 127.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 114.0, 128.0, 94.0, 128.0, 142.0, 142.0, 140.0, 111.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [228.0, 262.0, 196.0, 198.0, 192.0, 255.0, 285.0, 192.0, 283.0, 276.0], "value": 236.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 86.0, 73.0, 52.0, 83.0, 78.0, 91.0, 51.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 85.0, 73.0, 70.0, 71.0, 81.0, 72.0, 97.0, 109.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 88.0, 90.0, 101.0, 90.0, 88.0, 89.0, 86.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 105.0, 153.0, 113.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 89.0, 92.0, 93.0, 134.0, 147.0, 91.0, 93.0, 90.0], "value": 106.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 59.0, 60.0, 62.0, 60.0, 62.0, 62.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 78.0, 77.0, 71.0, 70.0, 69.0, 68.0, 74.0, 71.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 103.0, 71.0, 91.0, 103.0, 101.0, 104.0, 82.0, 86.0, 83.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 147.0, 127.0, 129.0, 135.0, 137.0, 136.0, 139.0, 178.0, 142.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 163.0, 164.0, 168.0, 162.0, 164.0, 175.0, 226.0, 195.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 62.0, 64.0, 65.0, 65.0, 64.0, 64.0, 63.0], "value": 64.4, "unit": "score"}]}]} 11:30:03 INFO - Return code: 0 11:30:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:30:03 ERROR - # TBPL SUCCESS # 11:30:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:30:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:30:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:30:03 INFO - 2017-03-21 11:30:03.722 screenresolution[1981:13502] starting screenresolution argv=screenresolution get 11:30:03 INFO - 2017-03-21 11:30:03.725 screenresolution[1981:13502] Display 0: 1600x1200x32@60 11:30:03 INFO - 2017-03-21 11:30:03.731 screenresolution[1982:13505] starting screenresolution argv=screenresolution list 11:30:03 INFO - Available Modes on Display 0 11:30:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:30:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:30:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:30:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:30:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:30:03 INFO - Intel Iris: 11:30:03 INFO - Chipset Model: Intel Iris 11:30:03 INFO - Type: GPU 11:30:03 INFO - Bus: Built-In 11:30:03 INFO - VRAM (Dynamic, Max): 1536 MB 11:30:03 INFO - Vendor: Intel (0x8086) 11:30:03 INFO - Device ID: 0x0a2e 11:30:03 INFO - Revision ID: 0x0009 11:30:03 INFO - Displays: 11:30:03 INFO - Display: 11:30:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:30:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:30:03 INFO - Display Serial Number: 1600x1200 60 11:30:03 INFO - Main Display: Yes 11:30:03 INFO - Mirror: Off 11:30:03 INFO - Online: Yes 11:30:03 INFO - Rotation: Supported 11:30:03 INFO - Return code: 0 11:30:03 INFO - Running post-action listener: _resource_record_post_action 11:30:03 INFO - [mozharness: 2017-03-21 18:30:03.965475Z] Finished run-tests step (success) 11:30:03 INFO - Running post-run listener: _resource_record_post_run 11:30:04 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 356352; Write bytes: 425099776; Read time: 5; Write time: 1539 11:30:04 INFO - TinderboxPrint: CPU usage
54.4% 11:30:04 INFO - TinderboxPrint: I/O read bytes / time
356,352 / 5 11:30:04 INFO - TinderboxPrint: I/O write bytes / time
425,099,776 / 1,539 11:30:04 INFO - TinderboxPrint: CPU idle
2,170.3 (45.6%) 11:30:04 INFO - TinderboxPrint: CPU system
957.3 (20.1%) 11:30:04 INFO - TinderboxPrint: CPU user
1,630.0 (34.3%) 11:30:04 INFO - TinderboxPrint: Swap in / out
121,753,600 / 0 11:30:04 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 113037824; Write bytes: 110770176; Read time: 10144; Write time: 335 11:30:04 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 356352; Write bytes: 299092480; Read time: 5; Write time: 1155 11:30:04 INFO - Running post-run listener: _upload_blobber_files 11:30:04 INFO - Blob upload gear active. 11:30:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:30:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:30:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:30:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:30:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:06 INFO - (blobuploader) - INFO - Done attempting. 11:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:30:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:30:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:07 INFO - (blobuploader) - INFO - Done attempting. 11:30:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:30:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:08 INFO - (blobuploader) - INFO - Done attempting. 11:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:11 INFO - (blobuploader) - INFO - Done attempting. 11:30:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:30:11 INFO - Return code: 0 11:30:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:30:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:30:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a441bacd9de9affb0eb224e472bd430ae9fd78bdb4a59fbd8b12eed1bc85bc00934060bff10512a05124140a979d3d152e0182143e4f5243b131a9c3f211edc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6606aa92291947f6a7b5612d7428c00d9b1655fb0eecdff531ed99fd6c7c9056d35531ac41fe68606f46fb4eddff20a196600dd9d1f00daf2452cae06015258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bac73a08d790b3da91f3f0ffd7b2cc758f323e506fdacf31b58941b9d49c5a147cce8c11e0efe5c2bada370893c11f4fc7eecfeb515fe1cf7470c9d0c18a5e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca8f495eae63b38091d02e328ad5b10bdbeab934b41bbbe55d7d1e0c9fc041505ef3682e4e907cfa996ee8b7830a1b0572141b696b0bdfe085e90e9b6ff56fce"} 11:30:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:30:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:30:11 INFO - Contents: 11:30:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a441bacd9de9affb0eb224e472bd430ae9fd78bdb4a59fbd8b12eed1bc85bc00934060bff10512a05124140a979d3d152e0182143e4f5243b131a9c3f211edc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6606aa92291947f6a7b5612d7428c00d9b1655fb0eecdff531ed99fd6c7c9056d35531ac41fe68606f46fb4eddff20a196600dd9d1f00daf2452cae06015258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bac73a08d790b3da91f3f0ffd7b2cc758f323e506fdacf31b58941b9d49c5a147cce8c11e0efe5c2bada370893c11f4fc7eecfeb515fe1cf7470c9d0c18a5e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca8f495eae63b38091d02e328ad5b10bdbeab934b41bbbe55d7d1e0c9fc041505ef3682e4e907cfa996ee8b7830a1b0572141b696b0bdfe085e90e9b6ff56fce"} 11:30:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:30:11 INFO - Copying logs to upload dir... 11:30:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:30:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.055289 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-21 11:30:11.226639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 11:30:11.230425) ========= 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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-Beta/sha512/5a441bacd9de9affb0eb224e472bd430ae9fd78bdb4a59fbd8b12eed1bc85bc00934060bff10512a05124140a979d3d152e0182143e4f5243b131a9c3f211edc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6606aa92291947f6a7b5612d7428c00d9b1655fb0eecdff531ed99fd6c7c9056d35531ac41fe68606f46fb4eddff20a196600dd9d1f00daf2452cae06015258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bac73a08d790b3da91f3f0ffd7b2cc758f323e506fdacf31b58941b9d49c5a147cce8c11e0efe5c2bada370893c11f4fc7eecfeb515fe1cf7470c9d0c18a5e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca8f495eae63b38091d02e328ad5b10bdbeab934b41bbbe55d7d1e0c9fc041505ef3682e4e907cfa996ee8b7830a1b0572141b696b0bdfe085e90e9b6ff56fce"} build_url:https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010956 build_url: 'https://queue.taskcluster.net/v1/task/Xhany4BISlu4vb7i6AfpEQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a441bacd9de9affb0eb224e472bd430ae9fd78bdb4a59fbd8b12eed1bc85bc00934060bff10512a05124140a979d3d152e0182143e4f5243b131a9c3f211edc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6606aa92291947f6a7b5612d7428c00d9b1655fb0eecdff531ed99fd6c7c9056d35531ac41fe68606f46fb4eddff20a196600dd9d1f00daf2452cae06015258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bac73a08d790b3da91f3f0ffd7b2cc758f323e506fdacf31b58941b9d49c5a147cce8c11e0efe5c2bada370893c11f4fc7eecfeb515fe1cf7470c9d0c18a5e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca8f495eae63b38091d02e328ad5b10bdbeab934b41bbbe55d7d1e0c9fc041505ef3682e4e907cfa996ee8b7830a1b0572141b696b0bdfe085e90e9b6ff56fce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 11:30:11.264483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:30:11.264804) ========= 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.ajaVHrkUx6/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.n6CYNSUUdp/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005254 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:30:11.313909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 11:30:11.314240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 11:30:11.314568) ========= ========= Total master_lag: 0.19 =========