builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0009 starttime: 1487586079.43 results: success (0) buildid: 20170220004023 builduid: ef79a22facad43988fbf2baa6797e9c9 revision: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.434000) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.434510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.434830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.466026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.466496) ========= 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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-20 02:21:19-- 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% 16.5M=0.001s 2017-02-20 02:21:19 (16.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132173 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.624345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.624694) ========= 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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.027182 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:19.674859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-20 02:21:19.675246) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ai0DBekF85/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.2MDA7ojLRJ/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-20 02:21:19,952 truncating revision to first 12 chars 2017-02-20 02:21:19,952 Setting DEBUG logging. 2017-02-20 02:21:19,952 attempt 1/10 2017-02-20 02:21:19,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2ddf71e1526a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-20 02:21:20,992 unpacking tar archive at: mozilla-aurora-2ddf71e1526a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.307423 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-20 02:21:21.008920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:21.009426) ========= script_repo_revision: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:21.010056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:21.010481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 02:21:21.032134) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-20 02:21:21.032537) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ai0DBekF85/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.2MDA7ojLRJ/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:21:21 INFO - MultiFileLogger online at 20170220 02:21:21 in /builds/slave/test 02:21:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:21:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:21:21 INFO - {'append_to_log': False, 02:21:21 INFO - 'base_work_dir': '/builds/slave/test', 02:21:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:21:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:21:21 INFO - 'branch': 'Mozilla-Aurora', 02:21:21 INFO - 'buildbot_json_path': 'buildprops.json', 02:21:21 INFO - 'config_files': ('talos/mac_config.py',), 02:21:21 INFO - 'default_actions': ('clobber', 02:21:21 INFO - 'read-buildbot-config', 02:21:21 INFO - 'download-and-extract', 02:21:21 INFO - 'populate-webroot', 02:21:21 INFO - 'create-virtualenv', 02:21:21 INFO - 'install', 02:21:21 INFO - 'run-tests'), 02:21:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:21:21 INFO - 'download_minidump_stackwalk': True, 02:21:21 INFO - 'download_symbols': 'ondemand', 02:21:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:21:21 INFO - 'tooltool.py': '/tools/tooltool.py', 02:21:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:21:21 INFO - '/tools/misc-python/virtualenv.py')}, 02:21:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:21:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:21:21 INFO - 'installer_path': 'installer.exe', 02:21:21 INFO - 'log_level': 'info', 02:21:21 INFO - 'log_name': 'talos', 02:21:21 INFO - 'log_to_console': True, 02:21:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:21:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:21:21 INFO - 'opt_config_files': (), 02:21:21 INFO - 'pip_index': False, 02:21:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:21:21 INFO - 'cmd': ('bash', 02:21:21 INFO - '-c', 02:21:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:21:21 INFO - 'enabled': True, 02:21:21 INFO - 'halt_on_failure': False, 02:21:21 INFO - 'name': 'check_screen_resolution'},), 02:21:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:21:21 INFO - 'cmd': ('bash', 02:21:21 INFO - '-c', 02:21:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:21:21 INFO - 'enabled': True, 02:21:21 INFO - 'halt_on_failure': False, 02:21:21 INFO - 'name': 'check_screen_resolution'},), 02:21:21 INFO - 'run_cmd_checks_enabled': True, 02:21:21 INFO - 'sps_profile': False, 02:21:21 INFO - 'sps_profile_interval': 0, 02:21:21 INFO - 'suite': 'dromaeojs-e10s', 02:21:21 INFO - 'system_bits': '32', 02:21:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:21:21 INFO - 'title': 't-yosemite-r7-0009', 02:21:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:21:21 INFO - 'use_talos_json': True, 02:21:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:21:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:21:21 INFO - 'work_dir': 'build'} 02:21:21 INFO - [mozharness: 2017-02-20 10:21:21.424868Z] Running clobber step. 02:21:21 INFO - Running pre-action listener: _resource_record_pre_action 02:21:21 INFO - Running main action method: clobber 02:21:21 INFO - rmtree: /builds/slave/test/build 02:21:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:21:23 INFO - Running post-action listener: _resource_record_post_action 02:21:23 INFO - [mozharness: 2017-02-20 10:21:23.999744Z] Finished clobber step (success) 02:21:23 INFO - [mozharness: 2017-02-20 10:21:23.999940Z] Running read-buildbot-config step. 02:21:24 INFO - Running pre-action listener: _resource_record_pre_action 02:21:24 INFO - Running main action method: read_buildbot_config 02:21:24 INFO - Using buildbot properties: 02:21:24 INFO - { 02:21:24 INFO - "project": "", 02:21:24 INFO - "product": "firefox", 02:21:24 INFO - "script_repo_revision": "production", 02:21:24 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:21:24 INFO - "repository": "", 02:21:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:21:24 INFO - "buildid": "20170220004023", 02:21:24 INFO - "stage_platform": "macosx64", 02:21:24 INFO - "basedir": "/builds/slave/test", 02:21:24 INFO - "nightly_build": "True", 02:21:24 INFO - "buildnumber": 51, 02:21:24 INFO - "slavename": "t-yosemite-r7-0009", 02:21:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:21:24 INFO - "platform": "yosemite_r7", 02:21:24 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:21:24 INFO - "branch": "mozilla-aurora", 02:21:24 INFO - "repo_path": "releases/mozilla-aurora", 02:21:24 INFO - "revision": "2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c", 02:21:24 INFO - "pgo_build": "False", 02:21:24 INFO - "builduid": "ef79a22facad43988fbf2baa6797e9c9", 02:21:24 INFO - "slavebuilddir": "test" 02:21:24 INFO - } 02:21:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:21:24 INFO - Running post-action listener: _resource_record_post_action 02:21:24 INFO - [mozharness: 2017-02-20 10:21:24.006131Z] Finished read-buildbot-config step (success) 02:21:24 INFO - [mozharness: 2017-02-20 10:21:24.006331Z] Running download-and-extract step. 02:21:24 INFO - Running pre-action listener: _resource_record_pre_action 02:21:24 INFO - Running main action method: download_and_extract 02:21:24 INFO - mkdir: /builds/slave/test/build/tests 02:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:24 INFO - trying https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:21:24 INFO - Downloading https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:21:25 INFO - Downloaded 1199 bytes. 02:21:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:21:25 INFO - Using the following test package requirements: 02:21:25 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:21:25 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:21:25 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:21:25 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'jsshell-mac.zip'], 02:21:25 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:21:25 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:21:25 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:21:25 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:21:25 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:21:25 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:21:25 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:21:25 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:21:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:21:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:21:25 INFO - Fetch https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:21:26 INFO - Expected file size: 16359074 02:21:26 INFO - Obtained file size: 16359074 02:21:32 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:21:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:21:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:21:32 INFO - Fetch https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:21:33 INFO - Expected file size: 16359074 02:21:33 INFO - Obtained file size: 16359074 02:21:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:21:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:21:40 INFO - Fetch https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:21:41 INFO - Expected file size: 14403485 02:21:41 INFO - Obtained file size: 14403485 02:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:42 INFO - trying https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:21:42 INFO - Downloading https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:21:44 INFO - Downloaded 74025961 bytes. 02:21:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:21:44 INFO - mkdir: /builds/slave/test/properties 02:21:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:21:44 INFO - Writing to file /builds/slave/test/properties/build_url 02:21:44 INFO - Contents: 02:21:44 INFO - build_url:https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:21:45 INFO - Running post-action listener: _resource_record_post_action 02:21:45 INFO - Running post-action listener: set_extra_try_arguments 02:21:45 INFO - [mozharness: 2017-02-20 10:21:45.764735Z] Finished download-and-extract step (success) 02:21:45 INFO - [mozharness: 2017-02-20 10:21:45.764841Z] Running populate-webroot step. 02:21:45 INFO - Running pre-action listener: _resource_record_pre_action 02:21:45 INFO - Running main action method: populate_webroot 02:21:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:21:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:21:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:21:45 INFO - '--tppagecycles', 02:21:45 INFO - '7'], 02:21:45 INFO - 'tests': ['tsvgm']}}, 02:21:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:21:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:21:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:21:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:21:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:21:45 INFO - 'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:21:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:21:45 INFO - 'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['damp', 'tps']}, 02:21:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:21:45 INFO - 'tests': ['damp', 'tps']}, 02:21:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['dromaeo_dom']}, 02:21:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:21:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['basic_compositor_video']}, 02:21:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:21:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['a11yr', 02:21:45 INFO - 'ts_paint', 02:21:45 INFO - 'tpaint', 02:21:45 INFO - 'sessionrestore', 02:21:45 INFO - 'sessionrestore_no_auto_restore', 02:21:45 INFO - 'tabpaint']}, 02:21:45 INFO - 'other-e10s': {'tests': ['a11yr', 02:21:45 INFO - 'ts_paint', 02:21:45 INFO - 'tpaint', 02:21:45 INFO - 'sessionrestore', 02:21:45 INFO - 'sessionrestore_no_auto_restore', 02:21:45 INFO - 'tabpaint']}, 02:21:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:21:45 INFO - 'ts_paint', 02:21:45 INFO - 'tpaint', 02:21:45 INFO - 'sessionrestore', 02:21:45 INFO - 'sessionrestore_no_auto_restore', 02:21:45 INFO - 'tabpaint']}, 02:21:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:21:45 INFO - 'ts_paint', 02:21:45 INFO - 'tpaint', 02:21:45 INFO - 'sessionrestore', 02:21:45 INFO - 'sessionrestore_no_auto_restore', 02:21:45 INFO - 'tabpaint']}, 02:21:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['a11yr', 02:21:45 INFO - 'ts_paint', 02:21:45 INFO - 'tpaint', 02:21:45 INFO - 'sessionrestore', 02:21:45 INFO - 'sessionrestore_no_auto_restore', 02:21:45 INFO - 'tabpaint']}, 02:21:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['a11yr', 02:21:45 INFO - 'ts_paint', 02:21:45 INFO - 'tpaint', 02:21:45 INFO - 'sessionrestore', 02:21:45 INFO - 'sessionrestore_no_auto_restore', 02:21:45 INFO - 'tabpaint']}, 02:21:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['tsvgx', 02:21:45 INFO - 'tsvgr_opacity', 02:21:45 INFO - 'tart', 02:21:45 INFO - 'tscrollx', 02:21:45 INFO - 'cart', 02:21:45 INFO - 'tsvg_static']}, 02:21:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:21:45 INFO - 'tsvgr_opacity', 02:21:45 INFO - 'tart', 02:21:45 INFO - 'tscrollx', 02:21:45 INFO - 'cart', 02:21:45 INFO - 'tsvg_static']}, 02:21:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:21:45 INFO - 'talos_options': ['--disable-e10s'], 02:21:45 INFO - 'tests': ['tp5o']}, 02:21:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:21:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:21:45 INFO - 'talos_options': ['--disable-e10s', 02:21:45 INFO - '--xperf_path', 02:21:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:45 INFO - 'tests': ['tp5n']}, 02:21:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:21:45 INFO - 'talos_options': ['--xperf_path', 02:21:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:45 INFO - 'tests': ['tp5n']}}, 02:21:45 INFO - 'talos.zip': {'path': '', 02:21:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:21:45 INFO - Running post-action listener: _resource_record_post_action 02:21:45 INFO - [mozharness: 2017-02-20 10:21:45.783095Z] Finished populate-webroot step (success) 02:21:45 INFO - [mozharness: 2017-02-20 10:21:45.783222Z] Running create-virtualenv step. 02:21:45 INFO - Running pre-action listener: _resource_record_pre_action 02:21:45 INFO - Running main action method: create_virtualenv 02:21:45 INFO - Creating virtualenv /builds/slave/test/build/venv 02:21:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:21:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:21:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:21:45 INFO - Using real prefix '/tools/python27' 02:21:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:21:46 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:49 INFO - Installing pip.................done. 02:21:49 INFO - Return code: 0 02:21:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:21:50 INFO - Reading from file tmpfile_stdout 02:21:50 INFO - Output received: 02:21:50 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) 02:21:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:50 INFO - 'HOME': '/Users/cltbld', 02:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:50 INFO - 'LOGNAME': 'cltbld', 02:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:50 INFO - 'MOZ_NO_REMOTE': '1', 02:21:50 INFO - 'NO_EM_RESTART': '1', 02:21:50 INFO - 'PAGER': '/bin/cat', 02:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:50 INFO - 'PWD': '/builds/slave/test', 02:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:50 INFO - 'SHELL': '/bin/bash', 02:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:21:50 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:50 INFO - 'USER': 'cltbld', 02:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:50 INFO - 'XPC_FLAGS': '0x0', 02:21:50 INFO - 'XPC_SERVICE_NAME': '0', 02:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:21:50 INFO - Cleaning up... 02:21:50 INFO - Return code: 0 02:21:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:50 INFO - 'HOME': '/Users/cltbld', 02:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:50 INFO - 'LOGNAME': 'cltbld', 02:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:50 INFO - 'MOZ_NO_REMOTE': '1', 02:21:50 INFO - 'NO_EM_RESTART': '1', 02:21:50 INFO - 'PAGER': '/bin/cat', 02:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:50 INFO - 'PWD': '/builds/slave/test', 02:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:50 INFO - 'SHELL': '/bin/bash', 02:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:21:50 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:50 INFO - 'USER': 'cltbld', 02:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:50 INFO - 'XPC_FLAGS': '0x0', 02:21:50 INFO - 'XPC_SERVICE_NAME': '0', 02:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:50 INFO - Downloading/unpacking psutil>=3.1.1 02:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:54 INFO - Installing collected packages: psutil 02:21:54 INFO - Running setup.py install for psutil 02:21:55 INFO - building 'psutil._psutil_osx' extension 02:21:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:21:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:21:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:21:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:21:55 INFO - building 'psutil._psutil_posix' extension 02:21:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:21:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:21:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:21:55 INFO - ^ 02:21:55 INFO - 1 warning generated. 02:21:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:21:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:56 INFO - Successfully installed psutil 02:21:56 INFO - Cleaning up... 02:21:56 INFO - Return code: 0 02:21:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:56 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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:56 INFO - 'HOME': '/Users/cltbld', 02:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:56 INFO - 'LOGNAME': 'cltbld', 02:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:56 INFO - 'MOZ_NO_REMOTE': '1', 02:21:56 INFO - 'NO_EM_RESTART': '1', 02:21:56 INFO - 'PAGER': '/bin/cat', 02:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:56 INFO - 'PWD': '/builds/slave/test', 02:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:56 INFO - 'SHELL': '/bin/bash', 02:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:21:56 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:56 INFO - 'USER': 'cltbld', 02:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:56 INFO - 'XPC_FLAGS': '0x0', 02:21:56 INFO - 'XPC_SERVICE_NAME': '0', 02:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:00 INFO - Installing collected packages: mozsystemmonitor 02:22:00 INFO - Running setup.py install for mozsystemmonitor 02:22:00 INFO - Successfully installed mozsystemmonitor 02:22:00 INFO - Cleaning up... 02:22:00 INFO - Return code: 0 02:22:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:22:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:00 INFO - 'HOME': '/Users/cltbld', 02:22:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:00 INFO - 'LOGNAME': 'cltbld', 02:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:00 INFO - 'MOZ_NO_REMOTE': '1', 02:22:00 INFO - 'NO_EM_RESTART': '1', 02:22:00 INFO - 'PAGER': '/bin/cat', 02:22:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:00 INFO - 'PWD': '/builds/slave/test', 02:22:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:00 INFO - 'SHELL': '/bin/bash', 02:22:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:00 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:00 INFO - 'USER': 'cltbld', 02:22:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:00 INFO - 'XPC_FLAGS': '0x0', 02:22:00 INFO - 'XPC_SERVICE_NAME': '0', 02:22:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:00 INFO - Downloading/unpacking jsonschema==2.5.1 02:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:03 INFO - warning: no files found matching '*.txt' 02:22:03 INFO - no previously-included directories found matching 'build' 02:22:03 INFO - no previously-included directories found matching 'dist' 02:22:03 INFO - no previously-included directories found matching '.git*' 02:22:03 INFO - Installing collected packages: jsonschema, functools32 02:22:03 INFO - Running setup.py install for functools32 02:22:03 INFO - warning: no files found matching '*.txt' 02:22:03 INFO - no previously-included directories found matching 'build' 02:22:03 INFO - no previously-included directories found matching 'dist' 02:22:03 INFO - no previously-included directories found matching '.git*' 02:22:04 INFO - Successfully installed jsonschema functools32 02:22:04 INFO - Cleaning up... 02:22:04 INFO - Return code: 0 02:22:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:04 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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:04 INFO - 'HOME': '/Users/cltbld', 02:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:04 INFO - 'LOGNAME': 'cltbld', 02:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:04 INFO - 'MOZ_NO_REMOTE': '1', 02:22:04 INFO - 'NO_EM_RESTART': '1', 02:22:04 INFO - 'PAGER': '/bin/cat', 02:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:04 INFO - 'PWD': '/builds/slave/test', 02:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:04 INFO - 'SHELL': '/bin/bash', 02:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:04 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:04 INFO - 'USER': 'cltbld', 02:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:04 INFO - 'XPC_FLAGS': '0x0', 02:22:04 INFO - 'XPC_SERVICE_NAME': '0', 02:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:22:04 INFO - Cleaning up... 02:22:04 INFO - Return code: 0 02:22:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:04 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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:04 INFO - 'HOME': '/Users/cltbld', 02:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:04 INFO - 'LOGNAME': 'cltbld', 02:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:04 INFO - 'MOZ_NO_REMOTE': '1', 02:22:04 INFO - 'NO_EM_RESTART': '1', 02:22:04 INFO - 'PAGER': '/bin/cat', 02:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:04 INFO - 'PWD': '/builds/slave/test', 02:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:04 INFO - 'SHELL': '/bin/bash', 02:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:04 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:04 INFO - 'USER': 'cltbld', 02:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:04 INFO - 'XPC_FLAGS': '0x0', 02:22:04 INFO - 'XPC_SERVICE_NAME': '0', 02:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:07 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:08 INFO - Downloading docopt-0.6.1.tar.gz 02:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:09 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:09 INFO - Running setup.py install for blobuploader 02:22:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:09 INFO - Running setup.py install for requests 02:22:09 INFO - Running setup.py install for docopt 02:22:09 INFO - Successfully installed blobuploader requests docopt 02:22:09 INFO - Cleaning up... 02:22:09 INFO - Return code: 0 02:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:09 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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:09 INFO - 'HOME': '/Users/cltbld', 02:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:09 INFO - 'LOGNAME': 'cltbld', 02:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:09 INFO - 'MOZ_NO_REMOTE': '1', 02:22:09 INFO - 'NO_EM_RESTART': '1', 02:22:09 INFO - 'PAGER': '/bin/cat', 02:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:09 INFO - 'PWD': '/builds/slave/test', 02:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:09 INFO - 'SHELL': '/bin/bash', 02:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:09 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:09 INFO - 'USER': 'cltbld', 02:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:09 INFO - 'XPC_FLAGS': '0x0', 02:22:09 INFO - 'XPC_SERVICE_NAME': '0', 02:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-SSjJtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-0ZEjJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-8FsAvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-5EWj7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-EudJzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-P1t90g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-bc2HQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-dCv4WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-bxrB6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-v5SZKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-hq5V3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-c8Nuaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-WfdzLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Yq2pmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VuaFwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-f9Fry6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-jQTzGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:12 INFO - Running setup.py install for manifestparser 02:22:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:12 INFO - Running setup.py install for mozcrash 02:22:12 INFO - Running setup.py install for mozdebug 02:22:12 INFO - Running setup.py install for mozdevice 02:22:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:12 INFO - Running setup.py install for mozfile 02:22:12 INFO - Running setup.py install for mozhttpd 02:22:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:12 INFO - Running setup.py install for mozinfo 02:22:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozInstall 02:22:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozleak 02:22:13 INFO - Running setup.py install for mozlog 02:22:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for moznetwork 02:22:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozprocess 02:22:13 INFO - Running setup.py install for mozprofile 02:22:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:13 INFO - Running setup.py install for mozrunner 02:22:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:14 INFO - Running setup.py install for mozscreenshot 02:22:14 INFO - Running setup.py install for moztest 02:22:14 INFO - Running setup.py install for mozversion 02:22:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:14 INFO - Cleaning up... 02:22:14 INFO - Return code: 0 02:22:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:16 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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:16 INFO - 'HOME': '/Users/cltbld', 02:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:16 INFO - 'LOGNAME': 'cltbld', 02:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:16 INFO - 'MOZ_NO_REMOTE': '1', 02:22:16 INFO - 'NO_EM_RESTART': '1', 02:22:16 INFO - 'PAGER': '/bin/cat', 02:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:16 INFO - 'PWD': '/builds/slave/test', 02:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:16 INFO - 'SHELL': '/bin/bash', 02:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:16 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:16 INFO - 'USER': 'cltbld', 02:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:16 INFO - 'XPC_FLAGS': '0x0', 02:22:16 INFO - 'XPC_SERVICE_NAME': '0', 02:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-SjmQpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mB8a89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:16 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)) 02:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-8JJNUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-LWc8BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:16 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)) 02:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-_uoO9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ePXoNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-C4uon2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-6vA41J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-51hRaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-oCRu1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-zrfhcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qCAimc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:17 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)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-a4cYuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Kw0rSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:17 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)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-0GMu3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:17 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-pEAN3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:18 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)) 02:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:18 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-5y7qL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:22:18 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)) 02:22:18 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)) 02:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:22:18 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)) 02:22:18 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)) 02:22:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:21 INFO - Downloading blessings-1.6.tar.gz 02:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:21 INFO - Installing collected packages: blessings 02:22:21 INFO - Running setup.py install for blessings 02:22:21 INFO - Successfully installed blessings 02:22:21 INFO - Cleaning up... 02:22:21 INFO - Return code: 0 02:22:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:21 INFO - Reading from file tmpfile_stdout 02:22:21 INFO - Current package versions: 02:22:21 INFO - blessings == 1.6 02:22:21 INFO - blobuploader == 1.2.4 02:22:21 INFO - docopt == 0.6.1 02:22:21 INFO - functools32 == 3.2.3-2 02:22:21 INFO - jsonschema == 2.5.1 02:22:21 INFO - manifestparser == 1.1 02:22:21 INFO - mozInstall == 1.12 02:22:21 INFO - mozcrash == 1.0 02:22:21 INFO - mozdebug == 0.1 02:22:21 INFO - mozdevice == 0.49 02:22:21 INFO - mozfile == 1.2 02:22:21 INFO - mozhttpd == 0.7 02:22:21 INFO - mozinfo == 0.9 02:22:21 INFO - mozleak == 0.1 02:22:21 INFO - mozlog == 3.4 02:22:21 INFO - moznetwork == 0.27 02:22:21 INFO - mozprocess == 0.24 02:22:21 INFO - mozprofile == 0.28 02:22:21 INFO - mozrunner == 6.13 02:22:21 INFO - mozscreenshot == 0.1 02:22:21 INFO - mozsystemmonitor == 0.3 02:22:21 INFO - moztest == 0.8 02:22:21 INFO - mozversion == 1.4 02:22:21 INFO - psutil == 3.1.1 02:22:21 INFO - requests == 1.2.3 02:22:21 INFO - wsgiref == 0.1.2 02:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:21 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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:21 INFO - 'HOME': '/Users/cltbld', 02:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:21 INFO - 'LOGNAME': 'cltbld', 02:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:21 INFO - 'MOZ_NO_REMOTE': '1', 02:22:21 INFO - 'NO_EM_RESTART': '1', 02:22:21 INFO - 'PAGER': '/bin/cat', 02:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:21 INFO - 'PWD': '/builds/slave/test', 02:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:21 INFO - 'SHELL': '/bin/bash', 02:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:21 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:21 INFO - 'USER': 'cltbld', 02:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:21 INFO - 'XPC_FLAGS': '0x0', 02:22:21 INFO - 'XPC_SERVICE_NAME': '0', 02:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:22 INFO - Cleaning up... 02:22:22 INFO - Return code: 0 02:22:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:22 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 0x10ed8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2335d0090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, '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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:22 INFO - 'HOME': '/Users/cltbld', 02:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:22 INFO - 'LOGNAME': 'cltbld', 02:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:22 INFO - 'MOZ_NO_REMOTE': '1', 02:22:22 INFO - 'NO_EM_RESTART': '1', 02:22:22 INFO - 'PAGER': '/bin/cat', 02:22:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:22 INFO - 'PWD': '/builds/slave/test', 02:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:22 INFO - 'SHELL': '/bin/bash', 02:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:22 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:22 INFO - 'USER': 'cltbld', 02:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:22 INFO - 'XPC_FLAGS': '0x0', 02:22:22 INFO - 'XPC_SERVICE_NAME': '0', 02:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:22:22 INFO - Cleaning up... 02:22:22 INFO - Return code: 0 02:22:22 INFO - Running post-action listener: _resource_record_post_action 02:22:22 INFO - Running post-action listener: _start_resource_monitoring 02:22:22 INFO - Starting resource monitoring. 02:22:22 INFO - [mozharness: 2017-02-20 10:22:22.394288Z] Finished create-virtualenv step (success) 02:22:22 INFO - [mozharness: 2017-02-20 10:22:22.395308Z] Running install step. 02:22:22 INFO - Running pre-action listener: _resource_record_pre_action 02:22:22 INFO - Running main action method: install 02:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:22 INFO - Reading from file tmpfile_stdout 02:22:22 INFO - Detecting whether we're running mozinstall >=1.0... 02:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:22:22 INFO - Reading from file tmpfile_stdout 02:22:22 INFO - Output received: 02:22:22 INFO - Usage: mozinstall [options] installer 02:22:22 INFO - Options: 02:22:22 INFO - -h, --help show this help message and exit 02:22:22 INFO - -d DEST, --destination=DEST 02:22:22 INFO - Directory to install application into. [default: 02:22:22 INFO - "/builds/slave/test"] 02:22:22 INFO - --app=APP Application being installed. [default: firefox] 02:22:22 INFO - mkdir: /builds/slave/test/build/application 02:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:22:42 INFO - Reading from file tmpfile_stdout 02:22:42 INFO - Output received: 02:22:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:22:42 INFO - Running post-action listener: _resource_record_post_action 02:22:42 INFO - [mozharness: 2017-02-20 10:22:42.590367Z] Finished install step (success) 02:22:42 INFO - [mozharness: 2017-02-20 10:22:42.590527Z] Running run-tests step. 02:22:42 INFO - Running pre-action listener: _resource_record_pre_action 02:22:42 INFO - Running main action method: run_tests 02:22:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:42 INFO - 2017-02-20 02:22:42.605 screenresolution[1631:7328] starting screenresolution argv=screenresolution get 02:22:42 INFO - 2017-02-20 02:22:42.607 screenresolution[1631:7328] Display 0: 1600x1200x32@60 02:22:42 INFO - 2017-02-20 02:22:42.612 screenresolution[1632:7331] starting screenresolution argv=screenresolution list 02:22:42 INFO - Available Modes on Display 0 02:22:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:42 INFO - Intel Iris: 02:22:42 INFO - Chipset Model: Intel Iris 02:22:42 INFO - Type: GPU 02:22:42 INFO - Bus: Built-In 02:22:42 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:42 INFO - Vendor: Intel (0x8086) 02:22:42 INFO - Device ID: 0x0a2e 02:22:42 INFO - Revision ID: 0x0009 02:22:42 INFO - Displays: 02:22:42 INFO - Display: 02:22:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:42 INFO - Display Serial Number: 1600x1200 60 02:22:42 INFO - Main Display: Yes 02:22:42 INFO - Mirror: Off 02:22:42 INFO - Online: Yes 02:22:42 INFO - Rotation: Supported 02:22:42 INFO - Return code: 0 02:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:22:42 INFO - Python 2.7.3 02:22:42 INFO - Return code: 0 02:22:42 INFO - grabbing minidump binary from tooltool 02:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:42 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 0x10eb6cd30>, '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 0x10ea93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb61be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:22:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:22:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:22:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:22:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:22:42 INFO - Return code: 0 02:22:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:22:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:22:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:22:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:22:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 02:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --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 02:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ai0DBekF85/Render', 02:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:42 INFO - 'HOME': '/Users/cltbld', 02:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:42 INFO - 'LOGNAME': 'cltbld', 02:22:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:22:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:42 INFO - 'MOZ_NO_REMOTE': '1', 02:22:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:22:42 INFO - 'NO_EM_RESTART': '1', 02:22:42 INFO - 'PAGER': '/bin/cat', 02:22:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:42 INFO - 'PWD': '/builds/slave/test', 02:22:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:42 INFO - 'SHELL': '/bin/bash', 02:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2MDA7ojLRJ/Listeners', 02:22:42 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 02:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:42 INFO - 'USER': 'cltbld', 02:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:42 INFO - 'XPC_FLAGS': '0x0', 02:22:42 INFO - 'XPC_SERVICE_NAME': '0', 02:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 02:22:43 INFO - mozversion application_buildid: 20170220004023 02:22:43 INFO - mozversion application_changeset: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c 02:22:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:22:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:22:43 INFO - mozversion application_name: Firefox 02:22:43 INFO - mozversion application_remotingname: firefox-dev 02:22:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:22:43 INFO - mozversion application_vendor: Mozilla 02:22:43 INFO - mozversion application_version: 53.0a2 02:22:43 INFO - mozversion platform_buildid: 20170220004023 02:22:43 INFO - mozversion platform_changeset: 2ddf71e1526a67d4d3f0166fd17f18dbcb223c2c 02:22:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:22:43 INFO - mozversion platform_version: 53.0a2 02:22:43 INFO - using testdate: 1487586163 02:22:43 INFO - actual date: 1487586163 02:22:43 INFO - starting webserver on 'localhost:49241' 02:22:43 INFO - SUITE-START | Running 2 tests 02:22:43 INFO - TEST-START | dromaeo_css 02:22:43 INFO - operating with platform_type : mac_ 02:22:43 INFO - Initialising browser for dromaeo_css test... 02:22:43 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpxzKO1r/profile http://localhost:49241/getInfo.html) 02:22:46 INFO - PROCESS | 1642 | 2017-02-20 02:22:46.533 plugin-container[1645:7518] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 02:22:46 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:46 INFO - PROCESS | 1642 | 2017-02-20 02:22:46.536 plugin-container[1645:7518] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d27, name = 'com.apple.CFPasteboardClient' 02:22:46 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:46 INFO - PROCESS | 1642 | 2017-02-20 02:22:46.536 plugin-container[1645:7518] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:22:46 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 02:22:46 INFO - PROCESS | 1642 | colorDepth:24 02:22:46 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 02:22:46 INFO - PROCESS | 1642 | __metrics 02:22:46 ERROR - PROCESS | 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 02:22:47 INFO - TEST-INFO | 1642: exit 0 02:22:47 INFO - Browser initialized. 02:22:47 INFO - Running cycle 1/1 for dromaeo_css test... 02:22:47 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpxzKO1r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:49 INFO - PROCESS | 1646 | 2017-02-20 02:22:49.831 plugin-container[1647:7653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8947, name = 'com.apple.tsm.portname' 02:22:49 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:49 INFO - PROCESS | 1646 | 2017-02-20 02:22:49.832 plugin-container[1647:7653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 02:22:49 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:22:49 INFO - PROCESS | 1646 | 2017-02-20 02:22:49.832 plugin-container[1647:7653] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:22:59 INFO - PROCESS | 1646 | RSS: Main: 219672576 02:22:59 INFO - PROCESS | 1646 | 02:26:02 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:26:04 INFO - PROCESS | 1646 | RSS: Main: 240021504 02:26:04 INFO - PROCESS | 1646 | 02:27:48 INFO - PROCESS | 1646 | ************************* 02:27:48 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 02:27:48 INFO - PROCESS | 1646 | 02:27:48 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:27:48 INFO - PROCESS | 1646 | Full stack: 02:27:48 INFO - PROCESS | 1646 | ************************* 02:29:06 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 02:29:07 INFO - PROCESS | 1646 | RSS: Main: 249466880 02:29:07 INFO - PROCESS | 1646 | 02:32:09 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 02:32:09 INFO - PROCESS | 1646 | RSS: Main: 255954944 02:32:09 INFO - PROCESS | 1646 | 02:35:11 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 02:35:12 INFO - PROCESS | 1646 | RSS: Main: 253554688 02:35:12 INFO - PROCESS | 1646 | 02:38:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 02:38:15 INFO - PROCESS | 1646 | RSS: Main: 257544192 02:38:15 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 02:41:18 INFO - PROCESS | 1646 | RSS: Main: 259272704 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | __start_tp_report 02:41:18 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 02:41:18 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 02:41:18 INFO - PROCESS | 1646 | |i|pagename|runs| 02:41:18 INFO - PROCESS | 1646 | |0;dojo.html;3021.788474806763;3395.456726923692;3416.5900091988933;3433.639467855875;3434.982825085875;5760.222369980052;5765.365809760928;5804.709764511768;5829;5856.707164641773;5540.944590554093;5691.7723291068305;5797.884042319151;5829.854253643661;5838.591298609099;4597.494275629678;5271.657342272759;5308.283381743464;5310.8141215057485;5358.196270559409;5365.061114305001;5369.543588794957;5369.812056578021;5378.8924221515545;5424.457554244584;5215.1395019821875;5222.981518603874;5343.305370301875;5364.249005139283;5366.517013468787;5231.816886408977;5240.9213861792105;5297.549708274802;5298.36419629643;5348.91976620351;5157.742112894341;5236.816711415082;5252;5253.343332083489;5308.097623403992;5595.412481689405;5678.346990096151;5723.856903577403;5803;5830.271216097988;6117.12715980571;6228.34602366754;6240.968795156041;6291.402316779899;6396.968015159941;6326.335734747877;6331.366863313678;6349.1428657131155;6357.96821015892;6370.90443643341;5884.117382392633;5896.292444906639;5918.822435326947;5922.437368450033;5922.763089476459;5318.946810531846;6282.089097080989;6288.339724328971;6293.056041593798;6322.778702745381;6160.568760186834;6182.103594978703;6197.194364732556;6217.813465596039;6236.688165591702;6336.112944187817;6362.236531616236;6375.904361434582;6377;6383.680815959184;5236.790528378899;6089.634621922699;6118.923762351576;6233.532485063638;6254.530910181755;6335.841603959938;6341.207349081365;6348.365163483615;6357.618542887441;6395.904061439082;4670.579647831712;4807.95192048082;5038.773255203525;5040.773165207501;5096.082705113041;4419.18245124653;4435.866923992221;4451.5103338632725;4515.164694531522;4515.932261016087;5910.290765108214;5941.197938278364;5982.312034116132;6018.307894592091;6075.726592303357;6306.558540902184;6323.7786677466065;6341.873162536724;6346.428821406003;6348.77779277723;5771.105478650816;5838.649681019152;5914.822555323347;5942.762289508458;5965.313988891333;5545.77816887328;5548.722563871871;5552.805651802168;5559.9444005560235;5573.27547418833;5761.4238576143725;6440;6446.387593178641;6467.838304042342;6473.967630161819;4987.675801072919;5216.426193118829;6178.721957511832;6181.84545386351;6246.968765156145;5283.39240987276;6356.77751278703;6375.6493392861985;6406.1031455597185;6414.198225221848;5160.948390516197;6279.246490421178;6314.936850631619;6325.209348831396;6340.4927605792345;6027.78902738402;6057.697115144137;6119.746288422617;6245.937540624535;6263.906041409474;6120.325235636462;6219.595726277777;6228.003519436868;6229.53278504123;6238.407351301619;6141.84645383869;6208.379162083756;6210.099535567408;6226.62640241587;6272.4982001440685;5117.5394214520875;5748.109043098327;5855.560832937462;6117.96941015292;6140.631562106288;5193.948060519498;6114.266954506099;6143.784967526115;6158.568900177123;6247.031710084944;6015.639061656315;6082.969585152223;6098.969505152623;6102.389761023862;6102.420270074336 02:41:18 INFO - PROCESS | 1646 | |1;ext.html;435.5492065711988;488.9242167464042;497.3981482406288;498.1780062896223;509.9949000509995;34844;38553;42666;42813.14373712524;42902;44518.33222501657;44744;45011.77494112533;45167.54832451674;45210;8387;8644.783880403009;9248.306377021716;9500.904990950072;9513.33406661534;10983.956524130195;11376.146788990818;11619.012383947374;11674.649760507198;11750.412479375997;10753.569857205703;11485.712857178554;11656.883431165665;11664.825027624593;11668.824967625493;11557.942210288895;11631;11692.298462092216;11716.062714982823;11723.237989530739;11495.02292305155;11505.5973040944;11539.307641541534;11560.364179970098;11562.248453850558;42618;42688.35967460491;42824.57175428237;42870.35694464586;42947.78526107349;3957.762534247954;3974.4435778990965;4022.738521996061;4023;4030.254402935437;29910.850445747634;31069.689303106905;31080.067597971873;31971.360572788413;31987.6801231987;3122.953155702666;3126.093432904455;3184.6656101109284;3270.2641905571054;3307.206270495088;509356;511136;513630;515646.9999999963;516497;63108.368916310246;66915;67274.66362668155;67514;67556.66221668958;71962.64018679873;72693.636531817;72742.63628681823;73039;73104.26895731081;17144.742828857576;17360.784745067976;17396;17397.565060873327;17444.563885902953;11767.529298828122;12057.276563406223;12844.165129266568;13094.01794865389;13153.145045572199;19096.427107186806;19464.70802937957;19479.415617531497;19639.214431422868;19675.31136410219;6812.931870681329;7953.5227886327;8077.919220807717;8100.392470564731;8127;856.2465030773004;867.597319956226;869.0831173112301;869.3002133282641;895.632790555869;19476.902615486833;21295.148194072375;22952.65571016436;23805.880970595383;24012.15957441481;1046.9685909422576;1053.4627340056627;1058.396713873085;1060.2101434431245;1069.8496022993838;12440;14276.14343139415;15059.247037648292;15215.771763423336;15277.847221527643;569078;604668;634417;635429;637192;54539.45460545423;54742.17886731702;54929.45070549243;55014;55441.168382474294;1415.0448447298033;1425.5723283015054;1460.9050411723204;1461.1379286220968;1472.3668822406255;26886.32784180411;27369.863150684916;27405.177844664693;27761;28845.56731648985;48397;48406;48736.75631621819;48838.77903052452;48968.26547601718;531136;532026;532194;534985;535831;25214.621780672936;25361.619575706747;25595.872020639777;25877.870610646827;25920;43424.56575434205;43579.34630980474;44593;44663.55336446594;44897.32654010127;25234.873825630755;35412.46881296834;36534;37765.48938042448;38011;32933.67066329402;34462.96611101671;35839.46240806338;35849;36725.81637091797;35496.82251588725;35587.466188006685;36024.639753602125;36146;36295.455568167024;30911.536326955564;32267.031989040366;32339.838300808344;32456.35087298288;32828.67171328256;21652.24217152392;25013.12454064099;25085.372865678502;25293.747062529874;25514.744852551237 02:41:18 INFO - PROCESS | 1646 | |2;jquery.html;356.3407695762839;385.17572395074546;399.81009020715163;402.6155021954034;415.0723133795967;17107.74338384925;19247.903760481197;21074.89462552687;21116.78273781254;21333.040013199385;21601.56796864062;21825.908704564747;21841.126354945784;22149.66775498369;22182.00180991855;5865.85335366615;5914.556408269386;6052.636841789506;6105.481034112106;6107.297660769024;4251.319788833787;4471.552844715535;5913.497352725002;6016.488598469114;6544.149260596139;6768.796936091925;6860.3139686031245;6866.34769696878;6867.587944723307;6882.552634078794;6600.306967768387;6759.7296108155615;6793.524453288272;6795.694193761293;6802.217744959294;5837.854053648651;5902;5902.32123305821;5940.198073260098;5979.850503737398;23128.65307020396;25626.743732562623;25667.871660641766;25841;25998;2427.7936375408112;2466.4080620651093;2668.806466951967;2728.4406696627343;2787;12903.67740806478;14464.349104290332;15293.847061529354;15972.76040859388;16514.58713532159;1505.5633866178796;1701.3789966662202;1809.1225755508567;1817.9365071433228;1856.443067079884;141693;143398;143623;144104;146542;10627.88407217231;11534.826977595343;11960.820587691192;12015.819762703566;12252.387380630933;15626.531204063896;15634.140122293156;15678.9216053919;15688.058716477048;15706.371745130295;8747.825043499095;8937.910620893708;8958.68644597436;8978.281737460988;9055.049219831955;8610;8656.307495400353;8698.695545655872;8804.8679269811;8817.426867253607;4776.665633405698;4779.474257831635;4779.545943135397;4794.424669039738;4845.103655823684;1673.5899704572457;1763.206557049333;1768.3103589600066;2009.276660402254;2064.133064113076;990.3810118675827;991.9950400248097;997.1872923567414;1002.6490728245055;1045.8849526552074;17872.92762434258;20336.79663203349;21963.341099767033;22291.44271393228;22364.55270894573;1006.8471600017939;1024.7284469615558;1033.6020632056561;1056.1234175634359;1073.8013467508379;9738.513074346254;11510.769784604261;11560.421978901022;11560.826587601192;11618.6514404568;358598;358974;359683;632669.836650823;748069;135868;154837;157545;161047.19476402542;164528;937.95310234488;1032.2670903658336;1049.3231865446744;1068.7167900506372;1069.887661795516;14876.925615371854;18549.81450185481;19153.808461915203;19332.130054147878;19553.60892782165;59942.700286498286;61411.69294153501;61545.692271538355;62695.686521568925;63220.36779632145;86739;87693.68459472986;87773;89197.55401222952;98722;8191.549464779494;8536.274416674652;8591.269742071994;8855.955720221358;9032.690259912408;10347.689569312932;10736.570537178426;13161.47354105825;13494.392752326365;13510.527131550742;11273.71815704614;11519.596814111466;11537.59618413385;11691;11839.82240266414;11080.11359091287;11108.61119860801;11471;11533.365664888512;11562.075033997427;10026.899731002597;11393.14551408631;11468.139889508153;11744.412779360828;11828.46771895284;7300.671469783979;7668.539887606761;8397.076321604742;8815.515146666738;8883.555822208735;9439.292053095907;9958.601655933682;10025.431868968744;10134.442605656759;10241.283110182216 02:41:18 INFO - PROCESS | 1646 | |3;mootools.html;1320.1089264746295;1352.7700290950543;1442.9855701442982;1447.8696917277443;1453.7964684944106;7445.590492522909;7637.083549974004;7710.768676939687;8467.491950482967;8498.022727386353;7959.482633628824;8235.91764082359;8241.381896357767;8338.374621903351;8373.665053397857;2310.445493081657;2330.0446816805115;2348.9177878774244;2355.1992322610395;2355.882205889707;2024.9696254556193;2060.1450398084776;2295.9540809183804;2361.8346715729904;2365.195833416638;2050.846186536008;2249.3814201094665;2326.057946531649;2328.953420931589;2333.288347054148;2291.6104262275285;2309.2725791375747;2313.6413855852284;2316.81465482761;2323;2292.9197478088186;2300.2639155470256;2353.5881220786464;2357.834951553392;2360.6223004319227;8400.663973441055;8410.873836892451;8489.405741598091;8498.192671696179;8514.914850851535;5038.521340472649;5180.352455943007;5212.973935130338;5214.322138122057;5223.608229382811;3451.5858097028267;3501.7723847950056;3504.54440922681;3531.964680353215;3566.7681600695873;1196.5453127811463;1201.5073819733955;1231.612042206702;1243.564752336684;1260.9558665446757;10680.038796508274;10766.676999690022;10791;10797.676069717922;10802.189835762349;4402.163588918095;4412.889677758018;4680.438347398334;4747.192977193886;4775.689580177347;8753.255973242218;8765.824683506295;8855.822883542292;9529.285303602257;9624.51877406127;5212.791488340424;5268.841934741964;5287.894242115213;5294.894102117936;5297.417284098746;4560;4814.037192561502;4838.588719958772;4851.757412129379;4865.416150062015;3368.39368913593;3880.3403421418425;3912.882613521599;3959.366501359769;4024.5371782245415;1179.9852127170627;1215.5927764198916;1287.549357724789;1291.599604122706;1292.8642492538336;708.6421357214676;750.1763659668276;766.7853001159684;771.7916162636056;796.6932730898529;5418.1330987042675;5442.619016668875;5457.61796674229;5708.486236238676;5735.770569177186;948.9229724262873;972.1250874213123;984.3945973226557;992.6823416506649;1001.2240513601871;3557.8932632021083;3712.6658600725523;3811.7331786774657;3823.273578020223;3885.4948856648457;9569.808603828023;10072.395656260647;10084.193264538966;10096.899031009596;10103.343282686601;9552.95223523878;9784.510774461249;10032.749181270381;10054.245931555162;10142.949285253526;7816.921830781619;7899.486533375312;7925.801854953672;7927.128015918244;7934.166912474223;5312.62811603184;5316.787328506816;5359.276497672764;5490.066688663017;5502.119660854244;8957.462552246887;9082.500462474627;9297.163255306785;9321.021292764162;9321.6271349148;9280.025597312455;9374.250059995047;9381.014993425591;9406.529673516434;9488.905110948803;7062.646867656699;7064.752733654503;7150.96424517874;7168.103987001625;7213.170485394037;7722.18917013728;7744.380449564134;7834.334081603128;7835.255650713173;7844.176361481962;7006.159260888726;7116.644167791694;7145.678444469907;7176.174739904978;7273.054502914587;6943.51395402317;6999.580025198505;7016.789496315118;7027.894581581382;7099.325564071405;6349.841253968688;6383.808485745435;6391.9041214380895;6452.419282264619;6466.030095485715;4938.333325001079;4953;4967.105920934267;5028.622853285945;5036.874078148076;4905.48492408292;4928.827491037797;4947.307376967299;5084;5090 02:41:18 INFO - PROCESS | 1646 | |4;prototype.html;358.4175714463996;359.36213221531784;366.4741096526484;368.9465027571004;376.44662346350873;4484.461864576251;4594.954050459494;4651.813927442907;5347.54545863602;5497.202905578693;4487.887802804931;5290.259363689077;5367.7922467444805;5380.865478363043;5387.78448862046;4248.893777655552;4274.658027357804;4283.7429754214845;4300.741955482666;4355.978220108911;3758.2295629396044;4019.3970904364287;4044.6562042226446;4143;4245.34197199433;4050.5949405059405;4174.457320548325;4192;4215.620594146526;4293.613574778269;3209.7271731902815;3746.9625303746884;4220.965863363464;4241.448611680493;4244.554321796198;3420.3843308204514;3469.664179290966;3538.9913874545887;3683.6684698377276;3769.5099637047283;4325.84859529915;5170.095233334151;5180.6373553851245;5227.3465816772905;5254.65844720092;4506.535376002779;4507.549245075499;4880;4893.363862697862;4905.2151655734915;5642.435756424325;5721.0846264597885;5731.856703582402;5762.942370576283;5780.624259423124;3305.4215512285496;3587.677109060171;3696.2607478504406;3822.560405553369;3888.6972864090562;5542.750576224039;5995.160677505153;6031.577789554733;6036.667983260919;6038.245219347626;3612.422012477991;3744.5132132823105;3947.5657677655436;3954.940675889864;3987.501562304654;3703.777773333609;3927.3127202739406;4018.557958624549;4025.2754504188943;4052.1085361220485;4470.307102399133;4654.37165982588;4658.045100754337;4662.323963025342;4677.672562920563;4427.955720442818;4840.7337596432535;5343.500007495019;5348.705821179795;5776.508996735324;1122.9213955023233;1144.450663681421;1171;1214.2775048845922;1291.4898615047005;802.4062193976415;873.3929918706438;878.0341624213314;882.6292956957965;883.3507372081515;4635.447125213092;4690.95309046912;4885.853424397274;4904.681195722338;5031.6729412588065;4904.411470623477;5051.368578927634;5232.555232805178;5571.749271282802;5638.238837756932;4968.552830245295;5034.974825125851;5038.420581633086;5073.416557095908;5110.591152707774;2646.8147229694123;2745.7391547802927;2880.884764609434;2921.2258751430886;2955.9801868355385;4947.505249475023;5010.473900240422;5293.517815011803;5755.309362876482;5819.70901454934;4918.581585797836;5163.8242480874;5722.4277572242445;5758.193852860602;5758.510526605201;4860.83692756734;5477.507024367746;5698.116791897262;5764.6476909932735;5880.323762767336;5156.639035267495;5178.508041736029;5280.445553216857;5486.6982315973;5564.749586268708;5373.733740933829;5509.917351239815;5514.420985796594;5524.364698059774;5530.91703624454;5080.695158290514;5473.522149019822;5756.373484704609;5775.8556036099435;5831.393199372618;3699.8181563854523;3701.3152566775234;3709.27669104522;3743.5882052974694;3750.1562148516364;5533.667979921218;5553.222548843084;5564.38791732901;5576.91634625489;5577.386487486455;4424.668149888836;4691.319758635047;4839.225404184742;4950.975245123751;5240.101344844057;4885.462599114166;5254.868628284324;5705.37240903492;5760.415885631317;5760.798372056958;4438.467383913951;4919.54780923265;5295.391030031596;5528.143137813645;5646.830595082154;5702.173184888251;5711.286614015862;5711.5716321276905;5742.540596752333;5745.3105627324985;4329.631981281626;5585.469380408855;5607;5619.887602247851;5652.630001498675 02:41:18 INFO - PROCESS | 1646 | |5;yui.html;555.3086407422759;708.2917082917083;734.7979305690934;772.2354868680005;859.9785005374865;13958;14999.850001499995;15426.922865385686;15438.459653912101;15561.922190389061;13997.930010349959;14276;14283.071600345997;14411.919106067035;14496.42014319426;846.525945470537;856.2379482260761;856.7472595584318;858.3305022082785;859.944103633265;688.9862202755942;710.4103594016954;832.7876391520153;856.5973992223645;858.4720396955859;907.2469850024497;919.9172074513292;920.392540922991;921.2445794448555;922.2207234886511;910.5310764956052;915.4690279637861;916.4684482999844;918.5866360137965;923.2198792020732;682.7166725808784;685.7908337956922;686.5503095472474;687.0998991321335;687.1170545848561;14602;15138.621534461616;15603.687926241526;15636;15664.92167539155;13616.523421680193;13871.930640346834;13906.374213160432;13915.165090094526;14018.43926242949;11542.884571154349;11586.246893951951;11607.30356178632;11754;12386.442610082478;3540.415831387818;3654.8172591370326;3655.214128962259;3671.94492082619;3796.6393192646656;87738.56130719434;95490;109185;110351.34472982911;112787;9473.147416732527;10253.692389228336;10584.312019718695;10633.989770971746;10674.25280230392;20407.081681324376;20407.79592204059;21987.010584523734;22122;22190.778092218872;7367.926320736831;7657;7747;7838.216178382117;7899.328557072713;4181.435506206623;4188.937165942513;4269.786510674454;4315.266404711207;4329.783510824509;3572.1248294167576;3645.671889529955;3651.72612054097;3659.908502287411;3663.9816800915823;693.9132608423947;711.2531841566334;711.900333953247;720.477653701073;728.3481284250672;640.5196102922808;659.2155335151155;690.5821977703417;696.2489339311635;716.9784906452815;10112.696619101438;10292.691219263434;10427.530761115768;10459.581616735397;10460;649.1463725201439;679.6635665345586;685.3044160177424;685.3900028974217;689.5483458334799;5020.322256495399;5061;5077;5087.440381558025;5133.974330128325;89242;101509.47735783969;104192.95807041985;106496;108108;70722.9391559127;90395.09604903999;93403.99999999865;93544;96337;48483.515164848606;57237.71381143068;71714.28285717285;77390.6130469344;83369;8085.989251343582;10517.00088491592;11028.724281893017;11158.051565617014;11282.266652667879;48626.756866215444;49092.01815963732;49649.50350496449;50005.74997124991;50083.74790630263;59406.405935940085;61094.694526527084;62342;62990;63044.16301266362;13066.869331306565;13077.280749558486;13254;13526.59420217395;13684;14101.294935253401;14192.858071419154;14512.492062777752;14797.778033329723;14927.104373737177;12953.41709623088;13143.342832858127;13229.140105893086;13323.400446979715;13695.657608559468;13189.165509241851;13377.732445350845;13424.261665608095;13618.319084045559;13646.795298070338;13033.804492932803;13332.600021999355;13431.597052088062;13465.259410732504;13835;10858.45707714627;11233.269837460539;11349.716257093309;11369.772604547697;11428.885711143115;9164.495952722664;9361.485118318558;10933.540831188384;11154.274972126786;11161.441927903736 02:41:18 INFO - PROCESS | 1646 | __end_tp_report 02:41:18 INFO - PROCESS | 1646 | __start_cc_report 02:41:18 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,394 02:41:18 INFO - PROCESS | 1646 | __end_cc_report 02:41:18 INFO - PROCESS | 1646 | __startTimestamp1487587278761__endTimestamp 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | ------- Summary: start ------- 02:41:18 INFO - PROCESS | 1646 | Number of tests: 6 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5770.01 Median:5965.31 stddev:662.50 (11.1%) stddev-sans-first:628.48 02:41:18 INFO - PROCESS | 1646 | Values: 3021.8 3395.5 3416.6 3433.6 3435.0 5760.2 5765.4 5804.7 5829.0 5856.7 5540.9 5691.8 5797.9 5829.9 5838.6 4597.5 5271.7 5308.3 5310.8 5358.2 5365.1 5369.5 5369.8 5378.9 5424.5 5215.1 5223.0 5343.3 5364.2 5366.5 5231.8 5240.9 5297.5 5298.4 5348.9 5157.7 5236.8 5252.0 5253.3 5308.1 5595.4 5678.3 5723.9 5803.0 5830.3 6117.1 6228.3 6241.0 6291.4 6397.0 6326.3 6331.4 6349.1 6358.0 6370.9 5884.1 5896.3 5918.8 5922.4 5922.8 5318.9 6282.1 6288.3 6293.1 6322.8 6160.6 6182.1 6197.2 6217.8 6236.7 6336.1 6362.2 6375.9 6377.0 6383.7 5236.8 6089.6 6118.9 6233.5 6254.5 6335.8 6341.2 6348.4 6357.6 6395.9 4670.6 4808.0 5038.8 5040.8 5096.1 4419.2 4435.9 4451.5 4515.2 4515.9 5910.3 5941.2 5982.3 6018.3 6075.7 6306.6 6323.8 6341.9 6346.4 6348.8 5771.1 5838.6 5914.8 5942.8 5965.3 5545.8 5548.7 5552.8 5559.9 5573.3 5761.4 6440.0 6446.4 6467.8 6474.0 4987.7 5216.4 6178.7 6181.8 6247.0 5283.4 6356.8 6375.6 6406.1 6414.2 5160.9 6279.2 6314.9 6325.2 6340.5 6027.8 6057.7 6119.7 6245.9 6263.9 6120.3 6219.6 6228.0 6229.5 6238.4 6141.8 6208.4 6210.1 6226.6 6272.5 5117.5 5748.1 5855.6 6118.0 6140.6 5193.9 6114.3 6143.8 6158.6 6247.0 6015.6 6083.0 6099.0 6102.4 6102.4 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:69020.91 Median:35542.14 stddev:148474.74 (417.7%) stddev-sans-first:148801.95 02:41:18 INFO - PROCESS | 1646 | Values: 435.5 488.9 497.4 498.2 510.0 34844.0 38553.0 42666.0 42813.1 42902.0 44518.3 44744.0 45011.8 45167.5 45210.0 8387.0 8644.8 9248.3 9500.9 9513.3 10984.0 11376.1 11619.0 11674.6 11750.4 10753.6 11485.7 11656.9 11664.8 11668.8 11557.9 11631.0 11692.3 11716.1 11723.2 11495.0 11505.6 11539.3 11560.4 11562.2 42618.0 42688.4 42824.6 42870.4 42947.8 3957.8 3974.4 4022.7 4023.0 4030.3 29910.9 31069.7 31080.1 31971.4 31987.7 3123.0 3126.1 3184.7 3270.3 3307.2 509356.0 511136.0 513630.0 515647.0 516497.0 63108.4 66915.0 67274.7 67514.0 67556.7 71962.6 72693.6 72742.6 73039.0 73104.3 17144.7 17360.8 17396.0 17397.6 17444.6 11767.5 12057.3 12844.2 13094.0 13153.1 19096.4 19464.7 19479.4 19639.2 19675.3 6812.9 7953.5 8077.9 8100.4 8127.0 856.2 867.6 869.1 869.3 895.6 19476.9 21295.1 22952.7 23805.9 24012.2 1047.0 1053.5 1058.4 1060.2 1069.8 12440.0 14276.1 15059.2 15215.8 15277.8 569078.0 604668.0 634417.0 635429.0 637192.0 54539.5 54742.2 54929.5 55014.0 55441.2 1415.0 1425.6 1460.9 1461.1 1472.4 26886.3 27369.9 27405.2 27761.0 28845.6 48397.0 48406.0 48736.8 48838.8 48968.3 531136.0 532026.0 532194.0 534985.0 535831.0 25214.6 25361.6 25595.9 25877.9 25920.0 43424.6 43579.3 44593.0 44663.6 44897.3 25234.9 35412.5 36534.0 37765.5 38011.0 32933.7 34463.0 35839.5 35849.0 36725.8 35496.8 35587.5 36024.6 36146.0 36295.5 30911.5 32267.0 32339.8 32456.4 32828.7 21652.2 25013.1 25085.4 25293.7 25514.7 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:34399.19 Median:22236.72 stddev:89637.20 (403.1%) stddev-sans-first:89852.21 02:41:18 INFO - PROCESS | 1646 | Values: 356.3 385.2 399.8 402.6 415.1 17107.7 19247.9 21074.9 21116.8 21333.0 21601.6 21825.9 21841.1 22149.7 22182.0 5865.9 5914.6 6052.6 6105.5 6107.3 4251.3 4471.6 5913.5 6016.5 6544.1 6768.8 6860.3 6866.3 6867.6 6882.6 6600.3 6759.7 6793.5 6795.7 6802.2 5837.9 5902.0 5902.3 5940.2 5979.9 23128.7 25626.7 25667.9 25841.0 25998.0 2427.8 2466.4 2668.8 2728.4 2787.0 12903.7 14464.3 15293.8 15972.8 16514.6 1505.6 1701.4 1809.1 1817.9 1856.4 141693.0 143398.0 143623.0 144104.0 146542.0 10627.9 11534.8 11960.8 12015.8 12252.4 15626.5 15634.1 15678.9 15688.1 15706.4 8747.8 8937.9 8958.7 8978.3 9055.0 8610.0 8656.3 8698.7 8804.9 8817.4 4776.7 4779.5 4779.5 4794.4 4845.1 1673.6 1763.2 1768.3 2009.3 2064.1 990.4 992.0 997.2 1002.6 1045.9 17872.9 20336.8 21963.3 22291.4 22364.6 1006.8 1024.7 1033.6 1056.1 1073.8 9738.5 11510.8 11560.4 11560.8 11618.7 358598.0 358974.0 359683.0 632669.8 748069.0 135868.0 154837.0 157545.0 161047.2 164528.0 938.0 1032.3 1049.3 1068.7 1069.9 14876.9 18549.8 19153.8 19332.1 19553.6 59942.7 61411.7 61545.7 62695.7 63220.4 86739.0 87693.7 87773.0 89197.6 98722.0 8191.5 8536.3 8591.3 8856.0 9032.7 10347.7 10736.6 13161.5 13494.4 13510.5 11273.7 11519.6 11537.6 11691.0 11839.8 11080.1 11108.6 11471.0 11533.4 11562.1 10026.9 11393.1 11468.1 11744.4 11828.5 7300.7 7668.5 8397.1 8815.5 8883.6 9439.3 9958.6 10025.4 10134.4 10241.3 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5426.17 Median:5212.88 stddev:2945.50 (56.5%) stddev-sans-first:2937.59 02:41:18 INFO - PROCESS | 1646 | Values: 1320.1 1352.8 1443.0 1447.9 1453.8 7445.6 7637.1 7710.8 8467.5 8498.0 7959.5 8235.9 8241.4 8338.4 8373.7 2310.4 2330.0 2348.9 2355.2 2355.9 2025.0 2060.1 2296.0 2361.8 2365.2 2050.8 2249.4 2326.1 2329.0 2333.3 2291.6 2309.3 2313.6 2316.8 2323.0 2292.9 2300.3 2353.6 2357.8 2360.6 8400.7 8410.9 8489.4 8498.2 8514.9 5038.5 5180.4 5213.0 5214.3 5223.6 3451.6 3501.8 3504.5 3532.0 3566.8 1196.5 1201.5 1231.6 1243.6 1261.0 10680.0 10766.7 10791.0 10797.7 10802.2 4402.2 4412.9 4680.4 4747.2 4775.7 8753.3 8765.8 8855.8 9529.3 9624.5 5212.8 5268.8 5287.9 5294.9 5297.4 4560.0 4814.0 4838.6 4851.8 4865.4 3368.4 3880.3 3912.9 3959.4 4024.5 1180.0 1215.6 1287.5 1291.6 1292.9 708.6 750.2 766.8 771.8 796.7 5418.1 5442.6 5457.6 5708.5 5735.8 948.9 972.1 984.4 992.7 1001.2 3557.9 3712.7 3811.7 3823.3 3885.5 9569.8 10072.4 10084.2 10096.9 10103.3 9553.0 9784.5 10032.7 10054.2 10142.9 7816.9 7899.5 7925.8 7927.1 7934.2 5312.6 5316.8 5359.3 5490.1 5502.1 8957.5 9082.5 9297.2 9321.0 9321.6 9280.0 9374.3 9381.0 9406.5 9488.9 7062.6 7064.8 7151.0 7168.1 7213.2 7722.2 7744.4 7834.3 7835.3 7844.2 7006.2 7116.6 7145.7 7176.2 7273.1 6943.5 6999.6 7016.8 7027.9 7099.3 6349.8 6383.8 6391.9 6452.4 6466.0 4938.3 4953.0 4967.1 5028.6 5036.9 4905.5 4928.8 4947.3 5084.0 5090.0 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4494.17 Median:4933.53 stddev:1361.55 (27.6%) stddev-sans-first:1329.52 02:41:18 INFO - PROCESS | 1646 | Values: 358.4 359.4 366.5 368.9 376.4 4484.5 4595.0 4651.8 5347.5 5497.2 4487.9 5290.3 5367.8 5380.9 5387.8 4248.9 4274.7 4283.7 4300.7 4356.0 3758.2 4019.4 4044.7 4143.0 4245.3 4050.6 4174.5 4192.0 4215.6 4293.6 3209.7 3747.0 4221.0 4241.4 4244.6 3420.4 3469.7 3539.0 3683.7 3769.5 4325.8 5170.1 5180.6 5227.3 5254.7 4506.5 4507.5 4880.0 4893.4 4905.2 5642.4 5721.1 5731.9 5762.9 5780.6 3305.4 3587.7 3696.3 3822.6 3888.7 5542.8 5995.2 6031.6 6036.7 6038.2 3612.4 3744.5 3947.6 3954.9 3987.5 3703.8 3927.3 4018.6 4025.3 4052.1 4470.3 4654.4 4658.0 4662.3 4677.7 4428.0 4840.7 5343.5 5348.7 5776.5 1122.9 1144.5 1171.0 1214.3 1291.5 802.4 873.4 878.0 882.6 883.4 4635.4 4691.0 4885.9 4904.7 5031.7 4904.4 5051.4 5232.6 5571.7 5638.2 4968.6 5035.0 5038.4 5073.4 5110.6 2646.8 2745.7 2880.9 2921.2 2956.0 4947.5 5010.5 5293.5 5755.3 5819.7 4918.6 5163.8 5722.4 5758.2 5758.5 4860.8 5477.5 5698.1 5764.6 5880.3 5156.6 5178.5 5280.4 5486.7 5564.7 5373.7 5509.9 5514.4 5524.4 5530.9 5080.7 5473.5 5756.4 5775.9 5831.4 3699.8 3701.3 3709.3 3743.6 3750.2 5533.7 5553.2 5564.4 5576.9 5577.4 4424.7 4691.3 4839.2 4951.0 5240.1 4885.5 5254.9 5705.4 5760.4 5760.8 4438.5 4919.5 5295.4 5528.1 5646.8 5702.2 5711.3 5711.6 5742.5 5745.3 4329.6 5585.5 5607.0 5619.9 5652.6 02:41:18 INFO - PROCESS | 1646 | 02:41:18 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19903.63 Median:3667.96 stddev:28446.10 (775.5%) stddev-sans-first:28488.80 02:41:18 INFO - PROCESS | 1646 | Values: 555.3 708.3 734.8 772.2 860.0 13958.0 14999.9 15426.9 15438.5 15561.9 13997.9 14276.0 14283.1 14411.9 14496.4 846.5 856.2 856.7 858.3 859.9 689.0 710.4 832.8 856.6 858.5 907.2 919.9 920.4 921.2 922.2 910.5 915.5 916.5 918.6 923.2 682.7 685.8 686.6 687.1 687.1 14602.0 15138.6 15603.7 15636.0 15664.9 13616.5 13871.9 13906.4 13915.2 14018.4 11542.9 11586.2 11607.3 11754.0 12386.4 3540.4 3654.8 3655.2 3671.9 3796.6 87738.6 95490.0 109185.0 110351.3 112787.0 9473.1 10253.7 10584.3 10634.0 10674.3 20407.1 20407.8 21987.0 22122.0 22190.8 7367.9 7657.0 7747.0 7838.2 7899.3 4181.4 4188.9 4269.8 4315.3 4329.8 3572.1 3645.7 3651.7 3659.9 3664.0 693.9 711.3 711.9 720.5 728.3 640.5 659.2 690.6 696.2 717.0 10112.7 10292.7 10427.5 10459.6 10460.0 649.1 679.7 685.3 685.4 689.5 5020.3 5061.0 5077.0 5087.4 5134.0 89242.0 101509.5 104193.0 106496.0 108108.0 70722.9 90395.1 93404.0 93544.0 96337.0 48483.5 57237.7 71714.3 77390.6 83369.0 8086.0 10517.0 11028.7 11158.1 11282.3 48626.8 49092.0 49649.5 50005.7 50083.7 59406.4 61094.7 62342.0 62990.0 63044.2 13066.9 13077.3 13254.0 13526.6 13684.0 14101.3 14192.9 14512.5 14797.8 14927.1 12953.4 13143.3 13229.1 13323.4 13695.7 13189.2 13377.7 13424.3 13618.3 13646.8 13033.8 13332.6 13431.6 13465.3 13835.0 10858.5 11233.3 11349.7 11369.8 11428.9 9164.5 9361.5 10933.5 11154.3 11161.4 02:41:18 INFO - PROCESS | 1646 | -------- Summary: end -------- 02:41:18 INFO - PROCESS | 1646 | 02:41:19 INFO - TEST-INFO | 1646: exit 0 02:41:19 INFO - TEST-OK | dromaeo_css | took 1116193ms 02:41:19 INFO - TEST-START | kraken 02:41:19 INFO - operating with platform_type : mac_ 02:41:19 INFO - Initialising browser for kraken test... 02:41:19 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpIpJKvC/profile http://localhost:49241/getInfo.html) 02:41:22 INFO - PROCESS | 1658 | 2017-02-20 02:41:22.277 plugin-container[1659:10110] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 02:41:22 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:41:22 INFO - PROCESS | 1658 | 2017-02-20 02:41:22.277 plugin-container[1659:10110] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 02:41:22 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:41:22 INFO - PROCESS | 1658 | 2017-02-20 02:41:22.277 plugin-container[1659:10110] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:41:22 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 02:41:22 INFO - PROCESS | 1658 | colorDepth:24 02:41:22 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 02:41:22 INFO - PROCESS | 1658 | __metrics 02:41:22 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 02:41:23 INFO - TEST-INFO | 1658: exit 0 02:41:23 INFO - Browser initialized. 02:41:23 INFO - Running cycle 1/1 for kraken test... 02:41:23 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpIpJKvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:41:25 INFO - PROCESS | 1660 | 2017-02-20 02:41:25.654 plugin-container[1661:10236] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 02:41:25 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:41:25 INFO - PROCESS | 1660 | 2017-02-20 02:41:25.654 plugin-container[1661:10236] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890f, name = 'com.apple.CFPasteboardClient' 02:41:25 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:41:25 INFO - PROCESS | 1660 | 2017-02-20 02:41:25.654 plugin-container[1661:10236] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:41:35 INFO - PROCESS | 1660 | RSS: Main: 219586560 02:41:35 INFO - PROCESS | 1660 | 02:41:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 02:41:39 INFO - PROCESS | 1660 | RSS: Main: 233967616 02:41:39 INFO - PROCESS | 1660 | 02:41:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 02:41:43 INFO - PROCESS | 1660 | RSS: Main: 241754112 02:41:43 INFO - PROCESS | 1660 | 02:41:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 02:41:47 INFO - PROCESS | 1660 | RSS: Main: 245555200 02:41:47 INFO - PROCESS | 1660 | 02:41:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 02:41:49 INFO - PROCESS | 1660 | RSS: Main: 246915072 02:41:49 INFO - PROCESS | 1660 | 02:41:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:41:52 INFO - PROCESS | 1660 | RSS: Main: 246792192 02:41:52 INFO - PROCESS | 1660 | 02:41:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 02:41:55 INFO - PROCESS | 1660 | RSS: Main: 251412480 02:41:55 INFO - PROCESS | 1660 | 02:41:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 02:41:59 INFO - PROCESS | 1660 | RSS: Main: 250396672 02:41:59 INFO - PROCESS | 1660 | 02:42:02 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 02:42:02 INFO - PROCESS | 1660 | RSS: Main: 250580992 02:42:02 INFO - PROCESS | 1660 | 02:42:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:05 INFO - PROCESS | 1660 | RSS: Main: 250138624 02:42:05 INFO - PROCESS | 1660 | 02:42:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:07 INFO - PROCESS | 1660 | RSS: Main: 250040320 02:42:07 INFO - PROCESS | 1660 | 02:42:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:10 INFO - PROCESS | 1660 | RSS: Main: 250167296 02:42:10 INFO - PROCESS | 1660 | 02:42:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:14 INFO - PROCESS | 1660 | RSS: Main: 250449920 02:42:14 INFO - PROCESS | 1660 | 02:42:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:17 INFO - PROCESS | 1660 | RSS: Main: 250486784 02:42:17 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 02:42:19 INFO - PROCESS | 1660 | RSS: Main: 252088320 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | __start_tp_report 02:42:19 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 02:42:19 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 02:42:19 INFO - PROCESS | 1660 | |i|pagename|runs| 02:42:19 INFO - PROCESS | 1660 | |0;ai-astar;106;130;162;125;98;172;122;158;165;125 02:42:19 INFO - PROCESS | 1660 | |1;audio-beat-detection;141;122;162;176;113;113;112;112;162;142 02:42:19 INFO - PROCESS | 1660 | |2;audio-dft;198;196;194;196;197;237;226;192;198;217 02:42:19 INFO - PROCESS | 1660 | |3;audio-fft;81;60;60;85;62;59;68;80;64;62 02:42:19 INFO - PROCESS | 1660 | |4;audio-oscillator;84;70;86;81;95;102;82;70;72;82 02:42:19 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;90;88;102;87;95;130;91;87;89;86 02:42:19 INFO - PROCESS | 1660 | |6;imaging-darkroom;102;96;95;96;97;95;96;107;123;95 02:42:19 INFO - PROCESS | 1660 | |7;imaging-desaturate;93;91;92;93;96;90;144;144;142;93 02:42:19 INFO - PROCESS | 1660 | |8;json-parse-financial;62;60;60;64;63;64;63;63;64;64 02:42:19 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;69;74;74;72;70;67;68;71;70;73 02:42:19 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;68;76;99;104;107;82;86;103;97;105 02:42:19 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;140;140;138;128;160;149;139;142;186;146 02:42:19 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;169;168;164;168;169;168;171;171;179;151 02:42:19 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;74;84;88;79;68;66;66;67;67;65 02:42:19 INFO - PROCESS | 1660 | __end_tp_report 02:42:19 INFO - PROCESS | 1660 | __start_cc_report 02:42:19 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,978 02:42:19 INFO - PROCESS | 1660 | __end_cc_report 02:42:19 INFO - PROCESS | 1660 | __startTimestamp1487587339678__endTimestamp 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | ------- Summary: start ------- 02:42:19 INFO - PROCESS | 1660 | Number of tests: 14 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:136.30 Median:160.00 stddev:26.06 (16.3%) stddev-sans-first:25.23 02:42:19 INFO - PROCESS | 1660 | Values: 106.0 130.0 162.0 125.0 98.0 172.0 122.0 158.0 165.0 125.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:141.50 stddev:24.53 (17.3%) stddev-sans-first:25.94 02:42:19 INFO - PROCESS | 1660 | Values: 141.0 122.0 162.0 176.0 113.0 113.0 112.0 112.0 162.0 142.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:205.10 Median:198.00 stddev:15.72 (7.9%) stddev-sans-first:16.46 02:42:19 INFO - PROCESS | 1660 | Values: 198.0 196.0 194.0 196.0 197.0 237.0 226.0 192.0 198.0 217.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:68.10 Median:66.00 stddev:9.99 (15.1%) stddev-sans-first:9.45 02:42:19 INFO - PROCESS | 1660 | Values: 81.0 60.0 60.0 85.0 62.0 59.0 68.0 80.0 64.0 62.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:82.00 stddev:10.42 (12.7%) stddev-sans-first:11.03 02:42:19 INFO - PROCESS | 1660 | Values: 84.0 70.0 86.0 81.0 95.0 102.0 82.0 70.0 72.0 82.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:88.50 stddev:13.36 (15.1%) stddev-sans-first:14.07 02:42:19 INFO - PROCESS | 1660 | Values: 90.0 88.0 102.0 87.0 95.0 130.0 91.0 87.0 89.0 86.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:95.50 stddev:8.90 (9.3%) stddev-sans-first:9.42 02:42:19 INFO - PROCESS | 1660 | Values: 102.0 96.0 95.0 96.0 97.0 95.0 96.0 107.0 123.0 95.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:92.50 stddev:24.58 (26.6%) stddev-sans-first:25.48 02:42:19 INFO - PROCESS | 1660 | Values: 93.0 91.0 92.0 93.0 96.0 90.0 144.0 144.0 142.0 93.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.50 stddev:1.57 (2.5%) stddev-sans-first:1.64 02:42:19 INFO - PROCESS | 1660 | Values: 62.0 60.0 60.0 64.0 63.0 64.0 63.0 63.0 64.0 64.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.50 stddev:2.44 (3.4%) stddev-sans-first:2.50 02:42:19 INFO - PROCESS | 1660 | Values: 69.0 74.0 74.0 72.0 70.0 67.0 68.0 71.0 70.0 73.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:79.00 stddev:13.73 (17.4%) stddev-sans-first:11.28 02:42:19 INFO - PROCESS | 1660 | Values: 68.0 76.0 99.0 104.0 107.0 82.0 86.0 103.0 97.0 105.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:144.00 stddev:16.07 (11.2%) stddev-sans-first:16.85 02:42:19 INFO - PROCESS | 1660 | Values: 140.0 140.0 138.0 128.0 160.0 149.0 139.0 142.0 186.0 146.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:169.00 stddev:7.04 (4.2%) stddev-sans-first:7.45 02:42:19 INFO - PROCESS | 1660 | Values: 169.0 168.0 164.0 168.0 169.0 168.0 171.0 171.0 179.0 151.0 02:42:19 INFO - PROCESS | 1660 | 02:42:19 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:71.00 stddev:8.42 (11.9%) stddev-sans-first:8.91 02:42:19 INFO - PROCESS | 1660 | Values: 74.0 84.0 88.0 79.0 68.0 66.0 66.0 67.0 67.0 65.0 02:42:19 INFO - PROCESS | 1660 | -------- Summary: end -------- 02:42:19 INFO - PROCESS | 1660 | 02:42:20 INFO - TEST-INFO | 1660: exit 0 02:42:20 INFO - TEST-OK | kraken | took 61227ms 02:42:20 INFO - SUITE-END | took 1177s 02:42:20 INFO - Completed test suite (00:19:37) 02:42:20 INFO - javascript benchmark 02:42:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7329.8395271466425, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3021.788474806763, 3395.456726923692, 3416.5900091988933, 3433.639467855875, 3434.982825085875, 5760.222369980052, 5765.365809760928, 5804.709764511768, 5829.0, 5856.707164641773, 5540.944590554093, 5691.7723291068305, 5797.884042319151, 5829.854253643661, 5838.591298609099, 4597.494275629678, 5271.657342272759, 5308.283381743464, 5310.8141215057485, 5358.196270559409, 5365.061114305001, 5369.543588794957, 5369.812056578021, 5378.8924221515545, 5424.457554244584, 5215.1395019821875, 5222.981518603874, 5343.305370301875, 5364.249005139283, 5366.517013468787, 5231.816886408977, 5240.9213861792105, 5297.549708274802, 5298.36419629643, 5348.91976620351, 5157.742112894341, 5236.816711415082, 5252.0, 5253.343332083489, 5308.097623403992, 5595.412481689405, 5678.346990096151, 5723.856903577403, 5803.0, 5830.271216097988, 6117.12715980571, 6228.34602366754, 6240.968795156041, 6291.402316779899, 6396.968015159941, 6326.335734747877, 6331.366863313678, 6349.1428657131155, 6357.96821015892, 6370.90443643341, 5884.117382392633, 5896.292444906639, 5918.822435326947, 5922.437368450033, 5922.763089476459, 5318.946810531846, 6282.089097080989, 6288.339724328971, 6293.056041593798, 6322.778702745381, 6160.568760186834, 6182.103594978703, 6197.194364732556, 6217.813465596039, 6236.688165591702, 6336.112944187817, 6362.236531616236, 6375.904361434582, 6377.0, 6383.680815959184, 5236.790528378899, 6089.634621922699, 6118.923762351576, 6233.532485063638, 6254.530910181755, 6335.841603959938, 6341.207349081365, 6348.365163483615, 6357.618542887441, 6395.904061439082, 4670.579647831712, 4807.95192048082, 5038.773255203525, 5040.773165207501, 5096.082705113041, 4419.18245124653, 4435.866923992221, 4451.5103338632725, 4515.164694531522, 4515.932261016087, 5910.290765108214, 5941.197938278364, 5982.312034116132, 6018.307894592091, 6075.726592303357, 6306.558540902184, 6323.7786677466065, 6341.873162536724, 6346.428821406003, 6348.77779277723, 5771.105478650816, 5838.649681019152, 5914.822555323347, 5942.762289508458, 5965.313988891333, 5545.77816887328, 5548.722563871871, 5552.805651802168, 5559.9444005560235, 5573.27547418833, 5761.4238576143725, 6440.0, 6446.387593178641, 6467.838304042342, 6473.967630161819, 4987.675801072919, 5216.426193118829, 6178.721957511832, 6181.84545386351, 6246.968765156145, 5283.39240987276, 6356.77751278703, 6375.6493392861985, 6406.1031455597185, 6414.198225221848, 5160.948390516197, 6279.246490421178, 6314.936850631619, 6325.209348831396, 6340.4927605792345, 6027.78902738402, 6057.697115144137, 6119.746288422617, 6245.937540624535, 6263.906041409474, 6120.325235636462, 6219.595726277777, 6228.003519436868, 6229.53278504123, 6238.407351301619, 6141.84645383869, 6208.379162083756, 6210.099535567408, 6226.62640241587, 6272.4982001440685, 5117.5394214520875, 5748.109043098327, 5855.560832937462, 6117.96941015292, 6140.631562106288, 5193.948060519498, 6114.266954506099, 6143.784967526115, 6158.568900177123, 6247.031710084944, 6015.639061656315, 6082.969585152223, 6098.969505152623, 6102.389761023862, 6102.420270074336], "value": 5729.261147421064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.5492065711988, 488.9242167464042, 497.3981482406288, 498.1780062896223, 509.9949000509995, 34844.0, 38553.0, 42666.0, 42813.14373712524, 42902.0, 44518.33222501657, 44744.0, 45011.77494112533, 45167.54832451674, 45210.0, 8387.0, 8644.783880403009, 9248.306377021716, 9500.904990950072, 9513.33406661534, 10983.956524130195, 11376.146788990818, 11619.012383947374, 11674.649760507198, 11750.412479375997, 10753.569857205703, 11485.712857178554, 11656.883431165665, 11664.825027624593, 11668.824967625493, 11557.942210288895, 11631.0, 11692.298462092216, 11716.062714982823, 11723.237989530739, 11495.02292305155, 11505.5973040944, 11539.307641541534, 11560.364179970098, 11562.248453850558, 42618.0, 42688.35967460491, 42824.57175428237, 42870.35694464586, 42947.78526107349, 3957.762534247954, 3974.4435778990965, 4022.738521996061, 4023.0, 4030.254402935437, 29910.850445747634, 31069.689303106905, 31080.067597971873, 31971.360572788413, 31987.6801231987, 3122.953155702666, 3126.093432904455, 3184.6656101109284, 3270.2641905571054, 3307.206270495088, 509356.0, 511136.0, 513630.0, 515646.9999999963, 516497.0, 63108.368916310246, 66915.0, 67274.66362668155, 67514.0, 67556.66221668958, 71962.64018679873, 72693.636531817, 72742.63628681823, 73039.0, 73104.26895731081, 17144.742828857576, 17360.784745067976, 17396.0, 17397.565060873327, 17444.563885902953, 11767.529298828122, 12057.276563406223, 12844.165129266568, 13094.01794865389, 13153.145045572199, 19096.427107186806, 19464.70802937957, 19479.415617531497, 19639.214431422868, 19675.31136410219, 6812.931870681329, 7953.5227886327, 8077.919220807717, 8100.392470564731, 8127.0, 856.2465030773004, 867.597319956226, 869.0831173112301, 869.3002133282641, 895.632790555869, 19476.902615486833, 21295.148194072375, 22952.65571016436, 23805.880970595383, 24012.15957441481, 1046.9685909422576, 1053.4627340056627, 1058.396713873085, 1060.2101434431245, 1069.8496022993838, 12440.0, 14276.14343139415, 15059.247037648292, 15215.771763423336, 15277.847221527643, 569078.0, 604668.0, 634417.0, 635429.0, 637192.0, 54539.45460545423, 54742.17886731702, 54929.45070549243, 55014.0, 55441.168382474294, 1415.0448447298033, 1425.5723283015054, 1460.9050411723204, 1461.1379286220968, 1472.3668822406255, 26886.32784180411, 27369.863150684916, 27405.177844664693, 27761.0, 28845.56731648985, 48397.0, 48406.0, 48736.75631621819, 48838.77903052452, 48968.26547601718, 531136.0, 532026.0, 532194.0, 534985.0, 535831.0, 25214.621780672936, 25361.619575706747, 25595.872020639777, 25877.870610646827, 25920.0, 43424.56575434205, 43579.34630980474, 44593.0, 44663.55336446594, 44897.32654010127, 25234.873825630755, 35412.46881296834, 36534.0, 37765.48938042448, 38011.0, 32933.67066329402, 34462.96611101671, 35839.46240806338, 35849.0, 36725.81637091797, 35496.82251588725, 35587.466188006685, 36024.639753602125, 36146.0, 36295.455568167024, 30911.536326955564, 32267.031989040366, 32339.838300808344, 32456.35087298288, 32828.67171328256, 21652.24217152392, 25013.12454064099, 25085.372865678502, 25293.747062529874, 25514.744852551237], "value": 20094.473434968215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.3407695762839, 385.17572395074546, 399.81009020715163, 402.6155021954034, 415.0723133795967, 17107.74338384925, 19247.903760481197, 21074.89462552687, 21116.78273781254, 21333.040013199385, 21601.56796864062, 21825.908704564747, 21841.126354945784, 22149.66775498369, 22182.00180991855, 5865.85335366615, 5914.556408269386, 6052.636841789506, 6105.481034112106, 6107.297660769024, 4251.319788833787, 4471.552844715535, 5913.497352725002, 6016.488598469114, 6544.149260596139, 6768.796936091925, 6860.3139686031245, 6866.34769696878, 6867.587944723307, 6882.552634078794, 6600.306967768387, 6759.7296108155615, 6793.524453288272, 6795.694193761293, 6802.217744959294, 5837.854053648651, 5902.0, 5902.32123305821, 5940.198073260098, 5979.850503737398, 23128.65307020396, 25626.743732562623, 25667.871660641766, 25841.0, 25998.0, 2427.7936375408112, 2466.4080620651093, 2668.806466951967, 2728.4406696627343, 2787.0, 12903.67740806478, 14464.349104290332, 15293.847061529354, 15972.76040859388, 16514.58713532159, 1505.5633866178796, 1701.3789966662202, 1809.1225755508567, 1817.9365071433228, 1856.443067079884, 141693.0, 143398.0, 143623.0, 144104.0, 146542.0, 10627.88407217231, 11534.826977595343, 11960.820587691192, 12015.819762703566, 12252.387380630933, 15626.531204063896, 15634.140122293156, 15678.9216053919, 15688.058716477048, 15706.371745130295, 8747.825043499095, 8937.910620893708, 8958.68644597436, 8978.281737460988, 9055.049219831955, 8610.0, 8656.307495400353, 8698.695545655872, 8804.8679269811, 8817.426867253607, 4776.665633405698, 4779.474257831635, 4779.545943135397, 4794.424669039738, 4845.103655823684, 1673.5899704572457, 1763.206557049333, 1768.3103589600066, 2009.276660402254, 2064.133064113076, 990.3810118675827, 991.9950400248097, 997.1872923567414, 1002.6490728245055, 1045.8849526552074, 17872.92762434258, 20336.79663203349, 21963.341099767033, 22291.44271393228, 22364.55270894573, 1006.8471600017939, 1024.7284469615558, 1033.6020632056561, 1056.1234175634359, 1073.8013467508379, 9738.513074346254, 11510.769784604261, 11560.421978901022, 11560.826587601192, 11618.6514404568, 358598.0, 358974.0, 359683.0, 632669.836650823, 748069.0, 135868.0, 154837.0, 157545.0, 161047.19476402542, 164528.0, 937.95310234488, 1032.2670903658336, 1049.3231865446744, 1068.7167900506372, 1069.887661795516, 14876.925615371854, 18549.81450185481, 19153.808461915203, 19332.130054147878, 19553.60892782165, 59942.700286498286, 61411.69294153501, 61545.692271538355, 62695.686521568925, 63220.36779632145, 86739.0, 87693.68459472986, 87773.0, 89197.55401222952, 98722.0, 8191.549464779494, 8536.274416674652, 8591.269742071994, 8855.955720221358, 9032.690259912408, 10347.689569312932, 10736.570537178426, 13161.47354105825, 13494.392752326365, 13510.527131550742, 11273.71815704614, 11519.596814111466, 11537.59618413385, 11691.0, 11839.82240266414, 11080.11359091287, 11108.61119860801, 11471.0, 11533.365664888512, 11562.075033997427, 10026.899731002597, 11393.14551408631, 11468.139889508153, 11744.412779360828, 11828.46771895284, 7300.671469783979, 7668.539887606761, 8397.076321604742, 8815.515146666738, 8883.555822208735, 9439.292053095907, 9958.601655933682, 10025.431868968744, 10134.442605656759, 10241.283110182216], "value": 10055.647518812493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.1089264746295, 1352.7700290950543, 1442.9855701442982, 1447.8696917277443, 1453.7964684944106, 7445.590492522909, 7637.083549974004, 7710.768676939687, 8467.491950482967, 8498.022727386353, 7959.482633628824, 8235.91764082359, 8241.381896357767, 8338.374621903351, 8373.665053397857, 2310.445493081657, 2330.0446816805115, 2348.9177878774244, 2355.1992322610395, 2355.882205889707, 2024.9696254556193, 2060.1450398084776, 2295.9540809183804, 2361.8346715729904, 2365.195833416638, 2050.846186536008, 2249.3814201094665, 2326.057946531649, 2328.953420931589, 2333.288347054148, 2291.6104262275285, 2309.2725791375747, 2313.6413855852284, 2316.81465482761, 2323.0, 2292.9197478088186, 2300.2639155470256, 2353.5881220786464, 2357.834951553392, 2360.6223004319227, 8400.663973441055, 8410.873836892451, 8489.405741598091, 8498.192671696179, 8514.914850851535, 5038.521340472649, 5180.352455943007, 5212.973935130338, 5214.322138122057, 5223.608229382811, 3451.5858097028267, 3501.7723847950056, 3504.54440922681, 3531.964680353215, 3566.7681600695873, 1196.5453127811463, 1201.5073819733955, 1231.612042206702, 1243.564752336684, 1260.9558665446757, 10680.038796508274, 10766.676999690022, 10791.0, 10797.676069717922, 10802.189835762349, 4402.163588918095, 4412.889677758018, 4680.438347398334, 4747.192977193886, 4775.689580177347, 8753.255973242218, 8765.824683506295, 8855.822883542292, 9529.285303602257, 9624.51877406127, 5212.791488340424, 5268.841934741964, 5287.894242115213, 5294.894102117936, 5297.417284098746, 4560.0, 4814.037192561502, 4838.588719958772, 4851.757412129379, 4865.416150062015, 3368.39368913593, 3880.3403421418425, 3912.882613521599, 3959.366501359769, 4024.5371782245415, 1179.9852127170627, 1215.5927764198916, 1287.549357724789, 1291.599604122706, 1292.8642492538336, 708.6421357214676, 750.1763659668276, 766.7853001159684, 771.7916162636056, 796.6932730898529, 5418.1330987042675, 5442.619016668875, 5457.61796674229, 5708.486236238676, 5735.770569177186, 948.9229724262873, 972.1250874213123, 984.3945973226557, 992.6823416506649, 1001.2240513601871, 3557.8932632021083, 3712.6658600725523, 3811.7331786774657, 3823.273578020223, 3885.4948856648457, 9569.808603828023, 10072.395656260647, 10084.193264538966, 10096.899031009596, 10103.343282686601, 9552.95223523878, 9784.510774461249, 10032.749181270381, 10054.245931555162, 10142.949285253526, 7816.921830781619, 7899.486533375312, 7925.801854953672, 7927.128015918244, 7934.166912474223, 5312.62811603184, 5316.787328506816, 5359.276497672764, 5490.066688663017, 5502.119660854244, 8957.462552246887, 9082.500462474627, 9297.163255306785, 9321.021292764162, 9321.6271349148, 9280.025597312455, 9374.250059995047, 9381.014993425591, 9406.529673516434, 9488.905110948803, 7062.646867656699, 7064.752733654503, 7150.96424517874, 7168.103987001625, 7213.170485394037, 7722.18917013728, 7744.380449564134, 7834.334081603128, 7835.255650713173, 7844.176361481962, 7006.159260888726, 7116.644167791694, 7145.678444469907, 7176.174739904978, 7273.054502914587, 6943.51395402317, 6999.580025198505, 7016.789496315118, 7027.894581581382, 7099.325564071405, 6349.841253968688, 6383.808485745435, 6391.9041214380895, 6452.419282264619, 6466.030095485715, 4938.333325001079, 4953.0, 4967.105920934267, 5028.622853285945, 5036.874078148076, 4905.48492408292, 4928.827491037797, 4947.307376967299, 5084.0, 5090.0], "value": 4404.116155342115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.4175714463996, 359.36213221531784, 366.4741096526484, 368.9465027571004, 376.44662346350873, 4484.461864576251, 4594.954050459494, 4651.813927442907, 5347.54545863602, 5497.202905578693, 4487.887802804931, 5290.259363689077, 5367.7922467444805, 5380.865478363043, 5387.78448862046, 4248.893777655552, 4274.658027357804, 4283.7429754214845, 4300.741955482666, 4355.978220108911, 3758.2295629396044, 4019.3970904364287, 4044.6562042226446, 4143.0, 4245.34197199433, 4050.5949405059405, 4174.457320548325, 4192.0, 4215.620594146526, 4293.613574778269, 3209.7271731902815, 3746.9625303746884, 4220.965863363464, 4241.448611680493, 4244.554321796198, 3420.3843308204514, 3469.664179290966, 3538.9913874545887, 3683.6684698377276, 3769.5099637047283, 4325.84859529915, 5170.095233334151, 5180.6373553851245, 5227.3465816772905, 5254.65844720092, 4506.535376002779, 4507.549245075499, 4880.0, 4893.363862697862, 4905.2151655734915, 5642.435756424325, 5721.0846264597885, 5731.856703582402, 5762.942370576283, 5780.624259423124, 3305.4215512285496, 3587.677109060171, 3696.2607478504406, 3822.560405553369, 3888.6972864090562, 5542.750576224039, 5995.160677505153, 6031.577789554733, 6036.667983260919, 6038.245219347626, 3612.422012477991, 3744.5132132823105, 3947.5657677655436, 3954.940675889864, 3987.501562304654, 3703.777773333609, 3927.3127202739406, 4018.557958624549, 4025.2754504188943, 4052.1085361220485, 4470.307102399133, 4654.37165982588, 4658.045100754337, 4662.323963025342, 4677.672562920563, 4427.955720442818, 4840.7337596432535, 5343.500007495019, 5348.705821179795, 5776.508996735324, 1122.9213955023233, 1144.450663681421, 1171.0, 1214.2775048845922, 1291.4898615047005, 802.4062193976415, 873.3929918706438, 878.0341624213314, 882.6292956957965, 883.3507372081515, 4635.447125213092, 4690.95309046912, 4885.853424397274, 4904.681195722338, 5031.6729412588065, 4904.411470623477, 5051.368578927634, 5232.555232805178, 5571.749271282802, 5638.238837756932, 4968.552830245295, 5034.974825125851, 5038.420581633086, 5073.416557095908, 5110.591152707774, 2646.8147229694123, 2745.7391547802927, 2880.884764609434, 2921.2258751430886, 2955.9801868355385, 4947.505249475023, 5010.473900240422, 5293.517815011803, 5755.309362876482, 5819.70901454934, 4918.581585797836, 5163.8242480874, 5722.4277572242445, 5758.193852860602, 5758.510526605201, 4860.83692756734, 5477.507024367746, 5698.116791897262, 5764.6476909932735, 5880.323762767336, 5156.639035267495, 5178.508041736029, 5280.445553216857, 5486.6982315973, 5564.749586268708, 5373.733740933829, 5509.917351239815, 5514.420985796594, 5524.364698059774, 5530.91703624454, 5080.695158290514, 5473.522149019822, 5756.373484704609, 5775.8556036099435, 5831.393199372618, 3699.8181563854523, 3701.3152566775234, 3709.27669104522, 3743.5882052974694, 3750.1562148516364, 5533.667979921218, 5553.222548843084, 5564.38791732901, 5576.91634625489, 5577.386487486455, 4424.668149888836, 4691.319758635047, 4839.225404184742, 4950.975245123751, 5240.101344844057, 4885.462599114166, 5254.868628284324, 5705.37240903492, 5760.415885631317, 5760.798372056958, 4438.467383913951, 4919.54780923265, 5295.391030031596, 5528.143137813645, 5646.830595082154, 5702.173184888251, 5711.286614015862, 5711.5716321276905, 5742.540596752333, 5745.3105627324985, 4329.631981281626, 5585.469380408855, 5607.0, 5619.887602247851, 5652.630001498675], "value": 4069.7433857764427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3086407422759, 708.2917082917083, 734.7979305690934, 772.2354868680005, 859.9785005374865, 13958.0, 14999.850001499995, 15426.922865385686, 15438.459653912101, 15561.922190389061, 13997.930010349959, 14276.0, 14283.071600345997, 14411.919106067035, 14496.42014319426, 846.525945470537, 856.2379482260761, 856.7472595584318, 858.3305022082785, 859.944103633265, 688.9862202755942, 710.4103594016954, 832.7876391520153, 856.5973992223645, 858.4720396955859, 907.2469850024497, 919.9172074513292, 920.392540922991, 921.2445794448555, 922.2207234886511, 910.5310764956052, 915.4690279637861, 916.4684482999844, 918.5866360137965, 923.2198792020732, 682.7166725808784, 685.7908337956922, 686.5503095472474, 687.0998991321335, 687.1170545848561, 14602.0, 15138.621534461616, 15603.687926241526, 15636.0, 15664.92167539155, 13616.523421680193, 13871.930640346834, 13906.374213160432, 13915.165090094526, 14018.43926242949, 11542.884571154349, 11586.246893951951, 11607.30356178632, 11754.0, 12386.442610082478, 3540.415831387818, 3654.8172591370326, 3655.214128962259, 3671.94492082619, 3796.6393192646656, 87738.56130719434, 95490.0, 109185.0, 110351.34472982911, 112787.0, 9473.147416732527, 10253.692389228336, 10584.312019718695, 10633.989770971746, 10674.25280230392, 20407.081681324376, 20407.79592204059, 21987.010584523734, 22122.0, 22190.778092218872, 7367.926320736831, 7657.0, 7747.0, 7838.216178382117, 7899.328557072713, 4181.435506206623, 4188.937165942513, 4269.786510674454, 4315.266404711207, 4329.783510824509, 3572.1248294167576, 3645.671889529955, 3651.72612054097, 3659.908502287411, 3663.9816800915823, 693.9132608423947, 711.2531841566334, 711.900333953247, 720.477653701073, 728.3481284250672, 640.5196102922808, 659.2155335151155, 690.5821977703417, 696.2489339311635, 716.9784906452815, 10112.696619101438, 10292.691219263434, 10427.530761115768, 10459.581616735397, 10460.0, 649.1463725201439, 679.6635665345586, 685.3044160177424, 685.3900028974217, 689.5483458334799, 5020.322256495399, 5061.0, 5077.0, 5087.440381558025, 5133.974330128325, 89242.0, 101509.47735783969, 104192.95807041985, 106496.0, 108108.0, 70722.9391559127, 90395.09604903999, 93403.99999999865, 93544.0, 96337.0, 48483.515164848606, 57237.71381143068, 71714.28285717285, 77390.6130469344, 83369.0, 8085.989251343582, 10517.00088491592, 11028.724281893017, 11158.051565617014, 11282.266652667879, 48626.756866215444, 49092.01815963732, 49649.50350496449, 50005.74997124991, 50083.74790630263, 59406.405935940085, 61094.694526527084, 62342.0, 62990.0, 63044.16301266362, 13066.869331306565, 13077.280749558486, 13254.0, 13526.59420217395, 13684.0, 14101.294935253401, 14192.858071419154, 14512.492062777752, 14797.778033329723, 14927.104373737177, 12953.41709623088, 13143.342832858127, 13229.140105893086, 13323.400446979715, 13695.657608559468, 13189.165509241851, 13377.732445350845, 13424.261665608095, 13618.319084045559, 13646.795298070338, 13033.804492932803, 13332.600021999355, 13431.597052088062, 13465.259410732504, 13835.0, 10858.45707714627, 11233.269837460539, 11349.716257093309, 11369.772604547697, 11428.885711143115, 9164.495952722664, 9361.485118318558, 10933.540831188384, 11154.274972126786, 11161.441927903736], "value": 7473.210091148035, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 130.0, 162.0, 125.0, 98.0, 172.0, 122.0, 158.0, 165.0, 125.0], "value": 136.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 122.0, 162.0, 176.0, 113.0, 113.0, 112.0, 112.0, 162.0, 142.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 194.0, 196.0, 197.0, 237.0, 226.0, 192.0, 198.0, 217.0], "value": 205.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 85.0, 62.0, 59.0, 68.0, 80.0, 64.0, 62.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 86.0, 81.0, 95.0, 102.0, 82.0, 70.0, 72.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 102.0, 87.0, 95.0, 130.0, 91.0, 87.0, 89.0, 86.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 107.0, 123.0, 95.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 92.0, 93.0, 96.0, 90.0, 144.0, 144.0, 142.0, 93.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 74.0, 72.0, 70.0, 67.0, 68.0, 71.0, 70.0, 73.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 99.0, 104.0, 107.0, 82.0, 86.0, 103.0, 97.0, 105.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 138.0, 128.0, 160.0, 149.0, 139.0, 142.0, 186.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 164.0, 168.0, 169.0, 168.0, 171.0, 171.0, 179.0, 151.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 84.0, 88.0, 79.0, 68.0, 66.0, 66.0, 67.0, 67.0, 65.0], "value": 72.4, "unit": "score"}]}]} 02:42:20 INFO - Return code: 0 02:42:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:42:20 ERROR - # TBPL SUCCESS # 02:42:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:42:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:42:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:42:21 INFO - 2017-02-20 02:42:21.006 screenresolution[1665:10627] starting screenresolution argv=screenresolution get 02:42:21 INFO - 2017-02-20 02:42:21.009 screenresolution[1665:10627] Display 0: 1600x1200x32@60 02:42:21 INFO - 2017-02-20 02:42:21.015 screenresolution[1666:10630] starting screenresolution argv=screenresolution list 02:42:21 INFO - Available Modes on Display 0 02:42:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:42:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:42:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:42:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:42:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:42:21 INFO - Intel Iris: 02:42:21 INFO - Chipset Model: Intel Iris 02:42:21 INFO - Type: GPU 02:42:21 INFO - Bus: Built-In 02:42:21 INFO - VRAM (Dynamic, Max): 1536 MB 02:42:21 INFO - Vendor: Intel (0x8086) 02:42:21 INFO - Device ID: 0x0a2e 02:42:21 INFO - Revision ID: 0x0009 02:42:21 INFO - Displays: 02:42:21 INFO - Display: 02:42:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:42:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:42:21 INFO - Display Serial Number: 1600x1200 60 02:42:21 INFO - Main Display: Yes 02:42:21 INFO - Mirror: Off 02:42:21 INFO - Online: Yes 02:42:21 INFO - Rotation: Supported 02:42:21 INFO - Return code: 0 02:42:21 INFO - Running post-action listener: _resource_record_post_action 02:42:21 INFO - [mozharness: 2017-02-20 10:42:21.257755Z] Finished run-tests step (success) 02:42:21 INFO - Running post-run listener: _resource_record_post_run 02:42:21 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 40466432; Write bytes: 512555008; Read time: 401; Write time: 1811 02:42:21 INFO - TinderboxPrint: CPU usage
54.4% 02:42:21 INFO - TinderboxPrint: I/O read bytes / time
40,466,432 / 401 02:42:21 INFO - TinderboxPrint: I/O write bytes / time
512,555,008 / 1,811 02:42:21 INFO - TinderboxPrint: CPU idle
2,186.2 (45.6%) 02:42:21 INFO - TinderboxPrint: CPU system
964.1 (20.1%) 02:42:21 INFO - TinderboxPrint: CPU user
1,643.4 (34.3%) 02:42:21 INFO - TinderboxPrint: Swap in / out
248,102,912 / 0 02:42:21 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207643136; Write bytes: 199979008; Read time: 15908; Write time: 386 02:42:21 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 38361088; Write bytes: 302528512; Read time: 373; Write time: 1387 02:42:21 INFO - Running post-run listener: _upload_blobber_files 02:42:21 INFO - Blob upload gear active. 02:42:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:42:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:42:22 INFO - (blobuploader) - INFO - Open directory for files ... 02:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:23 INFO - (blobuploader) - INFO - Done attempting. 02:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:24 INFO - (blobuploader) - INFO - Done attempting. 02:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:42:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:25 INFO - (blobuploader) - INFO - Done attempting. 02:42:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:42:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:42:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:42:28 INFO - (blobuploader) - INFO - Done attempting. 02:42:28 INFO - (blobuploader) - INFO - Iteration through files over. 02:42:28 INFO - Return code: 0 02:42:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:42:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:42:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/895be26cd627925fce307f2d91d27417c6d294e5f21f2a8080026e2a2950be370c4705b163eb7842d2d7f31f42bf2e4f824e45b5126265d3adf3d7675287e6a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/981ee8cebc5e2c94e18db396e5b824f561175d1b22b6fe385656e17aabbfc6ddf86c18eb1c2970d3d99aec723245f901da7a76fec1a0c57edea7f4b40892b541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dde906634f3adc8a577cf77f285e36d33e177d6a4e7c8e5396c7c234a55e8cd7345ce597aeedc0f0a3887e46335f37ecf3c155641be97dfa1455afc80c53f9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ce787d850cd8dcfd211efac76e1e5de133be5cb6c26d661fbf87e648813b735ca0bd7961290ce46b5d2de9c6372881d8d15b9e756bf4213b7c16d6721c8b834"} 02:42:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:42:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:42:28 INFO - Contents: 02:42:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/895be26cd627925fce307f2d91d27417c6d294e5f21f2a8080026e2a2950be370c4705b163eb7842d2d7f31f42bf2e4f824e45b5126265d3adf3d7675287e6a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/981ee8cebc5e2c94e18db396e5b824f561175d1b22b6fe385656e17aabbfc6ddf86c18eb1c2970d3d99aec723245f901da7a76fec1a0c57edea7f4b40892b541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dde906634f3adc8a577cf77f285e36d33e177d6a4e7c8e5396c7c234a55e8cd7345ce597aeedc0f0a3887e46335f37ecf3c155641be97dfa1455afc80c53f9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ce787d850cd8dcfd211efac76e1e5de133be5cb6c26d661fbf87e648813b735ca0bd7961290ce46b5d2de9c6372881d8d15b9e756bf4213b7c16d6721c8b834"} 02:42:28 INFO - Running post-run listener: copy_logs_to_upload_dir 02:42:28 INFO - Copying logs to upload dir... 02:42:28 INFO - mkdir: /builds/slave/test/build/upload/logs 02:42:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.868277 ========= master_lag: -0.17 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-20 02:42:27.728747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 02:42:27.732492) ========= 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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/895be26cd627925fce307f2d91d27417c6d294e5f21f2a8080026e2a2950be370c4705b163eb7842d2d7f31f42bf2e4f824e45b5126265d3adf3d7675287e6a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/981ee8cebc5e2c94e18db396e5b824f561175d1b22b6fe385656e17aabbfc6ddf86c18eb1c2970d3d99aec723245f901da7a76fec1a0c57edea7f4b40892b541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dde906634f3adc8a577cf77f285e36d33e177d6a4e7c8e5396c7c234a55e8cd7345ce597aeedc0f0a3887e46335f37ecf3c155641be97dfa1455afc80c53f9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ce787d850cd8dcfd211efac76e1e5de133be5cb6c26d661fbf87e648813b735ca0bd7961290ce46b5d2de9c6372881d8d15b9e756bf4213b7c16d6721c8b834"} build_url:https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/QVU65-jiT760O2_zy92SpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/895be26cd627925fce307f2d91d27417c6d294e5f21f2a8080026e2a2950be370c4705b163eb7842d2d7f31f42bf2e4f824e45b5126265d3adf3d7675287e6a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/981ee8cebc5e2c94e18db396e5b824f561175d1b22b6fe385656e17aabbfc6ddf86c18eb1c2970d3d99aec723245f901da7a76fec1a0c57edea7f4b40892b541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dde906634f3adc8a577cf77f285e36d33e177d6a4e7c8e5396c7c234a55e8cd7345ce597aeedc0f0a3887e46335f37ecf3c155641be97dfa1455afc80c53f9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ce787d850cd8dcfd211efac76e1e5de133be5cb6c26d661fbf87e648813b735ca0bd7961290ce46b5d2de9c6372881d8d15b9e756bf4213b7c16d6721c8b834"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 02:42:27.774571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-02-20 02:42:27.774958) ========= 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.Ai0DBekF85/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.2MDA7ojLRJ/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005061 ========= master_lag: 1.65 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-02-20 02:42:29.434263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 02:42:29.434666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 02:42:29.445316) ========= ========= Total master_lag: 1.59 =========