builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0108 starttime: 1481496646.59 results: success (0) buildid: 20161211134851 builduid: 6e8482c0a7d64b6a9ef783c4b9c3a8e9 revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.594425) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.594918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.595236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.902000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:46.902549) ========= 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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-11 14:50:46-- 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% 55.3M=0s 2016-12-11 14:50:47 (55.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152794 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:47.120706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:47.121112) ========= 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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.026047 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:47.190463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 14:50:47.190856) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2qGU4eYgoP/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.LnWBLEAYJo/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-11 14:50:47,307 truncating revision to first 12 chars 2016-12-11 14:50:47,308 Setting DEBUG logging. 2016-12-11 14:50:47,308 attempt 1/10 2016-12-11 14:50:47,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42086c06f756?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-11 14:50:48,292 unpacking tar archive at: mozilla-central-42086c06f756/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262129 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 14:50:48.519717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.519983) ========= script_repo_revision: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.520364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.520700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 14:50:48.623891) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-11 14:50:48.624296) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2qGU4eYgoP/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.LnWBLEAYJo/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:50:48 INFO - MultiFileLogger online at 20161211 14:50:48 in /builds/slave/test 14:50:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:50:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:50:48 INFO - {'append_to_log': False, 14:50:48 INFO - 'base_work_dir': '/builds/slave/test', 14:50:48 INFO - 'blob_upload_branch': 'Firefox', 14:50:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:50:48 INFO - 'branch': 'Firefox', 14:50:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:48 INFO - 'config_files': ('talos/mac_config.py',), 14:50:48 INFO - 'default_actions': ('clobber', 14:50:48 INFO - 'read-buildbot-config', 14:50:48 INFO - 'download-and-extract', 14:50:48 INFO - 'populate-webroot', 14:50:48 INFO - 'create-virtualenv', 14:50:48 INFO - 'install', 14:50:48 INFO - 'run-tests'), 14:50:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:48 INFO - 'download_minidump_stackwalk': True, 14:50:48 INFO - 'download_symbols': 'ondemand', 14:50:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:48 INFO - 'installer_path': 'installer.exe', 14:50:48 INFO - 'log_level': 'info', 14:50:48 INFO - 'log_name': 'talos', 14:50:48 INFO - 'log_to_console': True, 14:50:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:50:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:50:48 INFO - 'opt_config_files': (), 14:50:48 INFO - 'pip_index': False, 14:50:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:48 INFO - 'cmd': ('bash', 14:50:48 INFO - '-c', 14:50:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:48 INFO - 'enabled': True, 14:50:48 INFO - 'halt_on_failure': False, 14:50:48 INFO - 'name': 'check_screen_resolution'},), 14:50:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:48 INFO - 'cmd': ('bash', 14:50:48 INFO - '-c', 14:50:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:48 INFO - 'enabled': True, 14:50:48 INFO - 'halt_on_failure': False, 14:50:48 INFO - 'name': 'check_screen_resolution'},), 14:50:48 INFO - 'run_cmd_checks_enabled': True, 14:50:48 INFO - 'sps_profile': False, 14:50:48 INFO - 'sps_profile_interval': 0, 14:50:48 INFO - 'suite': 'dromaeojs-e10s', 14:50:48 INFO - 'system_bits': '32', 14:50:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:48 INFO - 'title': 't-yosemite-r7-0108', 14:50:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:48 INFO - 'use_talos_json': True, 14:50:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:50:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:48 INFO - 'work_dir': 'build'} 14:50:48 INFO - [mozharness: 2016-12-11 22:50:48.827199Z] Running clobber step. 14:50:48 INFO - Running pre-action listener: _resource_record_pre_action 14:50:48 INFO - Running main action method: clobber 14:50:48 INFO - rmtree: /builds/slave/test/build 14:50:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:50:51 INFO - Running post-action listener: _resource_record_post_action 14:50:51 INFO - [mozharness: 2016-12-11 22:50:51.232431Z] Finished clobber step (success) 14:50:51 INFO - [mozharness: 2016-12-11 22:50:51.232682Z] Running read-buildbot-config step. 14:50:51 INFO - Running pre-action listener: _resource_record_pre_action 14:50:51 INFO - Running main action method: read_buildbot_config 14:50:51 INFO - Using buildbot properties: 14:50:51 INFO - { 14:50:51 INFO - "project": "", 14:50:51 INFO - "product": "firefox", 14:50:51 INFO - "script_repo_revision": "production", 14:50:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:50:51 INFO - "repository": "", 14:50:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:50:51 INFO - "buildid": "20161211134851", 14:50:51 INFO - "pgo_build": "False", 14:50:51 INFO - "basedir": "/builds/slave/test", 14:50:51 INFO - "buildnumber": 25, 14:50:51 INFO - "slavename": "t-yosemite-r7-0108", 14:50:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:50:51 INFO - "platform": "yosemite_r7", 14:50:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:50:51 INFO - "branch": "mozilla-central", 14:50:51 INFO - "repo_path": "mozilla-central", 14:50:51 INFO - "revision": "42086c06f756cda7fbc25a2e7c20a5711f7e5f26", 14:50:51 INFO - "stage_platform": "macosx64", 14:50:51 INFO - "builduid": "6e8482c0a7d64b6a9ef783c4b9c3a8e9", 14:50:51 INFO - "slavebuilddir": "test" 14:50:51 INFO - } 14:50:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 14:50:51 INFO - Running post-action listener: _resource_record_post_action 14:50:51 INFO - [mozharness: 2016-12-11 22:50:51.238487Z] Finished read-buildbot-config step (success) 14:50:51 INFO - [mozharness: 2016-12-11 22:50:51.238705Z] Running download-and-extract step. 14:50:51 INFO - Running pre-action listener: _resource_record_pre_action 14:50:51 INFO - Running main action method: download_and_extract 14:50:51 INFO - mkdir: /builds/slave/test/build/tests 14:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:51 INFO - trying https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:50:51 INFO - Downloading https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 14:50:52 INFO - Downloaded 1235 bytes. 14:50:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 14:50:52 INFO - Using the following test package requirements: 14:50:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 14:50:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 14:50:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 14:50:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'jsshell-mac64.zip'], 14:50:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 14:50:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 14:50:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 14:50:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 14:50:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 14:50:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 14:50:52 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 14:50:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 14:50:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 14:50:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 14:50:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 14:50:53 INFO - Expected file size: 16289294 14:50:53 INFO - Obtained file size: 16289294 14:51:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 14:51:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 14:51:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 14:51:00 INFO - Fetch https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 14:51:01 INFO - Expected file size: 16289294 14:51:01 INFO - Obtained file size: 16289294 14:51:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 14:51:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 14:51:07 INFO - Fetch https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 14:51:08 INFO - Expected file size: 14409734 14:51:08 INFO - Obtained file size: 14409734 14:51: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')]} 14:51:09 INFO - trying https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 14:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 14:51:11 INFO - Downloaded 69675736 bytes. 14:51:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:51:11 INFO - mkdir: /builds/slave/test/properties 14:51:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:51:11 INFO - Writing to file /builds/slave/test/properties/build_url 14:51:11 INFO - Contents: 14:51:11 INFO - build_url:https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 14:51:11 INFO - Running post-action listener: _resource_record_post_action 14:51:11 INFO - Running post-action listener: set_extra_try_arguments 14:51:11 INFO - [mozharness: 2016-12-11 22:51:11.915626Z] Finished download-and-extract step (success) 14:51:11 INFO - [mozharness: 2016-12-11 22:51:11.915737Z] Running populate-webroot step. 14:51:11 INFO - Running pre-action listener: _resource_record_pre_action 14:51:11 INFO - Running main action method: populate_webroot 14:51:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:11 INFO - '--tppagecycles', 14:51:11 INFO - '7'], 14:51:11 INFO - 'tests': ['tsvgm']}}, 14:51:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:51:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:51:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:51:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:51:11 INFO - 'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:51:11 INFO - 'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['damp', 'tps']}, 14:51:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:51:11 INFO - 'tests': ['damp', 'tps']}, 14:51:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['dromaeo_dom']}, 14:51:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['basic_compositor_video']}, 14:51:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:51:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['a11yr', 14:51:11 INFO - 'ts_paint', 14:51:11 INFO - 'tpaint', 14:51:11 INFO - 'sessionrestore', 14:51:11 INFO - 'sessionrestore_no_auto_restore', 14:51:11 INFO - 'tabpaint']}, 14:51:11 INFO - 'other-e10s': {'tests': ['a11yr', 14:51:11 INFO - 'ts_paint', 14:51:11 INFO - 'tpaint', 14:51:11 INFO - 'sessionrestore', 14:51:11 INFO - 'sessionrestore_no_auto_restore', 14:51:11 INFO - 'tabpaint']}, 14:51:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:51:11 INFO - 'ts_paint', 14:51:11 INFO - 'tpaint', 14:51:11 INFO - 'sessionrestore', 14:51:11 INFO - 'sessionrestore_no_auto_restore', 14:51:11 INFO - 'tabpaint']}, 14:51:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:51:11 INFO - 'ts_paint', 14:51:11 INFO - 'tpaint', 14:51:11 INFO - 'sessionrestore', 14:51:11 INFO - 'sessionrestore_no_auto_restore', 14:51:11 INFO - 'tabpaint']}, 14:51:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['a11yr', 14:51:11 INFO - 'ts_paint', 14:51:11 INFO - 'tpaint', 14:51:11 INFO - 'sessionrestore', 14:51:11 INFO - 'sessionrestore_no_auto_restore', 14:51:11 INFO - 'tabpaint']}, 14:51:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['a11yr', 14:51:11 INFO - 'ts_paint', 14:51:11 INFO - 'tpaint', 14:51:11 INFO - 'sessionrestore', 14:51:11 INFO - 'sessionrestore_no_auto_restore', 14:51:11 INFO - 'tabpaint']}, 14:51:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['tsvgx', 14:51:11 INFO - 'tsvgr_opacity', 14:51:11 INFO - 'tart', 14:51:11 INFO - 'tscrollx', 14:51:11 INFO - 'cart', 14:51:11 INFO - 'tsvg_static']}, 14:51:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:51:11 INFO - 'tsvgr_opacity', 14:51:11 INFO - 'tart', 14:51:11 INFO - 'tscrollx', 14:51:11 INFO - 'cart', 14:51:11 INFO - 'tsvg_static']}, 14:51:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:51:11 INFO - 'talos_options': ['--disable-e10s'], 14:51:11 INFO - 'tests': ['tp5o']}, 14:51:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:51:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:51:11 INFO - 'talos_options': ['--disable-e10s', 14:51:11 INFO - '--xperf_path', 14:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:11 INFO - 'tests': ['tp5n']}, 14:51:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:51:11 INFO - 'talos_options': ['--xperf_path', 14:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:11 INFO - 'tests': ['tp5n']}}, 14:51:11 INFO - 'talos.zip': {'path': '', 14:51:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:11 INFO - Running post-action listener: _resource_record_post_action 14:51:11 INFO - [mozharness: 2016-12-11 22:51:11.934182Z] Finished populate-webroot step (success) 14:51:11 INFO - [mozharness: 2016-12-11 22:51:11.934320Z] Running create-virtualenv step. 14:51:11 INFO - Running pre-action listener: _resource_record_pre_action 14:51:11 INFO - Running main action method: create_virtualenv 14:51:11 INFO - Creating virtualenv /builds/slave/test/build/venv 14:51:11 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 14:51:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:51:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:12 INFO - Using real prefix '/tools/python27' 14:51:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:51:12 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:15 INFO - Installing pip.................done. 14:51:15 INFO - Return code: 0 14:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:51:15 INFO - Reading from file tmpfile_stdout 14:51:15 INFO - Output received: 14:51:15 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) 14:51:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:15 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:15 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 14:51:15 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 14:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:15 INFO - 'HOME': '/Users/cltbld', 14:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:15 INFO - 'LOGNAME': 'cltbld', 14:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:15 INFO - 'MOZ_NO_REMOTE': '1', 14:51:15 INFO - 'NO_EM_RESTART': '1', 14:51:15 INFO - 'PAGER': '/bin/cat', 14:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:15 INFO - 'PWD': '/builds/slave/test', 14:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:15 INFO - 'SHELL': '/bin/bash', 14:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:15 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:15 INFO - 'USER': 'cltbld', 14:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:15 INFO - 'XPC_FLAGS': '0x0', 14:51:15 INFO - 'XPC_SERVICE_NAME': '0', 14:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:16 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 14:51:16 INFO - Cleaning up... 14:51:16 INFO - Return code: 0 14:51:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:16 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:16 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 14:51:16 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 14:51:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:16 INFO - 'HOME': '/Users/cltbld', 14:51:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:16 INFO - 'LOGNAME': 'cltbld', 14:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:16 INFO - 'MOZ_NO_REMOTE': '1', 14:51:16 INFO - 'NO_EM_RESTART': '1', 14:51:16 INFO - 'PAGER': '/bin/cat', 14:51:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:16 INFO - 'PWD': '/builds/slave/test', 14:51:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:16 INFO - 'SHELL': '/bin/bash', 14:51:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:16 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:16 INFO - 'USER': 'cltbld', 14:51:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:16 INFO - 'XPC_FLAGS': '0x0', 14:51:16 INFO - 'XPC_SERVICE_NAME': '0', 14:51:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:16 INFO - Downloading/unpacking psutil>=3.1.1 14:51:16 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 14:51:16 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 14:51:16 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 14:51:16 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 14:51:16 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 14:51:16 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 14:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:20 INFO - Installing collected packages: psutil 14:51:20 INFO - Running setup.py install for psutil 14:51:20 INFO - building 'psutil._psutil_osx' extension 14:51:20 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 14:51:20 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 14:51:20 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 14:51:21 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 14:51:21 INFO - building 'psutil._psutil_posix' extension 14:51:21 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 14:51:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:51:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:51:21 INFO - ^ 14:51:21 INFO - 1 warning generated. 14:51:21 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 14:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:21 INFO - Successfully installed psutil 14:51:21 INFO - Cleaning up... 14:51:21 INFO - Return code: 0 14:51:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:21 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:21 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 14:51:21 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 14:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:21 INFO - 'HOME': '/Users/cltbld', 14:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:21 INFO - 'LOGNAME': 'cltbld', 14:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:21 INFO - 'MOZ_NO_REMOTE': '1', 14:51:21 INFO - 'NO_EM_RESTART': '1', 14:51:21 INFO - 'PAGER': '/bin/cat', 14:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:21 INFO - 'PWD': '/builds/slave/test', 14:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:21 INFO - 'SHELL': '/bin/bash', 14:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:21 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:21 INFO - 'USER': 'cltbld', 14:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:21 INFO - 'XPC_FLAGS': '0x0', 14:51:21 INFO - 'XPC_SERVICE_NAME': '0', 14:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:51:21 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 14:51:21 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 14:51:21 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 14:51:21 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 14:51:21 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 14:51:21 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 14:51:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:51:24 INFO - Installing collected packages: mozsystemmonitor 14:51:24 INFO - Running setup.py install for mozsystemmonitor 14:51:24 INFO - Successfully installed mozsystemmonitor 14:51:24 INFO - Cleaning up... 14:51:24 INFO - Return code: 0 14:51:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:24 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:24 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 14:51:24 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 14:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:24 INFO - 'HOME': '/Users/cltbld', 14:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:24 INFO - 'LOGNAME': 'cltbld', 14:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:24 INFO - 'MOZ_NO_REMOTE': '1', 14:51:24 INFO - 'NO_EM_RESTART': '1', 14:51:24 INFO - 'PAGER': '/bin/cat', 14:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:24 INFO - 'PWD': '/builds/slave/test', 14:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:24 INFO - 'SHELL': '/bin/bash', 14:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:24 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:24 INFO - 'USER': 'cltbld', 14:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:24 INFO - 'XPC_FLAGS': '0x0', 14:51:24 INFO - 'XPC_SERVICE_NAME': '0', 14:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:24 INFO - Downloading/unpacking jsonschema==2.5.1 14:51:25 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 14:51:25 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 14:51:25 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 14:51:25 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 14:51:25 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 14:51:25 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 14:51:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:51:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:51:28 INFO - warning: no files found matching '*.txt' 14:51:28 INFO - no previously-included directories found matching 'build' 14:51:28 INFO - no previously-included directories found matching 'dist' 14:51:28 INFO - no previously-included directories found matching '.git*' 14:51:28 INFO - Installing collected packages: jsonschema, functools32 14:51:28 INFO - Running setup.py install for functools32 14:51:28 INFO - warning: no files found matching '*.txt' 14:51:28 INFO - no previously-included directories found matching 'build' 14:51:28 INFO - no previously-included directories found matching 'dist' 14:51:28 INFO - no previously-included directories found matching '.git*' 14:51:28 INFO - Successfully installed jsonschema functools32 14:51:28 INFO - Cleaning up... 14:51:28 INFO - Return code: 0 14:51:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:51:28 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')]} 14:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:28 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')]} 14:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:28 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:28 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 14:51:28 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 14:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:28 INFO - 'HOME': '/Users/cltbld', 14:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:28 INFO - 'LOGNAME': 'cltbld', 14:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:28 INFO - 'MOZ_NO_REMOTE': '1', 14:51:28 INFO - 'NO_EM_RESTART': '1', 14:51:28 INFO - 'PAGER': '/bin/cat', 14:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:28 INFO - 'PWD': '/builds/slave/test', 14:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:28 INFO - 'SHELL': '/bin/bash', 14:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:28 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:28 INFO - 'USER': 'cltbld', 14:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:28 INFO - 'XPC_FLAGS': '0x0', 14:51:28 INFO - 'XPC_SERVICE_NAME': '0', 14:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:51:28 INFO - Cleaning up... 14:51:28 INFO - Return code: 0 14:51:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:51:28 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')]} 14:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:28 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')]} 14:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:28 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:28 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 14:51:28 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 14:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:28 INFO - 'HOME': '/Users/cltbld', 14:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:28 INFO - 'LOGNAME': 'cltbld', 14:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:28 INFO - 'MOZ_NO_REMOTE': '1', 14:51:28 INFO - 'NO_EM_RESTART': '1', 14:51:28 INFO - 'PAGER': '/bin/cat', 14:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:28 INFO - 'PWD': '/builds/slave/test', 14:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:28 INFO - 'SHELL': '/bin/bash', 14:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:28 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:28 INFO - 'USER': 'cltbld', 14:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:28 INFO - 'XPC_FLAGS': '0x0', 14:51:28 INFO - 'XPC_SERVICE_NAME': '0', 14:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:51:28 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 14:51:28 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 14:51:28 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 14:51:28 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 14:51:28 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 14:51:28 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 14:51:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:51:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:32 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 14:51:32 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 14:51:32 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 14:51:32 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 14:51:32 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 14:51:32 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 14:51:32 INFO - Downloading docopt-0.6.1.tar.gz 14:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:32 INFO - Running setup.py install for blobuploader 14:51:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:51:32 INFO - Running setup.py install for requests 14:51:33 INFO - Running setup.py install for docopt 14:51:33 INFO - Successfully installed blobuploader requests docopt 14:51:33 INFO - Cleaning up... 14:51:33 INFO - Return code: 0 14:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:33 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')]} 14:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:33 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')]} 14:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:33 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:33 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 14:51:33 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 14:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:33 INFO - 'HOME': '/Users/cltbld', 14:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:33 INFO - 'LOGNAME': 'cltbld', 14:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:33 INFO - 'MOZ_NO_REMOTE': '1', 14:51:33 INFO - 'NO_EM_RESTART': '1', 14:51:33 INFO - 'PAGER': '/bin/cat', 14:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:33 INFO - 'PWD': '/builds/slave/test', 14:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:33 INFO - 'SHELL': '/bin/bash', 14:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:33 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:33 INFO - 'USER': 'cltbld', 14:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:33 INFO - 'XPC_FLAGS': '0x0', 14:51:33 INFO - 'XPC_SERVICE_NAME': '0', 14:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:33 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-csnk86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-czcCIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-WNV0WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-HbeHNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-ObPlyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-EXDWqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-84gbsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-gbbjn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-xEwrC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-XtUey_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:34 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-npnjIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:35 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-bvoawY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:35 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Qd9V27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:35 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-JRZg3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:35 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-fhI14v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:35 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-1tKtQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:35 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-q2oPkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:35 INFO - Running setup.py install for manifestparser 14:51:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for mozcrash 14:51:35 INFO - Running setup.py install for mozdebug 14:51:36 INFO - Running setup.py install for mozdevice 14:51:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozfile 14:51:36 INFO - Running setup.py install for mozhttpd 14:51:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozinfo 14:51:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozInstall 14:51:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozleak 14:51:36 INFO - Running setup.py install for mozlog 14:51:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Running setup.py install for moznetwork 14:51:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Running setup.py install for mozprocess 14:51:37 INFO - Running setup.py install for mozprofile 14:51:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Running setup.py install for mozrunner 14:51:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:51:37 INFO - Running setup.py install for mozscreenshot 14:51:37 INFO - Running setup.py install for moztest 14:51:38 INFO - Running setup.py install for mozversion 14:51:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:51:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:51:38 INFO - Cleaning up... 14:51:38 INFO - Return code: 0 14:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:38 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:38 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 14:51:38 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 14:51:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:38 INFO - 'HOME': '/Users/cltbld', 14:51:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:38 INFO - 'LOGNAME': 'cltbld', 14:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:38 INFO - 'MOZ_NO_REMOTE': '1', 14:51:38 INFO - 'NO_EM_RESTART': '1', 14:51:38 INFO - 'PAGER': '/bin/cat', 14:51:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:38 INFO - 'PWD': '/builds/slave/test', 14:51:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:38 INFO - 'SHELL': '/bin/bash', 14:51:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:38 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:38 INFO - 'USER': 'cltbld', 14:51:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:38 INFO - 'XPC_FLAGS': '0x0', 14:51:38 INFO - 'XPC_SERVICE_NAME': '0', 14:51:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:38 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-53x0_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:38 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-xcYaab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:38 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-AiFKfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:38 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-DFNfRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:38 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-WCn7Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Nnhoif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-RXC1hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-QwJ6rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-LN3pXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-k59aig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-RMHf_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-djyxCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-FbAzbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:39 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)) 14:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:39 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-1DI5mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:40 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)) 14:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:40 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-Ii4wuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:40 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)) 14:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:40 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-h06jxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:40 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-hhLyrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:40 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)) 14:51:40 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)) 14:51:40 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)) 14:51:40 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)) 14:51:40 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)) 14:51:40 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)) 14:51:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:40 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 14:51:40 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 14:51:40 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 14:51:40 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 14:51:40 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 14:51:40 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 14:51:42 INFO - Downloading blessings-1.6.tar.gz 14:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:43 INFO - Installing collected packages: blessings 14:51:43 INFO - Running setup.py install for blessings 14:51:43 INFO - Successfully installed blessings 14:51:43 INFO - Cleaning up... 14:51:43 INFO - Return code: 0 14:51:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:43 INFO - Reading from file tmpfile_stdout 14:51:43 INFO - Current package versions: 14:51:43 INFO - blessings == 1.6 14:51:43 INFO - blobuploader == 1.2.4 14:51:43 INFO - docopt == 0.6.1 14:51:43 INFO - functools32 == 3.2.3-2 14:51:43 INFO - jsonschema == 2.5.1 14:51:43 INFO - manifestparser == 1.1 14:51:43 INFO - mozInstall == 1.12 14:51:43 INFO - mozcrash == 1.0 14:51:43 INFO - mozdebug == 0.1 14:51:43 INFO - mozdevice == 0.49 14:51:43 INFO - mozfile == 1.2 14:51:43 INFO - mozhttpd == 0.7 14:51:43 INFO - mozinfo == 0.9 14:51:43 INFO - mozleak == 0.1 14:51:43 INFO - mozlog == 3.4 14:51:43 INFO - moznetwork == 0.27 14:51:43 INFO - mozprocess == 0.23 14:51:43 INFO - mozprofile == 0.28 14:51:43 INFO - mozrunner == 6.13 14:51:43 INFO - mozscreenshot == 0.1 14:51:43 INFO - mozsystemmonitor == 0.3 14:51:43 INFO - moztest == 0.7 14:51:43 INFO - mozversion == 1.4 14:51:43 INFO - psutil == 3.1.1 14:51:43 INFO - requests == 1.2.3 14:51:43 INFO - wsgiref == 0.1.2 14:51:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:43 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')]} 14:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 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')]} 14:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:43 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 14:51:43 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 14:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:43 INFO - 'HOME': '/Users/cltbld', 14:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:43 INFO - 'LOGNAME': 'cltbld', 14:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:43 INFO - 'MOZ_NO_REMOTE': '1', 14:51:43 INFO - 'NO_EM_RESTART': '1', 14:51:43 INFO - 'PAGER': '/bin/cat', 14:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:43 INFO - 'PWD': '/builds/slave/test', 14:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:43 INFO - 'SHELL': '/bin/bash', 14:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:43 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:43 INFO - 'USER': 'cltbld', 14:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:43 INFO - 'XPC_FLAGS': '0x0', 14:51:43 INFO - 'XPC_SERVICE_NAME': '0', 14:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 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)) 14:51:43 INFO - Cleaning up... 14:51:43 INFO - Return code: 0 14:51:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:51:43 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')]} 14:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 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')]} 14:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:43 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 0x10a9383f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8ae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5b15a2be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, '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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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 14:51:43 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 14:51:43 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 14:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:43 INFO - 'HOME': '/Users/cltbld', 14:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:43 INFO - 'LOGNAME': 'cltbld', 14:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:43 INFO - 'MOZ_NO_REMOTE': '1', 14:51:43 INFO - 'NO_EM_RESTART': '1', 14:51:43 INFO - 'PAGER': '/bin/cat', 14:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:43 INFO - 'PWD': '/builds/slave/test', 14:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:43 INFO - 'SHELL': '/bin/bash', 14:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:51:43 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:43 INFO - 'USER': 'cltbld', 14:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:43 INFO - 'XPC_FLAGS': '0x0', 14:51:43 INFO - 'XPC_SERVICE_NAME': '0', 14:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:51:44 INFO - Cleaning up... 14:51:44 INFO - Return code: 0 14:51:44 INFO - Running post-action listener: _resource_record_post_action 14:51:44 INFO - Running post-action listener: _start_resource_monitoring 14:51:44 INFO - Starting resource monitoring. 14:51:44 INFO - [mozharness: 2016-12-11 22:51:44.189907Z] Finished create-virtualenv step (success) 14:51:44 INFO - [mozharness: 2016-12-11 22:51:44.190879Z] Running install step. 14:51:44 INFO - Running pre-action listener: _resource_record_pre_action 14:51:44 INFO - Running main action method: install 14:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:44 INFO - Reading from file tmpfile_stdout 14:51:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:51:44 INFO - Reading from file tmpfile_stdout 14:51:44 INFO - Output received: 14:51:44 INFO - Usage: mozinstall [options] installer 14:51:44 INFO - Options: 14:51:44 INFO - -h, --help show this help message and exit 14:51:44 INFO - -d DEST, --destination=DEST 14:51:44 INFO - Directory to install application into. [default: 14:51:44 INFO - "/builds/slave/test"] 14:51:44 INFO - --app=APP Application being installed. [default: firefox] 14:51:44 INFO - mkdir: /builds/slave/test/build/application 14:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 14:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 14:52:06 INFO - Reading from file tmpfile_stdout 14:52:06 INFO - Output received: 14:52:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:52:06 INFO - Running post-action listener: _resource_record_post_action 14:52:06 INFO - [mozharness: 2016-12-11 22:52:06.325589Z] Finished install step (success) 14:52:06 INFO - [mozharness: 2016-12-11 22:52:06.325726Z] Running run-tests step. 14:52:06 INFO - Running pre-action listener: _resource_record_pre_action 14:52:06 INFO - Running main action method: run_tests 14:52:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:52:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:52:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:52:06 INFO - 2016-12-11 14:52:06.340 screenresolution[1634:8227] starting screenresolution argv=screenresolution get 14:52:06 INFO - 2016-12-11 14:52:06.342 screenresolution[1634:8227] Display 0: 1600x1200x32@60 14:52:06 INFO - 2016-12-11 14:52:06.348 screenresolution[1635:8230] starting screenresolution argv=screenresolution list 14:52:06 INFO - Available Modes on Display 0 14:52:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:52:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:52:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:52:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:52:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:52:06 INFO - Intel Iris: 14:52:06 INFO - Chipset Model: Intel Iris 14:52:06 INFO - Type: GPU 14:52:06 INFO - Bus: Built-In 14:52:06 INFO - VRAM (Dynamic, Max): 1536 MB 14:52:06 INFO - Vendor: Intel (0x8086) 14:52:06 INFO - Device ID: 0x0a2e 14:52:06 INFO - Revision ID: 0x0009 14:52:06 INFO - Displays: 14:52:06 INFO - Display: 14:52:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:52:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:52:06 INFO - Display Serial Number: 1600x1200 60 14:52:06 INFO - Main Display: Yes 14:52:06 INFO - Mirror: Off 14:52:06 INFO - Online: Yes 14:52:06 INFO - Rotation: Supported 14:52:06 INFO - Return code: 0 14:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:06 INFO - Python 2.7.3 14:52:06 INFO - Return code: 0 14:52:06 INFO - grabbing minidump binary from tooltool 14:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:06 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 0x10a74dd30>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a745b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:06 INFO - Return code: 0 14:52:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:52:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:52:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--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 14:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0108 --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 14:52:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qGU4eYgoP/Render', 14:52:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:06 INFO - 'HOME': '/Users/cltbld', 14:52:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:06 INFO - 'LOGNAME': 'cltbld', 14:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:06 INFO - 'MOZ_NO_REMOTE': '1', 14:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:06 INFO - 'NO_EM_RESTART': '1', 14:52:06 INFO - 'PAGER': '/bin/cat', 14:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:06 INFO - 'PWD': '/builds/slave/test', 14:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:06 INFO - 'SHELL': '/bin/bash', 14:52:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LnWBLEAYJo/Listeners', 14:52:06 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 14:52:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:06 INFO - 'USER': 'cltbld', 14:52:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:06 INFO - 'XPC_FLAGS': '0x0', 14:52:06 INFO - 'XPC_SERVICE_NAME': '0', 14:52:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--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 14:52:06 INFO - mozversion application_buildid: 20161211134851 14:52:06 INFO - mozversion application_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 14:52:06 INFO - mozversion application_display_name: Nightly 14:52:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:06 INFO - mozversion application_name: Firefox 14:52:06 INFO - mozversion application_remotingname: firefox 14:52:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:52:06 INFO - mozversion application_vendor: Mozilla 14:52:06 INFO - mozversion application_version: 53.0a1 14:52:06 INFO - mozversion platform_buildid: 20161211134851 14:52:06 INFO - mozversion platform_changeset: 42086c06f756cda7fbc25a2e7c20a5711f7e5f26 14:52:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:52:06 INFO - mozversion platform_version: 53.0a1 14:52:06 INFO - using testdate: 1481496726 14:52:06 INFO - actual date: 1481496726 14:52:06 INFO - starting webserver on 'localhost:49241' 14:52:06 INFO - SUITE-START | Running 2 tests 14:52:06 INFO - TEST-START | dromaeo_css 14:52:06 INFO - operating with platform_type : mac_ 14:52:06 INFO - Initialising browser for dromaeo_css test... 14:52:06 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpZoqS0G/profile http://localhost:49241/getInfo.html) 14:52:09 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 14:52:09 INFO - PROCESS | 1645 | colorDepth:24 14:52:09 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 14:52:09 INFO - PROCESS | 1645 | __metrics 14:52:09 INFO - PROCESS | 1645 | 2016-12-11 14:52:09.994 plugin-container[1647:8401] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3b, name = 'com.apple.tsm.portname' 14:52:09 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:10 INFO - PROCESS | 1645 | 2016-12-11 14:52:09.998 plugin-container[1647:8401] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 14:52:10 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:10 INFO - PROCESS | 1645 | 2016-12-11 14:52:09.998 plugin-container[1647:8401] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:52:10 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 14:52:10 INFO - TEST-INFO | 1645: exit 0 14:52:10 INFO - Browser initialized. 14:52:10 INFO - Running cycle 1/1 for dromaeo_css test... 14:52:10 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpZoqS0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:13 INFO - PROCESS | 1649 | 2016-12-11 14:52:13.360 plugin-container[1650:8528] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8743, name = 'com.apple.tsm.portname' 14:52:13 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:13 INFO - PROCESS | 1649 | 2016-12-11 14:52:13.360 plugin-container[1650:8528] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4313, name = 'com.apple.CFPasteboardClient' 14:52:13 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:52:13 INFO - PROCESS | 1649 | 2016-12-11 14:52:13.360 plugin-container[1650:8528] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:52:22 INFO - PROCESS | 1649 | RSS: Main: 236965888 14:52:22 INFO - PROCESS | 1649 | 14:53:12 INFO - PROCESS | 1649 | 1481496792610 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:55:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 14:55:27 INFO - PROCESS | 1649 | RSS: Main: 256913408 14:55:27 INFO - PROCESS | 1649 | 14:58:30 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 14:58:31 INFO - PROCESS | 1649 | RSS: Main: 265400320 14:58:31 INFO - PROCESS | 1649 | 15:01:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:01:33 INFO - PROCESS | 1649 | RSS: Main: 271314944 15:01:33 INFO - PROCESS | 1649 | 15:04:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:04:36 INFO - PROCESS | 1649 | RSS: Main: 270262272 15:04:36 INFO - PROCESS | 1649 | 15:07:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:07:39 INFO - PROCESS | 1649 | RSS: Main: 278003712 15:07:39 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:10:42 INFO - PROCESS | 1649 | RSS: Main: 280469504 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | __start_tp_report 15:10:42 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 15:10:42 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 15:10:42 INFO - PROCESS | 1649 | |i|pagename|runs| 15:10:42 INFO - PROCESS | 1649 | |0;dojo.html;3082.506798912174;3317.6018877734678;3326.4345061339586;3337.149026998115;3389.796612203267;5524.502794748471;5560.249366335549;5592.049351610226;5596.58025648077;5604.439556044394;5502.944970550293;5578.44215578442;5629.296337957755;5644.125160600103;5651.886962260753;4183.853565125221;5116.488351164891;5124.820631277906;5177.48225177483;5190.455002224769;5113.872153196163;5188.299579556749;5204.817831375903;5219.947800521984;5232;4299.226139294926;5188.403333616626;5188.714620695879;5206.947930520703;5232.372115346164;5140.203268493371;5182.792688292501;5184.248283998799;5194.610404219679;5212.270282160501;5056.342675452168;5151.639385243035;5152.690838549699;5155.458676838953;5180.974095129538;5475.397706252309;5519.089350257203;5530.253415788858;5552.583556233259;5639.577031722637;4979.680384698058;5952.791652292192;5983.1623572699855;5985.670788106652;5997.100434934751;6088.238970128734;6113.052476866093;6128.8086916200045;6130.184124957599;6178.258608966908;5649.717514124277;5677.3754886962815;5688.772449102031;5753.683547404849;5789.536837052983;6216.906746398808;6238.875222495615;6263.060540918898;6302.936970630327;6325.177726895567;5916.970415147983;5923.733431995571;6059.272887253558;6065.787697430569;6096.969515152485;6107.037103281127;6112.694365281718;6154.876902461926;6209.161763161916;6250.781222657185;6117.84705382369;6173.629582225081;6175.104609831549;6182.6599537025895;6198.659073750987;6044.576879618385;6127.6936153193055;6139.171211886338;6154.230721159855;6202.131701561785;3836.5971572984995;4231.640310573574;4240.533541310453;4405.207062728739;4632.351470794091;4258.61672449481;4371.191329604034;4406.889827754268;4407.493138289074;4421.071574969293;5769.711514424262;5774.68239246837;5785.4793068623185;5841.153032810219;5894.8821023579285;5044.495550444926;5049.747512624354;6119.624418755179;6131.162586540582;6183.876322473526;5792.797252096157;5795.8551036224435;5807.128930660435;5813.215215945877;5845.88308233833;5262.158054711228;5320.893582128336;5349.86625334362;5351.117065684119;5376.596755243372;5149.459306772735;6123.755049797958;6140.5701600887505;6221.657808820558;6245.937540624535;6178.351273116258;6188.690565471798;6218.160548326099;6228.626282423069;6235.189425374672;6160.9383906160365;6253.030780229072;6267;6274.968625156845;6289.27673317556;6024.3975602439405;6114.785982490592;6115.755369785159;6118.449339559461;6121.969390153021;6127.908081378872;6147.354527774519;6158.722857471335;6173.043178307369;6173.536984726254;4896.632752543503;5283.233931080049;5895.469407753323;6053.545984051302;6070.301915279622;6087;6107.786227482017;6117.143599895929;6118.235220597426;6129;5764.654120752768;5905.970470147622;5934.673592952429;5936.317323507679;5947.04847224442;5945.0190718532685;5970.58205925581;6016.939830601638;6063.090536419572;6125.326214116354;5914.497267732291;5919.467247947706;5931.555133365101;5931.881362372642;5937.673427961504 15:10:42 INFO - PROCESS | 1649 | |1;ext.html;460.97925593348293;486.27059410883675;492.15595254139146;521.3274875410721;524.8189374665741;37736.811315943414;39250;39274;39308;39351.212975740505;39697;40233;40281;40381;40399.59600403995;8392.580370981457;8655.134486551326;9240.306976976737;9521.190698790611;9522.952385238099;11105.111591072735;11437.542498300058;11441.199116061878;11629.360385178812;11632.476538555786;11431.256968297075;11477.540898364055;11494.195406321562;11540.538378464851;11551.30692158469;11367.602133925315;11426.257293275952;11426.657200284004;11443.885561144449;11453.37006464644;11161.497732602053;11238.381888996102;11241.606543771011;11246.831297530543;11259.662210133709;32974.83512582446;38803.805980970195;38894.41658375126;39025.80487097575;39133.21733565313;3101.0696790962847;3126.7654925880424;3249.862548108143;3506.2636846262317;3665;27488.900443982217;28035.878564857383;28068.578971315448;28226.717732822613;28723.85638071817;2670.5994100884827;3148.370325934822;3178.523221516768;3189.776715629907;3251.1872031992;484005;487940;490422.54788726184;491404;493207.5339623315;54576;54771;55091.89816203734;55209;55216.44783552193;50341.23805666784;56287.43712562904;56536;57422;57523.71238143783;14745.410183592536;14906;14988.175650339117;14994.775078373834;15005.499450054907;9574.808503829885;10573.418461984666;10873.619423320146;11770.470328835223;11872.940635296942;15626.68746625061;15679.137647429501;16913.492595222164;17164.914175429043;17291.82708172902;5811.82564523065;7406;7593.012908321883;7634.580098094658;7647.617619119022;749.8762704153862;974.488393593355;975.9707208783748;992.5583115513527;1011.4487604255551;28944.7105528942;29137.56293655597;29604.111876643736;29896.701032989826;30047.098587042423;1038.1227862456212;1039.9948000260101;1040.9375437473775;1092.7377429416883;1145.450183911727;15138.318775655121;15397.99913005651;15399.92200545951;15433.382664693287;15503.922480387751;588649;629269;631194;641196.5880341136;641924;57594;58244.7087764567;58287.70856145692;58328.833423332144;58401;1329.9933500332436;1367.09771550776;1383.9377228024764;1389.5622878793147;1391.631217727303;29141.417171656023;29147.708522914498;29447.263818403855;29852.70147298586;29989.700102999563;49138.75430622824;49333.753331233114;49894.50105499044;49908;50089.49910500849;483865;484824;487632;493133;498345;24642;25039.74960250447;25161.245162644416;26149.215523534323;29146.854265728536;30126.69873301239;40130.99672508211;40288.79855600703;40626;43444.782776085915;27868.721312786613;32907.45274509564;35071;36109.63890361168;36492.635073648926;34833.825830870686;35637.82181089078;35940.92177234687;36119.63880361268;36832;24772.876135619208;34369.888698287825;34867.65132348746;35100.297994040484;35495.290094198484;29836.85081574665;30852;30977.69022309748;30994.690053100083;31013.224669383446;23511.471754335915;23923.829160822093;24024.519509610058;24025.399365016016;24103.63844542298 15:10:42 INFO - PROCESS | 1649 | |2;jquery.html;326.2300969711481;364.6517575715192;373.73651575639167;382.3022983055924;401.8987972954105;18375.264989400424;18700.345487907925;18831;19298.131584078732;19503;17940.730889036644;18175.54561135969;18278.268869245247;18580.907095464503;20057.997100145007;5630.211770352154;5787.392323805992;5884.293884733816;5993.310769261525;6001.939980600204;5710.229119068914;5889.381614930414;5934.5845790794665;5936.910946335808;5938.732757025922;5695.43375571719;5753.371349886999;5867.76528938842;5887.1463637772495;5903.2325797646245;5765.942340576604;5820.330661973863;5863.912041319383;5874.9118763218585;5893.675847828367;5061.291419201315;5068.4171320298265;5112.923306150411;5156.432792392834;5172.146595811687;24482.632760508608;24736.628950565755;24750.752492475025;24865.129720459696;25044.49911001788;1966.2331690640663;2258.7967082962614;2351.976480235193;2353.1411034972284;2996.895108671186;10097.192224622013;10174.898251017468;10408;10438.217133714927;10560.577576896992;1788.9910550447294;1827.424361326178;1903.3718872771951;1911.808819118091;1918.6834172361544;108394.45802771015;110159;113966.86033139729;114984;116114;11220.66338009861;11245.044171245372;11336.829947550794;11435.94282028601;11485.425728713531;11830.88169118315;14434.278286085653;14569.344379502947;14573.854261457249;14583.125012499284;6391.744330226739;8090.069641991128;8194.385421093442;8221.17788221173;8409.20112589303;8049.9597502013285;8065.677372905136;8069.394795390369;8174.550399728072;8209.753707388787;4032.818523166406;4358.346248062816;4386.670999675037;4601.148787474328;4660.46404663468;1688.8564472020016;1727.8185790492068;1823.334482913727;1959.8922059286876;1961.3135402609257;838.7777239031661;889.3774357949461;918.4856480371013;943.1888575824785;981.5779214937645;17707.55731106707;19386.4184074478;20603.58792824135;20716.067776950073;20730.58538829215;782.964766585505;818.7134502924048;835;862.5902696219246;878.4597472554333;10324.535395907202;10581.206409519316;11188.776224475629;11207.599050118735;11474.885251147549;492611;546304;554403;554549;563940;99520.00479995253;105544;115979;124682.37658811829;127324;896.3277541843618;997.835357166074;1071.3732466507024;1074;1079.6221322537049;18509.72235416443;18749.718754218426;18926.810731892503;19171.46628269707;19188;49888.75055624844;53313.20030199628;54352;54650.72674636601;54866;66710;69776.86004129724;70395;78838;84841.72737409067;6996.615186164606;7783.416243781626;8022.478538894953;8024.879626805486;8189.50862948225;9010.423175944316;12071.57749478764;12538.122331436713;12550.372481376076;12562.748745024866;9331.673391431268;10428;10509.737256568647;10628.946855265674;10938.179636527133;10047.547860346449;10115.949420252851;10406.219533535166;10718.35689858611;10846.728831779268;10726.463676815973;10852.294600850919;10894.509747061244;11089.722756931142;11219.831702524305;6782.321767823179;7220.942031520991;7223.927760722326;7410.333070023724;8167.754967350989;9552.713418597454;10890.29213101146;11167.497462614365;11170.944145279222;11198.608048718255 15:10:42 INFO - PROCESS | 1649 | |3;mootools.html;1431.949881754139;1490.5304828978872;1709.8204688507706;1766.5318690546999;1785.4375871600437;7438.218987006368;7701.92298077019;7836.333911617512;8321.916780832189;8331.87502187467;7742.8451430971345;8105.027396712403;8122.0659624143245;8130.9186908130905;8139.837203255931;2255.3684968208886;2311.5376924615143;2317.9304620861403;2320.721513418384;2328.3946173994714;2300.9654855177187;2337.812974961999;2346.120204923154;2351.8236132290062;2355.1639168095335;2262.0386335807298;2284.942876428094;2313.9884300578474;2320.1299512682745;2324.6861673674093;2243.6971008913833;2275.0672224388086;2276.702279700571;2281.5094754627753;2281.828862835294;2308.1459859851793;2325.744168141503;2327.057541695616;2329.7087864017;2337.8778186470417;6575.210974683068;7124.14510258767;8203.71287004952;8219.712310069119;8225.300849427806;4963.40439147301;5101.132807422747;5130.640855140142;5131.1277082895995;5134.101532231844;2880.3663194097267;3093;3344.782589131723;3441.587009558869;3552.8578856845697;959.5442164971653;969.2488321550784;969.6121551379434;1038.68839348196;1056.0864851903125;8672.739817805414;10132.138768204712;10178.23663225261;10262.794744105076;10280.74298142545;4476.552344765498;4531.524189960007;4604.493505714368;4638;4647.767611619473;9181.862272065924;9260.073992600686;9361.204297634777;9412.858807117898;9419.529023548796;5170.276161337416;5180.300659411007;5180.6891586504935;5183.740812959337;5197.610179236573;4214.789260536961;4229.238737027365;4618.67669263155;4655.674102812771;4745.193317136026;3706.629337066272;3770.792606406619;3799.639034291793;3832.3485007548784;3859.5754467008605;1043.2540733375522;1269.2891980490954;1273.6815796050987;1278.401997503121;1281.2888846689991;851.9957400212959;866.9176428239307;877.3551439691821;894.9284057275403;924.246738907788;4784.904301914012;5289.259503669489;5443;5769.423057694281;5935.436133567304;858.5106489301038;871.7079778274349;895.3329769321897;931.3945935142211;960.7550074730899;2748.7800975921878;3663.505426767352;3901.9609803902167;3926.8612102489956;3931.036895960508;9472.857907131398;9805.509724513746;9810.80378392428;9826.75433114178;9842.015798420243;9145.634174633073;9612.75968100803;9651.420914745138;9781.804363912683;9793.90206097944;7484.775456736306;7694;7706.576138312446;7715.691372345155;7723.806904827312;5322.121849894724;5398.40617532079;5428.864278393072;5635.06305643513;5832.096025116114;8939.59771810257;9197.586108624993;9208.723738287863;9230.492322922304;9239.584218710308;7275.890861636974;8942.552872356486;9051.366404351633;9157.267418606361;9274.165325120772;6495.707693153725;6651.4013738761805;6956.130483689539;6987.545809522569;7143.9285607143265;6572.901406478811;7786.532808031537;7791.727289544839;7794.986651735238;7834.686612535663;6831.863362732817;6965;6970.756023539152;6991;7083.220845707071;6886.380225779704;6912.9284960831155;6959.582425054513;6962.512624116263;6994.160700715946;5934.9109763354445;6130.570860039755;6628.370304821035;6629.4696424284975;6638;4032.5765794591143;4671.976640116778;4749.335093087039;4801.423829140525;4900.534449227318;4730.621550276039;4747.8575642730775;4816.614670826255;4869.220924652039;5008.098542262428 15:10:42 INFO - PROCESS | 1649 | |4;prototype.html;329.09827073817746;345.7804294273137;350.3186302641362;360.65917707766164;369.70423661071135;4149.709520333574;4643.767811609415;4730.148573256813;5101.78072538446;5220.921686174705;4863.495299920543;5134.7432628368615;5136.64043516954;5173.508516690908;5205.739713014353;3762.6237376262293;4045.5752146024683;4069.7354671946227;4103.528094269167;4106.240345536085;3483.1988642612214;3638.8719496955896;3821.7961342177127;4094.9590504094876;4135.800617820843;3529.7705649132854;3810.5236845394325;4032.3145065338817;4046.5953404659595;4061.57353477885;3437.65623437658;3559.555055618048;3971.046948732298;4025.81883815229;4032.374981877784;3601.6398360164035;3602;3603.5855876574005;3608.855645774166;3650.2152037312107;4428.3800267962515;5040.521150490697;5072.061668591323;5079.720615366154;5090.9236361454605;4123.36087906375;4604.769761511944;4641.419822522184;4655.4180727409075;4661.394018777537;4880.877978050577;5191.480851914816;5501.504864562168;5510.9448905510835;5520.392756796749;3305.0910999475095;3400.863965441379;3435.914102147441;3758.9436158457647;3985.2826491231567;5667.943320566824;5698.17376480408;5713.628614140068;5753.7123143843055;5763.250777398953;4024.63778259958;4043.2722110020477;4054.918901621951;4056.634902858698;4077.225327187825;3958.762474251554;4094.63148316647;4115.789684046448;4129.607687269705;4143.544210136883;4044.716869819143;4601.263797792337;4641.234196357631;4651.279051746985;4654.25531914892;4936.975315123402;5103.826119992423;5440.17754052389;5515.145152501369;5515.751791169407;1089.7384627689298;1174.1194104421684;1186.3415804228737;1234.9441227750324;1291.185883833216;888.7733627924838;934.8644446555212;951.6478902806006;957.4111921168432;971.9502936828209;4338.696291259582;4425.513193548707;4846.085796110587;4903.313536104877;4915.48387419323;4613.615915225419;4618.49196588375;4912.646572755186;5127.436581442519;5319;4292.3561465780385;4380.802863871069;4830.565249127595;4879.463259041502;4882.023595280887;2507.8213239777274;2781.735735105162;2788.721127887195;2792.933229410222;2799.2567284061734;4618.745968971739;5070.771815268322;5312.787488500417;5467.617266791286;5581.609287349846;4534.886627834265;5400.324959380077;5457.863553411196;5470.538257784013;5518.613697041169;4877.975610121926;5355.866103347447;5493.533049690741;5518.91721624176;5561.694106824163;4246.596573325529;4616.815327386867;4763;5146.305248791366;5356.384015838228;5303.734813259244;5362.919556206582;5628.649124210078;5659.349174844946;5683.623609820498;5240.68555886648;5812.360640329476;5894.20428242199;5910.349861515316;5925.459380561171;3430.622631510582;3777.735558510878;3801.50580424543;3802.129392308789;3820.140468394589;4988.451270360185;5684.811347631109;5695.914561281501;5718.914216286676;5736.971315143564;5517.2551705519245;5548.750306236309;5563.638363506359;5581.581381396492;5592.608517403743;5051.848444546669;5260.473952604709;5497.45025497447;5542.3903370628395;5563.638363506359;5134.255532947776;5265.4997775211295;5287.625217443416;5453.700046497481;5486.91769623448;4679.438467383799;5082.923756143587;5160.922586161136;5362.302900622894;5579.581531385081;4894.461609222912;5073.822416215415;5392.164214546751;5426.864328391822;5456.290682211287 15:10:42 INFO - PROCESS | 1649 | |5;yui.html;693.4798900824381;711.8683043636925;768.4428789127883;768.8692922203224;792.5363662257581;14651.267436628166;15427;15446.459373921914;15448.459303924365;15478.61303467414;14192.864570834334;14353.928230358859;14356;14357.353919073641;14362;687.0964681443885;709.8048036789872;847.4830353484369;867.3234876796109;886.162576365335;855.7090589199671;856.755824589992;862.3920136303891;868.7393781865446;870.8824308718337;918.2378625740653;923.4551614547415;930.5579849571467;930.6556574067605;931.6273490603745;920.7329874336501;922.1101636920404;922.7324076017946;923.833709932212;924.3437159616647;678.0507289794278;685.7428464325877;690.2717632897292;690.5994523176596;690.7685925215059;14742.926285368505;15208.847911520854;15297.929144959857;15361.308741106677;15535;14099.718005639932;14411.78382324266;14436.711265774626;14443.98892077555;14593.197374144418;11667;11693.649190524298;11750.647480575597;11833.94083029588;11860.110491713156;3659.1218107654236;3701.5373078365205;3721.497597824286;3722.404415293567;3875.593062728401;87665.24669506638;95346.56980145373;103739.481302593;106504;117522;8151.057763244491;10307.639232626821;10920.12638988879;10931.222641962035;10940.234183607072;23130;23225.419364516023;23271.534569308857;23289.41776455568;23321.95051222699;7532.8798411616435;7636.350910172698;7688.308052275322;7725.768226953201;7877.645505952246;4219.894502637398;4301.225779359683;4358.956410435919;4364.650827933758;4486.730796152241;2892.884284628591;3523.559555055618;3546.2375589248436;3580.427131658922;3580.749347545699;580.796721147595;623.2396476298908;634.2072409488139;635.6853357588024;654.1496055128314;580.6864293281665;623.8752249550108;659.610829610532;660.7588230295908;680.8502129531495;8861.512616806138;9213.748796656135;9250.167484926389;9400.388974716621;9483.715488535356;549.2585010236229;626.5050610018126;661.7419206509466;661.7716887673745;681.2744427185032;3697.8335974881193;3840.251151025579;4430.689851710349;4501.3022981437925;4538.818447262139;90642.54678726695;110452;112448.43775781232;112508.4374578122;113744;97607.53588696175;99374;99418.50290748644;100123;100543.49728251313;64228.67885660542;79106.60446697845;79626;79988.60034198983;81019;6337.271213810471;7431.5912624804;8432.578371081545;8768.60541275657;9077.77305567366;39346.213075738895;42544.78727606342;50861.491385085676;50908.981820364126;51617.22574161466;62653.373466264755;69707;69887.30112698808;72460;72965.6351718238;10794.19043571751;10903.890961090288;11085.113190944867;11168.329900206014;11580.47269274978;11952.701182470508;11983.510023465215;12249.877501224873;13764;14629.268536573341;13121.720567404293;13480.730385392433;13558.38987245596;13600.86399135996;14123.435062597791;13075.280859552435;13343.866561334262;13687.726245475234;13702.588922332347;13749.656258593615;12952.28762418076;13280.003999700255;13437.86562134366;13521.86478135206;13975.580732578039;10887.782244355227;11069.889301106887;11083.944580277048;11507.712307192387;11596.94201528987;9943.602255909971;10327.690169294632;11327.465278467827;11574.537018519502;11581.189316747746 15:10:42 INFO - PROCESS | 1649 | __end_tp_report 15:10:42 INFO - PROCESS | 1649 | __start_cc_report 15:10:42 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,374 15:10:42 INFO - PROCESS | 1649 | __end_cc_report 15:10:42 INFO - PROCESS | 1649 | __startTimestamp1481497842832__endTimestamp 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | ------- Summary: start ------- 15:10:42 INFO - PROCESS | 1649 | Number of tests: 6 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5620.40 Median:5895.47 stddev:683.60 (11.6%) stddev-sans-first:656.06 15:10:42 INFO - PROCESS | 1649 | Values: 3082.5 3317.6 3326.4 3337.1 3389.8 5524.5 5560.2 5592.0 5596.6 5604.4 5502.9 5578.4 5629.3 5644.1 5651.9 4183.9 5116.5 5124.8 5177.5 5190.5 5113.9 5188.3 5204.8 5219.9 5232.0 4299.2 5188.4 5188.7 5206.9 5232.4 5140.2 5182.8 5184.2 5194.6 5212.3 5056.3 5151.6 5152.7 5155.5 5181.0 5475.4 5519.1 5530.3 5552.6 5639.6 4979.7 5952.8 5983.2 5985.7 5997.1 6088.2 6113.1 6128.8 6130.2 6178.3 5649.7 5677.4 5688.8 5753.7 5789.5 6216.9 6238.9 6263.1 6302.9 6325.2 5917.0 5923.7 6059.3 6065.8 6097.0 6107.0 6112.7 6154.9 6209.2 6250.8 6117.8 6173.6 6175.1 6182.7 6198.7 6044.6 6127.7 6139.2 6154.2 6202.1 3836.6 4231.6 4240.5 4405.2 4632.4 4258.6 4371.2 4406.9 4407.5 4421.1 5769.7 5774.7 5785.5 5841.2 5894.9 5044.5 5049.7 6119.6 6131.2 6183.9 5792.8 5795.9 5807.1 5813.2 5845.9 5262.2 5320.9 5349.9 5351.1 5376.6 5149.5 6123.8 6140.6 6221.7 6245.9 6178.4 6188.7 6218.2 6228.6 6235.2 6160.9 6253.0 6267.0 6275.0 6289.3 6024.4 6114.8 6115.8 6118.4 6122.0 6127.9 6147.4 6158.7 6173.0 6173.5 4896.6 5283.2 5895.5 6053.5 6070.3 6087.0 6107.8 6117.1 6118.2 6129.0 5764.7 5906.0 5934.7 5936.3 5947.0 5945.0 5970.6 6016.9 6063.1 6125.3 5914.5 5919.5 5931.6 5931.9 5937.7 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:66110.69 Median:18079.32 stddev:144021.29 (796.6%) stddev-sans-first:144340.96 15:10:42 INFO - PROCESS | 1649 | Values: 461.0 486.3 492.2 521.3 524.8 37736.8 39250.0 39274.0 39308.0 39351.2 39697.0 40233.0 40281.0 40381.0 40399.6 8392.6 8655.1 9240.3 9521.2 9523.0 11105.1 11437.5 11441.2 11629.4 11632.5 11431.3 11477.5 11494.2 11540.5 11551.3 11367.6 11426.3 11426.7 11443.9 11453.4 11161.5 11238.4 11241.6 11246.8 11259.7 32974.8 38803.8 38894.4 39025.8 39133.2 3101.1 3126.8 3249.9 3506.3 3665.0 27488.9 28035.9 28068.6 28226.7 28723.9 2670.6 3148.4 3178.5 3189.8 3251.2 484005.0 487940.0 490422.5 491404.0 493207.5 54576.0 54771.0 55091.9 55209.0 55216.4 50341.2 56287.4 56536.0 57422.0 57523.7 14745.4 14906.0 14988.2 14994.8 15005.5 9574.8 10573.4 10873.6 11770.5 11872.9 15626.7 15679.1 16913.5 17164.9 17291.8 5811.8 7406.0 7593.0 7634.6 7647.6 749.9 974.5 976.0 992.6 1011.4 28944.7 29137.6 29604.1 29896.7 30047.1 1038.1 1040.0 1040.9 1092.7 1145.5 15138.3 15398.0 15399.9 15433.4 15503.9 588649.0 629269.0 631194.0 641196.6 641924.0 57594.0 58244.7 58287.7 58328.8 58401.0 1330.0 1367.1 1383.9 1389.6 1391.6 29141.4 29147.7 29447.3 29852.7 29989.7 49138.8 49333.8 49894.5 49908.0 50089.5 483865.0 484824.0 487632.0 493133.0 498345.0 24642.0 25039.7 25161.2 26149.2 29146.9 30126.7 40131.0 40288.8 40626.0 43444.8 27868.7 32907.5 35071.0 36109.6 36492.6 34833.8 35637.8 35940.9 36119.6 36832.0 24772.9 34369.9 34867.7 35100.3 35495.3 29836.9 30852.0 30977.7 30994.7 31013.2 23511.5 23923.8 24024.5 24025.4 24103.6 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:32569.74 Median:24807.94 stddev:90719.84 (365.7%) stddev-sans-first:90942.03 15:10:42 INFO - PROCESS | 1649 | Values: 326.2 364.7 373.7 382.3 401.9 18375.3 18700.3 18831.0 19298.1 19503.0 17940.7 18175.5 18278.3 18580.9 20058.0 5630.2 5787.4 5884.3 5993.3 6001.9 5710.2 5889.4 5934.6 5936.9 5938.7 5695.4 5753.4 5867.8 5887.1 5903.2 5765.9 5820.3 5863.9 5874.9 5893.7 5061.3 5068.4 5112.9 5156.4 5172.1 24482.6 24736.6 24750.8 24865.1 25044.5 1966.2 2258.8 2352.0 2353.1 2996.9 10097.2 10174.9 10408.0 10438.2 10560.6 1789.0 1827.4 1903.4 1911.8 1918.7 108394.5 110159.0 113966.9 114984.0 116114.0 11220.7 11245.0 11336.8 11435.9 11485.4 11830.9 14434.3 14569.3 14573.9 14583.1 6391.7 8090.1 8194.4 8221.2 8409.2 8050.0 8065.7 8069.4 8174.6 8209.8 4032.8 4358.3 4386.7 4601.1 4660.5 1688.9 1727.8 1823.3 1959.9 1961.3 838.8 889.4 918.5 943.2 981.6 17707.6 19386.4 20603.6 20716.1 20730.6 783.0 818.7 835.0 862.6 878.5 10324.5 10581.2 11188.8 11207.6 11474.9 492611.0 546304.0 554403.0 554549.0 563940.0 99520.0 105544.0 115979.0 124682.4 127324.0 896.3 997.8 1071.4 1074.0 1079.6 18509.7 18749.7 18926.8 19171.5 19188.0 49888.8 53313.2 54352.0 54650.7 54866.0 66710.0 69776.9 70395.0 78838.0 84841.7 6996.6 7783.4 8022.5 8024.9 8189.5 9010.4 12071.6 12538.1 12550.4 12562.7 9331.7 10428.0 10509.7 10628.9 10938.2 10047.5 10115.9 10406.2 10718.4 10846.7 10726.5 10852.3 10894.5 11089.7 11219.8 6782.3 7220.9 7223.9 7410.3 8167.8 9552.7 10890.3 11167.5 11170.9 11198.6 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5282.40 Median:5435.93 stddev:2837.41 (52.2%) stddev-sans-first:2830.61 15:10:42 INFO - PROCESS | 1649 | Values: 1431.9 1490.5 1709.8 1766.5 1785.4 7438.2 7701.9 7836.3 8321.9 8331.9 7742.8 8105.0 8122.1 8130.9 8139.8 2255.4 2311.5 2317.9 2320.7 2328.4 2301.0 2337.8 2346.1 2351.8 2355.2 2262.0 2284.9 2314.0 2320.1 2324.7 2243.7 2275.1 2276.7 2281.5 2281.8 2308.1 2325.7 2327.1 2329.7 2337.9 6575.2 7124.1 8203.7 8219.7 8225.3 4963.4 5101.1 5130.6 5131.1 5134.1 2880.4 3093.0 3344.8 3441.6 3552.9 959.5 969.2 969.6 1038.7 1056.1 8672.7 10132.1 10178.2 10262.8 10280.7 4476.6 4531.5 4604.5 4638.0 4647.8 9181.9 9260.1 9361.2 9412.9 9419.5 5170.3 5180.3 5180.7 5183.7 5197.6 4214.8 4229.2 4618.7 4655.7 4745.2 3706.6 3770.8 3799.6 3832.3 3859.6 1043.3 1269.3 1273.7 1278.4 1281.3 852.0 866.9 877.4 894.9 924.2 4784.9 5289.3 5443.0 5769.4 5935.4 858.5 871.7 895.3 931.4 960.8 2748.8 3663.5 3902.0 3926.9 3931.0 9472.9 9805.5 9810.8 9826.8 9842.0 9145.6 9612.8 9651.4 9781.8 9793.9 7484.8 7694.0 7706.6 7715.7 7723.8 5322.1 5398.4 5428.9 5635.1 5832.1 8939.6 9197.6 9208.7 9230.5 9239.6 7275.9 8942.6 9051.4 9157.3 9274.2 6495.7 6651.4 6956.1 6987.5 7143.9 6572.9 7786.5 7791.7 7795.0 7834.7 6831.9 6965.0 6970.8 6991.0 7083.2 6886.4 6912.9 6959.6 6962.5 6994.2 5934.9 6130.6 6628.4 6629.5 6638.0 4032.6 4672.0 4749.3 4801.4 4900.5 4730.6 4747.9 4816.6 4869.2 5008.1 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4403.25 Median:4880.17 stddev:1321.37 (27.1%) stddev-sans-first:1289.21 15:10:42 INFO - PROCESS | 1649 | Values: 329.1 345.8 350.3 360.7 369.7 4149.7 4643.8 4730.1 5101.8 5220.9 4863.5 5134.7 5136.6 5173.5 5205.7 3762.6 4045.6 4069.7 4103.5 4106.2 3483.2 3638.9 3821.8 4095.0 4135.8 3529.8 3810.5 4032.3 4046.6 4061.6 3437.7 3559.6 3971.0 4025.8 4032.4 3601.6 3602.0 3603.6 3608.9 3650.2 4428.4 5040.5 5072.1 5079.7 5090.9 4123.4 4604.8 4641.4 4655.4 4661.4 4880.9 5191.5 5501.5 5510.9 5520.4 3305.1 3400.9 3435.9 3758.9 3985.3 5667.9 5698.2 5713.6 5753.7 5763.3 4024.6 4043.3 4054.9 4056.6 4077.2 3958.8 4094.6 4115.8 4129.6 4143.5 4044.7 4601.3 4641.2 4651.3 4654.3 4937.0 5103.8 5440.2 5515.1 5515.8 1089.7 1174.1 1186.3 1234.9 1291.2 888.8 934.9 951.6 957.4 972.0 4338.7 4425.5 4846.1 4903.3 4915.5 4613.6 4618.5 4912.6 5127.4 5319.0 4292.4 4380.8 4830.6 4879.5 4882.0 2507.8 2781.7 2788.7 2792.9 2799.3 4618.7 5070.8 5312.8 5467.6 5581.6 4534.9 5400.3 5457.9 5470.5 5518.6 4878.0 5355.9 5493.5 5518.9 5561.7 4246.6 4616.8 4763.0 5146.3 5356.4 5303.7 5362.9 5628.6 5659.3 5683.6 5240.7 5812.4 5894.2 5910.3 5925.5 3430.6 3777.7 3801.5 3802.1 3820.1 4988.5 5684.8 5695.9 5718.9 5737.0 5517.3 5548.8 5563.6 5581.6 5592.6 5051.8 5260.5 5497.5 5542.4 5563.6 5134.3 5265.5 5287.6 5453.7 5486.9 4679.4 5082.9 5160.9 5362.3 5579.6 4894.5 5073.8 5392.2 5426.9 5456.3 15:10:42 INFO - PROCESS | 1649 | 15:10:42 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:20601.07 Median:23382.34 stddev:30327.75 (129.7%) stddev-sans-first:30375.99 15:10:42 INFO - PROCESS | 1649 | Values: 693.5 711.9 768.4 768.9 792.5 14651.3 15427.0 15446.5 15448.5 15478.6 14192.9 14353.9 14356.0 14357.4 14362.0 687.1 709.8 847.5 867.3 886.2 855.7 856.8 862.4 868.7 870.9 918.2 923.5 930.6 930.7 931.6 920.7 922.1 922.7 923.8 924.3 678.1 685.7 690.3 690.6 690.8 14742.9 15208.8 15297.9 15361.3 15535.0 14099.7 14411.8 14436.7 14444.0 14593.2 11667.0 11693.6 11750.6 11833.9 11860.1 3659.1 3701.5 3721.5 3722.4 3875.6 87665.2 95346.6 103739.5 106504.0 117522.0 8151.1 10307.6 10920.1 10931.2 10940.2 23130.0 23225.4 23271.5 23289.4 23322.0 7532.9 7636.4 7688.3 7725.8 7877.6 4219.9 4301.2 4359.0 4364.7 4486.7 2892.9 3523.6 3546.2 3580.4 3580.7 580.8 623.2 634.2 635.7 654.1 580.7 623.9 659.6 660.8 680.9 8861.5 9213.7 9250.2 9400.4 9483.7 549.3 626.5 661.7 661.8 681.3 3697.8 3840.3 4430.7 4501.3 4538.8 90642.5 110452.0 112448.4 112508.4 113744.0 97607.5 99374.0 99418.5 100123.0 100543.5 64228.7 79106.6 79626.0 79988.6 81019.0 6337.3 7431.6 8432.6 8768.6 9077.8 39346.2 42544.8 50861.5 50909.0 51617.2 62653.4 69707.0 69887.3 72460.0 72965.6 10794.2 10903.9 11085.1 11168.3 11580.5 11952.7 11983.5 12249.9 13764.0 14629.3 13121.7 13480.7 13558.4 13600.9 14123.4 13075.3 13343.9 13687.7 13702.6 13749.7 12952.3 13280.0 13437.9 13521.9 13975.6 10887.8 11069.9 11083.9 11507.7 11596.9 9943.6 10327.7 11327.5 11574.5 11581.2 15:10:42 INFO - PROCESS | 1649 | -------- Summary: end -------- 15:10:42 INFO - PROCESS | 1649 | 15:10:43 INFO - TEST-INFO | 1649: exit 0 15:10:43 INFO - TEST-OK | dromaeo_css | took 1116640ms 15:10:43 INFO - TEST-START | kraken 15:10:43 INFO - operating with platform_type : mac_ 15:10:43 INFO - Initialising browser for kraken test... 15:10:43 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmplhZT3L/profile http://localhost:49241/getInfo.html) 15:10:46 INFO - PROCESS | 1658 | 2016-12-11 15:10:46.192 plugin-container[1659:10904] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 15:10:46 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:10:46 INFO - PROCESS | 1658 | 2016-12-11 15:10:46.194 plugin-container[1659:10904] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 15:10:46 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:10:46 INFO - PROCESS | 1658 | 2016-12-11 15:10:46.194 plugin-container[1659:10904] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:10:46 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 15:10:46 INFO - PROCESS | 1658 | colorDepth:24 15:10:46 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 15:10:46 INFO - PROCESS | 1658 | __metrics 15:10:46 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 15:10:46 INFO - TEST-INFO | 1658: exit 0 15:10:46 INFO - Browser initialized. 15:10:46 INFO - Running cycle 1/1 for kraken test... 15:10:46 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmplhZT3L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:49 INFO - PROCESS | 1660 | 2016-12-11 15:10:49.445 plugin-container[1661:11022] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x872b, name = 'com.apple.tsm.portname' 15:10:49 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:10:49 INFO - PROCESS | 1660 | 2016-12-11 15:10:49.446 plugin-container[1661:11022] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 15:10:49 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:10:49 INFO - PROCESS | 1660 | 2016-12-11 15:10:49.446 plugin-container[1661:11022] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:10:58 INFO - PROCESS | 1660 | RSS: Main: 237166592 15:10:58 INFO - PROCESS | 1660 | 15:11:01 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) 15:11:02 INFO - PROCESS | 1660 | RSS: Main: 249720832 15:11:02 INFO - PROCESS | 1660 | 15:11:05 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) 15:11:06 INFO - PROCESS | 1660 | RSS: Main: 257208320 15:11:06 INFO - PROCESS | 1660 | 15:11:09 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) 15:11:10 INFO - PROCESS | 1660 | RSS: Main: 259727360 15:11:10 INFO - PROCESS | 1660 | 15:11:12 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) 15:11:13 INFO - PROCESS | 1660 | RSS: Main: 260952064 15:11:13 INFO - PROCESS | 1660 | 15:11:15 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) 15:11:15 INFO - PROCESS | 1660 | RSS: Main: 262627328 15:11:15 INFO - PROCESS | 1660 | 15:11:18 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) 15:11:19 INFO - PROCESS | 1660 | RSS: Main: 268386304 15:11:19 INFO - PROCESS | 1660 | 15:11:22 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) 15:11:23 INFO - PROCESS | 1660 | RSS: Main: 268099584 15:11:23 INFO - PROCESS | 1660 | 15:11:26 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) 15:11:26 INFO - PROCESS | 1660 | RSS: Main: 268132352 15:11:26 INFO - PROCESS | 1660 | 15:11:28 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) 15:11:29 INFO - PROCESS | 1660 | RSS: Main: 267321344 15:11:29 INFO - PROCESS | 1660 | 15:11:31 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) 15:11:31 INFO - PROCESS | 1660 | RSS: Main: 267288576 15:11:31 INFO - PROCESS | 1660 | 15:11:34 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) 15:11:34 INFO - PROCESS | 1660 | RSS: Main: 267325440 15:11:34 INFO - PROCESS | 1660 | 15:11:37 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) 15:11:38 INFO - PROCESS | 1660 | RSS: Main: 267591680 15:11:38 INFO - PROCESS | 1660 | 15:11:41 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) 15:11:42 INFO - PROCESS | 1660 | RSS: Main: 267587584 15:11:42 INFO - PROCESS | 1660 | 15:11:43 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) 15:11:44 INFO - PROCESS | 1660 | RSS: Main: 268677120 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | __start_tp_report 15:11:44 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 15:11:44 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 15:11:44 INFO - PROCESS | 1660 | |i|pagename|runs| 15:11:44 INFO - PROCESS | 1660 | |0;ai-astar;117;121;120;118;119;118;117;119;120;158 15:11:44 INFO - PROCESS | 1660 | |1;audio-beat-detection;149;118;144;187;108;137;150;141;122;135 15:11:44 INFO - PROCESS | 1660 | |2;audio-dft;201;213;208;237;274;260;194;200;265;269 15:11:44 INFO - PROCESS | 1660 | |3;audio-fft;86;59;60;83;63;62;60;71;98;82 15:11:44 INFO - PROCESS | 1660 | |4;audio-oscillator;86;64;79;74;61;105;119;103;102;85 15:11:44 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;108;111;110;132;166;172;115;113;110;110 15:11:44 INFO - PROCESS | 1660 | |6;imaging-darkroom;95;101;96;96;96;96;108;153;153;96 15:11:44 INFO - PROCESS | 1660 | |7;imaging-desaturate;92;93;92;92;102;93;93;95;91;90 15:11:44 INFO - PROCESS | 1660 | |8;json-parse-financial;58;58;59;58;56;64;79;90;89;57 15:11:44 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;69;84;116;93;71;71;88;98;90;72 15:11:44 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;86;91;93;90;89;88;93;108;91;87 15:11:44 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;149;162;148;150;182;188;150;149;222;133 15:11:44 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;182;181;218;242;240;186;179;177;184;187 15:11:44 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;69;71;67;66;68;68;69;67;65 15:11:44 INFO - PROCESS | 1660 | __end_tp_report 15:11:44 INFO - PROCESS | 1660 | __start_cc_report 15:11:44 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,959 15:11:44 INFO - PROCESS | 1660 | __end_cc_report 15:11:44 INFO - PROCESS | 1660 | __startTimestamp1481497904171__endTimestamp 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | ------- Summary: start ------- 15:11:44 INFO - PROCESS | 1660 | Number of tests: 14 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:122.70 Median:119.50 stddev:12.47 (10.4%) stddev-sans-first:13.06 15:11:44 INFO - PROCESS | 1660 | Values: 117.0 121.0 120.0 118.0 119.0 118.0 117.0 119.0 120.0 158.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:142.50 stddev:21.77 (15.3%) stddev-sans-first:22.79 15:11:44 INFO - PROCESS | 1660 | Values: 149.0 118.0 144.0 187.0 108.0 137.0 150.0 141.0 122.0 135.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:232.10 Median:248.50 stddev:32.31 (13.0%) stddev-sans-first:32.25 15:11:44 INFO - PROCESS | 1660 | Values: 201.0 213.0 208.0 237.0 274.0 260.0 194.0 200.0 265.0 269.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:72.40 Median:76.50 stddev:13.87 (18.1%) stddev-sans-first:13.81 15:11:44 INFO - PROCESS | 1660 | Values: 86.0 59.0 60.0 83.0 63.0 62.0 60.0 71.0 98.0 82.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:69.00 stddev:19.05 (27.6%) stddev-sans-first:20.19 15:11:44 INFO - PROCESS | 1660 | Values: 86.0 64.0 79.0 74.0 61.0 105.0 119.0 103.0 102.0 85.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:124.70 Median:114.00 stddev:24.36 (21.4%) stddev-sans-first:25.08 15:11:44 INFO - PROCESS | 1660 | Values: 108.0 111.0 110.0 132.0 166.0 172.0 115.0 113.0 110.0 110.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:96.00 stddev:23.52 (24.5%) stddev-sans-first:24.39 15:11:44 INFO - PROCESS | 1660 | Values: 95.0 101.0 96.0 96.0 96.0 96.0 108.0 153.0 153.0 96.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:92.50 stddev:3.33 (3.6%) stddev-sans-first:3.50 15:11:44 INFO - PROCESS | 1660 | Values: 92.0 93.0 92.0 92.0 102.0 93.0 93.0 95.0 91.0 90.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:61.50 stddev:13.72 (22.3%) stddev-sans-first:14.18 15:11:44 INFO - PROCESS | 1660 | Values: 58.0 58.0 59.0 58.0 56.0 64.0 79.0 90.0 89.0 57.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:85.20 Median:86.00 stddev:15.08 (17.5%) stddev-sans-first:14.81 15:11:44 INFO - PROCESS | 1660 | Values: 69.0 84.0 116.0 93.0 71.0 71.0 88.0 98.0 90.0 72.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:90.50 stddev:6.22 (6.9%) stddev-sans-first:6.26 15:11:44 INFO - PROCESS | 1660 | Values: 86.0 91.0 93.0 90.0 89.0 88.0 93.0 108.0 91.0 87.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:163.30 Median:156.00 stddev:26.50 (17.0%) stddev-sans-first:27.60 15:11:44 INFO - PROCESS | 1660 | Values: 149.0 162.0 148.0 150.0 182.0 188.0 150.0 149.0 222.0 133.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.60 Median:186.50 stddev:25.62 (13.7%) stddev-sans-first:26.54 15:11:44 INFO - PROCESS | 1660 | Values: 182.0 181.0 218.0 242.0 240.0 186.0 179.0 177.0 184.0 187.0 15:11:44 INFO - PROCESS | 1660 | 15:11:44 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.73 (2.5%) stddev-sans-first:1.79 15:11:44 INFO - PROCESS | 1660 | Values: 69.0 69.0 71.0 67.0 66.0 68.0 68.0 69.0 67.0 65.0 15:11:44 INFO - PROCESS | 1660 | -------- Summary: end -------- 15:11:44 INFO - PROCESS | 1660 | 15:11:45 INFO - TEST-INFO | 1660: exit 0 15:11:45 INFO - TEST-OK | kraken | took 61575ms 15:11:45 INFO - SUITE-END | took 1178s 15:11:45 INFO - Completed test suite (00:19:38) 15:11:45 INFO - javascript benchmark 15:11:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7081.819769006354, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.506798912174, 3317.6018877734678, 3326.4345061339586, 3337.149026998115, 3389.796612203267, 5524.502794748471, 5560.249366335549, 5592.049351610226, 5596.58025648077, 5604.439556044394, 5502.944970550293, 5578.44215578442, 5629.296337957755, 5644.125160600103, 5651.886962260753, 4183.853565125221, 5116.488351164891, 5124.820631277906, 5177.48225177483, 5190.455002224769, 5113.872153196163, 5188.299579556749, 5204.817831375903, 5219.947800521984, 5232.0, 4299.226139294926, 5188.403333616626, 5188.714620695879, 5206.947930520703, 5232.372115346164, 5140.203268493371, 5182.792688292501, 5184.248283998799, 5194.610404219679, 5212.270282160501, 5056.342675452168, 5151.639385243035, 5152.690838549699, 5155.458676838953, 5180.974095129538, 5475.397706252309, 5519.089350257203, 5530.253415788858, 5552.583556233259, 5639.577031722637, 4979.680384698058, 5952.791652292192, 5983.1623572699855, 5985.670788106652, 5997.100434934751, 6088.238970128734, 6113.052476866093, 6128.8086916200045, 6130.184124957599, 6178.258608966908, 5649.717514124277, 5677.3754886962815, 5688.772449102031, 5753.683547404849, 5789.536837052983, 6216.906746398808, 6238.875222495615, 6263.060540918898, 6302.936970630327, 6325.177726895567, 5916.970415147983, 5923.733431995571, 6059.272887253558, 6065.787697430569, 6096.969515152485, 6107.037103281127, 6112.694365281718, 6154.876902461926, 6209.161763161916, 6250.781222657185, 6117.84705382369, 6173.629582225081, 6175.104609831549, 6182.6599537025895, 6198.659073750987, 6044.576879618385, 6127.6936153193055, 6139.171211886338, 6154.230721159855, 6202.131701561785, 3836.5971572984995, 4231.640310573574, 4240.533541310453, 4405.207062728739, 4632.351470794091, 4258.61672449481, 4371.191329604034, 4406.889827754268, 4407.493138289074, 4421.071574969293, 5769.711514424262, 5774.68239246837, 5785.4793068623185, 5841.153032810219, 5894.8821023579285, 5044.495550444926, 5049.747512624354, 6119.624418755179, 6131.162586540582, 6183.876322473526, 5792.797252096157, 5795.8551036224435, 5807.128930660435, 5813.215215945877, 5845.88308233833, 5262.158054711228, 5320.893582128336, 5349.86625334362, 5351.117065684119, 5376.596755243372, 5149.459306772735, 6123.755049797958, 6140.5701600887505, 6221.657808820558, 6245.937540624535, 6178.351273116258, 6188.690565471798, 6218.160548326099, 6228.626282423069, 6235.189425374672, 6160.9383906160365, 6253.030780229072, 6267.0, 6274.968625156845, 6289.27673317556, 6024.3975602439405, 6114.785982490592, 6115.755369785159, 6118.449339559461, 6121.969390153021, 6127.908081378872, 6147.354527774519, 6158.722857471335, 6173.043178307369, 6173.536984726254, 4896.632752543503, 5283.233931080049, 5895.469407753323, 6053.545984051302, 6070.301915279622, 6087.0, 6107.786227482017, 6117.143599895929, 6118.235220597426, 6129.0, 5764.654120752768, 5905.970470147622, 5934.673592952429, 5936.317323507679, 5947.04847224442, 5945.0190718532685, 5970.58205925581, 6016.939830601638, 6063.090536419572, 6125.326214116354, 5914.497267732291, 5919.467247947706, 5931.555133365101, 5931.881362372642, 5937.673427961504], "value": 5575.304878639043, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.97925593348293, 486.27059410883675, 492.15595254139146, 521.3274875410721, 524.8189374665741, 37736.811315943414, 39250.0, 39274.0, 39308.0, 39351.212975740505, 39697.0, 40233.0, 40281.0, 40381.0, 40399.59600403995, 8392.580370981457, 8655.134486551326, 9240.306976976737, 9521.190698790611, 9522.952385238099, 11105.111591072735, 11437.542498300058, 11441.199116061878, 11629.360385178812, 11632.476538555786, 11431.256968297075, 11477.540898364055, 11494.195406321562, 11540.538378464851, 11551.30692158469, 11367.602133925315, 11426.257293275952, 11426.657200284004, 11443.885561144449, 11453.37006464644, 11161.497732602053, 11238.381888996102, 11241.606543771011, 11246.831297530543, 11259.662210133709, 32974.83512582446, 38803.805980970195, 38894.41658375126, 39025.80487097575, 39133.21733565313, 3101.0696790962847, 3126.7654925880424, 3249.862548108143, 3506.2636846262317, 3665.0, 27488.900443982217, 28035.878564857383, 28068.578971315448, 28226.717732822613, 28723.85638071817, 2670.5994100884827, 3148.370325934822, 3178.523221516768, 3189.776715629907, 3251.1872031992, 484005.0, 487940.0, 490422.54788726184, 491404.0, 493207.5339623315, 54576.0, 54771.0, 55091.89816203734, 55209.0, 55216.44783552193, 50341.23805666784, 56287.43712562904, 56536.0, 57422.0, 57523.71238143783, 14745.410183592536, 14906.0, 14988.175650339117, 14994.775078373834, 15005.499450054907, 9574.808503829885, 10573.418461984666, 10873.619423320146, 11770.470328835223, 11872.940635296942, 15626.68746625061, 15679.137647429501, 16913.492595222164, 17164.914175429043, 17291.82708172902, 5811.82564523065, 7406.0, 7593.012908321883, 7634.580098094658, 7647.617619119022, 749.8762704153862, 974.488393593355, 975.9707208783748, 992.5583115513527, 1011.4487604255551, 28944.7105528942, 29137.56293655597, 29604.111876643736, 29896.701032989826, 30047.098587042423, 1038.1227862456212, 1039.9948000260101, 1040.9375437473775, 1092.7377429416883, 1145.450183911727, 15138.318775655121, 15397.99913005651, 15399.92200545951, 15433.382664693287, 15503.922480387751, 588649.0, 629269.0, 631194.0, 641196.5880341136, 641924.0, 57594.0, 58244.7087764567, 58287.70856145692, 58328.833423332144, 58401.0, 1329.9933500332436, 1367.09771550776, 1383.9377228024764, 1389.5622878793147, 1391.631217727303, 29141.417171656023, 29147.708522914498, 29447.263818403855, 29852.70147298586, 29989.700102999563, 49138.75430622824, 49333.753331233114, 49894.50105499044, 49908.0, 50089.49910500849, 483865.0, 484824.0, 487632.0, 493133.0, 498345.0, 24642.0, 25039.74960250447, 25161.245162644416, 26149.215523534323, 29146.854265728536, 30126.69873301239, 40130.99672508211, 40288.79855600703, 40626.0, 43444.782776085915, 27868.721312786613, 32907.45274509564, 35071.0, 36109.63890361168, 36492.635073648926, 34833.825830870686, 35637.82181089078, 35940.92177234687, 36119.63880361268, 36832.0, 24772.876135619208, 34369.888698287825, 34867.65132348746, 35100.297994040484, 35495.290094198484, 29836.85081574665, 30852.0, 30977.69022309748, 30994.690053100083, 31013.224669383446, 23511.471754335915, 23923.829160822093, 24024.519509610058, 24025.399365016016, 24103.63844542298], "value": 19285.944474576823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.2300969711481, 364.6517575715192, 373.73651575639167, 382.3022983055924, 401.8987972954105, 18375.264989400424, 18700.345487907925, 18831.0, 19298.131584078732, 19503.0, 17940.730889036644, 18175.54561135969, 18278.268869245247, 18580.907095464503, 20057.997100145007, 5630.211770352154, 5787.392323805992, 5884.293884733816, 5993.310769261525, 6001.939980600204, 5710.229119068914, 5889.381614930414, 5934.5845790794665, 5936.910946335808, 5938.732757025922, 5695.43375571719, 5753.371349886999, 5867.76528938842, 5887.1463637772495, 5903.2325797646245, 5765.942340576604, 5820.330661973863, 5863.912041319383, 5874.9118763218585, 5893.675847828367, 5061.291419201315, 5068.4171320298265, 5112.923306150411, 5156.432792392834, 5172.146595811687, 24482.632760508608, 24736.628950565755, 24750.752492475025, 24865.129720459696, 25044.49911001788, 1966.2331690640663, 2258.7967082962614, 2351.976480235193, 2353.1411034972284, 2996.895108671186, 10097.192224622013, 10174.898251017468, 10408.0, 10438.217133714927, 10560.577576896992, 1788.9910550447294, 1827.424361326178, 1903.3718872771951, 1911.808819118091, 1918.6834172361544, 108394.45802771015, 110159.0, 113966.86033139729, 114984.0, 116114.0, 11220.66338009861, 11245.044171245372, 11336.829947550794, 11435.94282028601, 11485.425728713531, 11830.88169118315, 14434.278286085653, 14569.344379502947, 14573.854261457249, 14583.125012499284, 6391.744330226739, 8090.069641991128, 8194.385421093442, 8221.17788221173, 8409.20112589303, 8049.9597502013285, 8065.677372905136, 8069.394795390369, 8174.550399728072, 8209.753707388787, 4032.818523166406, 4358.346248062816, 4386.670999675037, 4601.148787474328, 4660.46404663468, 1688.8564472020016, 1727.8185790492068, 1823.334482913727, 1959.8922059286876, 1961.3135402609257, 838.7777239031661, 889.3774357949461, 918.4856480371013, 943.1888575824785, 981.5779214937645, 17707.55731106707, 19386.4184074478, 20603.58792824135, 20716.067776950073, 20730.58538829215, 782.964766585505, 818.7134502924048, 835.0, 862.5902696219246, 878.4597472554333, 10324.535395907202, 10581.206409519316, 11188.776224475629, 11207.599050118735, 11474.885251147549, 492611.0, 546304.0, 554403.0, 554549.0, 563940.0, 99520.00479995253, 105544.0, 115979.0, 124682.37658811829, 127324.0, 896.3277541843618, 997.835357166074, 1071.3732466507024, 1074.0, 1079.6221322537049, 18509.72235416443, 18749.718754218426, 18926.810731892503, 19171.46628269707, 19188.0, 49888.75055624844, 53313.20030199628, 54352.0, 54650.72674636601, 54866.0, 66710.0, 69776.86004129724, 70395.0, 78838.0, 84841.72737409067, 6996.615186164606, 7783.416243781626, 8022.478538894953, 8024.879626805486, 8189.50862948225, 9010.423175944316, 12071.57749478764, 12538.122331436713, 12550.372481376076, 12562.748745024866, 9331.673391431268, 10428.0, 10509.737256568647, 10628.946855265674, 10938.179636527133, 10047.547860346449, 10115.949420252851, 10406.219533535166, 10718.35689858611, 10846.728831779268, 10726.463676815973, 10852.294600850919, 10894.509747061244, 11089.722756931142, 11219.831702524305, 6782.321767823179, 7220.942031520991, 7223.927760722326, 7410.333070023724, 8167.754967350989, 9552.713418597454, 10890.29213101146, 11167.497462614365, 11170.944145279222, 11198.608048718255], "value": 9232.838035479215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.949881754139, 1490.5304828978872, 1709.8204688507706, 1766.5318690546999, 1785.4375871600437, 7438.218987006368, 7701.92298077019, 7836.333911617512, 8321.916780832189, 8331.87502187467, 7742.8451430971345, 8105.027396712403, 8122.0659624143245, 8130.9186908130905, 8139.837203255931, 2255.3684968208886, 2311.5376924615143, 2317.9304620861403, 2320.721513418384, 2328.3946173994714, 2300.9654855177187, 2337.812974961999, 2346.120204923154, 2351.8236132290062, 2355.1639168095335, 2262.0386335807298, 2284.942876428094, 2313.9884300578474, 2320.1299512682745, 2324.6861673674093, 2243.6971008913833, 2275.0672224388086, 2276.702279700571, 2281.5094754627753, 2281.828862835294, 2308.1459859851793, 2325.744168141503, 2327.057541695616, 2329.7087864017, 2337.8778186470417, 6575.210974683068, 7124.14510258767, 8203.71287004952, 8219.712310069119, 8225.300849427806, 4963.40439147301, 5101.132807422747, 5130.640855140142, 5131.1277082895995, 5134.101532231844, 2880.3663194097267, 3093.0, 3344.782589131723, 3441.587009558869, 3552.8578856845697, 959.5442164971653, 969.2488321550784, 969.6121551379434, 1038.68839348196, 1056.0864851903125, 8672.739817805414, 10132.138768204712, 10178.23663225261, 10262.794744105076, 10280.74298142545, 4476.552344765498, 4531.524189960007, 4604.493505714368, 4638.0, 4647.767611619473, 9181.862272065924, 9260.073992600686, 9361.204297634777, 9412.858807117898, 9419.529023548796, 5170.276161337416, 5180.300659411007, 5180.6891586504935, 5183.740812959337, 5197.610179236573, 4214.789260536961, 4229.238737027365, 4618.67669263155, 4655.674102812771, 4745.193317136026, 3706.629337066272, 3770.792606406619, 3799.639034291793, 3832.3485007548784, 3859.5754467008605, 1043.2540733375522, 1269.2891980490954, 1273.6815796050987, 1278.401997503121, 1281.2888846689991, 851.9957400212959, 866.9176428239307, 877.3551439691821, 894.9284057275403, 924.246738907788, 4784.904301914012, 5289.259503669489, 5443.0, 5769.423057694281, 5935.436133567304, 858.5106489301038, 871.7079778274349, 895.3329769321897, 931.3945935142211, 960.7550074730899, 2748.7800975921878, 3663.505426767352, 3901.9609803902167, 3926.8612102489956, 3931.036895960508, 9472.857907131398, 9805.509724513746, 9810.80378392428, 9826.75433114178, 9842.015798420243, 9145.634174633073, 9612.75968100803, 9651.420914745138, 9781.804363912683, 9793.90206097944, 7484.775456736306, 7694.0, 7706.576138312446, 7715.691372345155, 7723.806904827312, 5322.121849894724, 5398.40617532079, 5428.864278393072, 5635.06305643513, 5832.096025116114, 8939.59771810257, 9197.586108624993, 9208.723738287863, 9230.492322922304, 9239.584218710308, 7275.890861636974, 8942.552872356486, 9051.366404351633, 9157.267418606361, 9274.165325120772, 6495.707693153725, 6651.4013738761805, 6956.130483689539, 6987.545809522569, 7143.9285607143265, 6572.901406478811, 7786.532808031537, 7791.727289544839, 7794.986651735238, 7834.686612535663, 6831.863362732817, 6965.0, 6970.756023539152, 6991.0, 7083.220845707071, 6886.380225779704, 6912.9284960831155, 6959.582425054513, 6962.512624116263, 6994.160700715946, 5934.9109763354445, 6130.570860039755, 6628.370304821035, 6629.4696424284975, 6638.0, 4032.5765794591143, 4671.976640116778, 4749.335093087039, 4801.423829140525, 4900.534449227318, 4730.621550276039, 4747.8575642730775, 4816.614670826255, 4869.220924652039, 5008.098542262428], "value": 4314.530395803346, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.09827073817746, 345.7804294273137, 350.3186302641362, 360.65917707766164, 369.70423661071135, 4149.709520333574, 4643.767811609415, 4730.148573256813, 5101.78072538446, 5220.921686174705, 4863.495299920543, 5134.7432628368615, 5136.64043516954, 5173.508516690908, 5205.739713014353, 3762.6237376262293, 4045.5752146024683, 4069.7354671946227, 4103.528094269167, 4106.240345536085, 3483.1988642612214, 3638.8719496955896, 3821.7961342177127, 4094.9590504094876, 4135.800617820843, 3529.7705649132854, 3810.5236845394325, 4032.3145065338817, 4046.5953404659595, 4061.57353477885, 3437.65623437658, 3559.555055618048, 3971.046948732298, 4025.81883815229, 4032.374981877784, 3601.6398360164035, 3602.0, 3603.5855876574005, 3608.855645774166, 3650.2152037312107, 4428.3800267962515, 5040.521150490697, 5072.061668591323, 5079.720615366154, 5090.9236361454605, 4123.36087906375, 4604.769761511944, 4641.419822522184, 4655.4180727409075, 4661.394018777537, 4880.877978050577, 5191.480851914816, 5501.504864562168, 5510.9448905510835, 5520.392756796749, 3305.0910999475095, 3400.863965441379, 3435.914102147441, 3758.9436158457647, 3985.2826491231567, 5667.943320566824, 5698.17376480408, 5713.628614140068, 5753.7123143843055, 5763.250777398953, 4024.63778259958, 4043.2722110020477, 4054.918901621951, 4056.634902858698, 4077.225327187825, 3958.762474251554, 4094.63148316647, 4115.789684046448, 4129.607687269705, 4143.544210136883, 4044.716869819143, 4601.263797792337, 4641.234196357631, 4651.279051746985, 4654.25531914892, 4936.975315123402, 5103.826119992423, 5440.17754052389, 5515.145152501369, 5515.751791169407, 1089.7384627689298, 1174.1194104421684, 1186.3415804228737, 1234.9441227750324, 1291.185883833216, 888.7733627924838, 934.8644446555212, 951.6478902806006, 957.4111921168432, 971.9502936828209, 4338.696291259582, 4425.513193548707, 4846.085796110587, 4903.313536104877, 4915.48387419323, 4613.615915225419, 4618.49196588375, 4912.646572755186, 5127.436581442519, 5319.0, 4292.3561465780385, 4380.802863871069, 4830.565249127595, 4879.463259041502, 4882.023595280887, 2507.8213239777274, 2781.735735105162, 2788.721127887195, 2792.933229410222, 2799.2567284061734, 4618.745968971739, 5070.771815268322, 5312.787488500417, 5467.617266791286, 5581.609287349846, 4534.886627834265, 5400.324959380077, 5457.863553411196, 5470.538257784013, 5518.613697041169, 4877.975610121926, 5355.866103347447, 5493.533049690741, 5518.91721624176, 5561.694106824163, 4246.596573325529, 4616.815327386867, 4763.0, 5146.305248791366, 5356.384015838228, 5303.734813259244, 5362.919556206582, 5628.649124210078, 5659.349174844946, 5683.623609820498, 5240.68555886648, 5812.360640329476, 5894.20428242199, 5910.349861515316, 5925.459380561171, 3430.622631510582, 3777.735558510878, 3801.50580424543, 3802.129392308789, 3820.140468394589, 4988.451270360185, 5684.811347631109, 5695.914561281501, 5718.914216286676, 5736.971315143564, 5517.2551705519245, 5548.750306236309, 5563.638363506359, 5581.581381396492, 5592.608517403743, 5051.848444546669, 5260.473952604709, 5497.45025497447, 5542.3903370628395, 5563.638363506359, 5134.255532947776, 5265.4997775211295, 5287.625217443416, 5453.700046497481, 5486.91769623448, 4679.438467383799, 5082.923756143587, 5160.922586161136, 5362.302900622894, 5579.581531385081, 4894.461609222912, 5073.822416215415, 5392.164214546751, 5426.864328391822, 5456.290682211287], "value": 3996.865884939269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.4798900824381, 711.8683043636925, 768.4428789127883, 768.8692922203224, 792.5363662257581, 14651.267436628166, 15427.0, 15446.459373921914, 15448.459303924365, 15478.61303467414, 14192.864570834334, 14353.928230358859, 14356.0, 14357.353919073641, 14362.0, 687.0964681443885, 709.8048036789872, 847.4830353484369, 867.3234876796109, 886.162576365335, 855.7090589199671, 856.755824589992, 862.3920136303891, 868.7393781865446, 870.8824308718337, 918.2378625740653, 923.4551614547415, 930.5579849571467, 930.6556574067605, 931.6273490603745, 920.7329874336501, 922.1101636920404, 922.7324076017946, 923.833709932212, 924.3437159616647, 678.0507289794278, 685.7428464325877, 690.2717632897292, 690.5994523176596, 690.7685925215059, 14742.926285368505, 15208.847911520854, 15297.929144959857, 15361.308741106677, 15535.0, 14099.718005639932, 14411.78382324266, 14436.711265774626, 14443.98892077555, 14593.197374144418, 11667.0, 11693.649190524298, 11750.647480575597, 11833.94083029588, 11860.110491713156, 3659.1218107654236, 3701.5373078365205, 3721.497597824286, 3722.404415293567, 3875.593062728401, 87665.24669506638, 95346.56980145373, 103739.481302593, 106504.0, 117522.0, 8151.057763244491, 10307.639232626821, 10920.12638988879, 10931.222641962035, 10940.234183607072, 23130.0, 23225.419364516023, 23271.534569308857, 23289.41776455568, 23321.95051222699, 7532.8798411616435, 7636.350910172698, 7688.308052275322, 7725.768226953201, 7877.645505952246, 4219.894502637398, 4301.225779359683, 4358.956410435919, 4364.650827933758, 4486.730796152241, 2892.884284628591, 3523.559555055618, 3546.2375589248436, 3580.427131658922, 3580.749347545699, 580.796721147595, 623.2396476298908, 634.2072409488139, 635.6853357588024, 654.1496055128314, 580.6864293281665, 623.8752249550108, 659.610829610532, 660.7588230295908, 680.8502129531495, 8861.512616806138, 9213.748796656135, 9250.167484926389, 9400.388974716621, 9483.715488535356, 549.2585010236229, 626.5050610018126, 661.7419206509466, 661.7716887673745, 681.2744427185032, 3697.8335974881193, 3840.251151025579, 4430.689851710349, 4501.3022981437925, 4538.818447262139, 90642.54678726695, 110452.0, 112448.43775781232, 112508.4374578122, 113744.0, 97607.53588696175, 99374.0, 99418.50290748644, 100123.0, 100543.49728251313, 64228.67885660542, 79106.60446697845, 79626.0, 79988.60034198983, 81019.0, 6337.271213810471, 7431.5912624804, 8432.578371081545, 8768.60541275657, 9077.77305567366, 39346.213075738895, 42544.78727606342, 50861.491385085676, 50908.981820364126, 51617.22574161466, 62653.373466264755, 69707.0, 69887.30112698808, 72460.0, 72965.6351718238, 10794.19043571751, 10903.890961090288, 11085.113190944867, 11168.329900206014, 11580.47269274978, 11952.701182470508, 11983.510023465215, 12249.877501224873, 13764.0, 14629.268536573341, 13121.720567404293, 13480.730385392433, 13558.38987245596, 13600.86399135996, 14123.435062597791, 13075.280859552435, 13343.866561334262, 13687.726245475234, 13702.588922332347, 13749.656258593615, 12952.28762418076, 13280.003999700255, 13437.86562134366, 13521.86478135206, 13975.580732578039, 10887.782244355227, 11069.889301106887, 11083.944580277048, 11507.712307192387, 11596.94201528987, 9943.602255909971, 10327.690169294632, 11327.465278467827, 11574.537018519502, 11581.189316747746], "value": 7367.558755209071, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1653.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 120.0, 118.0, 119.0, 118.0, 117.0, 119.0, 120.0, 158.0], "value": 122.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 144.0, 187.0, 108.0, 137.0, 150.0, 141.0, 122.0, 135.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 213.0, 208.0, 237.0, 274.0, 260.0, 194.0, 200.0, 265.0, 269.0], "value": 232.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 59.0, 60.0, 83.0, 63.0, 62.0, 60.0, 71.0, 98.0, 82.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 64.0, 79.0, 74.0, 61.0, 105.0, 119.0, 103.0, 102.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 110.0, 132.0, 166.0, 172.0, 115.0, 113.0, 110.0, 110.0], "value": 124.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 96.0, 96.0, 96.0, 96.0, 108.0, 153.0, 153.0, 96.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 92.0, 102.0, 93.0, 93.0, 95.0, 91.0, 90.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 58.0, 56.0, 64.0, 79.0, 90.0, 89.0, 57.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 116.0, 93.0, 71.0, 71.0, 88.0, 98.0, 90.0, 72.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 93.0, 90.0, 89.0, 88.0, 93.0, 108.0, 91.0, 87.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 162.0, 148.0, 150.0, 182.0, 188.0, 150.0, 149.0, 222.0, 133.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 218.0, 242.0, 240.0, 186.0, 179.0, 177.0, 184.0, 187.0], "value": 197.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 67.0, 66.0, 68.0, 68.0, 69.0, 67.0, 65.0], "value": 67.9, "unit": "score"}]}]} 15:11:45 INFO - Return code: 0 15:11:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:11:45 ERROR - # TBPL SUCCESS # 15:11:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:45 INFO - 2016-12-11 15:11:45.510 screenresolution[1665:11409] starting screenresolution argv=screenresolution get 15:11:45 INFO - 2016-12-11 15:11:45.513 screenresolution[1665:11409] Display 0: 1600x1200x32@60 15:11:45 INFO - 2016-12-11 15:11:45.519 screenresolution[1666:11412] starting screenresolution argv=screenresolution list 15:11:45 INFO - Available Modes on Display 0 15:11:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:11:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:11:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:11:45 INFO - Intel Iris: 15:11:45 INFO - Chipset Model: Intel Iris 15:11:45 INFO - Type: GPU 15:11:45 INFO - Bus: Built-In 15:11:45 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:45 INFO - Vendor: Intel (0x8086) 15:11:45 INFO - Device ID: 0x0a2e 15:11:45 INFO - Revision ID: 0x0009 15:11:45 INFO - Displays: 15:11:45 INFO - Display: 15:11:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:11:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:45 INFO - Display Serial Number: 1600x1200 60 15:11:45 INFO - Main Display: Yes 15:11:45 INFO - Mirror: Off 15:11:45 INFO - Online: Yes 15:11:45 INFO - Rotation: Supported 15:11:45 INFO - Return code: 0 15:11:45 INFO - Running post-action listener: _resource_record_post_action 15:11:45 INFO - [mozharness: 2016-12-11 23:11:45.763806Z] Finished run-tests step (success) 15:11:45 INFO - Running post-run listener: _resource_record_post_run 15:11:45 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 34415104; Write bytes: 557228032; Read time: 320; Write time: 1693 15:11:45 INFO - TinderboxPrint: CPU usage
54.6% 15:11:45 INFO - TinderboxPrint: I/O read bytes / time
34,415,104 / 320 15:11:45 INFO - TinderboxPrint: I/O write bytes / time
557,228,032 / 1,693 15:11:45 INFO - TinderboxPrint: CPU idle
2,183.7 (45.4%) 15:11:45 INFO - TinderboxPrint: CPU system
969.7 (20.2%) 15:11:45 INFO - TinderboxPrint: CPU user
1,652.4 (34.4%) 15:11:45 INFO - TinderboxPrint: Swap in / out
280,895,488 / 0 15:11:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250358272; Write bytes: 242991104; Read time: 18098; Write time: 406 15:11:45 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 30138880; Write bytes: 302073856; Read time: 288; Write time: 1153 15:11:46 INFO - Running post-run listener: _upload_blobber_files 15:11:46 INFO - Blob upload gear active. 15:11:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:11:46 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 15:11:46 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:11:46 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:11:46 INFO - (blobuploader) - INFO - Open directory for files ... 15:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:47 INFO - (blobuploader) - INFO - Done attempting. 15:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:48 INFO - (blobuploader) - INFO - Done attempting. 15:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:51 INFO - (blobuploader) - INFO - Done attempting. 15:11:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:11:51 INFO - Return code: 0 15:11:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:11:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:11:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/544b18f273d042d97ca9a9ad2278d598c3cb97737ac94285d04ffdbcc43dfcbf9386439c2fda4278d072ffb2f98baad5c0b343690bf0b619cfb3d98e2bc84bc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2efa1758e62be9e48b5164d447ba49657d7ab0b7d06d79e5937a84ef3716aced412a7938b38e76070e33b33c229a28a9ed9634afaa7a680d9ac00f7d7e29ccbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/636be57f0d00819ac764015f8b679edbc0c1b00c3de803da91454efbddf16fdf2b9fab3ca7b2efbc8e7d1479fbe82244029a403fdceb7cf8a7e865f91a9b65a7"} 15:11:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:11:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:11:51 INFO - Contents: 15:11:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/544b18f273d042d97ca9a9ad2278d598c3cb97737ac94285d04ffdbcc43dfcbf9386439c2fda4278d072ffb2f98baad5c0b343690bf0b619cfb3d98e2bc84bc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2efa1758e62be9e48b5164d447ba49657d7ab0b7d06d79e5937a84ef3716aced412a7938b38e76070e33b33c229a28a9ed9634afaa7a680d9ac00f7d7e29ccbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/636be57f0d00819ac764015f8b679edbc0c1b00c3de803da91454efbddf16fdf2b9fab3ca7b2efbc8e7d1479fbe82244029a403fdceb7cf8a7e865f91a9b65a7"} 15:11:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:11:51 INFO - Copying logs to upload dir... 15:11:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:11:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.808136 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-11 15:11:51.472226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:51.475838) ========= 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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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/Firefox/sha512/544b18f273d042d97ca9a9ad2278d598c3cb97737ac94285d04ffdbcc43dfcbf9386439c2fda4278d072ffb2f98baad5c0b343690bf0b619cfb3d98e2bc84bc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2efa1758e62be9e48b5164d447ba49657d7ab0b7d06d79e5937a84ef3716aced412a7938b38e76070e33b33c229a28a9ed9634afaa7a680d9ac00f7d7e29ccbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/636be57f0d00819ac764015f8b679edbc0c1b00c3de803da91454efbddf16fdf2b9fab3ca7b2efbc8e7d1479fbe82244029a403fdceb7cf8a7e865f91a9b65a7"} build_url:https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/dsP0ymRNTPCBegdQJlCuWA/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/544b18f273d042d97ca9a9ad2278d598c3cb97737ac94285d04ffdbcc43dfcbf9386439c2fda4278d072ffb2f98baad5c0b343690bf0b619cfb3d98e2bc84bc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2efa1758e62be9e48b5164d447ba49657d7ab0b7d06d79e5937a84ef3716aced412a7938b38e76070e33b33c229a28a9ed9634afaa7a680d9ac00f7d7e29ccbc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/636be57f0d00819ac764015f8b679edbc0c1b00c3de803da91454efbddf16fdf2b9fab3ca7b2efbc8e7d1479fbe82244029a403fdceb7cf8a7e865f91a9b65a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:51.510115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:51.510442) ========= 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.2qGU4eYgoP/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.LnWBLEAYJo/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 15:11:51.559235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 15:11:51.559570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 15:11:51.559893) ========= ========= Total master_lag: 0.28 =========