builder: jamun_yosemite_r7_devedition_test-dromaeojs-e10s slave: t-yosemite-r7-0281 starttime: 1495706148.07 results: success (0) buildid: 20170524051524 builduid: f7f14b58f9784223a01684a359171c0a revision: 64d1f0c63422a0f1a8ce632fe87d81e744577f52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:48.068905) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:48.070240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-05-25 02:55:48.070528) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-05-25 02:55:49.084956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:49.085432) ========= 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.GgKGDLcVrL/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.45DyFiByE2/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-25 02:55:49-- 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% 69.1M=0s 2017-05-25 02:55:49 (69.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.206925 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:49.319541) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:49.319871) ========= 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.GgKGDLcVrL/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.45DyFiByE2/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.030939 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:49.370768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-25 02:55:49.371396) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev 64d1f0c63422a0f1a8ce632fe87d81e744577f52 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev 64d1f0c63422a0f1a8ce632fe87d81e744577f52 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GgKGDLcVrL/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.45DyFiByE2/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-25 02:55:49,472 truncating revision to first 12 chars 2017-05-25 02:55:49,472 Setting DEBUG logging. 2017-05-25 02:55:49,472 attempt 1/10 2017-05-25 02:55:49,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/64d1f0c63422?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 02:55:51,471 unpacking tar archive at: jamun-64d1f0c63422/testing/mozharness/ program finished with exit code 0 elapsedTime=2.276480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-25 02:55:51.670861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:51.674345) ========= script_repo_revision: 64d1f0c63422a0f1a8ce632fe87d81e744577f52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:51.674796) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:51.675069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 02:55:51.694180) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 23 secs) (at 2017-05-25 02:55:51.694561) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 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', 'Jamun', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Jamun'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GgKGDLcVrL/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.45DyFiByE2/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:55:51 INFO - MultiFileLogger online at 20170525 02:55:51 in /builds/slave/test 02:55:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 02:55:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:51 INFO - {'append_to_log': False, 02:55:51 INFO - 'base_work_dir': '/builds/slave/test', 02:55:51 INFO - 'blob_upload_branch': 'Jamun', 02:55:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:51 INFO - 'branch': 'Jamun', 02:55:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:51 INFO - 'config_files': ('talos/mac_config.py',), 02:55:51 INFO - 'default_actions': ('clobber', 02:55:51 INFO - 'read-buildbot-config', 02:55:51 INFO - 'download-and-extract', 02:55:51 INFO - 'populate-webroot', 02:55:51 INFO - 'create-virtualenv', 02:55:51 INFO - 'install', 02:55:51 INFO - 'run-tests'), 02:55:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:51 INFO - 'download_minidump_stackwalk': True, 02:55:51 INFO - 'download_symbols': 'ondemand', 02:55:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:55:51 INFO - 'tooltool.py': '/tools/tooltool.py', 02:55:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:55:51 INFO - '/tools/misc-python/virtualenv.py')}, 02:55:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:51 INFO - 'gecko_profile': False, 02:55:51 INFO - 'gecko_profile_interval': 0, 02:55:51 INFO - 'installer_path': 'installer.exe', 02:55:51 INFO - 'log_level': 'info', 02:55:51 INFO - 'log_name': 'talos', 02:55:51 INFO - 'log_to_console': True, 02:55:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:55:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:55:51 INFO - 'opt_config_files': (), 02:55:51 INFO - 'pip_index': False, 02:55:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:51 INFO - 'cmd': ('bash', 02:55:51 INFO - '-c', 02:55:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:51 INFO - 'enabled': True, 02:55:51 INFO - 'halt_on_failure': False, 02:55:51 INFO - 'name': 'check_screen_resolution'},), 02:55:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:51 INFO - 'cmd': ('bash', 02:55:51 INFO - '-c', 02:55:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:51 INFO - 'enabled': True, 02:55:51 INFO - 'halt_on_failure': False, 02:55:51 INFO - 'name': 'check_screen_resolution'},), 02:55:51 INFO - 'run_cmd_checks_enabled': True, 02:55:51 INFO - 'suite': 'dromaeojs-e10s', 02:55:51 INFO - 'system_bits': '32', 02:55:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:51 INFO - 'title': 't-yosemite-r7-0281', 02:55:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:51 INFO - 'use_talos_json': True, 02:55:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:51 INFO - 'work_dir': 'build'} 02:55:51 INFO - [mozharness: 2017-05-25 09:55:51.902229Z] Running clobber step. 02:55:51 INFO - Running pre-action listener: _resource_record_pre_action 02:55:51 INFO - Running main action method: clobber 02:55:51 INFO - rmtree: /builds/slave/test/build 02:55:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:54 INFO - Running post-action listener: _resource_record_post_action 02:55:54 INFO - [mozharness: 2017-05-25 09:55:54.293811Z] Finished clobber step (success) 02:55:54 INFO - [mozharness: 2017-05-25 09:55:54.293893Z] Running read-buildbot-config step. 02:55:54 INFO - Running pre-action listener: _resource_record_pre_action 02:55:54 INFO - Running main action method: read_buildbot_config 02:55:54 INFO - Using buildbot properties: 02:55:54 INFO - { 02:55:54 INFO - "project": "", 02:55:54 INFO - "product": "firefox", 02:55:54 INFO - "script_repo_revision": "production", 02:55:54 INFO - "builddir": "jamun_yosemite_r7_devedition_test-dromaeojs-e10s", 02:55:54 INFO - "repository": "", 02:55:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition jamun talos dromaeojs-e10s", 02:55:54 INFO - "buildid": "20170524051524", 02:55:54 INFO - "pgo_build": "False", 02:55:54 INFO - "basedir": "/builds/slave/test", 02:55:54 INFO - "buildnumber": 1, 02:55:54 INFO - "slavename": "t-yosemite-r7-0281", 02:55:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:55:54 INFO - "platform": "yosemite_r7_devedition", 02:55:54 INFO - "scheduler": "tests-jamun-macosx64-devedition-talos", 02:55:54 INFO - "branch": "jamun", 02:55:54 INFO - "repo_path": "projects/jamun", 02:55:54 INFO - "revision": "64d1f0c63422a0f1a8ce632fe87d81e744577f52", 02:55:54 INFO - "stage_platform": "macosx64-devedition", 02:55:54 INFO - "builduid": "f7f14b58f9784223a01684a359171c0a", 02:55:54 INFO - "slavebuilddir": "test" 02:55:54 INFO - } 02:55:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 02:55:54 INFO - Running post-action listener: _resource_record_post_action 02:55:54 INFO - [mozharness: 2017-05-25 09:55:54.297265Z] Finished read-buildbot-config step (success) 02:55:54 INFO - [mozharness: 2017-05-25 09:55:54.297405Z] Running download-and-extract step. 02:55:54 INFO - Running pre-action listener: _resource_record_pre_action 02:55:54 INFO - Running main action method: download_and_extract 02:55:54 INFO - mkdir: /builds/slave/test/build/tests 02:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:54 INFO - trying https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 02:55:54 INFO - Downloading https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 02:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 02:55:55 INFO - Downloaded 1287 bytes. 02:55:55 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 02:55:55 INFO - Using the following test package requirements: 02:55:55 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 02:55:55 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 02:55:55 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 02:55:55 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 02:55:55 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:55:55 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 02:55:55 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 02:55:55 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 02:55:55 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 02:55:55 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 02:55:55 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:55:55 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 02:55:55 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 02:55:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 02:55:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 02:55:55 INFO - Fetch https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 02:55:56 INFO - Expected file size: 51793722 02:55:56 INFO - Obtained file size: 51793722 02:56:12 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 02:56:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 02:56:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 02:56:12 INFO - Fetch https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 02:56:14 INFO - Expected file size: 51793722 02:56:14 INFO - Obtained file size: 51793722 02:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 02:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 02:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 02:56:30 INFO - Expected file size: 14404449 02:56:30 INFO - Obtained file size: 14404449 02:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:30 INFO - trying https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:56:30 INFO - Downloading https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 02:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 02:56:33 INFO - Downloaded 74761390 bytes. 02:56:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:56:33 INFO - mkdir: /builds/slave/test/properties 02:56:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:56:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:56:33 INFO - Contents: 02:56:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:56:33 INFO - Running post-action listener: _resource_record_post_action 02:56:33 INFO - Running post-action listener: set_extra_try_arguments 02:56:33 INFO - [mozharness: 2017-05-25 09:56:33.711474Z] Finished download-and-extract step (success) 02:56:33 INFO - [mozharness: 2017-05-25 09:56:33.711589Z] Running populate-webroot step. 02:56:33 INFO - Running pre-action listener: _resource_record_pre_action 02:56:33 INFO - Running main action method: populate_webroot 02:56:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:56:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:56:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:56:33 INFO - '--tppagecycles', 02:56:33 INFO - '7'], 02:56:33 INFO - 'tests': ['tsvgm']}}, 02:56:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:56:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:56:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:56:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:56:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:56:33 INFO - 'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:56:33 INFO - 'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['damp', 'tps']}, 02:56:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:56:33 INFO - 'tests': ['damp', 'tps']}, 02:56:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['dromaeo_dom']}, 02:56:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:56:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['basic_compositor_video']}, 02:56:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:56:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['a11yr', 02:56:33 INFO - 'ts_paint', 02:56:33 INFO - 'tpaint', 02:56:33 INFO - 'sessionrestore', 02:56:33 INFO - 'sessionrestore_no_auto_restore', 02:56:33 INFO - 'tabpaint']}, 02:56:33 INFO - 'other-e10s': {'tests': ['a11yr', 02:56:33 INFO - 'ts_paint', 02:56:33 INFO - 'tpaint', 02:56:33 INFO - 'sessionrestore', 02:56:33 INFO - 'sessionrestore_no_auto_restore', 02:56:33 INFO - 'tabpaint']}, 02:56:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:56:33 INFO - 'ts_paint', 02:56:33 INFO - 'tpaint', 02:56:33 INFO - 'sessionrestore', 02:56:33 INFO - 'sessionrestore_no_auto_restore', 02:56:33 INFO - 'tabpaint']}, 02:56:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:56:33 INFO - 'ts_paint', 02:56:33 INFO - 'tpaint', 02:56:33 INFO - 'sessionrestore', 02:56:33 INFO - 'sessionrestore_no_auto_restore', 02:56:33 INFO - 'tabpaint']}, 02:56:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['a11yr', 02:56:33 INFO - 'ts_paint', 02:56:33 INFO - 'tpaint', 02:56:33 INFO - 'sessionrestore', 02:56:33 INFO - 'sessionrestore_no_auto_restore', 02:56:33 INFO - 'tabpaint']}, 02:56:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['a11yr', 02:56:33 INFO - 'ts_paint', 02:56:33 INFO - 'tpaint', 02:56:33 INFO - 'sessionrestore', 02:56:33 INFO - 'sessionrestore_no_auto_restore', 02:56:33 INFO - 'tabpaint']}, 02:56:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['tsvgx', 02:56:33 INFO - 'tsvgr_opacity', 02:56:33 INFO - 'tart', 02:56:33 INFO - 'tscrollx', 02:56:33 INFO - 'cart', 02:56:33 INFO - 'tsvg_static']}, 02:56:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:56:33 INFO - 'tsvgr_opacity', 02:56:33 INFO - 'tart', 02:56:33 INFO - 'tscrollx', 02:56:33 INFO - 'cart', 02:56:33 INFO - 'tsvg_static']}, 02:56:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:56:33 INFO - 'talos_options': ['--disable-e10s'], 02:56:33 INFO - 'tests': ['tp5o']}, 02:56:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:56:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:56:33 INFO - 'talos_options': ['--disable-e10s', 02:56:33 INFO - '--xperf_path', 02:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:33 INFO - 'tests': ['tp5n']}, 02:56:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:56:33 INFO - 'talos_options': ['--xperf_path', 02:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:33 INFO - 'tests': ['tp5n']}}, 02:56:33 INFO - 'talos.zip': {'path': '', 02:56:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:56:33 INFO - Running post-action listener: _resource_record_post_action 02:56:33 INFO - [mozharness: 2017-05-25 09:56:33.730167Z] Finished populate-webroot step (success) 02:56:33 INFO - [mozharness: 2017-05-25 09:56:33.730289Z] Running create-virtualenv step. 02:56:33 INFO - Running pre-action listener: _resource_record_pre_action 02:56:33 INFO - Running main action method: create_virtualenv 02:56:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:56:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:56:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:56:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:56:33 INFO - Using real prefix '/tools/python27' 02:56:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:56:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:56:37 INFO - Installing pip.................done. 02:56:37 INFO - Return code: 0 02:56:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:56:37 INFO - Reading from file tmpfile_stdout 02:56:37 INFO - Output received: 02:56:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:56:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:37 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 02:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:37 INFO - 'HOME': '/Users/cltbld', 02:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:37 INFO - 'LOGNAME': 'cltbld', 02:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:37 INFO - 'MOZ_NO_REMOTE': '1', 02:56:37 INFO - 'NO_EM_RESTART': '1', 02:56:37 INFO - 'PAGER': '/bin/cat', 02:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:37 INFO - 'PWD': '/builds/slave/test', 02:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:37 INFO - 'SHELL': '/bin/bash', 02:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 02:56:37 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 02:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:37 INFO - 'USER': 'cltbld', 02:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:37 INFO - 'XPC_FLAGS': '0x0', 02:56:37 INFO - 'XPC_SERVICE_NAME': '0', 02:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:56:37 INFO - Cleaning up... 02:56:37 INFO - Return code: 0 02:56:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:37 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 02:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:37 INFO - 'HOME': '/Users/cltbld', 02:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:37 INFO - 'LOGNAME': 'cltbld', 02:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:37 INFO - 'MOZ_NO_REMOTE': '1', 02:56:37 INFO - 'NO_EM_RESTART': '1', 02:56:37 INFO - 'PAGER': '/bin/cat', 02:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:37 INFO - 'PWD': '/builds/slave/test', 02:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:37 INFO - 'SHELL': '/bin/bash', 02:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 02:56:37 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 02:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:37 INFO - 'USER': 'cltbld', 02:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:37 INFO - 'XPC_FLAGS': '0x0', 02:56:37 INFO - 'XPC_SERVICE_NAME': '0', 02:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:38 INFO - Downloading/unpacking psutil>=3.1.1 02:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:11 INFO - Installing collected packages: psutil 02:59:11 INFO - Running setup.py install for psutil 02:59:11 INFO - building 'psutil._psutil_osx' extension 02:59:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:59:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:59:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:59:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:59:11 INFO - building 'psutil._psutil_posix' extension 02:59:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:59:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:59:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:59:11 INFO - ^ 02:59:11 INFO - 1 warning generated. 02:59:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:59:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:12 INFO - Successfully installed psutil 02:59:12 INFO - Cleaning up... 02:59:12 INFO - Return code: 0 02:59:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:12 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 02:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:12 INFO - 'HOME': '/Users/cltbld', 02:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:12 INFO - 'LOGNAME': 'cltbld', 02:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:12 INFO - 'MOZ_NO_REMOTE': '1', 02:59:12 INFO - 'NO_EM_RESTART': '1', 02:59:12 INFO - 'PAGER': '/bin/cat', 02:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:12 INFO - 'PWD': '/builds/slave/test', 02:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:12 INFO - 'SHELL': '/bin/bash', 02:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 02:59:12 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 02:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:12 INFO - 'USER': 'cltbld', 02:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:12 INFO - 'XPC_FLAGS': '0x0', 02:59:12 INFO - 'XPC_SERVICE_NAME': '0', 02:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:12 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 03:01:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:01:45 INFO - Installing collected packages: mozsystemmonitor 03:01:45 INFO - Running setup.py install for mozsystemmonitor 03:01:45 INFO - Successfully installed mozsystemmonitor 03:01:45 INFO - Cleaning up... 03:01:45 INFO - Return code: 0 03:01:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:01:45 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')]} 03:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:45 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')]} 03:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:47 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:01:47 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 03:01:47 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 03:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:47 INFO - 'HOME': '/Users/cltbld', 03:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:47 INFO - 'LOGNAME': 'cltbld', 03:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:47 INFO - 'MOZ_NO_REMOTE': '1', 03:01:47 INFO - 'NO_EM_RESTART': '1', 03:01:47 INFO - 'PAGER': '/bin/cat', 03:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:47 INFO - 'PWD': '/builds/slave/test', 03:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:47 INFO - 'SHELL': '/bin/bash', 03:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:01:47 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:47 INFO - 'USER': 'cltbld', 03:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:47 INFO - 'XPC_FLAGS': '0x0', 03:01:47 INFO - 'XPC_SERVICE_NAME': '0', 03:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:47 INFO - Downloading/unpacking jsonschema==2.5.1 03:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:04:19 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 03:04:19 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 03:04:19 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 03:04:19 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 03:04:19 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 03:04:19 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 03:06:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:06:50 INFO - warning: no files found matching '*.txt' 03:06:50 INFO - no previously-included directories found matching 'build' 03:06:50 INFO - no previously-included directories found matching 'dist' 03:06:50 INFO - no previously-included directories found matching '.git*' 03:06:50 INFO - Installing collected packages: jsonschema, functools32 03:06:50 INFO - Running setup.py install for functools32 03:06:50 INFO - warning: no files found matching '*.txt' 03:06:50 INFO - no previously-included directories found matching 'build' 03:06:50 INFO - no previously-included directories found matching 'dist' 03:06:50 INFO - no previously-included directories found matching '.git*' 03:06:50 INFO - Successfully installed jsonschema functools32 03:06:50 INFO - Cleaning up... 03:06:50 INFO - Return code: 0 03:06:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:51 INFO - 'HOME': '/Users/cltbld', 03:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:51 INFO - 'LOGNAME': 'cltbld', 03:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:51 INFO - 'MOZ_NO_REMOTE': '1', 03:06:51 INFO - 'NO_EM_RESTART': '1', 03:06:51 INFO - 'PAGER': '/bin/cat', 03:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:51 INFO - 'PWD': '/builds/slave/test', 03:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:51 INFO - 'SHELL': '/bin/bash', 03:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:06:51 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:51 INFO - 'USER': 'cltbld', 03:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:51 INFO - 'XPC_FLAGS': '0x0', 03:06:51 INFO - 'XPC_SERVICE_NAME': '0', 03:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:06:52 INFO - Cleaning up... 03:06:52 INFO - Return code: 0 03:06:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:06:52 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')]} 03:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:52 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')]} 03:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:06:52 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:06:52 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 03:06:52 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 03:06:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:06:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:06:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:06:52 INFO - 'HOME': '/Users/cltbld', 03:06:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:06:52 INFO - 'LOGNAME': 'cltbld', 03:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:52 INFO - 'MOZ_NO_REMOTE': '1', 03:06:52 INFO - 'NO_EM_RESTART': '1', 03:06:52 INFO - 'PAGER': '/bin/cat', 03:06:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:52 INFO - 'PWD': '/builds/slave/test', 03:06:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:06:52 INFO - 'SHELL': '/bin/bash', 03:06:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:06:52 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:06:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:06:52 INFO - 'USER': 'cltbld', 03:06:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:06:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:52 INFO - 'XPC_FLAGS': '0x0', 03:06:52 INFO - 'XPC_SERVICE_NAME': '0', 03:06:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:06:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:06:52 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 03:06:52 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 03:06:52 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 03:06:52 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 03:06:52 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 03:06:52 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 03:09:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:24 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 03:09:24 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 03:09:24 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 03:09:24 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 03:09:24 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 03:09:24 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 03:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:25 INFO - Downloading docopt-0.6.1.tar.gz 03:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:14:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:14:26 INFO - Running setup.py install for blobuploader 03:14:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:14:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:14:26 INFO - Running setup.py install for requests 03:14:26 INFO - Running setup.py install for docopt 03:14:26 INFO - Successfully installed blobuploader requests docopt 03:14:26 INFO - Cleaning up... 03:14:26 INFO - Return code: 0 03:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:27 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:14:27 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 03:14:27 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 03:14:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:14:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:27 INFO - 'HOME': '/Users/cltbld', 03:14:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:27 INFO - 'LOGNAME': 'cltbld', 03:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:27 INFO - 'MOZ_NO_REMOTE': '1', 03:14:27 INFO - 'NO_EM_RESTART': '1', 03:14:27 INFO - 'PAGER': '/bin/cat', 03:14:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:27 INFO - 'PWD': '/builds/slave/test', 03:14:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:27 INFO - 'SHELL': '/bin/bash', 03:14:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:14:27 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:14:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:27 INFO - 'USER': 'cltbld', 03:14:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:27 INFO - 'XPC_FLAGS': '0x0', 03:14:27 INFO - 'XPC_SERVICE_NAME': '0', 03:14:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:14:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-f6u59t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-0Y_NRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ARqwaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-5Etc8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-9LMVJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Y9x1eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-PdFEd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-M9lIIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-eYWSCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-vyR745-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:14:28 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-fGg8EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:14:29 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ooPZmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:14:29 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-xA6GfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:14:29 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-regFbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:29 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-NwakWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:14:29 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ONm3Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:14:29 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-d2IhoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:14:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:14:29 INFO - Running setup.py install for manifestparser 03:14:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:14:29 INFO - Running setup.py install for mozcrash 03:14:29 INFO - Running setup.py install for mozdebug 03:14:30 INFO - Running setup.py install for mozdevice 03:14:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for mozfile 03:14:30 INFO - Running setup.py install for mozhttpd 03:14:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for mozinfo 03:14:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for mozInstall 03:14:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:14:30 INFO - Running setup.py install for mozleak 03:14:31 INFO - Running setup.py install for mozlog 03:14:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:14:31 INFO - Running setup.py install for moznetwork 03:14:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:14:31 INFO - Running setup.py install for mozprocess 03:14:31 INFO - Running setup.py install for mozprofile 03:14:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:14:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:14:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:14:31 INFO - Running setup.py install for mozrunner 03:14:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:14:31 INFO - Running setup.py install for mozscreenshot 03:14:31 INFO - Running setup.py install for moztest 03:14:32 INFO - Running setup.py install for mozversion 03:14:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:14:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:14:32 INFO - Cleaning up... 03:14:32 INFO - Return code: 0 03:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14:32 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')]} 03:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:32 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')]} 03:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:32 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:14:32 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 03:14:32 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 03:14:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:14:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:32 INFO - 'HOME': '/Users/cltbld', 03:14:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:32 INFO - 'LOGNAME': 'cltbld', 03:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:32 INFO - 'MOZ_NO_REMOTE': '1', 03:14:32 INFO - 'NO_EM_RESTART': '1', 03:14:32 INFO - 'PAGER': '/bin/cat', 03:14:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:32 INFO - 'PWD': '/builds/slave/test', 03:14:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:32 INFO - 'SHELL': '/bin/bash', 03:14:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:14:32 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:14:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:32 INFO - 'USER': 'cltbld', 03:14:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:32 INFO - 'XPC_FLAGS': '0x0', 03:14:32 INFO - 'XPC_SERVICE_NAME': '0', 03:14:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:14:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-sFVlrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:14:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-1KUNYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:14:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-KzMWSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:14:32 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)) 03:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:14:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-FfJ7uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-c5zlr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-1Ccs7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-zWVdjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-eCcxig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-JO3ZxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-MxG65A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-k0Zytf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:14:33 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-prQ1kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:14:33 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-QsyqOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:14:34 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)) 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:14:34 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-yFJCjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:14:34 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)) 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:34 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-P3lgzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:34 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)) 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:14:34 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Yq1rhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:14:34 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-TGSp8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:14:34 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)) 03:14:34 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)) 03:14:34 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)) 03:14:34 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)) 03:14:34 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)) 03:14:34 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)) 03:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:14:34 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 03:14:34 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 03:14:34 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 03:14:34 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 03:14:34 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 03:14:34 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 03:17:07 INFO - Downloading blessings-1.6.tar.gz 03:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:07 INFO - Installing collected packages: blessings 03:17:07 INFO - Running setup.py install for blessings 03:17:07 INFO - Successfully installed blessings 03:17:07 INFO - Cleaning up... 03:17:07 INFO - Return code: 0 03:17:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:07 INFO - Reading from file tmpfile_stdout 03:17:07 INFO - Current package versions: 03:17:07 INFO - blessings == 1.6 03:17:07 INFO - blobuploader == 1.2.4 03:17:07 INFO - docopt == 0.6.1 03:17:07 INFO - functools32 == 3.2.3-2 03:17:07 INFO - jsonschema == 2.5.1 03:17:07 INFO - manifestparser == 1.1 03:17:07 INFO - mozInstall == 1.12 03:17:07 INFO - mozcrash == 1.0 03:17:07 INFO - mozdebug == 0.1 03:17:07 INFO - mozdevice == 0.49 03:17:07 INFO - mozfile == 1.2 03:17:07 INFO - mozhttpd == 0.7 03:17:07 INFO - mozinfo == 0.9 03:17:07 INFO - mozleak == 0.1 03:17:07 INFO - mozlog == 3.4 03:17:07 INFO - moznetwork == 0.27 03:17:07 INFO - mozprocess == 0.25 03:17:07 INFO - mozprofile == 0.28 03:17:07 INFO - mozrunner == 6.13 03:17:07 INFO - mozscreenshot == 0.1 03:17:07 INFO - mozsystemmonitor == 0.3 03:17:07 INFO - moztest == 0.8 03:17:07 INFO - mozversion == 1.4 03:17:07 INFO - psutil == 3.1.1 03:17:07 INFO - requests == 1.2.3 03:17:07 INFO - wsgiref == 0.1.2 03:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:07 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')]} 03:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:07 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')]} 03:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:08 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:17:08 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 03:17:08 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 03:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:08 INFO - 'HOME': '/Users/cltbld', 03:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:08 INFO - 'LOGNAME': 'cltbld', 03:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:08 INFO - 'MOZ_NO_REMOTE': '1', 03:17:08 INFO - 'NO_EM_RESTART': '1', 03:17:08 INFO - 'PAGER': '/bin/cat', 03:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:08 INFO - 'PWD': '/builds/slave/test', 03:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:08 INFO - 'SHELL': '/bin/bash', 03:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:17:08 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:08 INFO - 'USER': 'cltbld', 03:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:08 INFO - 'XPC_FLAGS': '0x0', 03:17:08 INFO - 'XPC_SERVICE_NAME': '0', 03:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 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)) 03:17:08 INFO - Cleaning up... 03:17:08 INFO - Return code: 0 03:17:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:08 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 0x1039e5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8794a6e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, '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.GgKGDLcVrL/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.45DyFiByE2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 03:17:08 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 03:17:08 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 03:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:08 INFO - 'HOME': '/Users/cltbld', 03:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:08 INFO - 'LOGNAME': 'cltbld', 03:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:08 INFO - 'MOZ_NO_REMOTE': '1', 03:17:08 INFO - 'NO_EM_RESTART': '1', 03:17:08 INFO - 'PAGER': '/bin/cat', 03:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:08 INFO - 'PWD': '/builds/slave/test', 03:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:08 INFO - 'SHELL': '/bin/bash', 03:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:17:08 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:08 INFO - 'USER': 'cltbld', 03:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:08 INFO - 'XPC_FLAGS': '0x0', 03:17:08 INFO - 'XPC_SERVICE_NAME': '0', 03:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:09 INFO - Cleaning up... 03:17:09 INFO - Return code: 0 03:17:09 INFO - Running post-action listener: _resource_record_post_action 03:17:09 INFO - Running post-action listener: _start_resource_monitoring 03:17:09 INFO - Starting resource monitoring. 03:17:09 INFO - [mozharness: 2017-05-25 10:17:09.240907Z] Finished create-virtualenv step (success) 03:17:09 INFO - [mozharness: 2017-05-25 10:17:09.241857Z] Running install step. 03:17:09 INFO - Running pre-action listener: _resource_record_pre_action 03:17:09 INFO - Running main action method: install 03:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:09 INFO - Reading from file tmpfile_stdout 03:17:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:09 INFO - Reading from file tmpfile_stdout 03:17:09 INFO - Output received: 03:17:09 INFO - Usage: mozinstall [options] installer 03:17:09 INFO - Options: 03:17:09 INFO - -h, --help show this help message and exit 03:17:09 INFO - -d DEST, --destination=DEST 03:17:09 INFO - Directory to install application into. [default: 03:17:09 INFO - "/builds/slave/test"] 03:17:09 INFO - --app=APP Application being installed. [default: firefox] 03:17:09 INFO - mkdir: /builds/slave/test/build/application 03:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:17:29 INFO - Reading from file tmpfile_stdout 03:17:29 INFO - Output received: 03:17:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:17:29 INFO - Running post-action listener: _resource_record_post_action 03:17:29 INFO - [mozharness: 2017-05-25 10:17:29.517338Z] Finished install step (success) 03:17:29 INFO - [mozharness: 2017-05-25 10:17:29.517526Z] Running run-tests step. 03:17:29 INFO - Running pre-action listener: _resource_record_pre_action 03:17:29 INFO - Running main action method: run_tests 03:17:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:17:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:17:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:17:29 INFO - 2017-05-25 03:17:29.532 screenresolution[1631:9005] starting screenresolution argv=screenresolution get 03:17:29 INFO - 2017-05-25 03:17:29.534 screenresolution[1631:9005] Display 0: 1600x1200x32@60 03:17:29 INFO - 2017-05-25 03:17:29.540 screenresolution[1632:9008] starting screenresolution argv=screenresolution list 03:17:29 INFO - Available Modes on Display 0 03:17:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:17:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:17:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:17:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:17:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:17:29 INFO - Intel Iris: 03:17:29 INFO - Chipset Model: Intel Iris 03:17:29 INFO - Type: GPU 03:17:29 INFO - Bus: Built-In 03:17:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:17:29 INFO - Vendor: Intel (0x8086) 03:17:29 INFO - Device ID: 0x0a2e 03:17:29 INFO - Revision ID: 0x0009 03:17:29 INFO - Displays: 03:17:29 INFO - Display: 03:17:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:17:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:17:29 INFO - Display Serial Number: 1600x1200 60 03:17:29 INFO - Main Display: Yes 03:17:29 INFO - Mirror: Off 03:17:29 INFO - Online: Yes 03:17:29 INFO - Rotation: Supported 03:17:29 INFO - Return code: 0 03:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:29 INFO - Python 2.7.3 03:17:29 INFO - Return code: 0 03:17:29 INFO - grabbing minidump binary from tooltool 03:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c3d30>, '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 0x1036eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037b8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:17:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:17:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:17:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:29 INFO - Return code: 0 03:17:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:17:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:29 INFO - ENV: RUST_BACKTRACE is now 1 03:17:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:17:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 03:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Jamun --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0281 --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 03:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgKGDLcVrL/Render', 03:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:29 INFO - 'HOME': '/Users/cltbld', 03:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:29 INFO - 'LOGNAME': 'cltbld', 03:17:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:29 INFO - 'MOZ_NO_REMOTE': '1', 03:17:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:29 INFO - 'NO_EM_RESTART': '1', 03:17:29 INFO - 'PAGER': '/bin/cat', 03:17:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:29 INFO - 'PWD': '/builds/slave/test', 03:17:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:29 INFO - 'RUST_BACKTRACE': '1', 03:17:29 INFO - 'SHELL': '/bin/bash', 03:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45DyFiByE2/Listeners', 03:17:29 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 03:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:29 INFO - 'USER': 'cltbld', 03:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:29 INFO - 'XPC_FLAGS': '0x0', 03:17:29 INFO - 'XPC_SERVICE_NAME': '0', 03:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 03:17:30 INFO - mozversion application_buildid: 20170524051524 03:17:30 INFO - mozversion application_changeset: 64d1f0c63422a0f1a8ce632fe87d81e744577f52 03:17:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:17:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:30 INFO - mozversion application_name: Firefox 03:17:30 INFO - mozversion application_remotingname: firefox-dev 03:17:30 INFO - mozversion application_repository: https://hg.mozilla.org/projects/jamun 03:17:30 INFO - mozversion application_vendor: Mozilla 03:17:30 INFO - mozversion application_version: 54.0 03:17:30 INFO - mozversion platform_buildid: 20170524051524 03:17:30 INFO - mozversion platform_changeset: 64d1f0c63422a0f1a8ce632fe87d81e744577f52 03:17:30 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/jamun 03:17:30 INFO - mozversion platform_version: 54.0 03:17:30 INFO - using testdate: 1495707450 03:17:30 INFO - actual date: 1495707450 03:17:30 INFO - starting webserver on 'localhost:49251' 03:17:30 INFO - SUITE-START | Running 2 tests 03:17:30 INFO - TEST-START | dromaeo_css 03:17:30 INFO - operating with platform_type : mac_ 03:17:30 INFO - Initialising browser for dromaeo_css test... 03:17:30 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpzrqKh_/profile http://localhost:49251/getInfo.html) 03:17:33 INFO - PROCESS | 1642 | 2017-05-25 03:17:33.010 plugin-container[1646:9198] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e53, name = 'com.apple.tsm.portname' 03:17:33 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:33 INFO - PROCESS | 1642 | 2017-05-25 03:17:33.011 plugin-container[1646:9198] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9027, name = 'com.apple.CFPasteboardClient' 03:17:33 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:33 INFO - PROCESS | 1642 | 2017-05-25 03:17:33.012 plugin-container[1646:9198] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:17:33 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 03:17:33 INFO - PROCESS | 1642 | colorDepth:24 03:17:33 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 03:17:33 INFO - PROCESS | 1642 | __metrics 03:17:33 ERROR - PROCESS | 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 03:17:33 INFO - TEST-INFO | 1642: exit 0 03:17:33 INFO - Browser initialized. 03:17:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:33 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpzrqKh_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:36 INFO - PROCESS | 1648 | 2017-05-25 03:17:36.213 plugin-container[1649:9326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 03:17:36 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:36 INFO - PROCESS | 1648 | 2017-05-25 03:17:36.213 plugin-container[1649:9326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4523, name = 'com.apple.CFPasteboardClient' 03:17:36 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:36 INFO - PROCESS | 1648 | 2017-05-25 03:17:36.214 plugin-container[1649:9326] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:17:45 INFO - PROCESS | 1648 | RSS: Main: 202600448 03:17:45 INFO - PROCESS | 1648 | 03:20:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 03:20:51 INFO - PROCESS | 1648 | RSS: Main: 215810048 03:20:51 INFO - PROCESS | 1648 | 03:23:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 03:23:54 INFO - PROCESS | 1648 | RSS: Main: 229269504 03:23:54 INFO - PROCESS | 1648 | 03:26:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 03:26:56 INFO - PROCESS | 1648 | RSS: Main: 230559744 03:26:56 INFO - PROCESS | 1648 | 03:29:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 03:29:59 INFO - PROCESS | 1648 | RSS: Main: 233807872 03:29:59 INFO - PROCESS | 1648 | 03:33:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 03:33:02 INFO - PROCESS | 1648 | RSS: Main: 235868160 03:33:02 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 03:36:05 INFO - PROCESS | 1648 | RSS: Main: 233857024 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | __start_tp_report 03:36:05 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 03:36:05 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 03:36:05 INFO - PROCESS | 1648 | |i|pagename|runs| 03:36:05 INFO - PROCESS | 1648 | |0;dojo.html;3449.689527942485;3455.740819438542;3508.4737289406585;3509.3507701075287;3517.9648203517963;6072.240969878771;6088.995315772898;6093.390660933905;6122.448979591836;6159.322474527809;6081.878362432749;6112.816615501531;6173.536984726141;6186.907196392058;6194.7522099116095;5340.465953404648;5460.563154947595;5480.123180291154;5541.473560011793;5605.663660180382;5514;5564.443555644423;5591.2731344925105;5595.524380427648;5644.040513112781;5333.306670132897;5404.351477822647;5504.366997795265;5510.338759348863;5518.006758783417;5401.567874570025;5408.215808707755;5469.288992430958;5490.80782172626;5498.80754173602;5391.137418013099;5434.8913021739345;5435.891282174374;5436.103042997901;5445.455454454563;5014.598832093424;5740.655560666373;5978.5724612753775;6125.142480052797;6138.938610613926;6318.715657795365;6348.80953571389;6362.650054247015;6376.266729326094;6392.872142557123;6545.476361891085;6547.770828020996;6555.44278736308;6563.606183628997;6564.5404821662505;5728.742206600713;5930.377310382434;6233;6233.2208473940755;6257.18656574647;6389.648569328731;6475.093486911836;6642.800715978528;6682.699278532477;6707.228668703064;5777.017906955828;6014.7594096236535;6295.685215739286;6315.715792789336;6364.49084073273;6407.711652975628;6499.155109835786;6511.446527045254;6522.706478208492;6533.052707357407;6259.655718935411;6295.338989406138;6316.084167795736;6326.652034138075;6400.359964003563;5351.973240133774;6402.359764023654;6441.355864413521;6449.484041276686;6456.192975878015;5179.093658609803;5192.1173400522;5197.064528384852;5202.271681964528;5216.686998780086;4423.845165419195;4514.887127821765;4572.474165471013;4580.656450766206;4624.722516649012;5962.791302304486;5986.132010858489;6040.486558642477;6124.106319906264;6138.143176733788;6505.056766768792;6549.541532092803;6555.410013098844;6558.868822623521;6578.27638959714;6015.699215039231;6106.542009349317;6112.144299798032;6117.235345581802;6119.479844213202;4622.838200662961;5581.107022876401;5664.320281566156;5718.51392631631;5718.656880587178;5577.247071645438;6685.565438246498;6687.899681504684;6700.02849586817;6760.121184246016;6452.387023232785;6529.249136349381;6531.640759758069;6545.934540654533;6553.967230163818;6461.450776683847;6534.869302613826;6591.110200122922;6767.492438067263;6775.356341147583;6343.746250149942;6389.9680501597195;6406.615603063831;6407.487401008001;6435;6499.870002599827;6500.609963402211;6516.0551719999385;6527.281998980204;6532.248791389051;6193.907091393543;6247.531435142291;6259.436650701458;6296.6851657417865;6380.393862583047;5109.565686916654;6292.433680968735;6295.779647712491;6350.872982540416;6351.491880649629;5826.242588463472;6004.219451471281;6263.686815659108;6314.968425157845;6386.61680299165;6141.486007784364;6219.315875253628;6330.1454303668415;6344.4290013897125;6354.332795056637;6217.626942383471;6219.502439804714;6276.968615156895;6309.4952403806665;6316.778912738032 03:36:05 INFO - PROCESS | 1648 | |1;ext.html;747.9065116860393;790.6244533846422;835.3317346123102;969.5976169889497;975.1905918087988;38770.030749231286;39614.405783913266;41256.58743412565;41287.38068928961;41428.792856035754;40641.59358406423;40754.38868416969;40852.38721419181;40876.182476350456;40967.18065638685;8082.989626296713;8212.794680132985;8914.97477790056;10352.58589656413;10378.273520853543;11214.439278036107;11286.717832054183;11306.208565400426;11316.603918862842;11321.433928303552;10553.891841356663;11334.979851813336;11338.376389298584;11386.715332116722;11415.942920285386;10574.365538067741;11306.491207895624;11374.260673056226;11383.715407114805;11392.088632909348;9359.812803743955;11087.50106245221;11145.442727863656;11146.944265278622;11163.720906977309;35129.29741405157;35387.292254154774;35527;35547;35662.46506302407;3690.9261814763554;3868.4197370394386;3885.417187421881;3940.527136743609;3965.3060714375156;26072.60891086635;27081.864590677116;27525.587116193274;27732.861335693393;27778.305542361402;3087.6757940416383;3157.2264795125343;3173.3970545596494;3245.96754032459;3329.3174899145615;379385;379543;380501;380667;380741;46129.616111516705;46178.307325390146;46216;46241.30638040432;46249.07501849944;47401.81495462641;47462.76268618635;47469.762651187215;47511.76244118757;47524.28713569299;14567.635809104646;14674.192919389323;14679.55961321162;14703.264836758119;14711.55865324042;12557.937210314072;12567;12569.057320700802;12619.684507887376;12621.558245461549;8884.73345799627;12087.456064477119;12274.540387758152;12294.508219671292;12371.938140309241;5682.374938756733;5696.743646535916;5792.189093526909;5794.565407594363;5810.680412577349;885.6988623867787;1108.4080812301956;1118.3066498770813;1194.5818963362753;1208.1965492947268;27477.31306717348;27649.308767280578;27981.72018279832;28014.71985280162;28125.57811632827;1087.445402844539;1231.4212320209488;1284.3963337231487;1302.9218246905216;1311.4623004568082;14216.573502794932;14254.3585538651;14467.638309042148;14527.636809079646;14560.85439145595;179084;434323;434521;435106;435376;59061.11408328878;59432.70283648554;59642;59955;60080.39919600748;1263.2799304396406;1306.6341424401182;1483.859033391826;1500.5948393933795;1519.893607447468;28939;30566.08301750951;30939.0718278452;31639.52540711845;32400.189995250308;32506.83746581252;43493.78253108714;43559;43665.69002929917;45837;444602;445106;448618;449304;450974;32565.674343256265;32590.185245369055;33053.33893322168;33381.16547086342;33416.66583334136;40509.59490405176;42707;45164.54835451603;45192.54807452015;46457.76771116123;25181.24456266315;27432.491212983477;29475.55786663159;31860;32529;28946.7105328944;29547.556786647787;30946.53580196254;31116.68883311138;31512.212194695316;33655.32689346249;33841.49237761485;34298;34416.82791586026;34879.953601392;22007.779922200574;28831.56752648754;29041;30240.243993900327;30285.848570757003;20692.379228623166;23742.981846543236;23924.88037559801;24149.034038638256;24287 03:36:05 INFO - PROCESS | 1648 | |2;jquery.html;409.6026853951666;423.5870026723945;431.19664303284617;437.9233634114027;438.12156625964934;19603.313884014064;20544.486387840294;21956.23153189639;22144.557108857814;22201.2229571965;21999;22234;22627.208047718334;22925.885370573167;23024.88487557564;6891.9317505786685;6984.022236886814;7063.682134303968;7088.539244949062;7158.248383919691;6648.268690444047;7009.614471204081;7067.187273463566;7074.115735533059;7079.433645308389;6703.162104736908;6925.792226233221;7006.929930700679;7071.398931090864;7075.327843854826;6930.757423490179;6934.99442580828;6988.650567471606;7020.648967551628;7025.402840758542;6228.470580000705;6449.290578036413;6653.401193892524;6846.212685541177;6876.381125698661;27175.728242717516;27518.44963100747;27881.302967425774;27934.441311173865;28183.436331273464;2790.1071657069747;2998.415309014743;3009.653889802679;3013.2617508710287;3013.758899288052;15789.842101578952;16093.275802588912;16100.516984490367;16420.178991050518;16888.324467021306;2079.480129967508;2143.132031527234;2146.4633841539617;2147.226998280618;2152.117631770982;114944.42527787307;134067;139545;143357.2832135843;158756;18918.52703682419;19278;20531;21247;21315.36053918385;31973;32295.35409291801;32978;33103.675852965614;33118.50322245168;10537.947310263553;10582.153427725763;10602.734931626617;10764.3541387517;10945;7391.889121663179;8949.910500895037;8990.460572365548;8991.865122023175;9095.27237820986;8822.426542274732;9397.859032114524;9406.482643454676;9616.038396160468;9624;3795.772253664734;4171.144915292358;4185.58144185579;4206.369044643328;4207.684423668237;832.388194676912;892.1836519584507;906.8141031088611;947.6777895515557;951.3340661536952;20918.686219706717;22806.65790013151;22824.65763013556;22847.88576057109;22881.542369152525;716.4948711158621;934.345957829522;964.0793042644258;966.7244835221928;970.9223262139012;9569.186619137312;11518.88481115195;11773.88226117745;11810.88189118115;11869.347185904686;531409;596017;622328;630401;700560;161764.38235617493;163529;164645;165487;169830;1275.4961790092862;1318.4462525739214;1343.7715588350004;1349.1837438349853;1355.3426588104958;19547.609047818678;19946.002699864657;20325.49186270355;20407.387778366672;20439.59120817605;44770;58920;60058.69970650119;61380.69309653423;62201;75064.62467687626;76568;85723;86196.56901715451;88480.5575972116;9408.388454750419;10724.291714318246;11074.837142099963;11111;11411.372374519482;11959.820602690792;11985.161038727205;12016.759664806481;12328;12360.938195308965;10417.739556510845;10469.528871200966;10511.947440263055;10664.893351066701;10799;9768.413895166314;9851.901480985098;10003.249756268164;10094.798104038025;10141.645042423479;10554.894451055392;10843.078338341329;10886.836697449386;10984.560617575207;11142.164337674869;10990.945045274722;11125.443727813416;11259.774804504028;11321.377324247245;11423.485943132413;10631.946840266059;10680.946595266974;10737.886013056126;10803.189760768131;10876.401797901191 03:36:05 INFO - PROCESS | 1648 | |3;mootools.html;1418.3192067807452;1467.2663668165917;1584.9603759906008;1608.9597760056004;1630.2012014113084;9498.430094194353;10820.567177312907;11330.376829274386;11401.714957126076;11781.587644432446;11161.162912781554;11386.032187264072;11389.886101138985;11415.029722473579;11458.48436820343;2433.707955045397;2462.827602067856;2462.963055554168;2465.987670061656;2469.259222233332;2417.6857008588945;2421.4309637235237;2438.0247900839718;2445.7676520730593;2450.534398464286;2442.157455677788;2453.5924062554163;2454.0919859651954;2484.3789052736815;2491.0907518755703;2406.0255596483453;2428.9757102428925;2429.878506074698;2438.5244877248942;2443.6701045359005;1956.2859556262003;2410.3612542676206;2431.501542183848;2436.5857804173334;2443.6212387079854;11101.000909918146;11224.045956093742;11285.943570282096;11287.37919414432;11302.660920172408;5771.826845194651;5892.616979896293;5964.314103878066;5974.432428919289;5989.670568118751;3353.9496907546404;3396.762226644136;3449.379111759882;3488.476728490721;3554.8222588870453;1152.2049785647876;1154.9826752598717;1181.4565299961941;1196.8025275829477;1232.4761976160187;13805.447782088704;14103.153810771386;14903.329350179269;15371.846281537153;15531.068135911768;4751.121042607128;4871.220604703301;4871.707697538159;4884.4871288514905;4894.608431325485;11794.587189448499;11919.70200744971;11925.224860384047;11927.761444771057;11946.641600751991;5803.419658034163;5985.491233245223;6003.399660034049;6005.669688167105;6009.759609615567;5299.3905700844125;5377.381601115843;5462.426445223195;5491.588130890199;5514.448555144453;3824.9426258606145;3972.443857859902;3990.7605543667473;4020.778857162884;4068.3694027425795;1058.9947050264852;1063.2079101069753;1063.4788953412926;1073.592035026685;1077.8167711489066;937.8921424036187;956.1824639932896;967.5307475874196;973.2360097323567;1003.5584342889106;5688.146777983253;6246.46905013079;6705.597664140069;6789.626570538569;6950.652467376611;985.280745056113;1000.4997501249376;1017.2726500551993;1021.4790456866903;1040.7502199472224;3582.731295152874;3645.3802853514967;4204;4328.805203765838;4340.730420937369;11454.54181832734;13447.462101516025;14134.010619256758;14137.575872723835;14172.503962361268;13872.930635346758;13977.720445591234;14042.438302467992;14065.789013164811;14081.155130692192;10136.746581335525;10279.920608336166;10417.06246437809;10544;10558.419286939139;5743.282089738783;6659;6664.933350666432;6755.729770809113;6844.110265665432;10824.891751082389;12300.384980751105;12547.05897057706;12556.560520382109;12558.497660093859;9991.700248992542;10786.946065269623;12752.48990040388;12809.8078528824;13116.344182791014;7174.174969878531;8323.334133269445;8415.074341822272;8462.830743384975;8511.574421278787;10318.896811031793;10356.084124437004;10440.477976101012;10441.791164176826;10480.475976201007;8885.37802353855;8906.287497000354;8934.955325223333;8996.64013439455;9056.320775941698;7840.098388685375;8622.439541429787;8716.520591367536;8793.20861122502;8798.956005219932;5988.760449581968;7938.483998540077;8012.559309237815;8045;8136.267735903797;5619.915701264403;5639.295088113986;6015.2180216573315;6106.572539922163;6107.877842443215;5879.764809407576;6015.578909476295;6263;6310.684465776784;6326.841828954313 03:36:05 INFO - PROCESS | 1648 | |4;prototype.html;325.88756878876785;329.5551006141707;375.2026942746663;392.9155231625202;398.87834210565785;4141.287456715852;4989.850304490867;5108.948910510894;5219.295395121658;5405.540529055025;5192.948070519294;5341.385740639827;5344.572434205264;5376.623636345457;5380.946190538093;3954.2486927483687;4317.892052698676;4472.166411771158;4580.145041258295;4591.471980722226;3823.9426408603754;4522.547745225467;4559.99680070384;4652.139144342256;4656.650751193657;4612.469565999902;4654.394928659286;4672.929906051395;4682;4709.693869898446;3819.923601527954;4656.5110663380365;4661.300804879262;4672.929906051412;4728.905421891577;3794.146317078663;4216.304309788881;4346.869593912188;4456.6352403934825;4485.461744590637;4387.912241755147;4771.23660214364;5061.544460998491;5187.688738675692;5261.500157485033;4374.846880359204;4703.459102203256;5205.765740541685;5383.869387428645;5400.864978375572;5017.974910125463;5366.397297310801;5421;5730.7707691692285;5834;4214.726042807208;4570.291604801261;4925.177684256812;4933.925991110136;4936.925946110811;5362.65142765719;5616.32604087508;5804.245448091763;5907.4683278505145;5934;4494.505549420038;4733.881652958704;4989.600831933437;5026.346574945307;5078.5937125029905;4402.361657559636;5203.479652034766;5216.63483556155;5221.373435187726;5261.4738526147075;4593.185691651779;5104.770285337095;5129.538341549204;5315.362156541162;5412;5173.63784535079;5398.78404863801;5448.564114870801;5804.345761457964;5819.76720931158;1622.7809245751673;1746.5546285697067;1785.3215778004535;1803.5400972752127;1817.4729328494589;1022.9693109206736;1199.7060720123625;1217.794383560269;1220.7009282725612;1242.0001898471637;5238.68567885928;5304.92042619361;5315.687675861012;5328.749462827672;5346.732663366816;5108.106081435808;5447.809326673548;5916.408359164136;5918.260217472816;5960.5231581474245;4433.600975912119;4734.479207287196;5227.947720522746;5243.475652434802;5295.213922045756;2717.6738791345165;2896.6089577907132;2929.8095623784384;3093.458644737162;3102.30198205402;5274.841754747364;5396.514313711785;5477.507024367826;5790.826275211751;6084.908726369108;4901.779419926112;4942.159832828428;5414.374028596128;5550.91673624896;6205.565610407319;5700.714964251771;5824.573324273498;6133.815985520441;6181.7527298908435;6255.124282600348;4870.245112007645;5211.895762084661;5529.695866727368;5835.212246346859;5835.56233282514;4996.275540046746;5464.480874316933;5657.462541058593;5695.810346205973;5811.767529298781;5127.717975511383;5376.596755243294;5694.857628559319;6041.093835924647;6319.58922670025;4714.387129673258;4723.527647235386;4729.929051064168;4733.751468052647;4745.83389581363;5096.73195428031;5180.533751962342;5557.027520184032;5831.533477321889;5939.703014849154;4917.704937703749;4923.458419573915;5725.770969161354;5752.453516916054;5797.579428137419;4793.154635465301;5486.478784515464;5517.834464966058;5683.692750667452;5780.283266864567;5378.247045413724;5520.641158324696;5524.33707955048;5563.332400112013;5588.469095435927;4817.975910120427;5212.98346822366;5220.9738951305;5734.799282025276;5776.595638305278;5195.610329225399;5406.702631355313;5465.562754979672;5494.9725251375085;5531.408930587683 03:36:05 INFO - PROCESS | 1648 | |5;yui.html;740.6481921087484;754.5856738082223;776.7475570439605;825.9669613215472;847.0470720439506;12346.691332716686;15500.922495387522;16454.42409515667;16523.999999999985;16550.751738723928;13156.605301840937;15599.532014039569;15691.293891774869;15715.44995925143;15826.208689565534;972.6304004478307;981.990180098197;996.9252306077037;998.3909815012836;1005.2912696548952;959.1176117971448;987.3976874106825;992.9503524823766;993.2252842782641;993.7664648807524;1027.5170669785189;1038.9636362727306;1041.9791604167913;1043.3844032021107;1047.2302857399804;1020.5662593397814;1026.933249338798;1035.254616675992;1035.53400969564;1036.6371769880518;766.5132640773094;772.3859531672277;781.1524495921932;782.3115658220729;782.9217078292182;16235.512934611863;16645.750313745302;16664;17227.397041103628;17688.11559422024;14184;14350.64123396913;14356.64108397288;14377.281135943162;14405.567832965027;11887.167898247126;11892.167548271624;11910.702232444171;12513.37433128349;12578.81131783024;3630.8729194478065;3706.721995850322;3732.3841566141555;3751;3873.2447172801317;104784;118892.81107188904;119236;119676;119975.4001229997;10513.84229236562;10580;11114.11087113029;11209;11409.030232430336;21219.575608488052;21377.144914203258;21795.34613961584;21856.781432185475;21899.343019709435;7517.511361761468;7624.351930086005;7663.885041724378;7681.731139410093;7688.923110768821;4240.681948853849;4254.532001479834;4289.635380992589;4293.205756934977;4312.849050283287;3326.833658317123;3385.306012267479;3397.6432474590306;3406.114410253352;3417.79493230407;601.5157797972587;603.7705671844759;607.6900780601836;609.9908501372483;614.27822308787;654.6922946215271;661.3584822721951;664.123357168533;682.331315310998;688.8484533402643;9385.474860335196;10126.088652021353;10146.44194569291;10170.644027459004;10178.389296642225;649.6426965169233;678.0776498626351;684.8938414545753;691.7025678958096;692.8926016467456;4818.927716084261;4876.400586320794;4898.559129678346;4910;4939.431965323962;103648;107138;107925;108392.91607083986;110180;89143.55428222817;90509.54745226364;91606.08393915975;93551;93697;78953.81569276465;80782;82229;82253.76619350715;83068;9004.50475223869;9295.209907157698;9312;9350.298727595322;9372.48451335156;51475.742621288155;52183.21725174201;52191.73904130455;53320.13379531698;53550.73224633852;52444;65926.02221933349;66033.33966660273;66838.66580667066;67332.3266767326;9552.901416336932;9692.864766730649;9903.708419544815;11110.055645270242;11149.10807135411;11368.715782105513;12032.398380081137;12035.217710848767;12057.819132713192;12390.070744694363;11287.83583499927;11338.546458141582;11751.471183796579;11831.76336473283;12291.32397718134;11341.716457088638;11620.941895290469;11724.88275117238;12077.27536347822;12092.818607721067;11187.216894817284;11527.596534121602;11787.469563869818;12046.277223366626;12065.155439119177;8059.758207253792;8242.670293188205;8332.6666933322;8505.489670619783;8539.188777066169;6990.9300906990275;8127.469369836782;9136;9581.470906273025;9733.370420408633 03:36:05 INFO - PROCESS | 1648 | __end_tp_report 03:36:05 INFO - PROCESS | 1648 | __start_cc_report 03:36:05 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,378 03:36:05 INFO - PROCESS | 1648 | __end_cc_report 03:36:05 INFO - PROCESS | 1648 | __startTimestamp1495708565882__endTimestamp 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | ------- Summary: start ------- 03:36:05 INFO - PROCESS | 1648 | Number of tests: 6 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5975.99 Median:6219.32 stddev:678.03 (10.9%) stddev-sans-first:650.50 03:36:05 INFO - PROCESS | 1648 | Values: 3449.7 3455.7 3508.5 3509.4 3518.0 6072.2 6089.0 6093.4 6122.4 6159.3 6081.9 6112.8 6173.5 6186.9 6194.8 5340.5 5460.6 5480.1 5541.5 5605.7 5514.0 5564.4 5591.3 5595.5 5644.0 5333.3 5404.4 5504.4 5510.3 5518.0 5401.6 5408.2 5469.3 5490.8 5498.8 5391.1 5434.9 5435.9 5436.1 5445.5 5014.6 5740.7 5978.6 6125.1 6138.9 6318.7 6348.8 6362.7 6376.3 6392.9 6545.5 6547.8 6555.4 6563.6 6564.5 5728.7 5930.4 6233.0 6233.2 6257.2 6389.6 6475.1 6642.8 6682.7 6707.2 5777.0 6014.8 6295.7 6315.7 6364.5 6407.7 6499.2 6511.4 6522.7 6533.1 6259.7 6295.3 6316.1 6326.7 6400.4 5352.0 6402.4 6441.4 6449.5 6456.2 5179.1 5192.1 5197.1 5202.3 5216.7 4423.8 4514.9 4572.5 4580.7 4624.7 5962.8 5986.1 6040.5 6124.1 6138.1 6505.1 6549.5 6555.4 6558.9 6578.3 6015.7 6106.5 6112.1 6117.2 6119.5 4622.8 5581.1 5664.3 5718.5 5718.7 5577.2 6685.6 6687.9 6700.0 6760.1 6452.4 6529.2 6531.6 6545.9 6554.0 6461.5 6534.9 6591.1 6767.5 6775.4 6343.7 6390.0 6406.6 6407.5 6435.0 6499.9 6500.6 6516.1 6527.3 6532.2 6193.9 6247.5 6259.4 6296.7 6380.4 5109.6 6292.4 6295.8 6350.9 6351.5 5826.2 6004.2 6263.7 6315.0 6386.6 6141.5 6219.3 6330.1 6344.4 6354.3 6217.6 6219.5 6277.0 6309.5 6316.8 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:54337.70 Median:32130.09 stddev:108548.56 (337.8%) stddev-sans-first:108778.49 03:36:05 INFO - PROCESS | 1648 | Values: 747.9 790.6 835.3 969.6 975.2 38770.0 39614.4 41256.6 41287.4 41428.8 40641.6 40754.4 40852.4 40876.2 40967.2 8083.0 8212.8 8915.0 10352.6 10378.3 11214.4 11286.7 11306.2 11316.6 11321.4 10553.9 11335.0 11338.4 11386.7 11415.9 10574.4 11306.5 11374.3 11383.7 11392.1 9359.8 11087.5 11145.4 11146.9 11163.7 35129.3 35387.3 35527.0 35547.0 35662.5 3690.9 3868.4 3885.4 3940.5 3965.3 26072.6 27081.9 27525.6 27732.9 27778.3 3087.7 3157.2 3173.4 3246.0 3329.3 379385.0 379543.0 380501.0 380667.0 380741.0 46129.6 46178.3 46216.0 46241.3 46249.1 47401.8 47462.8 47469.8 47511.8 47524.3 14567.6 14674.2 14679.6 14703.3 14711.6 12557.9 12567.0 12569.1 12619.7 12621.6 8884.7 12087.5 12274.5 12294.5 12371.9 5682.4 5696.7 5792.2 5794.6 5810.7 885.7 1108.4 1118.3 1194.6 1208.2 27477.3 27649.3 27981.7 28014.7 28125.6 1087.4 1231.4 1284.4 1302.9 1311.5 14216.6 14254.4 14467.6 14527.6 14560.9 179084.0 434323.0 434521.0 435106.0 435376.0 59061.1 59432.7 59642.0 59955.0 60080.4 1263.3 1306.6 1483.9 1500.6 1519.9 28939.0 30566.1 30939.1 31639.5 32400.2 32506.8 43493.8 43559.0 43665.7 45837.0 444602.0 445106.0 448618.0 449304.0 450974.0 32565.7 32590.2 33053.3 33381.2 33416.7 40509.6 42707.0 45164.5 45192.5 46457.8 25181.2 27432.5 29475.6 31860.0 32529.0 28946.7 29547.6 30946.5 31116.7 31512.2 33655.3 33841.5 34298.0 34416.8 34880.0 22007.8 28831.6 29041.0 30240.2 30285.8 20692.4 23743.0 23924.9 24149.0 24287.0 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:39062.82 Median:25100.31 stddev:104412.33 (416.0%) stddev-sans-first:104664.90 03:36:05 INFO - PROCESS | 1648 | Values: 409.6 423.6 431.2 437.9 438.1 19603.3 20544.5 21956.2 22144.6 22201.2 21999.0 22234.0 22627.2 22925.9 23024.9 6891.9 6984.0 7063.7 7088.5 7158.2 6648.3 7009.6 7067.2 7074.1 7079.4 6703.2 6925.8 7006.9 7071.4 7075.3 6930.8 6935.0 6988.7 7020.6 7025.4 6228.5 6449.3 6653.4 6846.2 6876.4 27175.7 27518.4 27881.3 27934.4 28183.4 2790.1 2998.4 3009.7 3013.3 3013.8 15789.8 16093.3 16100.5 16420.2 16888.3 2079.5 2143.1 2146.5 2147.2 2152.1 114944.4 134067.0 139545.0 143357.3 158756.0 18918.5 19278.0 20531.0 21247.0 21315.4 31973.0 32295.4 32978.0 33103.7 33118.5 10537.9 10582.2 10602.7 10764.4 10945.0 7391.9 8949.9 8990.5 8991.9 9095.3 8822.4 9397.9 9406.5 9616.0 9624.0 3795.8 4171.1 4185.6 4206.4 4207.7 832.4 892.2 906.8 947.7 951.3 20918.7 22806.7 22824.7 22847.9 22881.5 716.5 934.3 964.1 966.7 970.9 9569.2 11518.9 11773.9 11810.9 11869.3 531409.0 596017.0 622328.0 630401.0 700560.0 161764.4 163529.0 164645.0 165487.0 169830.0 1275.5 1318.4 1343.8 1349.2 1355.3 19547.6 19946.0 20325.5 20407.4 20439.6 44770.0 58920.0 60058.7 61380.7 62201.0 75064.6 76568.0 85723.0 86196.6 88480.6 9408.4 10724.3 11074.8 11111.0 11411.4 11959.8 11985.2 12016.8 12328.0 12360.9 10417.7 10469.5 10511.9 10664.9 10799.0 9768.4 9851.9 10003.2 10094.8 10141.6 10554.9 10843.1 10886.8 10984.6 11142.2 10990.9 11125.4 11259.8 11321.4 11423.5 10631.9 10680.9 10737.9 10803.2 10876.4 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:6733.88 Median:2453.84 stddev:4197.81 (171.1%) stddev-sans-first:4190.58 03:36:05 INFO - PROCESS | 1648 | Values: 1418.3 1467.3 1585.0 1609.0 1630.2 9498.4 10820.6 11330.4 11401.7 11781.6 11161.2 11386.0 11389.9 11415.0 11458.5 2433.7 2462.8 2463.0 2466.0 2469.3 2417.7 2421.4 2438.0 2445.8 2450.5 2442.2 2453.6 2454.1 2484.4 2491.1 2406.0 2429.0 2429.9 2438.5 2443.7 1956.3 2410.4 2431.5 2436.6 2443.6 11101.0 11224.0 11285.9 11287.4 11302.7 5771.8 5892.6 5964.3 5974.4 5989.7 3353.9 3396.8 3449.4 3488.5 3554.8 1152.2 1155.0 1181.5 1196.8 1232.5 13805.4 14103.2 14903.3 15371.8 15531.1 4751.1 4871.2 4871.7 4884.5 4894.6 11794.6 11919.7 11925.2 11927.8 11946.6 5803.4 5985.5 6003.4 6005.7 6009.8 5299.4 5377.4 5462.4 5491.6 5514.4 3824.9 3972.4 3990.8 4020.8 4068.4 1059.0 1063.2 1063.5 1073.6 1077.8 937.9 956.2 967.5 973.2 1003.6 5688.1 6246.5 6705.6 6789.6 6950.7 985.3 1000.5 1017.3 1021.5 1040.8 3582.7 3645.4 4204.0 4328.8 4340.7 11454.5 13447.5 14134.0 14137.6 14172.5 13872.9 13977.7 14042.4 14065.8 14081.2 10136.7 10279.9 10417.1 10544.0 10558.4 5743.3 6659.0 6664.9 6755.7 6844.1 10824.9 12300.4 12547.1 12556.6 12558.5 9991.7 10786.9 12752.5 12809.8 13116.3 7174.2 8323.3 8415.1 8462.8 8511.6 10318.9 10356.1 10440.5 10441.8 10480.5 8885.4 8906.3 8935.0 8996.6 9056.3 7840.1 8622.4 8716.5 8793.2 8799.0 5988.8 7938.5 8012.6 8045.0 8136.3 5619.9 5639.3 6015.2 6106.6 6107.9 5879.8 6015.6 6263.0 6310.7 6326.8 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4787.08 Median:5199.54 stddev:1287.31 (24.8%) stddev-sans-first:1246.61 03:36:05 INFO - PROCESS | 1648 | Values: 325.9 329.6 375.2 392.9 398.9 4141.3 4989.9 5108.9 5219.3 5405.5 5192.9 5341.4 5344.6 5376.6 5380.9 3954.2 4317.9 4472.2 4580.1 4591.5 3823.9 4522.5 4560.0 4652.1 4656.7 4612.5 4654.4 4672.9 4682.0 4709.7 3819.9 4656.5 4661.3 4672.9 4728.9 3794.1 4216.3 4346.9 4456.6 4485.5 4387.9 4771.2 5061.5 5187.7 5261.5 4374.8 4703.5 5205.8 5383.9 5400.9 5018.0 5366.4 5421.0 5730.8 5834.0 4214.7 4570.3 4925.2 4933.9 4936.9 5362.7 5616.3 5804.2 5907.5 5934.0 4494.5 4733.9 4989.6 5026.3 5078.6 4402.4 5203.5 5216.6 5221.4 5261.5 4593.2 5104.8 5129.5 5315.4 5412.0 5173.6 5398.8 5448.6 5804.3 5819.8 1622.8 1746.6 1785.3 1803.5 1817.5 1023.0 1199.7 1217.8 1220.7 1242.0 5238.7 5304.9 5315.7 5328.7 5346.7 5108.1 5447.8 5916.4 5918.3 5960.5 4433.6 4734.5 5227.9 5243.5 5295.2 2717.7 2896.6 2929.8 3093.5 3102.3 5274.8 5396.5 5477.5 5790.8 6084.9 4901.8 4942.2 5414.4 5550.9 6205.6 5700.7 5824.6 6133.8 6181.8 6255.1 4870.2 5211.9 5529.7 5835.2 5835.6 4996.3 5464.5 5657.5 5695.8 5811.8 5127.7 5376.6 5694.9 6041.1 6319.6 4714.4 4723.5 4729.9 4733.8 4745.8 5096.7 5180.5 5557.0 5831.5 5939.7 4917.7 4923.5 5725.8 5752.5 5797.6 4793.2 5486.5 5517.8 5683.7 5780.3 5378.2 5520.6 5524.3 5563.3 5588.5 4818.0 5213.0 5221.0 5734.8 5776.6 5195.6 5406.7 5465.6 5495.0 5531.4 03:36:05 INFO - PROCESS | 1648 | 03:36:05 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20703.01 Median:3812.12 stddev:31026.85 (813.9%) stddev-sans-first:31077.68 03:36:05 INFO - PROCESS | 1648 | Values: 740.6 754.6 776.7 826.0 847.0 12346.7 15500.9 16454.4 16524.0 16550.8 13156.6 15599.5 15691.3 15715.4 15826.2 972.6 982.0 996.9 998.4 1005.3 959.1 987.4 993.0 993.2 993.8 1027.5 1039.0 1042.0 1043.4 1047.2 1020.6 1026.9 1035.3 1035.5 1036.6 766.5 772.4 781.2 782.3 782.9 16235.5 16645.8 16664.0 17227.4 17688.1 14184.0 14350.6 14356.6 14377.3 14405.6 11887.2 11892.2 11910.7 12513.4 12578.8 3630.9 3706.7 3732.4 3751.0 3873.2 104784.0 118892.8 119236.0 119676.0 119975.4 10513.8 10580.0 11114.1 11209.0 11409.0 21219.6 21377.1 21795.3 21856.8 21899.3 7517.5 7624.4 7663.9 7681.7 7688.9 4240.7 4254.5 4289.6 4293.2 4312.8 3326.8 3385.3 3397.6 3406.1 3417.8 601.5 603.8 607.7 610.0 614.3 654.7 661.4 664.1 682.3 688.8 9385.5 10126.1 10146.4 10170.6 10178.4 649.6 678.1 684.9 691.7 692.9 4818.9 4876.4 4898.6 4910.0 4939.4 103648.0 107138.0 107925.0 108392.9 110180.0 89143.6 90509.5 91606.1 93551.0 93697.0 78953.8 80782.0 82229.0 82253.8 83068.0 9004.5 9295.2 9312.0 9350.3 9372.5 51475.7 52183.2 52191.7 53320.1 53550.7 52444.0 65926.0 66033.3 66838.7 67332.3 9552.9 9692.9 9903.7 11110.1 11149.1 11368.7 12032.4 12035.2 12057.8 12390.1 11287.8 11338.5 11751.5 11831.8 12291.3 11341.7 11620.9 11724.9 12077.3 12092.8 11187.2 11527.6 11787.5 12046.3 12065.2 8059.8 8242.7 8332.7 8505.5 8539.2 6990.9 8127.5 9136.0 9581.5 9733.4 03:36:05 INFO - PROCESS | 1648 | -------- Summary: end -------- 03:36:05 INFO - PROCESS | 1648 | 03:36:06 INFO - TEST-INFO | 1648: exit 0 03:36:06 INFO - TEST-OK | dromaeo_css | took 1116212ms 03:36:06 INFO - TEST-START | kraken 03:36:06 INFO - operating with platform_type : mac_ 03:36:06 INFO - Initialising browser for kraken test... 03:36:06 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpvcPhJV/profile http://localhost:49251/getInfo.html) 03:36:09 INFO - PROCESS | 1679 | 2017-05-25 03:36:09.118 plugin-container[1681:11758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 03:36:09 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:09 INFO - PROCESS | 1679 | 2017-05-25 03:36:09.119 plugin-container[1681:11758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 03:36:09 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:09 INFO - PROCESS | 1679 | 2017-05-25 03:36:09.119 plugin-container[1681:11758] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:36:09 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 03:36:09 INFO - PROCESS | 1679 | colorDepth:24 03:36:09 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 03:36:09 INFO - PROCESS | 1679 | __metrics 03:36:09 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 03:36:09 INFO - TEST-INFO | 1679: exit 0 03:36:09 INFO - Browser initialized. 03:36:09 INFO - Running cycle 1/1 for kraken test... 03:36:09 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpvcPhJV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:12 INFO - PROCESS | 1682 | 2017-05-25 03:36:12.332 plugin-container[1683:11888] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x424b, name = 'com.apple.tsm.portname' 03:36:12 INFO - PROCESS | 1682 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:12 INFO - PROCESS | 1682 | 2017-05-25 03:36:12.332 plugin-container[1683:11888] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 03:36:12 INFO - PROCESS | 1682 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:12 INFO - PROCESS | 1682 | 2017-05-25 03:36:12.332 plugin-container[1683:11888] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:36:22 INFO - PROCESS | 1682 | RSS: Main: 202682368 03:36:22 INFO - PROCESS | 1682 | 03:36:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:26 INFO - PROCESS | 1682 | RSS: Main: 216260608 03:36:26 INFO - PROCESS | 1682 | 03:36:28 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 03:36:29 INFO - PROCESS | 1682 | RSS: Main: 224276480 03:36:29 INFO - PROCESS | 1682 | 03:36:32 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 03:36:33 INFO - PROCESS | 1682 | RSS: Main: 225738752 03:36:33 INFO - PROCESS | 1682 | 03:36:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 03:36:36 INFO - PROCESS | 1682 | RSS: Main: 227594240 03:36:36 INFO - PROCESS | 1682 | 03:36:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:38 INFO - PROCESS | 1682 | RSS: Main: 227913728 03:36:38 INFO - PROCESS | 1682 | 03:36:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:42 INFO - PROCESS | 1682 | RSS: Main: 232153088 03:36:42 INFO - PROCESS | 1682 | 03:36:45 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:46 INFO - PROCESS | 1682 | RSS: Main: 233103360 03:36:46 INFO - PROCESS | 1682 | 03:36:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 03:36:50 INFO - PROCESS | 1682 | RSS: Main: 233312256 03:36:50 INFO - PROCESS | 1682 | 03:36:52 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:52 INFO - PROCESS | 1682 | RSS: Main: 232361984 03:36:52 INFO - PROCESS | 1682 | 03:36:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:55 INFO - PROCESS | 1682 | RSS: Main: 232321024 03:36:55 INFO - PROCESS | 1682 | 03:36:57 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:57 INFO - PROCESS | 1682 | RSS: Main: 232579072 03:36:57 INFO - PROCESS | 1682 | 03:37:00 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:01 INFO - PROCESS | 1682 | RSS: Main: 232947712 03:37:01 INFO - PROCESS | 1682 | 03:37:04 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:05 INFO - PROCESS | 1682 | RSS: Main: 232673280 03:37:05 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 03:37:07 INFO - PROCESS | 1682 | RSS: Main: 236191744 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | __start_tp_report 03:37:07 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 03:37:07 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 03:37:07 INFO - PROCESS | 1682 | |i|pagename|runs| 03:37:07 INFO - PROCESS | 1682 | |0;ai-astar;108;121;122;121;121;119;119;121;118;121 03:37:07 INFO - PROCESS | 1682 | |1;audio-beat-detection;143;114;131;182;140;114;114;112;127;117 03:37:07 INFO - PROCESS | 1682 | |2;audio-dft;187;182;258;281;213;201;199;195;200;236 03:37:07 INFO - PROCESS | 1682 | |3;audio-fft;87;85;55;102;77;74;73;54;65;81 03:37:07 INFO - PROCESS | 1682 | |4;audio-oscillator;92;73;88;71;71;70;82;69;64;73 03:37:07 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;89;89;90;136;107;137;91;90;89;88 03:37:07 INFO - PROCESS | 1682 | |6;imaging-darkroom;96;116;118;96;95;118;116;154;150;96 03:37:07 INFO - PROCESS | 1682 | |7;imaging-desaturate;90;77;144;146;94;144;81;145;144;97 03:37:07 INFO - PROCESS | 1682 | |8;json-parse-financial;66;68;66;69;70;70;70;69;81;105 03:37:07 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;57;63;58;66;63;58;57;57;60;57 03:37:07 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;84;87;84;89;84;89;83;84;83;85 03:37:07 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;141;144;141;146;154;153;148;169;216;154 03:37:07 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;169;171;169;168;170;166;167;171;168;166 03:37:07 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;67;68;67;66;78;91;87;86;74;65 03:37:07 INFO - PROCESS | 1682 | __end_tp_report 03:37:07 INFO - PROCESS | 1682 | __start_cc_report 03:37:07 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1043 03:37:07 INFO - PROCESS | 1682 | __end_cc_report 03:37:07 INFO - PROCESS | 1682 | __startTimestamp1495708627279__endTimestamp 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | ------- Summary: start ------- 03:37:07 INFO - PROCESS | 1682 | Number of tests: 14 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:119.10 Median:121.00 stddev:4.09 (3.4%) stddev-sans-first:1.32 03:37:07 INFO - PROCESS | 1682 | Values: 108.0 121.0 122.0 121.0 121.0 119.0 119.0 121.0 118.0 121.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:129.00 stddev:21.71 (16.8%) stddev-sans-first:22.46 03:37:07 INFO - PROCESS | 1682 | Values: 143.0 114.0 131.0 182.0 140.0 114.0 114.0 112.0 127.0 117.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:215.20 Median:207.00 stddev:32.66 (15.8%) stddev-sans-first:33.01 03:37:07 INFO - PROCESS | 1682 | Values: 187.0 182.0 258.0 281.0 213.0 201.0 199.0 195.0 200.0 236.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:75.30 Median:75.50 stddev:14.75 (19.5%) stddev-sans-first:15.02 03:37:07 INFO - PROCESS | 1682 | Values: 87.0 85.0 55.0 102.0 77.0 74.0 73.0 54.0 65.0 81.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:73.00 stddev:8.99 (12.3%) stddev-sans-first:7.23 03:37:07 INFO - PROCESS | 1682 | Values: 92.0 73.0 88.0 71.0 71.0 70.0 82.0 69.0 64.0 73.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:89.00 stddev:19.72 (22.2%) stddev-sans-first:20.46 03:37:07 INFO - PROCESS | 1682 | Values: 89.0 89.0 90.0 136.0 107.0 137.0 91.0 90.0 89.0 88.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:115.50 Median:124.50 stddev:21.72 (17.4%) stddev-sans-first:21.86 03:37:07 INFO - PROCESS | 1682 | Values: 96.0 116.0 118.0 96.0 95.0 118.0 116.0 154.0 150.0 96.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:116.20 Median:79.00 stddev:30.48 (38.6%) stddev-sans-first:30.82 03:37:07 INFO - PROCESS | 1682 | Values: 90.0 77.0 144.0 146.0 94.0 144.0 81.0 145.0 144.0 97.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:73.40 Median:69.50 stddev:11.87 (17.1%) stddev-sans-first:12.29 03:37:07 INFO - PROCESS | 1682 | Values: 66.0 68.0 66.0 69.0 70.0 70.0 70.0 69.0 81.0 105.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.00 stddev:3.27 (5.5%) stddev-sans-first:3.33 03:37:07 INFO - PROCESS | 1682 | Values: 57.0 63.0 58.0 66.0 63.0 58.0 57.0 57.0 60.0 57.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:2.30 (2.7%) stddev-sans-first:2.40 03:37:07 INFO - PROCESS | 1682 | Values: 84.0 87.0 84.0 89.0 84.0 89.0 83.0 84.0 83.0 85.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:153.50 stddev:22.46 (14.6%) stddev-sans-first:23.10 03:37:07 INFO - PROCESS | 1682 | Values: 141.0 144.0 141.0 146.0 154.0 153.0 148.0 169.0 216.0 154.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 03:37:07 INFO - PROCESS | 1682 | Values: 169.0 171.0 169.0 168.0 170.0 166.0 167.0 171.0 168.0 166.0 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:76.00 stddev:9.94 (13.1%) stddev-sans-first:10.12 03:37:07 INFO - PROCESS | 1682 | Values: 67.0 68.0 67.0 66.0 78.0 91.0 87.0 86.0 74.0 65.0 03:37:07 INFO - PROCESS | 1682 | -------- Summary: end -------- 03:37:07 INFO - PROCESS | 1682 | 03:37:07 INFO - TEST-INFO | 1682: exit 0 03:37:07 INFO - TEST-OK | kraken | took 61584ms 03:37:07 INFO - SUITE-END | took 1177s 03:37:07 INFO - Completed test suite (00:19:37) 03:37:07 INFO - javascript benchmark 03:37:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7750.998701097028, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3449.689527942485, 3455.740819438542, 3508.4737289406585, 3509.3507701075287, 3517.9648203517963, 6072.240969878771, 6088.995315772898, 6093.390660933905, 6122.448979591836, 6159.322474527809, 6081.878362432749, 6112.816615501531, 6173.536984726141, 6186.907196392058, 6194.7522099116095, 5340.465953404648, 5460.563154947595, 5480.123180291154, 5541.473560011793, 5605.663660180382, 5514.0, 5564.443555644423, 5591.2731344925105, 5595.524380427648, 5644.040513112781, 5333.306670132897, 5404.351477822647, 5504.366997795265, 5510.338759348863, 5518.006758783417, 5401.567874570025, 5408.215808707755, 5469.288992430958, 5490.80782172626, 5498.80754173602, 5391.137418013099, 5434.8913021739345, 5435.891282174374, 5436.103042997901, 5445.455454454563, 5014.598832093424, 5740.655560666373, 5978.5724612753775, 6125.142480052797, 6138.938610613926, 6318.715657795365, 6348.80953571389, 6362.650054247015, 6376.266729326094, 6392.872142557123, 6545.476361891085, 6547.770828020996, 6555.44278736308, 6563.606183628997, 6564.5404821662505, 5728.742206600713, 5930.377310382434, 6233.0, 6233.2208473940755, 6257.18656574647, 6389.648569328731, 6475.093486911836, 6642.800715978528, 6682.699278532477, 6707.228668703064, 5777.017906955828, 6014.7594096236535, 6295.685215739286, 6315.715792789336, 6364.49084073273, 6407.711652975628, 6499.155109835786, 6511.446527045254, 6522.706478208492, 6533.052707357407, 6259.655718935411, 6295.338989406138, 6316.084167795736, 6326.652034138075, 6400.359964003563, 5351.973240133774, 6402.359764023654, 6441.355864413521, 6449.484041276686, 6456.192975878015, 5179.093658609803, 5192.1173400522, 5197.064528384852, 5202.271681964528, 5216.686998780086, 4423.845165419195, 4514.887127821765, 4572.474165471013, 4580.656450766206, 4624.722516649012, 5962.791302304486, 5986.132010858489, 6040.486558642477, 6124.106319906264, 6138.143176733788, 6505.056766768792, 6549.541532092803, 6555.410013098844, 6558.868822623521, 6578.27638959714, 6015.699215039231, 6106.542009349317, 6112.144299798032, 6117.235345581802, 6119.479844213202, 4622.838200662961, 5581.107022876401, 5664.320281566156, 5718.51392631631, 5718.656880587178, 5577.247071645438, 6685.565438246498, 6687.899681504684, 6700.02849586817, 6760.121184246016, 6452.387023232785, 6529.249136349381, 6531.640759758069, 6545.934540654533, 6553.967230163818, 6461.450776683847, 6534.869302613826, 6591.110200122922, 6767.492438067263, 6775.356341147583, 6343.746250149942, 6389.9680501597195, 6406.615603063831, 6407.487401008001, 6435.0, 6499.870002599827, 6500.609963402211, 6516.0551719999385, 6527.281998980204, 6532.248791389051, 6193.907091393543, 6247.531435142291, 6259.436650701458, 6296.6851657417865, 6380.393862583047, 5109.565686916654, 6292.433680968735, 6295.779647712491, 6350.872982540416, 6351.491880649629, 5826.242588463472, 6004.219451471281, 6263.686815659108, 6314.968425157845, 6386.61680299165, 6141.486007784364, 6219.315875253628, 6330.1454303668415, 6344.4290013897125, 6354.332795056637, 6217.626942383471, 6219.502439804714, 6276.968615156895, 6309.4952403806665, 6316.778912738032], "value": 5933.638873331204, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.9065116860393, 790.6244533846422, 835.3317346123102, 969.5976169889497, 975.1905918087988, 38770.030749231286, 39614.405783913266, 41256.58743412565, 41287.38068928961, 41428.792856035754, 40641.59358406423, 40754.38868416969, 40852.38721419181, 40876.182476350456, 40967.18065638685, 8082.989626296713, 8212.794680132985, 8914.97477790056, 10352.58589656413, 10378.273520853543, 11214.439278036107, 11286.717832054183, 11306.208565400426, 11316.603918862842, 11321.433928303552, 10553.891841356663, 11334.979851813336, 11338.376389298584, 11386.715332116722, 11415.942920285386, 10574.365538067741, 11306.491207895624, 11374.260673056226, 11383.715407114805, 11392.088632909348, 9359.812803743955, 11087.50106245221, 11145.442727863656, 11146.944265278622, 11163.720906977309, 35129.29741405157, 35387.292254154774, 35527.0, 35547.0, 35662.46506302407, 3690.9261814763554, 3868.4197370394386, 3885.417187421881, 3940.527136743609, 3965.3060714375156, 26072.60891086635, 27081.864590677116, 27525.587116193274, 27732.861335693393, 27778.305542361402, 3087.6757940416383, 3157.2264795125343, 3173.3970545596494, 3245.96754032459, 3329.3174899145615, 379385.0, 379543.0, 380501.0, 380667.0, 380741.0, 46129.616111516705, 46178.307325390146, 46216.0, 46241.30638040432, 46249.07501849944, 47401.81495462641, 47462.76268618635, 47469.762651187215, 47511.76244118757, 47524.28713569299, 14567.635809104646, 14674.192919389323, 14679.55961321162, 14703.264836758119, 14711.55865324042, 12557.937210314072, 12567.0, 12569.057320700802, 12619.684507887376, 12621.558245461549, 8884.73345799627, 12087.456064477119, 12274.540387758152, 12294.508219671292, 12371.938140309241, 5682.374938756733, 5696.743646535916, 5792.189093526909, 5794.565407594363, 5810.680412577349, 885.6988623867787, 1108.4080812301956, 1118.3066498770813, 1194.5818963362753, 1208.1965492947268, 27477.31306717348, 27649.308767280578, 27981.72018279832, 28014.71985280162, 28125.57811632827, 1087.445402844539, 1231.4212320209488, 1284.3963337231487, 1302.9218246905216, 1311.4623004568082, 14216.573502794932, 14254.3585538651, 14467.638309042148, 14527.636809079646, 14560.85439145595, 179084.0, 434323.0, 434521.0, 435106.0, 435376.0, 59061.11408328878, 59432.70283648554, 59642.0, 59955.0, 60080.39919600748, 1263.2799304396406, 1306.6341424401182, 1483.859033391826, 1500.5948393933795, 1519.893607447468, 28939.0, 30566.08301750951, 30939.0718278452, 31639.52540711845, 32400.189995250308, 32506.83746581252, 43493.78253108714, 43559.0, 43665.69002929917, 45837.0, 444602.0, 445106.0, 448618.0, 449304.0, 450974.0, 32565.674343256265, 32590.185245369055, 33053.33893322168, 33381.16547086342, 33416.66583334136, 40509.59490405176, 42707.0, 45164.54835451603, 45192.54807452015, 46457.76771116123, 25181.24456266315, 27432.491212983477, 29475.55786663159, 31860.0, 32529.0, 28946.7105328944, 29547.556786647787, 30946.53580196254, 31116.68883311138, 31512.212194695316, 33655.32689346249, 33841.49237761485, 34298.0, 34416.82791586026, 34879.953601392, 22007.779922200574, 28831.56752648754, 29041.0, 30240.243993900327, 30285.848570757003, 20692.379228623166, 23742.981846543236, 23924.88037559801, 24149.034038638256, 24287.0], "value": 18798.259398920345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.6026853951666, 423.5870026723945, 431.19664303284617, 437.9233634114027, 438.12156625964934, 19603.313884014064, 20544.486387840294, 21956.23153189639, 22144.557108857814, 22201.2229571965, 21999.0, 22234.0, 22627.208047718334, 22925.885370573167, 23024.88487557564, 6891.9317505786685, 6984.022236886814, 7063.682134303968, 7088.539244949062, 7158.248383919691, 6648.268690444047, 7009.614471204081, 7067.187273463566, 7074.115735533059, 7079.433645308389, 6703.162104736908, 6925.792226233221, 7006.929930700679, 7071.398931090864, 7075.327843854826, 6930.757423490179, 6934.99442580828, 6988.650567471606, 7020.648967551628, 7025.402840758542, 6228.470580000705, 6449.290578036413, 6653.401193892524, 6846.212685541177, 6876.381125698661, 27175.728242717516, 27518.44963100747, 27881.302967425774, 27934.441311173865, 28183.436331273464, 2790.1071657069747, 2998.415309014743, 3009.653889802679, 3013.2617508710287, 3013.758899288052, 15789.842101578952, 16093.275802588912, 16100.516984490367, 16420.178991050518, 16888.324467021306, 2079.480129967508, 2143.132031527234, 2146.4633841539617, 2147.226998280618, 2152.117631770982, 114944.42527787307, 134067.0, 139545.0, 143357.2832135843, 158756.0, 18918.52703682419, 19278.0, 20531.0, 21247.0, 21315.36053918385, 31973.0, 32295.35409291801, 32978.0, 33103.675852965614, 33118.50322245168, 10537.947310263553, 10582.153427725763, 10602.734931626617, 10764.3541387517, 10945.0, 7391.889121663179, 8949.910500895037, 8990.460572365548, 8991.865122023175, 9095.27237820986, 8822.426542274732, 9397.859032114524, 9406.482643454676, 9616.038396160468, 9624.0, 3795.772253664734, 4171.144915292358, 4185.58144185579, 4206.369044643328, 4207.684423668237, 832.388194676912, 892.1836519584507, 906.8141031088611, 947.6777895515557, 951.3340661536952, 20918.686219706717, 22806.65790013151, 22824.65763013556, 22847.88576057109, 22881.542369152525, 716.4948711158621, 934.345957829522, 964.0793042644258, 966.7244835221928, 970.9223262139012, 9569.186619137312, 11518.88481115195, 11773.88226117745, 11810.88189118115, 11869.347185904686, 531409.0, 596017.0, 622328.0, 630401.0, 700560.0, 161764.38235617493, 163529.0, 164645.0, 165487.0, 169830.0, 1275.4961790092862, 1318.4462525739214, 1343.7715588350004, 1349.1837438349853, 1355.3426588104958, 19547.609047818678, 19946.002699864657, 20325.49186270355, 20407.387778366672, 20439.59120817605, 44770.0, 58920.0, 60058.69970650119, 61380.69309653423, 62201.0, 75064.62467687626, 76568.0, 85723.0, 86196.56901715451, 88480.5575972116, 9408.388454750419, 10724.291714318246, 11074.837142099963, 11111.0, 11411.372374519482, 11959.820602690792, 11985.161038727205, 12016.759664806481, 12328.0, 12360.938195308965, 10417.739556510845, 10469.528871200966, 10511.947440263055, 10664.893351066701, 10799.0, 9768.413895166314, 9851.901480985098, 10003.249756268164, 10094.798104038025, 10141.645042423479, 10554.894451055392, 10843.078338341329, 10886.836697449386, 10984.560617575207, 11142.164337674869, 10990.945045274722, 11125.443727813416, 11259.774804504028, 11321.377324247245, 11423.485943132413, 10631.946840266059, 10680.946595266974, 10737.886013056126, 10803.189760768131, 10876.401797901191], "value": 11489.294917622507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.3192067807452, 1467.2663668165917, 1584.9603759906008, 1608.9597760056004, 1630.2012014113084, 9498.430094194353, 10820.567177312907, 11330.376829274386, 11401.714957126076, 11781.587644432446, 11161.162912781554, 11386.032187264072, 11389.886101138985, 11415.029722473579, 11458.48436820343, 2433.707955045397, 2462.827602067856, 2462.963055554168, 2465.987670061656, 2469.259222233332, 2417.6857008588945, 2421.4309637235237, 2438.0247900839718, 2445.7676520730593, 2450.534398464286, 2442.157455677788, 2453.5924062554163, 2454.0919859651954, 2484.3789052736815, 2491.0907518755703, 2406.0255596483453, 2428.9757102428925, 2429.878506074698, 2438.5244877248942, 2443.6701045359005, 1956.2859556262003, 2410.3612542676206, 2431.501542183848, 2436.5857804173334, 2443.6212387079854, 11101.000909918146, 11224.045956093742, 11285.943570282096, 11287.37919414432, 11302.660920172408, 5771.826845194651, 5892.616979896293, 5964.314103878066, 5974.432428919289, 5989.670568118751, 3353.9496907546404, 3396.762226644136, 3449.379111759882, 3488.476728490721, 3554.8222588870453, 1152.2049785647876, 1154.9826752598717, 1181.4565299961941, 1196.8025275829477, 1232.4761976160187, 13805.447782088704, 14103.153810771386, 14903.329350179269, 15371.846281537153, 15531.068135911768, 4751.121042607128, 4871.220604703301, 4871.707697538159, 4884.4871288514905, 4894.608431325485, 11794.587189448499, 11919.70200744971, 11925.224860384047, 11927.761444771057, 11946.641600751991, 5803.419658034163, 5985.491233245223, 6003.399660034049, 6005.669688167105, 6009.759609615567, 5299.3905700844125, 5377.381601115843, 5462.426445223195, 5491.588130890199, 5514.448555144453, 3824.9426258606145, 3972.443857859902, 3990.7605543667473, 4020.778857162884, 4068.3694027425795, 1058.9947050264852, 1063.2079101069753, 1063.4788953412926, 1073.592035026685, 1077.8167711489066, 937.8921424036187, 956.1824639932896, 967.5307475874196, 973.2360097323567, 1003.5584342889106, 5688.146777983253, 6246.46905013079, 6705.597664140069, 6789.626570538569, 6950.652467376611, 985.280745056113, 1000.4997501249376, 1017.2726500551993, 1021.4790456866903, 1040.7502199472224, 3582.731295152874, 3645.3802853514967, 4204.0, 4328.805203765838, 4340.730420937369, 11454.54181832734, 13447.462101516025, 14134.010619256758, 14137.575872723835, 14172.503962361268, 13872.930635346758, 13977.720445591234, 14042.438302467992, 14065.789013164811, 14081.155130692192, 10136.746581335525, 10279.920608336166, 10417.06246437809, 10544.0, 10558.419286939139, 5743.282089738783, 6659.0, 6664.933350666432, 6755.729770809113, 6844.110265665432, 10824.891751082389, 12300.384980751105, 12547.05897057706, 12556.560520382109, 12558.497660093859, 9991.700248992542, 10786.946065269623, 12752.48990040388, 12809.8078528824, 13116.344182791014, 7174.174969878531, 8323.334133269445, 8415.074341822272, 8462.830743384975, 8511.574421278787, 10318.896811031793, 10356.084124437004, 10440.477976101012, 10441.791164176826, 10480.475976201007, 8885.37802353855, 8906.287497000354, 8934.955325223333, 8996.64013439455, 9056.320775941698, 7840.098388685375, 8622.439541429787, 8716.520591367536, 8793.20861122502, 8798.956005219932, 5988.760449581968, 7938.483998540077, 8012.559309237815, 8045.0, 8136.267735903797, 5619.915701264403, 5639.295088113986, 6015.2180216573315, 6106.572539922163, 6107.877842443215, 5879.764809407576, 6015.578909476295, 6263.0, 6310.684465776784, 6326.841828954313], "value": 5155.236420223705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.88756878876785, 329.5551006141707, 375.2026942746663, 392.9155231625202, 398.87834210565785, 4141.287456715852, 4989.850304490867, 5108.948910510894, 5219.295395121658, 5405.540529055025, 5192.948070519294, 5341.385740639827, 5344.572434205264, 5376.623636345457, 5380.946190538093, 3954.2486927483687, 4317.892052698676, 4472.166411771158, 4580.145041258295, 4591.471980722226, 3823.9426408603754, 4522.547745225467, 4559.99680070384, 4652.139144342256, 4656.650751193657, 4612.469565999902, 4654.394928659286, 4672.929906051395, 4682.0, 4709.693869898446, 3819.923601527954, 4656.5110663380365, 4661.300804879262, 4672.929906051412, 4728.905421891577, 3794.146317078663, 4216.304309788881, 4346.869593912188, 4456.6352403934825, 4485.461744590637, 4387.912241755147, 4771.23660214364, 5061.544460998491, 5187.688738675692, 5261.500157485033, 4374.846880359204, 4703.459102203256, 5205.765740541685, 5383.869387428645, 5400.864978375572, 5017.974910125463, 5366.397297310801, 5421.0, 5730.7707691692285, 5834.0, 4214.726042807208, 4570.291604801261, 4925.177684256812, 4933.925991110136, 4936.925946110811, 5362.65142765719, 5616.32604087508, 5804.245448091763, 5907.4683278505145, 5934.0, 4494.505549420038, 4733.881652958704, 4989.600831933437, 5026.346574945307, 5078.5937125029905, 4402.361657559636, 5203.479652034766, 5216.63483556155, 5221.373435187726, 5261.4738526147075, 4593.185691651779, 5104.770285337095, 5129.538341549204, 5315.362156541162, 5412.0, 5173.63784535079, 5398.78404863801, 5448.564114870801, 5804.345761457964, 5819.76720931158, 1622.7809245751673, 1746.5546285697067, 1785.3215778004535, 1803.5400972752127, 1817.4729328494589, 1022.9693109206736, 1199.7060720123625, 1217.794383560269, 1220.7009282725612, 1242.0001898471637, 5238.68567885928, 5304.92042619361, 5315.687675861012, 5328.749462827672, 5346.732663366816, 5108.106081435808, 5447.809326673548, 5916.408359164136, 5918.260217472816, 5960.5231581474245, 4433.600975912119, 4734.479207287196, 5227.947720522746, 5243.475652434802, 5295.213922045756, 2717.6738791345165, 2896.6089577907132, 2929.8095623784384, 3093.458644737162, 3102.30198205402, 5274.841754747364, 5396.514313711785, 5477.507024367826, 5790.826275211751, 6084.908726369108, 4901.779419926112, 4942.159832828428, 5414.374028596128, 5550.91673624896, 6205.565610407319, 5700.714964251771, 5824.573324273498, 6133.815985520441, 6181.7527298908435, 6255.124282600348, 4870.245112007645, 5211.895762084661, 5529.695866727368, 5835.212246346859, 5835.56233282514, 4996.275540046746, 5464.480874316933, 5657.462541058593, 5695.810346205973, 5811.767529298781, 5127.717975511383, 5376.596755243294, 5694.857628559319, 6041.093835924647, 6319.58922670025, 4714.387129673258, 4723.527647235386, 4729.929051064168, 4733.751468052647, 4745.83389581363, 5096.73195428031, 5180.533751962342, 5557.027520184032, 5831.533477321889, 5939.703014849154, 4917.704937703749, 4923.458419573915, 5725.770969161354, 5752.453516916054, 5797.579428137419, 4793.154635465301, 5486.478784515464, 5517.834464966058, 5683.692750667452, 5780.283266864567, 5378.247045413724, 5520.641158324696, 5524.33707955048, 5563.332400112013, 5588.469095435927, 4817.975910120427, 5212.98346822366, 5220.9738951305, 5734.799282025276, 5776.595638305278, 5195.610329225399, 5406.702631355313, 5465.562754979672, 5494.9725251375085, 5531.408930587683], "value": 4405.527388579123, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.6481921087484, 754.5856738082223, 776.7475570439605, 825.9669613215472, 847.0470720439506, 12346.691332716686, 15500.922495387522, 16454.42409515667, 16523.999999999985, 16550.751738723928, 13156.605301840937, 15599.532014039569, 15691.293891774869, 15715.44995925143, 15826.208689565534, 972.6304004478307, 981.990180098197, 996.9252306077037, 998.3909815012836, 1005.2912696548952, 959.1176117971448, 987.3976874106825, 992.9503524823766, 993.2252842782641, 993.7664648807524, 1027.5170669785189, 1038.9636362727306, 1041.9791604167913, 1043.3844032021107, 1047.2302857399804, 1020.5662593397814, 1026.933249338798, 1035.254616675992, 1035.53400969564, 1036.6371769880518, 766.5132640773094, 772.3859531672277, 781.1524495921932, 782.3115658220729, 782.9217078292182, 16235.512934611863, 16645.750313745302, 16664.0, 17227.397041103628, 17688.11559422024, 14184.0, 14350.64123396913, 14356.64108397288, 14377.281135943162, 14405.567832965027, 11887.167898247126, 11892.167548271624, 11910.702232444171, 12513.37433128349, 12578.81131783024, 3630.8729194478065, 3706.721995850322, 3732.3841566141555, 3751.0, 3873.2447172801317, 104784.0, 118892.81107188904, 119236.0, 119676.0, 119975.4001229997, 10513.84229236562, 10580.0, 11114.11087113029, 11209.0, 11409.030232430336, 21219.575608488052, 21377.144914203258, 21795.34613961584, 21856.781432185475, 21899.343019709435, 7517.511361761468, 7624.351930086005, 7663.885041724378, 7681.731139410093, 7688.923110768821, 4240.681948853849, 4254.532001479834, 4289.635380992589, 4293.205756934977, 4312.849050283287, 3326.833658317123, 3385.306012267479, 3397.6432474590306, 3406.114410253352, 3417.79493230407, 601.5157797972587, 603.7705671844759, 607.6900780601836, 609.9908501372483, 614.27822308787, 654.6922946215271, 661.3584822721951, 664.123357168533, 682.331315310998, 688.8484533402643, 9385.474860335196, 10126.088652021353, 10146.44194569291, 10170.644027459004, 10178.389296642225, 649.6426965169233, 678.0776498626351, 684.8938414545753, 691.7025678958096, 692.8926016467456, 4818.927716084261, 4876.400586320794, 4898.559129678346, 4910.0, 4939.431965323962, 103648.0, 107138.0, 107925.0, 108392.91607083986, 110180.0, 89143.55428222817, 90509.54745226364, 91606.08393915975, 93551.0, 93697.0, 78953.81569276465, 80782.0, 82229.0, 82253.76619350715, 83068.0, 9004.50475223869, 9295.209907157698, 9312.0, 9350.298727595322, 9372.48451335156, 51475.742621288155, 52183.21725174201, 52191.73904130455, 53320.13379531698, 53550.73224633852, 52444.0, 65926.02221933349, 66033.33966660273, 66838.66580667066, 67332.3266767326, 9552.901416336932, 9692.864766730649, 9903.708419544815, 11110.055645270242, 11149.10807135411, 11368.715782105513, 12032.398380081137, 12035.217710848767, 12057.819132713192, 12390.070744694363, 11287.83583499927, 11338.546458141582, 11751.471183796579, 11831.76336473283, 12291.32397718134, 11341.716457088638, 11620.941895290469, 11724.88275117238, 12077.27536347822, 12092.818607721067, 11187.216894817284, 11527.596534121602, 11787.469563869818, 12046.277223366626, 12065.155439119177, 8059.758207253792, 8242.670293188205, 8332.6666933322, 8505.489670619783, 8539.188777066169, 6990.9300906990275, 8127.469369836782, 9136.0, 9581.470906273025, 9733.370420408633], "value": 7449.520920836379, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 122.0, 121.0, 121.0, 119.0, 119.0, 121.0, 118.0, 121.0], "value": 119.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 131.0, 182.0, 140.0, 114.0, 114.0, 112.0, 127.0, 117.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 258.0, 281.0, 213.0, 201.0, 199.0, 195.0, 200.0, 236.0], "value": 215.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 55.0, 102.0, 77.0, 74.0, 73.0, 54.0, 65.0, 81.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 73.0, 88.0, 71.0, 71.0, 70.0, 82.0, 69.0, 64.0, 73.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 136.0, 107.0, 137.0, 91.0, 90.0, 89.0, 88.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 116.0, 118.0, 96.0, 95.0, 118.0, 116.0, 154.0, 150.0, 96.0], "value": 115.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 77.0, 144.0, 146.0, 94.0, 144.0, 81.0, 145.0, 144.0, 97.0], "value": 116.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 69.0, 70.0, 70.0, 70.0, 69.0, 81.0, 105.0], "value": 73.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 58.0, 66.0, 63.0, 58.0, 57.0, 57.0, 60.0, 57.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 84.0, 89.0, 84.0, 89.0, 83.0, 84.0, 83.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 141.0, 146.0, 154.0, 153.0, 148.0, 169.0, 216.0, 154.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 169.0, 168.0, 170.0, 166.0, 167.0, 171.0, 168.0, 166.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 78.0, 91.0, 87.0, 86.0, 74.0, 65.0], "value": 74.9, "unit": "score"}]}]} 03:37:08 INFO - Return code: 0 03:37:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:37:08 ERROR - # TBPL SUCCESS # 03:37:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:37:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:37:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:37:08 INFO - 2017-05-25 03:37:08.108 screenresolution[1687:12272] starting screenresolution argv=screenresolution get 03:37:08 INFO - 2017-05-25 03:37:08.111 screenresolution[1687:12272] Display 0: 1600x1200x32@60 03:37:08 INFO - 2017-05-25 03:37:08.117 screenresolution[1688:12275] starting screenresolution argv=screenresolution list 03:37:08 INFO - Available Modes on Display 0 03:37:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:37:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:37:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:37:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:37:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:37:08 INFO - Intel Iris: 03:37:08 INFO - Chipset Model: Intel Iris 03:37:08 INFO - Type: GPU 03:37:08 INFO - Bus: Built-In 03:37:08 INFO - VRAM (Dynamic, Max): 1536 MB 03:37:08 INFO - Vendor: Intel (0x8086) 03:37:08 INFO - Device ID: 0x0a2e 03:37:08 INFO - Revision ID: 0x0009 03:37:08 INFO - Displays: 03:37:08 INFO - Display: 03:37:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:37:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:37:08 INFO - Display Serial Number: 1600x1200 60 03:37:08 INFO - Main Display: Yes 03:37:08 INFO - Mirror: Off 03:37:08 INFO - Online: Yes 03:37:08 INFO - Rotation: Supported 03:37:08 INFO - Return code: 0 03:37:08 INFO - Running post-action listener: _resource_record_post_action 03:37:08 INFO - [mozharness: 2017-05-25 10:37:08.367286Z] Finished run-tests step (success) 03:37:08 INFO - Running post-run listener: _resource_record_post_run 03:37:08 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 32698368; Write bytes: 513873920; Read time: 204; Write time: 1697 03:37:08 INFO - TinderboxPrint: CPU usage
54.5% 03:37:08 INFO - TinderboxPrint: I/O read bytes / time
32,698,368 / 204 03:37:08 INFO - TinderboxPrint: I/O write bytes / time
513,873,920 / 1,697 03:37:08 INFO - TinderboxPrint: CPU idle
2,179.0 (45.5%) 03:37:08 INFO - TinderboxPrint: CPU system
962.2 (20.1%) 03:37:08 INFO - TinderboxPrint: CPU user
1,652.5 (34.5%) 03:37:08 INFO - TinderboxPrint: Swap in / out
238,034,944 / 0 03:37:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206023168; Write bytes: 201734144; Read time: 15592; Write time: 435 03:37:08 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 30605312; Write bytes: 301068288; Read time: 183; Write time: 1223 03:37:08 INFO - Running post-run listener: _upload_blobber_files 03:37:08 INFO - Blob upload gear active. 03:37:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:37:08 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 03:37:08 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', 'Jamun', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:37:08 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 Jamun -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:37:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:37:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:37:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:10 INFO - (blobuploader) - INFO - Done attempting. 03:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:37:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:11 INFO - (blobuploader) - INFO - Done attempting. 03:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:37:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:13 INFO - (blobuploader) - INFO - Done attempting. 03:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:15 INFO - (blobuploader) - INFO - Done attempting. 03:37:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:37:15 INFO - Return code: 0 03:37:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:37:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:37:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/96603e74f83927e4476f27079f4068a73451112ed69c35ed44c5dcd188ff208eec8b16b867912d04f9429267189a888f080fdf5d2acdc1ad535082bd27e83b87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/ddf0a7cbaf478ec8e0c6deadbbc39174017d988e005d7716597a826a3497b0f010872ee074bfaf51a70ee505c8aa6a19b79e9b96e10955e7d9c720a10d7225d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b1a153624c32ab116a3051a886de7c0a435b9b724c24ab81a5432b72137715e3658692757c2dd3363bdd8e15aa59d77fa58995fd3487f67e4c65264df5b8832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/4644296e741a56c47bf031a721e3e4c31fa834a13867c7adb225f58f9b9d93c7ff08b279395931bb1cf72c371d6efcaa8c085b592d19593c6ec5692430ab61c5"} 03:37:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:37:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:37:15 INFO - Contents: 03:37:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/96603e74f83927e4476f27079f4068a73451112ed69c35ed44c5dcd188ff208eec8b16b867912d04f9429267189a888f080fdf5d2acdc1ad535082bd27e83b87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/ddf0a7cbaf478ec8e0c6deadbbc39174017d988e005d7716597a826a3497b0f010872ee074bfaf51a70ee505c8aa6a19b79e9b96e10955e7d9c720a10d7225d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b1a153624c32ab116a3051a886de7c0a435b9b724c24ab81a5432b72137715e3658692757c2dd3363bdd8e15aa59d77fa58995fd3487f67e4c65264df5b8832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/4644296e741a56c47bf031a721e3e4c31fa834a13867c7adb225f58f9b9d93c7ff08b279395931bb1cf72c371d6efcaa8c085b592d19593c6ec5692430ab61c5"} 03:37:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:37:15 INFO - Copying logs to upload dir... 03:37:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:37:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2483.373792 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 23 secs) (at 2017-05-25 03:37:15.110922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 03:37:15.114544) ========= 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.GgKGDLcVrL/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.45DyFiByE2/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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/Jamun/sha512/96603e74f83927e4476f27079f4068a73451112ed69c35ed44c5dcd188ff208eec8b16b867912d04f9429267189a888f080fdf5d2acdc1ad535082bd27e83b87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/ddf0a7cbaf478ec8e0c6deadbbc39174017d988e005d7716597a826a3497b0f010872ee074bfaf51a70ee505c8aa6a19b79e9b96e10955e7d9c720a10d7225d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b1a153624c32ab116a3051a886de7c0a435b9b724c24ab81a5432b72137715e3658692757c2dd3363bdd8e15aa59d77fa58995fd3487f67e4c65264df5b8832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/4644296e741a56c47bf031a721e3e4c31fa834a13867c7adb225f58f9b9d93c7ff08b279395931bb1cf72c371d6efcaa8c085b592d19593c6ec5692430ab61c5"} build_url:https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/QbveZ1_pQMWFfF68ddwJeQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/96603e74f83927e4476f27079f4068a73451112ed69c35ed44c5dcd188ff208eec8b16b867912d04f9429267189a888f080fdf5d2acdc1ad535082bd27e83b87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/ddf0a7cbaf478ec8e0c6deadbbc39174017d988e005d7716597a826a3497b0f010872ee074bfaf51a70ee505c8aa6a19b79e9b96e10955e7d9c720a10d7225d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/0b1a153624c32ab116a3051a886de7c0a435b9b724c24ab81a5432b72137715e3658692757c2dd3363bdd8e15aa59d77fa58995fd3487f67e4c65264df5b8832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/4644296e741a56c47bf031a721e3e4c31fa834a13867c7adb225f58f9b9d93c7ff08b279395931bb1cf72c371d6efcaa8c085b592d19593c6ec5692430ab61c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 03:37:15.148644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 03:37:15.148998) ========= 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.GgKGDLcVrL/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.45DyFiByE2/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.005219 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 03:37:15.197919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 03:37:15.198256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 03:37:15.198577) ========= ========= Total master_lag: 0.18 =========