builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0182 starttime: 1489783051.6 results: success (0) buildid: 20170317104120 builduid: 4b633499642944178d80cebe0eaf62cd revision: a41eef042ceb6cdba74b279d5df464f14a7bd181 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:31.596651) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:31.597141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:31.597425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:31.624586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:31.625043) ========= 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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-17 13:37:31-- 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% 2.63M=0.004s 2017-03-17 13:37:32 (2.63 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.494187 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:32.145061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:32.145569) ========= 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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.021405 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:32.199583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 13:37:32.200207) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a41eef042ceb6cdba74b279d5df464f14a7bd181 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a41eef042ceb6cdba74b279d5df464f14a7bd181 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gpFkJrx1vy/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.e8PNAVPFhW/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-17 13:37:32,292 truncating revision to first 12 chars 2017-03-17 13:37:32,292 Setting DEBUG logging. 2017-03-17 13:37:32,293 attempt 1/10 2017-03-17 13:37:32,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a41eef042ceb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 13:37:33,361 unpacking tar archive at: mozilla-beta-a41eef042ceb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.602611 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 13:37:33.830159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:33.830715) ========= script_repo_revision: a41eef042ceb6cdba74b279d5df464f14a7bd181 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:33.831404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:33.831879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 13:37:33.854180) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-17 13:37:33.854854) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gpFkJrx1vy/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.e8PNAVPFhW/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:37:34 INFO - MultiFileLogger online at 20170317 13:37:34 in /builds/slave/test 13:37:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:37:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:37:34 INFO - {'append_to_log': False, 13:37:34 INFO - 'base_work_dir': '/builds/slave/test', 13:37:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:37:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:37:34 INFO - 'branch': 'Mozilla-Beta', 13:37:34 INFO - 'buildbot_json_path': 'buildprops.json', 13:37:34 INFO - 'config_files': ('talos/mac_config.py',), 13:37:34 INFO - 'default_actions': ('clobber', 13:37:34 INFO - 'read-buildbot-config', 13:37:34 INFO - 'download-and-extract', 13:37:34 INFO - 'populate-webroot', 13:37:34 INFO - 'create-virtualenv', 13:37:34 INFO - 'install', 13:37:34 INFO - 'run-tests'), 13:37:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:37:34 INFO - 'download_minidump_stackwalk': True, 13:37:34 INFO - 'download_symbols': 'ondemand', 13:37:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:37:34 INFO - 'tooltool.py': '/tools/tooltool.py', 13:37:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:37:34 INFO - '/tools/misc-python/virtualenv.py')}, 13:37:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:37:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:37:34 INFO - 'installer_path': 'installer.exe', 13:37:34 INFO - 'log_level': 'info', 13:37:34 INFO - 'log_name': 'talos', 13:37:34 INFO - 'log_to_console': True, 13:37:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:37:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:37:34 INFO - 'opt_config_files': (), 13:37:34 INFO - 'pip_index': False, 13:37:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:37:34 INFO - 'cmd': ('bash', 13:37:34 INFO - '-c', 13:37:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:37:34 INFO - 'enabled': True, 13:37:34 INFO - 'halt_on_failure': False, 13:37:34 INFO - 'name': 'check_screen_resolution'},), 13:37:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:37:34 INFO - 'cmd': ('bash', 13:37:34 INFO - '-c', 13:37:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:37:34 INFO - 'enabled': True, 13:37:34 INFO - 'halt_on_failure': False, 13:37:34 INFO - 'name': 'check_screen_resolution'},), 13:37:34 INFO - 'run_cmd_checks_enabled': True, 13:37:34 INFO - 'sps_profile': False, 13:37:34 INFO - 'sps_profile_interval': 0, 13:37:34 INFO - 'suite': 'dromaeojs-e10s', 13:37:34 INFO - 'system_bits': '32', 13:37:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:37:34 INFO - 'title': 't-yosemite-r7-0182', 13:37:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:37:34 INFO - 'use_talos_json': True, 13:37:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:37:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:37:34 INFO - 'work_dir': 'build'} 13:37:34 INFO - [mozharness: 2017-03-17 20:37:34.069858Z] Running clobber step. 13:37:34 INFO - Running pre-action listener: _resource_record_pre_action 13:37:34 INFO - Running main action method: clobber 13:37:34 INFO - rmtree: /builds/slave/test/build 13:37:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:37:35 INFO - Running post-action listener: _resource_record_post_action 13:37:35 INFO - [mozharness: 2017-03-17 20:37:35.808096Z] Finished clobber step (success) 13:37:35 INFO - [mozharness: 2017-03-17 20:37:35.808264Z] Running read-buildbot-config step. 13:37:35 INFO - Running pre-action listener: _resource_record_pre_action 13:37:35 INFO - Running main action method: read_buildbot_config 13:37:35 INFO - Using buildbot properties: 13:37:35 INFO - { 13:37:35 INFO - "project": "", 13:37:35 INFO - "product": "firefox", 13:37:35 INFO - "script_repo_revision": "production", 13:37:35 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:37:35 INFO - "repository": "", 13:37:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:37:35 INFO - "buildid": "20170317104120", 13:37:35 INFO - "pgo_build": "False", 13:37:35 INFO - "basedir": "/builds/slave/test", 13:37:35 INFO - "buildnumber": 21, 13:37:35 INFO - "slavename": "t-yosemite-r7-0182", 13:37:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:37:35 INFO - "platform": "yosemite_r7", 13:37:35 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:37:35 INFO - "branch": "mozilla-beta", 13:37:35 INFO - "repo_path": "releases/mozilla-beta", 13:37:35 INFO - "revision": "a41eef042ceb6cdba74b279d5df464f14a7bd181", 13:37:35 INFO - "stage_platform": "macosx64", 13:37:35 INFO - "builduid": "4b633499642944178d80cebe0eaf62cd", 13:37:35 INFO - "slavebuilddir": "test" 13:37:35 INFO - } 13:37:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 13:37:35 INFO - Running post-action listener: _resource_record_post_action 13:37:35 INFO - [mozharness: 2017-03-17 20:37:35.811539Z] Finished read-buildbot-config step (success) 13:37:35 INFO - [mozharness: 2017-03-17 20:37:35.811646Z] Running download-and-extract step. 13:37:35 INFO - Running pre-action listener: _resource_record_pre_action 13:37:35 INFO - Running main action method: download_and_extract 13:37:35 INFO - mkdir: /builds/slave/test/build/tests 13:37:35 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')]} 13:37:35 INFO - trying https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 13:37:35 INFO - Downloading https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 13:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 13:37:37 INFO - Downloaded 1165 bytes. 13:37:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 13:37:37 INFO - Using the following test package requirements: 13:37:37 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:37:37 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:37:37 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 13:37:37 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:37:37 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 13:37:37 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:37:37 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:37:37 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 13:37:37 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:37:37 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:37:37 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 13:37:37 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:37:37 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 13:37:37 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:37:37 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 13:37:37 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:37:37 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 13:37:37 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 13:37:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:37:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:37:37 INFO - Fetch https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:37:38 INFO - Expected file size: 16108135 13:37:38 INFO - Obtained file size: 16108135 13:37:44 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:37:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:37:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:37:44 INFO - Fetch https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:37:45 INFO - Expected file size: 16108135 13:37:45 INFO - Obtained file size: 16108135 13:37:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 13:37:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 13:37:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 13:37:53 INFO - Expected file size: 14403650 13:37:53 INFO - Obtained file size: 14403650 13:37:53 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')]} 13:37:53 INFO - trying https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:37:53 INFO - Downloading https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 13:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 13:37:55 INFO - Downloaded 58717522 bytes. 13:37:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:37:55 INFO - mkdir: /builds/slave/test/properties 13:37:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:37:55 INFO - Writing to file /builds/slave/test/properties/build_url 13:37:55 INFO - Contents: 13:37:55 INFO - build_url:https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:37:55 INFO - Running post-action listener: _resource_record_post_action 13:37:55 INFO - Running post-action listener: set_extra_try_arguments 13:37:55 INFO - [mozharness: 2017-03-17 20:37:55.856063Z] Finished download-and-extract step (success) 13:37:55 INFO - [mozharness: 2017-03-17 20:37:55.856203Z] Running populate-webroot step. 13:37:55 INFO - Running pre-action listener: _resource_record_pre_action 13:37:55 INFO - Running main action method: populate_webroot 13:37:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:37:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:37:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:37:55 INFO - '--tppagecycles', 13:37:55 INFO - '7'], 13:37:55 INFO - 'tests': ['tsvgm']}}, 13:37:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:37:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:37:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:37:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:37:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:37:55 INFO - 'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:37:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:37:55 INFO - 'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['damp', 'tps']}, 13:37:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:37:55 INFO - 'tests': ['damp', 'tps']}, 13:37:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['dromaeo_dom']}, 13:37:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:37:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['basic_compositor_video']}, 13:37:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:37:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['a11yr', 13:37:55 INFO - 'ts_paint', 13:37:55 INFO - 'tpaint', 13:37:55 INFO - 'sessionrestore', 13:37:55 INFO - 'sessionrestore_no_auto_restore', 13:37:55 INFO - 'tabpaint']}, 13:37:55 INFO - 'other-e10s': {'tests': ['a11yr', 13:37:55 INFO - 'ts_paint', 13:37:55 INFO - 'tpaint', 13:37:55 INFO - 'sessionrestore', 13:37:55 INFO - 'sessionrestore_no_auto_restore', 13:37:55 INFO - 'tabpaint']}, 13:37:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:37:55 INFO - 'ts_paint', 13:37:55 INFO - 'tpaint', 13:37:55 INFO - 'sessionrestore', 13:37:55 INFO - 'sessionrestore_no_auto_restore', 13:37:55 INFO - 'tabpaint']}, 13:37:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:37:55 INFO - 'ts_paint', 13:37:55 INFO - 'tpaint', 13:37:55 INFO - 'sessionrestore', 13:37:55 INFO - 'sessionrestore_no_auto_restore', 13:37:55 INFO - 'tabpaint']}, 13:37:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['a11yr', 13:37:55 INFO - 'ts_paint', 13:37:55 INFO - 'tpaint', 13:37:55 INFO - 'sessionrestore', 13:37:55 INFO - 'sessionrestore_no_auto_restore', 13:37:55 INFO - 'tabpaint']}, 13:37:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['a11yr', 13:37:55 INFO - 'ts_paint', 13:37:55 INFO - 'tpaint', 13:37:55 INFO - 'sessionrestore', 13:37:55 INFO - 'sessionrestore_no_auto_restore', 13:37:55 INFO - 'tabpaint']}, 13:37:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['tsvgx', 13:37:55 INFO - 'tsvgr_opacity', 13:37:55 INFO - 'tart', 13:37:55 INFO - 'tscrollx', 13:37:55 INFO - 'cart', 13:37:55 INFO - 'tsvg_static']}, 13:37:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:37:55 INFO - 'tsvgr_opacity', 13:37:55 INFO - 'tart', 13:37:55 INFO - 'tscrollx', 13:37:55 INFO - 'cart', 13:37:55 INFO - 'tsvg_static']}, 13:37:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:37:55 INFO - 'talos_options': ['--disable-e10s'], 13:37:55 INFO - 'tests': ['tp5o']}, 13:37:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:37:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:37:55 INFO - 'talos_options': ['--disable-e10s', 13:37:55 INFO - '--xperf_path', 13:37:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:55 INFO - 'tests': ['tp5n']}, 13:37:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:37:55 INFO - 'talos_options': ['--xperf_path', 13:37:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:55 INFO - 'tests': ['tp5n']}}, 13:37:55 INFO - 'talos.zip': {'path': '', 13:37:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:37:55 INFO - Running post-action listener: _resource_record_post_action 13:37:55 INFO - [mozharness: 2017-03-17 20:37:55.874417Z] Finished populate-webroot step (success) 13:37:55 INFO - [mozharness: 2017-03-17 20:37:55.874555Z] Running create-virtualenv step. 13:37:55 INFO - Running pre-action listener: _resource_record_pre_action 13:37:55 INFO - Running main action method: create_virtualenv 13:37:55 INFO - Creating virtualenv /builds/slave/test/build/venv 13:37:55 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 13:37:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:37:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:37:55 INFO - Using real prefix '/tools/python27' 13:37:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:37:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:37:59 INFO - Installing pip.................done. 13:37:59 INFO - Return code: 0 13:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:37:59 INFO - Reading from file tmpfile_stdout 13:37:59 INFO - Output received: 13:37:59 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) 13:37:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:37:59 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')]} 13:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:37:59 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')]} 13:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:00 INFO - 'HOME': '/Users/cltbld', 13:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:00 INFO - 'LOGNAME': 'cltbld', 13:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:00 INFO - 'MOZ_NO_REMOTE': '1', 13:38:00 INFO - 'NO_EM_RESTART': '1', 13:38:00 INFO - 'PAGER': '/bin/cat', 13:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:00 INFO - 'PWD': '/builds/slave/test', 13:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:00 INFO - 'SHELL': '/bin/bash', 13:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:00 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:00 INFO - 'USER': 'cltbld', 13:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:00 INFO - 'XPC_FLAGS': '0x0', 13:38:00 INFO - 'XPC_SERVICE_NAME': '0', 13:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:00 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 13:38:00 INFO - Cleaning up... 13:38:00 INFO - Return code: 0 13:38:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:00 INFO - 'HOME': '/Users/cltbld', 13:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:00 INFO - 'LOGNAME': 'cltbld', 13:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:00 INFO - 'MOZ_NO_REMOTE': '1', 13:38:00 INFO - 'NO_EM_RESTART': '1', 13:38:00 INFO - 'PAGER': '/bin/cat', 13:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:00 INFO - 'PWD': '/builds/slave/test', 13:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:00 INFO - 'SHELL': '/bin/bash', 13:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:00 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:00 INFO - 'USER': 'cltbld', 13:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:00 INFO - 'XPC_FLAGS': '0x0', 13:38:00 INFO - 'XPC_SERVICE_NAME': '0', 13:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:00 INFO - Downloading/unpacking psutil>=3.1.1 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:38:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:04 INFO - Installing collected packages: psutil 13:38:04 INFO - Running setup.py install for psutil 13:38:04 INFO - building 'psutil._psutil_osx' extension 13:38:04 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 13:38:05 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 13:38:05 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 13:38:05 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 13:38:05 INFO - building 'psutil._psutil_posix' extension 13:38:05 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 13:38:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:38:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:38:05 INFO - ^ 13:38:05 INFO - 1 warning generated. 13:38:05 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 13:38:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:05 INFO - Successfully installed psutil 13:38:05 INFO - Cleaning up... 13:38:05 INFO - Return code: 0 13:38:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:38:05 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')]} 13:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:05 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')]} 13:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:05 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 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38:05 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 13:38:05 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 13:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:05 INFO - 'HOME': '/Users/cltbld', 13:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:05 INFO - 'LOGNAME': 'cltbld', 13:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:05 INFO - 'MOZ_NO_REMOTE': '1', 13:38:05 INFO - 'NO_EM_RESTART': '1', 13:38:05 INFO - 'PAGER': '/bin/cat', 13:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:05 INFO - 'PWD': '/builds/slave/test', 13:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:05 INFO - 'SHELL': '/bin/bash', 13:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:05 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:05 INFO - 'USER': 'cltbld', 13:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:05 INFO - 'XPC_FLAGS': '0x0', 13:38:05 INFO - 'XPC_SERVICE_NAME': '0', 13:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:38:05 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 13:38:05 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 13:38:05 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 13:38:05 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 13:38:05 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 13:38:05 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 13:38:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:38:08 INFO - Installing collected packages: mozsystemmonitor 13:38:08 INFO - Running setup.py install for mozsystemmonitor 13:38:08 INFO - Successfully installed mozsystemmonitor 13:38:08 INFO - Cleaning up... 13:38:08 INFO - Return code: 0 13:38:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38: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==2.5.1'] in /builds/slave/test/build 13:38: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==2.5.1 13:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:08 INFO - 'HOME': '/Users/cltbld', 13:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:08 INFO - 'LOGNAME': 'cltbld', 13:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:08 INFO - 'MOZ_NO_REMOTE': '1', 13:38:08 INFO - 'NO_EM_RESTART': '1', 13:38:08 INFO - 'PAGER': '/bin/cat', 13:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:08 INFO - 'PWD': '/builds/slave/test', 13:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:08 INFO - 'SHELL': '/bin/bash', 13:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:08 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:08 INFO - 'USER': 'cltbld', 13:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:08 INFO - 'XPC_FLAGS': '0x0', 13:38:08 INFO - 'XPC_SERVICE_NAME': '0', 13:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:08 INFO - Downloading/unpacking jsonschema==2.5.1 13:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:38:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:38:11 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 13:38:11 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 13:38:11 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 13:38:11 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 13:38:11 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 13:38:11 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 13:38:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:38:12 INFO - warning: no files found matching '*.txt' 13:38:12 INFO - no previously-included directories found matching 'build' 13:38:12 INFO - no previously-included directories found matching 'dist' 13:38:12 INFO - no previously-included directories found matching '.git*' 13:38:12 INFO - Installing collected packages: jsonschema, functools32 13:38:12 INFO - Running setup.py install for functools32 13:38:12 INFO - warning: no files found matching '*.txt' 13:38:12 INFO - no previously-included directories found matching 'build' 13:38:12 INFO - no previously-included directories found matching 'dist' 13:38:12 INFO - no previously-included directories found matching '.git*' 13:38:12 INFO - Successfully installed jsonschema functools32 13:38:12 INFO - Cleaning up... 13:38:12 INFO - Return code: 0 13:38:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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', '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 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:38: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 functools32==3.2.3-2 13:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:12 INFO - 'HOME': '/Users/cltbld', 13:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:12 INFO - 'LOGNAME': 'cltbld', 13:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:12 INFO - 'MOZ_NO_REMOTE': '1', 13:38:12 INFO - 'NO_EM_RESTART': '1', 13:38:12 INFO - 'PAGER': '/bin/cat', 13:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:12 INFO - 'PWD': '/builds/slave/test', 13:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:12 INFO - 'SHELL': '/bin/bash', 13:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:12 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:12 INFO - 'USER': 'cltbld', 13:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:12 INFO - 'XPC_FLAGS': '0x0', 13:38:12 INFO - 'XPC_SERVICE_NAME': '0', 13:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:38:12 INFO - Cleaning up... 13:38:12 INFO - Return code: 0 13:38:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:38: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')]} 13:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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')]} 13:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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', '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 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:38: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 blobuploader==1.2.4 13:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:12 INFO - 'HOME': '/Users/cltbld', 13:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:12 INFO - 'LOGNAME': 'cltbld', 13:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:12 INFO - 'MOZ_NO_REMOTE': '1', 13:38:12 INFO - 'NO_EM_RESTART': '1', 13:38:12 INFO - 'PAGER': '/bin/cat', 13:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:12 INFO - 'PWD': '/builds/slave/test', 13:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:12 INFO - 'SHELL': '/bin/bash', 13:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:12 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:12 INFO - 'USER': 'cltbld', 13:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:12 INFO - 'XPC_FLAGS': '0x0', 13:38:12 INFO - 'XPC_SERVICE_NAME': '0', 13:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:12 INFO - Downloading/unpacking blobuploader==1.2.4 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38:15 INFO - Downloading blobuploader-1.2.4.tar.gz 13:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:38:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:38:15 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 13:38:15 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 13:38:15 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 13:38:15 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 13:38:15 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 13:38:15 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 13:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:38:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:16 INFO - Downloading docopt-0.6.1.tar.gz 13:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:38:16 INFO - Installing collected packages: blobuploader, requests, docopt 13:38:16 INFO - Running setup.py install for blobuploader 13:38:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:38:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:38:16 INFO - Running setup.py install for requests 13:38:17 INFO - Running setup.py install for docopt 13:38:17 INFO - Successfully installed blobuploader requests docopt 13:38:17 INFO - Cleaning up... 13:38:17 INFO - Return code: 0 13:38:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:17 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')]} 13:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:17 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')]} 13:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:17 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 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38:17 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 13:38:17 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 13:38:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:17 INFO - 'HOME': '/Users/cltbld', 13:38:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:17 INFO - 'LOGNAME': 'cltbld', 13:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:17 INFO - 'MOZ_NO_REMOTE': '1', 13:38:17 INFO - 'NO_EM_RESTART': '1', 13:38:17 INFO - 'PAGER': '/bin/cat', 13:38:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:17 INFO - 'PWD': '/builds/slave/test', 13:38:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:17 INFO - 'SHELL': '/bin/bash', 13:38:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:17 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:17 INFO - 'USER': 'cltbld', 13:38:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:17 INFO - 'XPC_FLAGS': '0x0', 13:38:17 INFO - 'XPC_SERVICE_NAME': '0', 13:38:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:38:17 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-N60fYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-3J7_Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-71lfuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-J2izaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-5xKMml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-dCuJan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-OkUxdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-FR5YUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-j19q3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:38:18 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-mIYyHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:38:19 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-4O40mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:38:19 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-YkqUVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:38:19 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-dTfFHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:38:19 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-hFnph1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:19 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-gh013B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:38:19 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-3YaAer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:38:19 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-OIYrEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:38:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:38:19 INFO - Running setup.py install for manifestparser 13:38:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:38:19 INFO - Running setup.py install for mozcrash 13:38:20 INFO - Running setup.py install for mozdebug 13:38:20 INFO - Running setup.py install for mozdevice 13:38:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Running setup.py install for mozfile 13:38:20 INFO - Running setup.py install for mozhttpd 13:38:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Running setup.py install for mozinfo 13:38:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Running setup.py install for mozInstall 13:38:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:38:20 INFO - Running setup.py install for mozleak 13:38:21 INFO - Running setup.py install for mozlog 13:38:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:38:21 INFO - Running setup.py install for moznetwork 13:38:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:38:21 INFO - Running setup.py install for mozprocess 13:38:21 INFO - Running setup.py install for mozprofile 13:38:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:38:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:38:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:38:21 INFO - Running setup.py install for mozrunner 13:38:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:38:21 INFO - Running setup.py install for mozscreenshot 13:38:22 INFO - Running setup.py install for moztest 13:38:22 INFO - Running setup.py install for mozversion 13:38:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:38:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:38:22 INFO - Cleaning up... 13:38:22 INFO - Return code: 0 13:38:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:22 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 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38:22 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 13:38:22 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 13:38:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:22 INFO - 'HOME': '/Users/cltbld', 13:38:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:22 INFO - 'LOGNAME': 'cltbld', 13:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:22 INFO - 'MOZ_NO_REMOTE': '1', 13:38:22 INFO - 'NO_EM_RESTART': '1', 13:38:22 INFO - 'PAGER': '/bin/cat', 13:38:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:22 INFO - 'PWD': '/builds/slave/test', 13:38:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:22 INFO - 'SHELL': '/bin/bash', 13:38:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:22 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:22 INFO - 'USER': 'cltbld', 13:38:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:22 INFO - 'XPC_FLAGS': '0x0', 13:38:22 INFO - 'XPC_SERVICE_NAME': '0', 13:38:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:38:22 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-FaeEv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:38:22 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)) 13:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:38:22 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-7DvMcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:38:22 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)) 13:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:38:22 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-R9bumm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:38:22 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)) 13:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:38:22 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-e3fGtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-h3bTl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-m5N0JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-CtMYYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-t7oIf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-1AwaFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-Kze_zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-pvIAD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-sATtIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:38:23 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-_TVzCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:38:23 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)) 13:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:38:24 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-a4jEBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:38:24 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)) 13:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:24 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-bosJvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:38:24 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)) 13:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:38:24 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-PIyQ3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:38:24 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)) 13:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:38:24 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-c_dntA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:38:24 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)) 13:38:24 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)) 13:38:24 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)) 13:38:24 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)) 13:38:24 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)) 13:38:24 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)) 13:38:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38:27 INFO - Downloading blessings-1.6.tar.gz 13:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:38:27 INFO - Installing collected packages: blessings 13:38:27 INFO - Running setup.py install for blessings 13:38:27 INFO - Successfully installed blessings 13:38:27 INFO - Cleaning up... 13:38:27 INFO - Return code: 0 13:38:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:38:27 INFO - Reading from file tmpfile_stdout 13:38:27 INFO - Current package versions: 13:38:27 INFO - blessings == 1.6 13:38:27 INFO - blobuploader == 1.2.4 13:38:27 INFO - docopt == 0.6.1 13:38:27 INFO - functools32 == 3.2.3-2 13:38:27 INFO - jsonschema == 2.5.1 13:38:27 INFO - manifestparser == 1.1 13:38:27 INFO - mozInstall == 1.12 13:38:27 INFO - mozcrash == 1.0 13:38:27 INFO - mozdebug == 0.1 13:38:27 INFO - mozdevice == 0.49 13:38:27 INFO - mozfile == 1.2 13:38:27 INFO - mozhttpd == 0.7 13:38:27 INFO - mozinfo == 0.9 13:38:27 INFO - mozleak == 0.1 13:38:27 INFO - mozlog == 3.4 13:38:27 INFO - moznetwork == 0.27 13:38:27 INFO - mozprocess == 0.24 13:38:27 INFO - mozprofile == 0.28 13:38:27 INFO - mozrunner == 6.13 13:38:27 INFO - mozscreenshot == 0.1 13:38:27 INFO - mozsystemmonitor == 0.3 13:38:27 INFO - moztest == 0.8 13:38:27 INFO - mozversion == 1.4 13:38:27 INFO - psutil == 3.1.1 13:38:27 INFO - requests == 1.2.3 13:38:27 INFO - wsgiref == 0.1.2 13:38:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:27 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 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38:27 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 13:38:27 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 13:38:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:27 INFO - 'HOME': '/Users/cltbld', 13:38:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:27 INFO - 'LOGNAME': 'cltbld', 13:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:27 INFO - 'MOZ_NO_REMOTE': '1', 13:38:27 INFO - 'NO_EM_RESTART': '1', 13:38:27 INFO - 'PAGER': '/bin/cat', 13:38:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:27 INFO - 'PWD': '/builds/slave/test', 13:38:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:27 INFO - 'SHELL': '/bin/bash', 13:38:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:27 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:27 INFO - 'USER': 'cltbld', 13:38:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:27 INFO - 'XPC_FLAGS': '0x0', 13:38:27 INFO - 'XPC_SERVICE_NAME': '0', 13:38:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 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)) 13:38:27 INFO - Cleaning up... 13:38:28 INFO - Return code: 0 13:38:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7ac65140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, '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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 13:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:28 INFO - 'HOME': '/Users/cltbld', 13:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:28 INFO - 'LOGNAME': 'cltbld', 13:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:28 INFO - 'MOZ_NO_REMOTE': '1', 13:38:28 INFO - 'NO_EM_RESTART': '1', 13:38:28 INFO - 'PAGER': '/bin/cat', 13:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:28 INFO - 'PWD': '/builds/slave/test', 13:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:28 INFO - 'SHELL': '/bin/bash', 13:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:28 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:28 INFO - 'USER': 'cltbld', 13:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:28 INFO - 'XPC_FLAGS': '0x0', 13:38:28 INFO - 'XPC_SERVICE_NAME': '0', 13:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:38:28 INFO - Cleaning up... 13:38:28 INFO - Return code: 0 13:38:28 INFO - Running post-action listener: _resource_record_post_action 13:38:28 INFO - Running post-action listener: _start_resource_monitoring 13:38:28 INFO - Starting resource monitoring. 13:38:28 INFO - [mozharness: 2017-03-17 20:38:28.302108Z] Finished create-virtualenv step (success) 13:38:28 INFO - [mozharness: 2017-03-17 20:38:28.303073Z] Running install step. 13:38:28 INFO - Running pre-action listener: _resource_record_pre_action 13:38:28 INFO - Running main action method: install 13:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:38:28 INFO - Reading from file tmpfile_stdout 13:38:28 INFO - Detecting whether we're running mozinstall >=1.0... 13:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:38:28 INFO - Reading from file tmpfile_stdout 13:38:28 INFO - Output received: 13:38:28 INFO - Usage: mozinstall [options] installer 13:38:28 INFO - Options: 13:38:28 INFO - -h, --help show this help message and exit 13:38:28 INFO - -d DEST, --destination=DEST 13:38:28 INFO - Directory to install application into. [default: 13:38:28 INFO - "/builds/slave/test"] 13:38:28 INFO - --app=APP Application being installed. [default: firefox] 13:38:28 INFO - mkdir: /builds/slave/test/build/application 13:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:38:43 INFO - Reading from file tmpfile_stdout 13:38:43 INFO - Output received: 13:38:43 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:38:43 INFO - Running post-action listener: _resource_record_post_action 13:38:43 INFO - [mozharness: 2017-03-17 20:38:43.152213Z] Finished install step (success) 13:38:43 INFO - [mozharness: 2017-03-17 20:38:43.152341Z] Running run-tests step. 13:38:43 INFO - Running pre-action listener: _resource_record_pre_action 13:38:43 INFO - Running main action method: run_tests 13:38:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:38:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:38:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:38:43 INFO - 2017-03-17 13:38:43.166 screenresolution[2167:25615] starting screenresolution argv=screenresolution get 13:38:43 INFO - 2017-03-17 13:38:43.169 screenresolution[2167:25615] Display 0: 1600x1200x32@60 13:38:43 INFO - 2017-03-17 13:38:43.175 screenresolution[2168:25617] starting screenresolution argv=screenresolution list 13:38:43 INFO - Available Modes on Display 0 13:38:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:38:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:38:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:38:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:38:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:38:43 INFO - Intel Iris: 13:38:43 INFO - Chipset Model: Intel Iris 13:38:43 INFO - Type: GPU 13:38:43 INFO - Bus: Built-In 13:38:43 INFO - VRAM (Dynamic, Max): 1536 MB 13:38:43 INFO - Vendor: Intel (0x8086) 13:38:43 INFO - Device ID: 0x0a2e 13:38:43 INFO - Revision ID: 0x0009 13:38:43 INFO - Displays: 13:38:43 INFO - Display: 13:38:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:38:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:38:43 INFO - Display Serial Number: 1600x1200 60 13:38:43 INFO - Main Display: Yes 13:38:43 INFO - Mirror: Off 13:38:43 INFO - Online: Yes 13:38:43 INFO - Rotation: Supported 13:38:43 INFO - Return code: 0 13:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:38:43 INFO - Python 2.7.3 13:38:43 INFO - Return code: 0 13:38:43 INFO - grabbing minidump binary from tooltool 13:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:38:43 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 0x103c3fd30>, '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 0x103b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c34be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:38:43 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 13:38:43 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 13:38:43 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 13:38:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:38:43 INFO - Return code: 0 13:38:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:38:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:38:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:38:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:38:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 13:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 13:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gpFkJrx1vy/Render', 13:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:38:43 INFO - 'HOME': '/Users/cltbld', 13:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:38:43 INFO - 'LOGNAME': 'cltbld', 13:38:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:38:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:43 INFO - 'MOZ_NO_REMOTE': '1', 13:38:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:38:43 INFO - 'NO_EM_RESTART': '1', 13:38:43 INFO - 'PAGER': '/bin/cat', 13:38:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:43 INFO - 'PWD': '/builds/slave/test', 13:38:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:38:43 INFO - 'SHELL': '/bin/bash', 13:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e8PNAVPFhW/Listeners', 13:38:43 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 13:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:38:43 INFO - 'USER': 'cltbld', 13:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:43 INFO - 'XPC_FLAGS': '0x0', 13:38:43 INFO - 'XPC_SERVICE_NAME': '0', 13:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:38:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 13:38:43 INFO - mozversion application_buildid: 20170317104120 13:38:43 INFO - mozversion application_changeset: a41eef042ceb6cdba74b279d5df464f14a7bd181 13:38:43 INFO - mozversion application_display_name: Firefox 13:38:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:38:43 INFO - mozversion application_name: Firefox 13:38:43 INFO - mozversion application_remotingname: firefox 13:38:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:38:43 INFO - mozversion application_vendor: Mozilla 13:38:43 INFO - mozversion application_version: 53.0 13:38:43 INFO - mozversion platform_buildid: 20170317104120 13:38:43 INFO - mozversion platform_changeset: a41eef042ceb6cdba74b279d5df464f14a7bd181 13:38:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:38:43 INFO - mozversion platform_version: 53.0 13:38:43 INFO - using testdate: 1489783123 13:38:43 INFO - actual date: 1489783123 13:38:43 INFO - starting webserver on 'localhost:57661' 13:38:43 INFO - SUITE-START | Running 2 tests 13:38:43 INFO - TEST-START | dromaeo_css 13:38:43 INFO - operating with platform_type : mac_ 13:38:43 INFO - Initialising browser for dromaeo_css test... 13:38:43 INFO - TEST-INFO | started process 2178 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpTV9PJQ/profile http://localhost:57661/getInfo.html) 13:38:46 INFO - PROCESS | 2178 | 2017-03-17 13:38:46.657 plugin-container[2181:25764] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3b, name = 'com.apple.tsm.portname' 13:38:46 INFO - PROCESS | 2178 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:38:46 INFO - PROCESS | 2178 | 2017-03-17 13:38:46.658 plugin-container[2181:25764] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9023, name = 'com.apple.CFPasteboardClient' 13:38:46 INFO - PROCESS | 2178 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:38:46 INFO - PROCESS | 2178 | 2017-03-17 13:38:46.658 plugin-container[2181:25764] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:38:46 INFO - PROCESS | 2178 | __metrics Screen width/height:1600/1200 13:38:46 INFO - PROCESS | 2178 | colorDepth:24 13:38:46 INFO - PROCESS | 2178 | Browser inner width/height: 1024/689 13:38:46 INFO - PROCESS | 2178 | __metrics 13:38:46 ERROR - PROCESS | 2178 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 13:38:47 INFO - TEST-INFO | 2178: exit 0 13:38:47 INFO - Browser initialized. 13:38:47 INFO - Running cycle 1/1 for dromaeo_css test... 13:38:47 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpTV9PJQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:49 INFO - PROCESS | 2182 | 2017-03-17 13:38:49.824 plugin-container[2183:25895] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 13:38:49 INFO - PROCESS | 2182 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:38:49 INFO - PROCESS | 2182 | 2017-03-17 13:38:49.825 plugin-container[2183:25895] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 13:38:49 INFO - PROCESS | 2182 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:38:49 INFO - PROCESS | 2182 | 2017-03-17 13:38:49.825 plugin-container[2183:25895] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:38:59 INFO - PROCESS | 2182 | RSS: Main: 172871680 13:38:59 INFO - PROCESS | 2182 | 13:42:00 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:57661/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57661/tests/dromaeo/cssquery-ext.html) 13:42:02 INFO - PROCESS | 2182 | RSS: Main: 190447616 13:42:02 INFO - PROCESS | 2182 | 13:45:04 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:57661/tests/dromaeo/cssquery-ext.html (next: http://localhost:57661/tests/dromaeo/cssquery-jquery.html) 13:45:05 INFO - PROCESS | 2182 | RSS: Main: 202821632 13:45:05 INFO - PROCESS | 2182 | 13:48:07 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:57661/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57661/tests/dromaeo/cssquery-mootools.html) 13:48:08 INFO - PROCESS | 2182 | RSS: Main: 205643776 13:48:08 INFO - PROCESS | 2182 | 13:51:09 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:57661/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57661/tests/dromaeo/cssquery-prototype.html) 13:51:10 INFO - PROCESS | 2182 | RSS: Main: 209113088 13:51:10 INFO - PROCESS | 2182 | 13:54:13 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:57661/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57661/tests/dromaeo/cssquery-yui.html) 13:54:13 INFO - PROCESS | 2182 | RSS: Main: 210190336 13:54:13 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:57661/tests/dromaeo/cssquery-yui.html (next: http://localhost:57661/tests/dromaeo/cssquery-dojo.html) 13:57:16 INFO - PROCESS | 2182 | RSS: Main: 210239488 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | __start_tp_report 13:57:16 INFO - PROCESS | 2182 | _x_x_mozilla_page_load 13:57:16 INFO - PROCESS | 2182 | _x_x_mozilla_page_load_details 13:57:16 INFO - PROCESS | 2182 | |i|pagename|runs| 13:57:16 INFO - PROCESS | 2182 | |0;dojo.html;3380.577427821522;3460.498227756975;3461.8615255389777;3497.9125521861934;3511.4206155984266;5859.794907178244;5870.823875283738;5875.794347197854;5884;5897.911531327033;5857.4435428634215;5926.88146237075;5937.406259374071;5949.107633854924;5961.701914904259;5247.842564723055;5351.919721204185;5355.544778693816;5388.084025715618;5398.973005134969;4371.715838470505;5300.840974770763;5385.865353366158;5401.378841433227;5419.295491586108;5242.135047717122;5269.894602107936;5312.4687531246955;5333;5369.597280203961;5192.1173400522;5218.530332270114;5253.395859476171;5310.840674779763;5362.410134885159;5222.242774797671;5225.320708307896;5249.265102885599;5254;5278;4495.213337665896;5249.317588713443;5681.289838770153;5880.294364676223;5912.379200184005;6163.229596300463;6190.473809726179;6196.318404975449;6218.4714299284615;6294.937050629481;6318.43134117927;6329.303776584618;6341.4609758170145;6344.397282258178;6357.554971152022;6070.575059745864;6073.997790364585;6076;6097.024476083805;6116.847078823021;6148.846278843064;6265.154204182377;6279.434850863444;6288.434040936338;6314.842128946813;6214.036824292242;6265.404786545271;6267.059941008794;6273.309935907047;6278.277998030194;6316.526260530479;6335.11308416822;6338.112664227012;6354.682265886687;6363.395477429637;6142;6149.5080393568405;6173.290071641729;6183.443490085914;6204.627722336584;6232.220972378453;6241.687915604201;6255.593386429868;6257.78097766576;6274.435300822948;5044.142495775727;5072.746362681851;5078.289039534468;5088.084144853888;5101.362329708786;4423.049044455457;4517.232070548015;4566.70316429431;4575.656825738083;4582.679212455163;5788.044972579477;5874.206982057453;5893.764249430061;5947.434993675594;5960.76156953717;6245.094461303176;6269.968650156811;6299.874002519924;6308.779192728232;6321.841953951188;5724.513416359573;5771.961047011579;5836;5880.794172204038;5912.201852749909;5557.722113894289;5558.638688485235;5559.305086864142;5568.972155139199;5587.525060369833;6445.774397896145;6468.935310647022;6480.2547707013355;6482.384173503699;6510.316416776171;6188.752449901954;6213.813585592439;6235.469985051322;6254.781082662085;6336;6376.4580010697755;6434.806955791334;6465.64438955862;6472.482201423781;6499.28507864144;5262.947370526245;6293.213348331458;6295.3389894060465;6299.590526615755;6308.71610777507;6139.032198454696;6224.408681175281;6267.717952692049;6312.968435157794;6335.65153916539;6150.80059388415;6196.132541444292;6213.161223234805;6282.560220784501;6290.2766181889665;5234.7906083756225;6194.876102478015;6200.131981522681;6247.094171345038;6310.021946598285;5466.972665136649;5966.164736936919;5975.043992961106;6209.689515524296;6234.1583886174785;6165.691715414122;6170.136180934763;6175.96912015437;6198.566100373111;6268.717907694074;6156;6176.382361763787;6194.907076393948;6210.968945155245;6213.59611625261 13:57:16 INFO - PROCESS | 2182 | |1;ext.html;421.28802324072313;492.2050887816178;509.82920721558287;517.3894804131123;547.3732576200251;35274;39444;41246;42835.357469637944;42959;43522;44048;44135.55864441355;44290.557094429045;44304.670859874175;9054.683086091987;9254.259659227278;9456.8581471278;9693.127618514332;9716.75708107296;11641.767164656701;11981;12001.039916806634;12086.456109475052;12088.972437342836;11631.24396914202;11639.534418623245;11662.941685291604;11665.825012624817;11699;10355.896441035644;11429.828552571676;11740.706482337924;11777.764444711143;11869.52521899123;11861.169718119734;11872.406379681068;11931.1051671125;11943.402829858473;11954.402279886059;42243.36634950478;42260.1547969042;42429.1514169718;42595.57404425947;42685.786571067256;3556.466530020492;4096.637081508185;4108.712390132692;4149.564295748964;4278.037441575651;29718.554221686692;30427;30475.695243047507;30476.390472190655;31471;2833;3140.450421176285;3163.240822202678;3197.040887733694;3344.9331013379838;411966;437923.81038094603;465165;473691.6315418435;486152;56617;64300;64306;64426;64435.35564644387;65365;65824;66051;66279;66321;15172.468963586221;17162.570935726708;17403.303867845145;17648;17783.644327113387;12523.123381363217;12799.744005119845;13557.59327220185;13706.657333566542;13866.65333366674;16046.839531604768;16380.853340266067;16496.83503164977;16501.257443415074;16550.42073527421;5816.680082595413;6632.635205063768;6706.966465167643;6728.831779205461;6731.966340168366;718.81310859177;886.3573908916113;888.7644774134859;915.7298596913927;933.6918816790443;30880.69119308823;31022.844885775427;31160.688393116234;31172.688273117434;31446.37107257842;985.0887928665956;995.2386424385351;1026.4764969865273;1130.8982191602631;1245.9003279737599;15806.130662813426;15979.280932358071;16003.359865605245;16320.510384688478;16365.427210047592;632749;684034;697318;701202;788681;56133;56341;56572;56674;56832.86334273291;1449.3333066789185;1482.3699927530756;1492.5895378770924;1497.8427265137223;1502.8346881842988;27789.433720977155;27897.58153627738;28239.29401764972;29438.705612943595;29761.10716678503;46438.071238575714;50384.992300154525;51511;51662;55331.44668553263;602526;609144;610302;610815;611227;23488.942997565493;24035;25071;25300.367490812878;25469.87265063663;41142.58857411388;43270.78364608157;43349.78325108354;44422.55577444184;44469.77765111154;35366.115847103;36063.63936360603;36213.10295176327;36509.45235821412;37319.62680373162;35771.46342804912;35942.382592782866;36930.63069369272;36948.44577331289;37018.629813702595;34567;34718;34996.65003350036;35057.82471087628;35632.46551301681;29876.253093672833;31931.840340798146;31978.36043279075;32046.19884502906;32048.5192722114;23813.04747810068;24371.75628243695;24520;24536.631950521114;24984.000639974198 13:57:16 INFO - PROCESS | 2182 | |2;jquery.html;401.71277536561337;407.65349452965;410.9301418758811;417.1885682347833;434.86301814928294;20564.280250191245;20656.896715516403;21764.564708705817;21801;21863.453413664665;21974.780252197474;22226.222082227127;22463;22796.772032279674;23128.30615081546;5861.618994765337;6178.907316390258;6206.348333424993;6213.25440947087;6242.001279795234;5932.911006334908;6099.176611157503;6118.908216376758;6187.628742275456;6208.286047104573;6128.325884152762;6149.907751383733;6151.7231724572275;6162.7534898604;6166.537509686769;5853.85365365865;6009.248843894513;6060.878782424371;6062;6073.331933487313;4790.544898234697;5100.285959965608;5314.893702125974;5334.759935802898;5360.3567571891235;26498.73501264982;26886;27125.864370678217;27130.5559703349;27276;2819.1824370932404;3029.9848500757575;3237.6924192201704;3240.5625240592453;3271.1495011296997;15687.764683529756;15971.201439927958;16089.91955040229;16307.429239976544;16904.40834570784;1917.731517587539;1966.341275672637;2081.8022287882627;2093.089506064867;2096.15105882118;143626.28186858998;144822;149483.75774363393;151291;152472;12274.386280686109;12396.75206495865;12407.813882791765;12557.121001529806;12580.4338804754;16275;16343.85593008478;16381.426650067191;16389.42637007699;16403.83596164023;9085.636574536944;9306.953465232631;9319.953400233091;9366.391184573116;9439.103285187895;9090.409123406956;9166.037566055602;9190.172884440299;9333.626654933727;9383.436993780395;4948.282499037619;4985.252212168131;5012.8496145115705;5014.448410674823;5036.420811606639;1674.372110458578;1822.9453116406528;1949.5905859769607;2054.6609809381584;2118.3539020598555;1026.563710423082;1042.4363454817774;1062.7555662197738;1078.8348583529769;1084.208527774729;21928.780712192995;22168.667469987962;22290.665640015413;22347.776522234893;22460.550788984456;943.3255222515934;1075.7256899490737;1076.230495195923;1102.1953973599318;1108.2187058124002;9146.856642919634;10780.892191078146;10894.564217431373;11411.885881141248;11630.476628551736;561446;621660;658958;729856;786788;121458;145532;149357;163850;166105;1031.83490641497;1096.5065720426;1108.7172770943357;1112.9554817807198;1118.4799068433217;20110.79889201089;20444.48888777733;20965.790342096385;20970.161193552696;21032.684509732673;45926.77036614795;51032.74483627558;56721;60953;61057.69471152616;94640.52679736832;94649.5267523658;95813.52093239767;97447;97559.04881902464;5968.283805943314;7449.739259125905;7716.228377162239;7806.843863122819;8384.706535271236;11598.594049208237;12108.455119519467;12142.785721427786;13423.865761342262;13716.65708357299;11427.234161206237;11571.537138514364;11773.587924422603;11815.940920295343;11873.406329683308;9162.908370916206;9369.906300937177;10859;11525.596604118815;11567.537298507965;11550.59572914944;11677.24657806011;11755.823662644896;11830.526778928746;11929.761404771682;7724.806879828049;7770.50370083155;8078.636461359135;8185.672573097009;8197.221263979913;8452.915470845213;9970.700878973643;11555.480003400035;11562;11868.465919033491 13:57:16 INFO - PROCESS | 2182 | |3;mootools.html;1341.9463221471142;1464.5459907428692;1501.3769285746416;1509.2604623734373;1515.780211869279;7738.264864837845;7982;8159.306458950989;8566.742997710064;8596.226339629433;8052.8389432211325;8365.623546940387;8368.330533557317;8424;8443.535605541709;2062.2678948973125;2378.2508509819436;2408.157144999245;2412.5898597238424;2428.405040765015;2377.465070359173;2423.7091549014144;2438.6220135878966;2443.059422122487;2464.8767561621935;2396.544656515265;2403.002753857147;2428.9878550607223;2435.9634605480933;2440.804735621146;2387.952240955171;2388.653645221442;2410.4696966667307;2414.92755217342;2424.9330294670376;2215.789499997498;2242.9439264018365;2269.387265438339;2270.2394697776263;2271.9204827830945;8398.538080405575;8494.872576911352;8553.187447192508;8575.313974881994;8583.95708021462;5188.351456067991;5336.06618841705;5362.383325917492;5369.5167434931045;5374.865628359323;2966.5846781450614;3491.877784277538;3521.6478352164836;3562.1628917204434;3631.019624701316;1223.9938800305943;1229.7970834812334;1267.3283159925163;1280.5838102616688;1288.9484420623164;10805.891941080647;10830.458477076194;10838.458077096113;10839;10852.348859068481;4478.373027776114;4762.738049407316;4817.13291607514;4818.95181048185;4830.396200474941;8341.749747507585;9505.809883802285;9648.372855764354;9650.131488165958;9676.274279429072;5363.275957745733;5386.407495175527;5390.434004429557;5412.296401467863;5422.0511410503;3948.565657777642;4454.354118652777;4686.039361930796;4863.367762190893;4915.115279249698;3318.8506517206783;3460.7750496217664;4020.6582440492302;4062.654674352654;4102.446169767103;1139.7378602921374;1324.278268343755;1340.9664758381118;1345.2332170662824;1355.9186448813102;927.4296307770672;943.1935694980692;949.1599934058409;959.1607343574373;978.8923218445965;5452.1276595745285;5688.601797874192;5846.7076646167525;6007.699615019232;6018.398160183947;576.4149388370807;576.6223123853882;593.5696619950502;597.9222701048923;598.6288501129328;3529.294141171776;3532.0640030391965;3577.2130131371055;3606.4770608261656;3636.6726994570618;9606.375585586915;10045.447500387403;10171.033751793568;10175.796484070277;10203.744906377251;10015.148712359385;10065.345752526062;10093.293469457067;10110.545025473872;10121.835988861229;7812.804679882935;7886.605669716491;7913.802154946173;7975;8051.4766540174705;5514.228008078952;5556.138798486241;5677.886442271214;5736.684482353344;5816.447437493432;9085.500297483703;9170;9267.490288034223;9277.118673725985;9439.00890406525;9255.028222036859;9396.953015235154;9406.858897116412;9427.104425079606;9512.952435238056;6743.797686069426;6923.099997000358;7046.365827075588;7242.493025488166;7352.926470735438;7971.083325417651;8088.231617996281;8114.148014458633;8121.796955075934;8133.0646975598565;7085.681144348414;7105.9644701778225;7188.5327453715345;7235.63821808918;7321.3776828968;7014.123234595676;7167.319104685047;7193.928060719326;7247.311505406978;7299.963500182465;6460.612363258219;6472.482201423969;6534.117894084237;6570.5729127606555;6575.638339891352;4876.21980483121;5009.148444764326;5051.949480505148;5074.974625126851;5187.844364669066;4379.364992076067;5100.617453690914;5139.511746384088;5309.46905309466;5332.146856502941 13:57:16 INFO - PROCESS | 2182 | |4;prototype.html;371.5300145316174;378.0963497241593;384.84221469197627;385.7396257526169;390.84561598168744;4960.578350840183;5489.560835133189;5646.661200327978;5652.4630160134775;5699.121943418568;5305.283786688796;5353.223782551528;5527.972360138204;5543.805966791163;5556.749946252418;3647.0335361129255;4337.349397590355;4344.587264209895;4350.238153547818;4367.497737760166;3478.9304213915834;4004.3782268181435;4203.831846726127;4389.692721509496;4437.423134992447;4145.564715704838;4171.499420069581;4187.571208698962;4192.643625291854;4203.789810509477;3619.7828130312;4141.039157002728;4170.291050521419;4195.412642230091;4199.9370009449885;3668.468756557993;3668.559772827278;3671.6695497405362;3677.9448308275396;3679.6872265857432;5272.271701108941;5417.945820541783;5422.240886275925;5426.914617076561;5466.562674985991;4202.033532287591;4614.700044497131;4779.259214821708;4830.444498882638;4844.66087373884;4919.975400123012;4936.284238785392;5177.4822517747925;5239.423663397023;5880.500157486576;3482.2165012872156;3705.7961812100325;3984.302747019289;4005.2990726622725;4042.3734321180264;6202.937970620326;6241;6252.906206406862;6257.374262573751;6265.8746825063245;3681;4087.4890638670167;4094.7338423003007;4096.754194748265;4109.527404348538;3657.817109144532;3672.8614129619905;3838.731288809812;3852.9807350963065;4171.749695018248;3903.648671619511;4831.710097394168;4850.417949846041;4861.295112208781;4866.274886063816;5469.453054694499;5986.3714309997695;5997;5999.5800293979;6036.6679832609625;1085.1102096280974;1132.3488993828582;1166.3759888459633;1276.9680757980939;1327.7585457597177;759.320408234638;759.7530802489102;889.6975028490344;914.2092090341806;918.4443411735937;4839.588634965997;4968.354113965233;5124.256982737482;5263.842084737464;5331.520842808113;4943.9864827710235;5112.821051263188;5197.479222577047;5244.711540865289;5832.737526811304;4849.4908034656555;5151.922721159186;5316.521513063765;5330.706811125426;5343.477109023987;2968.495355789521;3002.324476992703;3002.894898678536;3018.607581014454;3025.7276845084048;5056.890012642272;5317.813876514303;5905.881882362329;5969.522438204933;6055.848603784941;5088.160453525201;5184.792608295701;5256.947430525723;5887.793927212527;5908.164081241029;5393.83818485446;5890.6128975839065;5898.8230353089475;5954.642721436728;5971.940280597225;4691.1001044577;5204.657903943165;5598.832035038955;5660.95272374612;5718.656880587178;4975.427825799935;5309.991101690821;5985.610935289193;6011.969940150271;6061.6666083365835;5612.354579223442;5876.41235876409;6305.40098690642;6335.402484981136;6345.777897773556;3948.9337878773144;4023.0545821731284;4042.6563742082253;4048.676105911579;4075;5350.545203657577;5601.439856014366;5783;5970.223870896755;6112.847178820565;5283.256525346703;5473.781048758005;5763.452472015152;5879.5002424792665;5889.466320207841;4832.758362081811;5010.674306170087;5152.9742351288005;5759.683217423082;5865.824025279248;4790.640701947298;4826;5795;5803.912941305799;5818.738156782871;5930.7627694893445;5937.554683398676;5939.851503712442;5973.193618861398;5989.670568118795;5543.556515478833;5658.264425624642;5701.287339082614;5849.64902105875;5849.678267695318 13:57:16 INFO - PROCESS | 2182 | |5;yui.html;735.6505659811589;738.2396131984058;745.8433728916928;800.6197056398212;866.5493943149562;15576.610584735387;15949.282282297296;16061.437849675263;16101.194940252984;16259.593510162236;14765;14910.254487275646;14927.626809329773;14942.850571494282;16214.351425942948;895.1138373010722;908.1372695938851;916.8951413546661;919.8022425178585;921.1341339141219;900.2168113741054;918.673870775875;920.3787443475627;920.6087412849512;925.296774451415;933.3653115881198;950.4249928793084;966.3815158298695;970.0638883477443;973.0561355485167;945.6595625574822;963.4556475591269;963.720521048895;963.7301555564418;964.5563041001147;685.3557655803529;707.7416742888809;718.6263143165577;723.8009547374462;724.3336130759714;15033.398664053424;15118.773218401733;15415.383384664712;15556.144412057332;15615.45345912899;14135.293235338191;14262.28688565578;14328.713425731532;14380.137191768526;14454.855451445455;11572.877906686748;11858.407079645984;11873.406329683481;11875.643730688093;12529.122961392706;3814.1036856338737;3822.4648549203134;3846.576876543578;3872.593377695358;3985.920281594381;106388;107611.46194269057;107641.46179269132;108126.99999999921;108386.45806770994;10481.42352170638;10750.731231719114;10771.407572583583;11289.209755317213;11334.43327833605;23110.075596975934;23131;23147.652785208236;23157.88421057884;23216.41958951006;7885.684572617146;7896.565688887052;7922.457245500598;8042.638081286356;8141.430099893069;4376.452943382077;4443.977780111079;4471;4472.418585583853;4517.186906356887;3615.5480564929385;3689.9077523062138;3725.385311423639;3763.1532905096683;3773.4339849022867;706.2760670312867;732.5604637217733;761.9657115429819;767.3170877918657;771.7839005078587;606.8877257707338;695.6730336741723;725.4704066031826;735.7204262380368;748.3638906929067;8688.695895643623;10268.33255838383;10400.583976641;10692.465376731132;11128.554857805759;703.1822738221653;727.618000549705;729.6716477585002;739.1979702023365;751.0799270893112;4241.512226093977;4351.3472979053395;4710.364100846342;4993.450720420751;5099.158638824627;91497.54251228701;99763.50118249362;110643;113302;116863;97740;99429;99788.50105749424;101218.49390753146;101470;63000.05499917505;82226.58886705528;85391.57304213439;88936;90849.54575227082;9319.394239374418;9489.718887950314;10642.947093871331;11136.276142050741;11277.266977646426;42473.5752642482;49984.50015499944;51190.97618047693;51566.9971218428;53170.936581267386;69684;69762.65118674374;70616;71452.64273678599;72844.63577682078;12878;13235.933820330836;13338.599842004756;13445.126066805626;13815.309234538032;14944;15174.93775435753;15208.391664333303;15651.530454086396;15810.130442825295;13236.470541178245;13293.26887021223;14192.219427931563;14513.274336283355;14715.484958026418;13546.390412431267;14018;14364.569062928129;14600.488982885548;14779.408823647364;13090.869091309345;13913.234772087633;13918;14229.08014228098;14349.64125896861;11149.888501115209;11266.380349080879;11450.656480305604;11846.526138954345;11975;8235.794105147419;10013.987411329861;10232.64185753495;10270.486475676036;11185.832212516656 13:57:16 INFO - PROCESS | 2182 | __end_tp_report 13:57:16 INFO - PROCESS | 2182 | __start_cc_report 13:57:16 INFO - PROCESS | 2182 | _x_x_mozilla_cycle_collect,374 13:57:16 INFO - PROCESS | 2182 | __end_cc_report 13:57:16 INFO - PROCESS | 2182 | __startTimestamp1489784236768__endTimestamp 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | ------- Summary: start ------- 13:57:16 INFO - PROCESS | 2182 | Number of tests: 6 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | [#0] dojo.html Cycles:165 Average:5827.26 Median:6148.85 stddev:650.99 (10.6%) stddev-sans-first:624.05 13:57:16 INFO - PROCESS | 2182 | Values: 3380.6 3460.5 3461.9 3497.9 3511.4 5859.8 5870.8 5875.8 5884.0 5897.9 5857.4 5926.9 5937.4 5949.1 5961.7 5247.8 5351.9 5355.5 5388.1 5399.0 4371.7 5300.8 5385.9 5401.4 5419.3 5242.1 5269.9 5312.5 5333.0 5369.6 5192.1 5218.5 5253.4 5310.8 5362.4 5222.2 5225.3 5249.3 5254.0 5278.0 4495.2 5249.3 5681.3 5880.3 5912.4 6163.2 6190.5 6196.3 6218.5 6294.9 6318.4 6329.3 6341.5 6344.4 6357.6 6070.6 6074.0 6076.0 6097.0 6116.8 6148.8 6265.2 6279.4 6288.4 6314.8 6214.0 6265.4 6267.1 6273.3 6278.3 6316.5 6335.1 6338.1 6354.7 6363.4 6142.0 6149.5 6173.3 6183.4 6204.6 6232.2 6241.7 6255.6 6257.8 6274.4 5044.1 5072.7 5078.3 5088.1 5101.4 4423.0 4517.2 4566.7 4575.7 4582.7 5788.0 5874.2 5893.8 5947.4 5960.8 6245.1 6270.0 6299.9 6308.8 6321.8 5724.5 5772.0 5836.0 5880.8 5912.2 5557.7 5558.6 5559.3 5569.0 5587.5 6445.8 6468.9 6480.3 6482.4 6510.3 6188.8 6213.8 6235.5 6254.8 6336.0 6376.5 6434.8 6465.6 6472.5 6499.3 5262.9 6293.2 6295.3 6299.6 6308.7 6139.0 6224.4 6267.7 6313.0 6335.7 6150.8 6196.1 6213.2 6282.6 6290.3 5234.8 6194.9 6200.1 6247.1 6310.0 5467.0 5966.2 5975.0 6209.7 6234.2 6165.7 6170.1 6176.0 6198.6 6268.7 6156.0 6176.4 6194.9 6211.0 6213.6 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | [#1] ext.html Cycles:180 Average:71854.14 Median:35701.96 stddev:160135.75 (448.5%) stddev-sans-first:160495.15 13:57:16 INFO - PROCESS | 2182 | Values: 421.3 492.2 509.8 517.4 547.4 35274.0 39444.0 41246.0 42835.4 42959.0 43522.0 44048.0 44135.6 44290.6 44304.7 9054.7 9254.3 9456.9 9693.1 9716.8 11641.8 11981.0 12001.0 12086.5 12089.0 11631.2 11639.5 11662.9 11665.8 11699.0 10355.9 11429.8 11740.7 11777.8 11869.5 11861.2 11872.4 11931.1 11943.4 11954.4 42243.4 42260.2 42429.2 42595.6 42685.8 3556.5 4096.6 4108.7 4149.6 4278.0 29718.6 30427.0 30475.7 30476.4 31471.0 2833.0 3140.5 3163.2 3197.0 3344.9 411966.0 437923.8 465165.0 473691.6 486152.0 56617.0 64300.0 64306.0 64426.0 64435.4 65365.0 65824.0 66051.0 66279.0 66321.0 15172.5 17162.6 17403.3 17648.0 17783.6 12523.1 12799.7 13557.6 13706.7 13866.7 16046.8 16380.9 16496.8 16501.3 16550.4 5816.7 6632.6 6707.0 6728.8 6732.0 718.8 886.4 888.8 915.7 933.7 30880.7 31022.8 31160.7 31172.7 31446.4 985.1 995.2 1026.5 1130.9 1245.9 15806.1 15979.3 16003.4 16320.5 16365.4 632749.0 684034.0 697318.0 701202.0 788681.0 56133.0 56341.0 56572.0 56674.0 56832.9 1449.3 1482.4 1492.6 1497.8 1502.8 27789.4 27897.6 28239.3 29438.7 29761.1 46438.1 50385.0 51511.0 51662.0 55331.4 602526.0 609144.0 610302.0 610815.0 611227.0 23488.9 24035.0 25071.0 25300.4 25469.9 41142.6 43270.8 43349.8 44422.6 44469.8 35366.1 36063.6 36213.1 36509.5 37319.6 35771.5 35942.4 36930.6 36948.4 37018.6 34567.0 34718.0 34996.7 35057.8 35632.5 29876.3 31931.8 31978.4 32046.2 32048.5 23813.0 24371.8 24520.0 24536.6 24984.0 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | [#2] jquery.html Cycles:180 Average:39626.41 Median:22461.78 stddev:113654.11 (506.0%) stddev-sans-first:113934.78 13:57:16 INFO - PROCESS | 2182 | Values: 401.7 407.7 410.9 417.2 434.9 20564.3 20656.9 21764.6 21801.0 21863.5 21974.8 22226.2 22463.0 22796.8 23128.3 5861.6 6178.9 6206.3 6213.3 6242.0 5932.9 6099.2 6118.9 6187.6 6208.3 6128.3 6149.9 6151.7 6162.8 6166.5 5853.9 6009.2 6060.9 6062.0 6073.3 4790.5 5100.3 5314.9 5334.8 5360.4 26498.7 26886.0 27125.9 27130.6 27276.0 2819.2 3030.0 3237.7 3240.6 3271.1 15687.8 15971.2 16089.9 16307.4 16904.4 1917.7 1966.3 2081.8 2093.1 2096.2 143626.3 144822.0 149483.8 151291.0 152472.0 12274.4 12396.8 12407.8 12557.1 12580.4 16275.0 16343.9 16381.4 16389.4 16403.8 9085.6 9307.0 9320.0 9366.4 9439.1 9090.4 9166.0 9190.2 9333.6 9383.4 4948.3 4985.3 5012.8 5014.4 5036.4 1674.4 1822.9 1949.6 2054.7 2118.4 1026.6 1042.4 1062.8 1078.8 1084.2 21928.8 22168.7 22290.7 22347.8 22460.6 943.3 1075.7 1076.2 1102.2 1108.2 9146.9 10780.9 10894.6 11411.9 11630.5 561446.0 621660.0 658958.0 729856.0 786788.0 121458.0 145532.0 149357.0 163850.0 166105.0 1031.8 1096.5 1108.7 1113.0 1118.5 20110.8 20444.5 20965.8 20970.2 21032.7 45926.8 51032.7 56721.0 60953.0 61057.7 94640.5 94649.5 95813.5 97447.0 97559.0 5968.3 7449.7 7716.2 7806.8 8384.7 11598.6 12108.5 12142.8 13423.9 13716.7 11427.2 11571.5 11773.6 11815.9 11873.4 9162.9 9369.9 10859.0 11525.6 11567.5 11550.6 11677.2 11755.8 11830.5 11929.8 7724.8 7770.5 8078.6 8185.7 8197.2 8452.9 9970.7 11555.5 11562.0 11868.5 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | [#3] mootools.html Cycles:180 Average:5494.64 Median:5349.22 stddev:2990.47 (55.9%) stddev-sans-first:2982.57 13:57:16 INFO - PROCESS | 2182 | Values: 1341.9 1464.5 1501.4 1509.3 1515.8 7738.3 7982.0 8159.3 8566.7 8596.2 8052.8 8365.6 8368.3 8424.0 8443.5 2062.3 2378.3 2408.2 2412.6 2428.4 2377.5 2423.7 2438.6 2443.1 2464.9 2396.5 2403.0 2429.0 2436.0 2440.8 2388.0 2388.7 2410.5 2414.9 2424.9 2215.8 2242.9 2269.4 2270.2 2271.9 8398.5 8494.9 8553.2 8575.3 8584.0 5188.4 5336.1 5362.4 5369.5 5374.9 2966.6 3491.9 3521.6 3562.2 3631.0 1224.0 1229.8 1267.3 1280.6 1288.9 10805.9 10830.5 10838.5 10839.0 10852.3 4478.4 4762.7 4817.1 4819.0 4830.4 8341.7 9505.8 9648.4 9650.1 9676.3 5363.3 5386.4 5390.4 5412.3 5422.1 3948.6 4454.4 4686.0 4863.4 4915.1 3318.9 3460.8 4020.7 4062.7 4102.4 1139.7 1324.3 1341.0 1345.2 1355.9 927.4 943.2 949.2 959.2 978.9 5452.1 5688.6 5846.7 6007.7 6018.4 576.4 576.6 593.6 597.9 598.6 3529.3 3532.1 3577.2 3606.5 3636.7 9606.4 10045.4 10171.0 10175.8 10203.7 10015.1 10065.3 10093.3 10110.5 10121.8 7812.8 7886.6 7913.8 7975.0 8051.5 5514.2 5556.1 5677.9 5736.7 5816.4 9085.5 9170.0 9267.5 9277.1 9439.0 9255.0 9397.0 9406.9 9427.1 9513.0 6743.8 6923.1 7046.4 7242.5 7352.9 7971.1 8088.2 8114.1 8121.8 8133.1 7085.7 7106.0 7188.5 7235.6 7321.4 7014.1 7167.3 7193.9 7247.3 7300.0 6460.6 6472.5 6534.1 6570.6 6575.6 4876.2 5009.1 5051.9 5075.0 5187.8 4379.4 5100.6 5139.5 5309.5 5332.1 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | [#4] prototype.html Cycles:180 Average:4664.16 Median:5191.14 stddev:1435.81 (27.7%) stddev-sans-first:1403.22 13:57:16 INFO - PROCESS | 2182 | Values: 371.5 378.1 384.8 385.7 390.8 4960.6 5489.6 5646.7 5652.5 5699.1 5305.3 5353.2 5528.0 5543.8 5556.7 3647.0 4337.3 4344.6 4350.2 4367.5 3478.9 4004.4 4203.8 4389.7 4437.4 4145.6 4171.5 4187.6 4192.6 4203.8 3619.8 4141.0 4170.3 4195.4 4199.9 3668.5 3668.6 3671.7 3677.9 3679.7 5272.3 5417.9 5422.2 5426.9 5466.6 4202.0 4614.7 4779.3 4830.4 4844.7 4920.0 4936.3 5177.5 5239.4 5880.5 3482.2 3705.8 3984.3 4005.3 4042.4 6202.9 6241.0 6252.9 6257.4 6265.9 3681.0 4087.5 4094.7 4096.8 4109.5 3657.8 3672.9 3838.7 3853.0 4171.7 3903.6 4831.7 4850.4 4861.3 4866.3 5469.5 5986.4 5997.0 5999.6 6036.7 1085.1 1132.3 1166.4 1277.0 1327.8 759.3 759.8 889.7 914.2 918.4 4839.6 4968.4 5124.3 5263.8 5331.5 4944.0 5112.8 5197.5 5244.7 5832.7 4849.5 5151.9 5316.5 5330.7 5343.5 2968.5 3002.3 3002.9 3018.6 3025.7 5056.9 5317.8 5905.9 5969.5 6055.8 5088.2 5184.8 5256.9 5887.8 5908.2 5393.8 5890.6 5898.8 5954.6 5971.9 4691.1 5204.7 5598.8 5661.0 5718.7 4975.4 5310.0 5985.6 6012.0 6061.7 5612.4 5876.4 6305.4 6335.4 6345.8 3948.9 4023.1 4042.7 4048.7 4075.0 5350.5 5601.4 5783.0 5970.2 6112.8 5283.3 5473.8 5763.5 5879.5 5889.5 4832.8 5010.7 5153.0 5759.7 5865.8 4790.6 4826.0 5795.0 5803.9 5818.7 5930.8 5937.6 5939.9 5973.2 5989.7 5543.6 5658.3 5701.3 5849.6 5849.7 13:57:16 INFO - PROCESS | 2182 | 13:57:16 INFO - PROCESS | 2182 | [#5] yui.html Cycles:180 Average:21347.93 Median:3793.77 stddev:30926.56 (815.2%) stddev-sans-first:30974.59 13:57:16 INFO - PROCESS | 2182 | Values: 735.7 738.2 745.8 800.6 866.5 15576.6 15949.3 16061.4 16101.2 16259.6 14765.0 14910.3 14927.6 14942.9 16214.4 895.1 908.1 916.9 919.8 921.1 900.2 918.7 920.4 920.6 925.3 933.4 950.4 966.4 970.1 973.1 945.7 963.5 963.7 963.7 964.6 685.4 707.7 718.6 723.8 724.3 15033.4 15118.8 15415.4 15556.1 15615.5 14135.3 14262.3 14328.7 14380.1 14454.9 11572.9 11858.4 11873.4 11875.6 12529.1 3814.1 3822.5 3846.6 3872.6 3985.9 106388.0 107611.5 107641.5 108127.0 108386.5 10481.4 10750.7 10771.4 11289.2 11334.4 23110.1 23131.0 23147.7 23157.9 23216.4 7885.7 7896.6 7922.5 8042.6 8141.4 4376.5 4444.0 4471.0 4472.4 4517.2 3615.5 3689.9 3725.4 3763.2 3773.4 706.3 732.6 762.0 767.3 771.8 606.9 695.7 725.5 735.7 748.4 8688.7 10268.3 10400.6 10692.5 11128.6 703.2 727.6 729.7 739.2 751.1 4241.5 4351.3 4710.4 4993.5 5099.2 91497.5 99763.5 110643.0 113302.0 116863.0 97740.0 99429.0 99788.5 101218.5 101470.0 63000.1 82226.6 85391.6 88936.0 90849.5 9319.4 9489.7 10642.9 11136.3 11277.3 42473.6 49984.5 51191.0 51567.0 53170.9 69684.0 69762.7 70616.0 71452.6 72844.6 12878.0 13235.9 13338.6 13445.1 13815.3 14944.0 15174.9 15208.4 15651.5 15810.1 13236.5 13293.3 14192.2 14513.3 14715.5 13546.4 14018.0 14364.6 14600.5 14779.4 13090.9 13913.2 13918.0 14229.1 14349.6 11149.9 11266.4 11450.7 11846.5 11975.0 8235.8 10014.0 10232.6 10270.5 11185.8 13:57:16 INFO - PROCESS | 2182 | -------- Summary: end -------- 13:57:16 INFO - PROCESS | 2182 | 13:57:17 INFO - TEST-INFO | 2182: exit 0 13:57:17 INFO - TEST-OK | dromaeo_css | took 1113572ms 13:57:17 INFO - TEST-START | kraken 13:57:17 INFO - operating with platform_type : mac_ 13:57:17 INFO - Initialising browser for kraken test... 13:57:17 INFO - TEST-INFO | started process 2186 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpa4BboU/profile http://localhost:57661/getInfo.html) 13:57:19 INFO - PROCESS | 2186 | 2017-03-17 13:57:19.904 plugin-container[2188:27823] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 13:57:19 INFO - PROCESS | 2186 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:19 INFO - PROCESS | 2186 | 2017-03-17 13:57:19.905 plugin-container[2188:27823] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4623, name = 'com.apple.CFPasteboardClient' 13:57:19 INFO - PROCESS | 2186 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:19 INFO - PROCESS | 2186 | 2017-03-17 13:57:19.905 plugin-container[2188:27823] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:57:19 INFO - PROCESS | 2186 | __metrics Screen width/height:1600/1200 13:57:19 INFO - PROCESS | 2186 | colorDepth:24 13:57:19 INFO - PROCESS | 2186 | Browser inner width/height: 1024/689 13:57:19 INFO - PROCESS | 2186 | __metrics 13:57:20 ERROR - PROCESS | 2186 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 13:57:20 INFO - TEST-INFO | 2186: exit 0 13:57:20 INFO - Browser initialized. 13:57:20 INFO - Running cycle 1/1 for kraken test... 13:57:20 INFO - TEST-INFO | started process 2189 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpa4BboU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:23 INFO - PROCESS | 2189 | 2017-03-17 13:57:23.016 plugin-container[2190:27955] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 13:57:23 INFO - PROCESS | 2189 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:23 INFO - PROCESS | 2189 | 2017-03-17 13:57:23.017 plugin-container[2190:27955] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 13:57:23 INFO - PROCESS | 2189 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:57:23 INFO - PROCESS | 2189 | 2017-03-17 13:57:23.017 plugin-container[2190:27955] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:57:32 INFO - PROCESS | 2189 | RSS: Main: 172818432 13:57:32 INFO - PROCESS | 2189 | 13:57:35 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57661/tests/kraken/driver.html?testName=audio-beat-detection) 13:57:36 INFO - PROCESS | 2189 | RSS: Main: 185475072 13:57:36 INFO - PROCESS | 2189 | 13:57:39 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57661/tests/kraken/driver.html?testName=audio-dft) 13:57:39 INFO - PROCESS | 2189 | RSS: Main: 193605632 13:57:39 INFO - PROCESS | 2189 | 13:57:43 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57661/tests/kraken/driver.html?testName=audio-fft) 13:57:43 INFO - PROCESS | 2189 | RSS: Main: 197255168 13:57:43 INFO - PROCESS | 2189 | 13:57:45 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57661/tests/kraken/driver.html?testName=audio-oscillator) 13:57:46 INFO - PROCESS | 2189 | RSS: Main: 198684672 13:57:46 INFO - PROCESS | 2189 | 13:57:48 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57661/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:57:48 INFO - PROCESS | 2189 | RSS: Main: 198651904 13:57:48 INFO - PROCESS | 2189 | 13:57:51 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57661/tests/kraken/driver.html?testName=imaging-darkroom) 13:57:52 INFO - PROCESS | 2189 | RSS: Main: 202723328 13:57:52 INFO - PROCESS | 2189 | 13:57:54 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57661/tests/kraken/driver.html?testName=imaging-desaturate) 13:57:55 INFO - PROCESS | 2189 | RSS: Main: 203132928 13:57:55 INFO - PROCESS | 2189 | 13:57:58 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57661/tests/kraken/driver.html?testName=json-parse-financial) 13:57:59 INFO - PROCESS | 2189 | RSS: Main: 202383360 13:57:59 INFO - PROCESS | 2189 | 13:58:00 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57661/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:58:01 INFO - PROCESS | 2189 | RSS: Main: 201658368 13:58:01 INFO - PROCESS | 2189 | 13:58:03 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:58:04 INFO - PROCESS | 2189 | RSS: Main: 201670656 13:58:04 INFO - PROCESS | 2189 | 13:58:06 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:58:06 INFO - PROCESS | 2189 | RSS: Main: 201560064 13:58:06 INFO - PROCESS | 2189 | 13:58:09 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:58:10 INFO - PROCESS | 2189 | RSS: Main: 201658368 13:58:10 INFO - PROCESS | 2189 | 13:58:13 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:58:13 INFO - PROCESS | 2189 | RSS: Main: 202067968 13:58:13 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:57661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57661/tests/kraken/driver.html?testName=ai-astar) 13:58:15 INFO - PROCESS | 2189 | RSS: Main: 204214272 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | __start_tp_report 13:58:15 INFO - PROCESS | 2189 | _x_x_mozilla_page_load 13:58:15 INFO - PROCESS | 2189 | _x_x_mozilla_page_load_details 13:58:15 INFO - PROCESS | 2189 | |i|pagename|runs| 13:58:15 INFO - PROCESS | 2189 | |0;ai-astar;104;119;120;117;119;117;117;117;118;119 13:58:15 INFO - PROCESS | 2189 | |1;audio-beat-detection;138;110;94;172;142;141;111;112;129;111 13:58:15 INFO - PROCESS | 2189 | |2;audio-dft;197;201;193;195;199;196;211;196;195;198 13:58:15 INFO - PROCESS | 2189 | |3;audio-fft;82;58;58;87;61;59;59;58;70;58 13:58:15 INFO - PROCESS | 2189 | |4;audio-oscillator;85;70;85;72;70;71;80;67;70;82 13:58:15 INFO - PROCESS | 2189 | |5;imaging-gaussian-blur;89;92;124;85;90;84;88;86;97;85 13:58:15 INFO - PROCESS | 2189 | |6;imaging-darkroom;140;94;96;94;94;94;95;96;94;103 13:58:15 INFO - PROCESS | 2189 | |7;imaging-desaturate;135;150;93;98;100;127;99;90;94;110 13:58:15 INFO - PROCESS | 2189 | |8;json-parse-financial;57;57;57;59;61;62;61;62;60;63 13:58:15 INFO - PROCESS | 2189 | |9;json-stringify-tinderbox;66;75;68;86;76;73;67;79;104;69 13:58:15 INFO - PROCESS | 2189 | |10;stanford-crypto-aes;84;80;85;99;80;81;85;84;83;85 13:58:15 INFO - PROCESS | 2189 | |11;stanford-crypto-ccm;136;134;134;134;133;159;133;147;199;144 13:58:15 INFO - PROCESS | 2189 | |12;stanford-crypto-pbkdf2;165;186;164;165;169;167;163;162;160;225 13:58:15 INFO - PROCESS | 2189 | |13;stanford-crypto-sha256-iterative;59;67;89;61;60;82;57;63;66;87 13:58:15 INFO - PROCESS | 2189 | __end_tp_report 13:58:15 INFO - PROCESS | 2189 | __start_cc_report 13:58:15 INFO - PROCESS | 2189 | _x_x_mozilla_cycle_collect,936 13:58:15 INFO - PROCESS | 2189 | __end_cc_report 13:58:15 INFO - PROCESS | 2189 | __startTimestamp1489784295853__endTimestamp 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | ------- Summary: start ------- 13:58:15 INFO - PROCESS | 2189 | Number of tests: 14 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.50 stddev:4.60 (3.9%) stddev-sans-first:1.17 13:58:15 INFO - PROCESS | 2189 | Values: 104.0 119.0 120.0 117.0 119.0 117.0 117.0 117.0 118.0 119.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:139.50 stddev:22.79 (16.3%) stddev-sans-first:23.76 13:58:15 INFO - PROCESS | 2189 | Values: 138.0 110.0 94.0 172.0 142.0 141.0 111.0 112.0 129.0 111.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#2] audio-dft Cycles:10 Average:198.10 Median:197.50 stddev:5.07 (2.6%) stddev-sans-first:5.36 13:58:15 INFO - PROCESS | 2189 | Values: 197.0 201.0 193.0 195.0 199.0 196.0 211.0 196.0 195.0 198.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#3] audio-fft Cycles:10 Average:65.00 Median:60.00 stddev:10.96 (18.3%) stddev-sans-first:9.75 13:58:15 INFO - PROCESS | 2189 | Values: 82.0 58.0 58.0 87.0 61.0 59.0 59.0 58.0 70.0 58.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:6.97 (9.2%) stddev-sans-first:6.43 13:58:15 INFO - PROCESS | 2189 | Values: 85.0 70.0 85.0 72.0 70.0 71.0 80.0 67.0 70.0 82.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:88.50 stddev:11.91 (13.5%) stddev-sans-first:12.58 13:58:15 INFO - PROCESS | 2189 | Values: 89.0 92.0 124.0 85.0 90.0 84.0 88.0 86.0 97.0 85.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:94.00 stddev:14.32 (15.2%) stddev-sans-first:2.92 13:58:15 INFO - PROCESS | 2189 | Values: 140.0 94.0 96.0 94.0 94.0 94.0 95.0 96.0 94.0 103.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#7] imaging-desaturate Cycles:10 Average:109.60 Median:91.50 stddev:20.61 (22.5%) stddev-sans-first:19.70 13:58:15 INFO - PROCESS | 2189 | Values: 135.0 150.0 93.0 98.0 100.0 127.0 99.0 90.0 94.0 110.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:61.00 stddev:2.28 (3.7%) stddev-sans-first:2.17 13:58:15 INFO - PROCESS | 2189 | Values: 57.0 57.0 57.0 59.0 61.0 62.0 61.0 62.0 60.0 63.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#9] json-stringify-tinderbox Cycles:10 Average:76.30 Median:74.00 stddev:11.53 (15.6%) stddev-sans-first:11.61 13:58:15 INFO - PROCESS | 2189 | Values: 66.0 75.0 68.0 86.0 76.0 73.0 67.0 79.0 104.0 69.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:5.44 (6.4%) stddev-sans-first:5.77 13:58:15 INFO - PROCESS | 2189 | Values: 84.0 80.0 85.0 99.0 80.0 81.0 85.0 84.0 83.0 85.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:140.00 stddev:20.68 (14.8%) stddev-sans-first:21.66 13:58:15 INFO - PROCESS | 2189 | Values: 136.0 134.0 134.0 134.0 133.0 159.0 133.0 147.0 199.0 144.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:166.00 stddev:19.78 (11.9%) stddev-sans-first:20.79 13:58:15 INFO - PROCESS | 2189 | Values: 165.0 186.0 164.0 165.0 169.0 167.0 163.0 162.0 160.0 225.0 13:58:15 INFO - PROCESS | 2189 | 13:58:15 INFO - PROCESS | 2189 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:66.50 stddev:12.16 (18.3%) stddev-sans-first:12.34 13:58:15 INFO - PROCESS | 2189 | Values: 59.0 67.0 89.0 61.0 60.0 82.0 57.0 63.0 66.0 87.0 13:58:15 INFO - PROCESS | 2189 | -------- Summary: end -------- 13:58:15 INFO - PROCESS | 2189 | 13:58:16 INFO - TEST-INFO | 2189: exit 0 13:58:16 INFO - TEST-OK | kraken | took 59339ms 13:58:16 INFO - SUITE-END | took 1172s 13:58:16 INFO - Completed test suite (00:19:33) 13:58:16 INFO - javascript benchmark 13:58:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7499.291115992201, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.577427821522, 3460.498227756975, 3461.8615255389777, 3497.9125521861934, 3511.4206155984266, 5859.794907178244, 5870.823875283738, 5875.794347197854, 5884.0, 5897.911531327033, 5857.4435428634215, 5926.88146237075, 5937.406259374071, 5949.107633854924, 5961.701914904259, 5247.842564723055, 5351.919721204185, 5355.544778693816, 5388.084025715618, 5398.973005134969, 4371.715838470505, 5300.840974770763, 5385.865353366158, 5401.378841433227, 5419.295491586108, 5242.135047717122, 5269.894602107936, 5312.4687531246955, 5333.0, 5369.597280203961, 5192.1173400522, 5218.530332270114, 5253.395859476171, 5310.840674779763, 5362.410134885159, 5222.242774797671, 5225.320708307896, 5249.265102885599, 5254.0, 5278.0, 4495.213337665896, 5249.317588713443, 5681.289838770153, 5880.294364676223, 5912.379200184005, 6163.229596300463, 6190.473809726179, 6196.318404975449, 6218.4714299284615, 6294.937050629481, 6318.43134117927, 6329.303776584618, 6341.4609758170145, 6344.397282258178, 6357.554971152022, 6070.575059745864, 6073.997790364585, 6076.0, 6097.024476083805, 6116.847078823021, 6148.846278843064, 6265.154204182377, 6279.434850863444, 6288.434040936338, 6314.842128946813, 6214.036824292242, 6265.404786545271, 6267.059941008794, 6273.309935907047, 6278.277998030194, 6316.526260530479, 6335.11308416822, 6338.112664227012, 6354.682265886687, 6363.395477429637, 6142.0, 6149.5080393568405, 6173.290071641729, 6183.443490085914, 6204.627722336584, 6232.220972378453, 6241.687915604201, 6255.593386429868, 6257.78097766576, 6274.435300822948, 5044.142495775727, 5072.746362681851, 5078.289039534468, 5088.084144853888, 5101.362329708786, 4423.049044455457, 4517.232070548015, 4566.70316429431, 4575.656825738083, 4582.679212455163, 5788.044972579477, 5874.206982057453, 5893.764249430061, 5947.434993675594, 5960.76156953717, 6245.094461303176, 6269.968650156811, 6299.874002519924, 6308.779192728232, 6321.841953951188, 5724.513416359573, 5771.961047011579, 5836.0, 5880.794172204038, 5912.201852749909, 5557.722113894289, 5558.638688485235, 5559.305086864142, 5568.972155139199, 5587.525060369833, 6445.774397896145, 6468.935310647022, 6480.2547707013355, 6482.384173503699, 6510.316416776171, 6188.752449901954, 6213.813585592439, 6235.469985051322, 6254.781082662085, 6336.0, 6376.4580010697755, 6434.806955791334, 6465.64438955862, 6472.482201423781, 6499.28507864144, 5262.947370526245, 6293.213348331458, 6295.3389894060465, 6299.590526615755, 6308.71610777507, 6139.032198454696, 6224.408681175281, 6267.717952692049, 6312.968435157794, 6335.65153916539, 6150.80059388415, 6196.132541444292, 6213.161223234805, 6282.560220784501, 6290.2766181889665, 5234.7906083756225, 6194.876102478015, 6200.131981522681, 6247.094171345038, 6310.021946598285, 5466.972665136649, 5966.164736936919, 5975.043992961106, 6209.689515524296, 6234.1583886174785, 6165.691715414122, 6170.136180934763, 6175.96912015437, 6198.566100373111, 6268.717907694074, 6156.0, 6176.382361763787, 6194.907076393948, 6210.968945155245, 6213.59611625261], "value": 5787.102139688451, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.28802324072313, 492.2050887816178, 509.82920721558287, 517.3894804131123, 547.3732576200251, 35274.0, 39444.0, 41246.0, 42835.357469637944, 42959.0, 43522.0, 44048.0, 44135.55864441355, 44290.557094429045, 44304.670859874175, 9054.683086091987, 9254.259659227278, 9456.8581471278, 9693.127618514332, 9716.75708107296, 11641.767164656701, 11981.0, 12001.039916806634, 12086.456109475052, 12088.972437342836, 11631.24396914202, 11639.534418623245, 11662.941685291604, 11665.825012624817, 11699.0, 10355.896441035644, 11429.828552571676, 11740.706482337924, 11777.764444711143, 11869.52521899123, 11861.169718119734, 11872.406379681068, 11931.1051671125, 11943.402829858473, 11954.402279886059, 42243.36634950478, 42260.1547969042, 42429.1514169718, 42595.57404425947, 42685.786571067256, 3556.466530020492, 4096.637081508185, 4108.712390132692, 4149.564295748964, 4278.037441575651, 29718.554221686692, 30427.0, 30475.695243047507, 30476.390472190655, 31471.0, 2833.0, 3140.450421176285, 3163.240822202678, 3197.040887733694, 3344.9331013379838, 411966.0, 437923.81038094603, 465165.0, 473691.6315418435, 486152.0, 56617.0, 64300.0, 64306.0, 64426.0, 64435.35564644387, 65365.0, 65824.0, 66051.0, 66279.0, 66321.0, 15172.468963586221, 17162.570935726708, 17403.303867845145, 17648.0, 17783.644327113387, 12523.123381363217, 12799.744005119845, 13557.59327220185, 13706.657333566542, 13866.65333366674, 16046.839531604768, 16380.853340266067, 16496.83503164977, 16501.257443415074, 16550.42073527421, 5816.680082595413, 6632.635205063768, 6706.966465167643, 6728.831779205461, 6731.966340168366, 718.81310859177, 886.3573908916113, 888.7644774134859, 915.7298596913927, 933.6918816790443, 30880.69119308823, 31022.844885775427, 31160.688393116234, 31172.688273117434, 31446.37107257842, 985.0887928665956, 995.2386424385351, 1026.4764969865273, 1130.8982191602631, 1245.9003279737599, 15806.130662813426, 15979.280932358071, 16003.359865605245, 16320.510384688478, 16365.427210047592, 632749.0, 684034.0, 697318.0, 701202.0, 788681.0, 56133.0, 56341.0, 56572.0, 56674.0, 56832.86334273291, 1449.3333066789185, 1482.3699927530756, 1492.5895378770924, 1497.8427265137223, 1502.8346881842988, 27789.433720977155, 27897.58153627738, 28239.29401764972, 29438.705612943595, 29761.10716678503, 46438.071238575714, 50384.992300154525, 51511.0, 51662.0, 55331.44668553263, 602526.0, 609144.0, 610302.0, 610815.0, 611227.0, 23488.942997565493, 24035.0, 25071.0, 25300.367490812878, 25469.87265063663, 41142.58857411388, 43270.78364608157, 43349.78325108354, 44422.55577444184, 44469.77765111154, 35366.115847103, 36063.63936360603, 36213.10295176327, 36509.45235821412, 37319.62680373162, 35771.46342804912, 35942.382592782866, 36930.63069369272, 36948.44577331289, 37018.629813702595, 34567.0, 34718.0, 34996.65003350036, 35057.82471087628, 35632.46551301681, 29876.253093672833, 31931.840340798146, 31978.36043279075, 32046.19884502906, 32048.5192722114, 23813.04747810068, 24371.75628243695, 24520.0, 24536.631950521114, 24984.000639974198], "value": 20273.26380809769, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.71277536561337, 407.65349452965, 410.9301418758811, 417.1885682347833, 434.86301814928294, 20564.280250191245, 20656.896715516403, 21764.564708705817, 21801.0, 21863.453413664665, 21974.780252197474, 22226.222082227127, 22463.0, 22796.772032279674, 23128.30615081546, 5861.618994765337, 6178.907316390258, 6206.348333424993, 6213.25440947087, 6242.001279795234, 5932.911006334908, 6099.176611157503, 6118.908216376758, 6187.628742275456, 6208.286047104573, 6128.325884152762, 6149.907751383733, 6151.7231724572275, 6162.7534898604, 6166.537509686769, 5853.85365365865, 6009.248843894513, 6060.878782424371, 6062.0, 6073.331933487313, 4790.544898234697, 5100.285959965608, 5314.893702125974, 5334.759935802898, 5360.3567571891235, 26498.73501264982, 26886.0, 27125.864370678217, 27130.5559703349, 27276.0, 2819.1824370932404, 3029.9848500757575, 3237.6924192201704, 3240.5625240592453, 3271.1495011296997, 15687.764683529756, 15971.201439927958, 16089.91955040229, 16307.429239976544, 16904.40834570784, 1917.731517587539, 1966.341275672637, 2081.8022287882627, 2093.089506064867, 2096.15105882118, 143626.28186858998, 144822.0, 149483.75774363393, 151291.0, 152472.0, 12274.386280686109, 12396.75206495865, 12407.813882791765, 12557.121001529806, 12580.4338804754, 16275.0, 16343.85593008478, 16381.426650067191, 16389.42637007699, 16403.83596164023, 9085.636574536944, 9306.953465232631, 9319.953400233091, 9366.391184573116, 9439.103285187895, 9090.409123406956, 9166.037566055602, 9190.172884440299, 9333.626654933727, 9383.436993780395, 4948.282499037619, 4985.252212168131, 5012.8496145115705, 5014.448410674823, 5036.420811606639, 1674.372110458578, 1822.9453116406528, 1949.5905859769607, 2054.6609809381584, 2118.3539020598555, 1026.563710423082, 1042.4363454817774, 1062.7555662197738, 1078.8348583529769, 1084.208527774729, 21928.780712192995, 22168.667469987962, 22290.665640015413, 22347.776522234893, 22460.550788984456, 943.3255222515934, 1075.7256899490737, 1076.230495195923, 1102.1953973599318, 1108.2187058124002, 9146.856642919634, 10780.892191078146, 10894.564217431373, 11411.885881141248, 11630.476628551736, 561446.0, 621660.0, 658958.0, 729856.0, 786788.0, 121458.0, 145532.0, 149357.0, 163850.0, 166105.0, 1031.83490641497, 1096.5065720426, 1108.7172770943357, 1112.9554817807198, 1118.4799068433217, 20110.79889201089, 20444.48888777733, 20965.790342096385, 20970.161193552696, 21032.684509732673, 45926.77036614795, 51032.74483627558, 56721.0, 60953.0, 61057.69471152616, 94640.52679736832, 94649.5267523658, 95813.52093239767, 97447.0, 97559.04881902464, 5968.283805943314, 7449.739259125905, 7716.228377162239, 7806.843863122819, 8384.706535271236, 11598.594049208237, 12108.455119519467, 12142.785721427786, 13423.865761342262, 13716.65708357299, 11427.234161206237, 11571.537138514364, 11773.587924422603, 11815.940920295343, 11873.406329683308, 9162.908370916206, 9369.906300937177, 10859.0, 11525.596604118815, 11567.537298507965, 11550.59572914944, 11677.24657806011, 11755.823662644896, 11830.526778928746, 11929.761404771682, 7724.806879828049, 7770.50370083155, 8078.636461359135, 8185.672573097009, 8197.221263979913, 8452.915470845213, 9970.700878973643, 11555.480003400035, 11562.0, 11868.465919033491], "value": 10371.893527807762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.9463221471142, 1464.5459907428692, 1501.3769285746416, 1509.2604623734373, 1515.780211869279, 7738.264864837845, 7982.0, 8159.306458950989, 8566.742997710064, 8596.226339629433, 8052.8389432211325, 8365.623546940387, 8368.330533557317, 8424.0, 8443.535605541709, 2062.2678948973125, 2378.2508509819436, 2408.157144999245, 2412.5898597238424, 2428.405040765015, 2377.465070359173, 2423.7091549014144, 2438.6220135878966, 2443.059422122487, 2464.8767561621935, 2396.544656515265, 2403.002753857147, 2428.9878550607223, 2435.9634605480933, 2440.804735621146, 2387.952240955171, 2388.653645221442, 2410.4696966667307, 2414.92755217342, 2424.9330294670376, 2215.789499997498, 2242.9439264018365, 2269.387265438339, 2270.2394697776263, 2271.9204827830945, 8398.538080405575, 8494.872576911352, 8553.187447192508, 8575.313974881994, 8583.95708021462, 5188.351456067991, 5336.06618841705, 5362.383325917492, 5369.5167434931045, 5374.865628359323, 2966.5846781450614, 3491.877784277538, 3521.6478352164836, 3562.1628917204434, 3631.019624701316, 1223.9938800305943, 1229.7970834812334, 1267.3283159925163, 1280.5838102616688, 1288.9484420623164, 10805.891941080647, 10830.458477076194, 10838.458077096113, 10839.0, 10852.348859068481, 4478.373027776114, 4762.738049407316, 4817.13291607514, 4818.95181048185, 4830.396200474941, 8341.749747507585, 9505.809883802285, 9648.372855764354, 9650.131488165958, 9676.274279429072, 5363.275957745733, 5386.407495175527, 5390.434004429557, 5412.296401467863, 5422.0511410503, 3948.565657777642, 4454.354118652777, 4686.039361930796, 4863.367762190893, 4915.115279249698, 3318.8506517206783, 3460.7750496217664, 4020.6582440492302, 4062.654674352654, 4102.446169767103, 1139.7378602921374, 1324.278268343755, 1340.9664758381118, 1345.2332170662824, 1355.9186448813102, 927.4296307770672, 943.1935694980692, 949.1599934058409, 959.1607343574373, 978.8923218445965, 5452.1276595745285, 5688.601797874192, 5846.7076646167525, 6007.699615019232, 6018.398160183947, 576.4149388370807, 576.6223123853882, 593.5696619950502, 597.9222701048923, 598.6288501129328, 3529.294141171776, 3532.0640030391965, 3577.2130131371055, 3606.4770608261656, 3636.6726994570618, 9606.375585586915, 10045.447500387403, 10171.033751793568, 10175.796484070277, 10203.744906377251, 10015.148712359385, 10065.345752526062, 10093.293469457067, 10110.545025473872, 10121.835988861229, 7812.804679882935, 7886.605669716491, 7913.802154946173, 7975.0, 8051.4766540174705, 5514.228008078952, 5556.138798486241, 5677.886442271214, 5736.684482353344, 5816.447437493432, 9085.500297483703, 9170.0, 9267.490288034223, 9277.118673725985, 9439.00890406525, 9255.028222036859, 9396.953015235154, 9406.858897116412, 9427.104425079606, 9512.952435238056, 6743.797686069426, 6923.099997000358, 7046.365827075588, 7242.493025488166, 7352.926470735438, 7971.083325417651, 8088.231617996281, 8114.148014458633, 8121.796955075934, 8133.0646975598565, 7085.681144348414, 7105.9644701778225, 7188.5327453715345, 7235.63821808918, 7321.3776828968, 7014.123234595676, 7167.319104685047, 7193.928060719326, 7247.311505406978, 7299.963500182465, 6460.612363258219, 6472.482201423969, 6534.117894084237, 6570.5729127606555, 6575.638339891352, 4876.21980483121, 5009.148444764326, 5051.949480505148, 5074.974625126851, 5187.844364669066, 4379.364992076067, 5100.617453690914, 5139.511746384088, 5309.46905309466, 5332.146856502941], "value": 4434.704252822761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.5300145316174, 378.0963497241593, 384.84221469197627, 385.7396257526169, 390.84561598168744, 4960.578350840183, 5489.560835133189, 5646.661200327978, 5652.4630160134775, 5699.121943418568, 5305.283786688796, 5353.223782551528, 5527.972360138204, 5543.805966791163, 5556.749946252418, 3647.0335361129255, 4337.349397590355, 4344.587264209895, 4350.238153547818, 4367.497737760166, 3478.9304213915834, 4004.3782268181435, 4203.831846726127, 4389.692721509496, 4437.423134992447, 4145.564715704838, 4171.499420069581, 4187.571208698962, 4192.643625291854, 4203.789810509477, 3619.7828130312, 4141.039157002728, 4170.291050521419, 4195.412642230091, 4199.9370009449885, 3668.468756557993, 3668.559772827278, 3671.6695497405362, 3677.9448308275396, 3679.6872265857432, 5272.271701108941, 5417.945820541783, 5422.240886275925, 5426.914617076561, 5466.562674985991, 4202.033532287591, 4614.700044497131, 4779.259214821708, 4830.444498882638, 4844.66087373884, 4919.975400123012, 4936.284238785392, 5177.4822517747925, 5239.423663397023, 5880.500157486576, 3482.2165012872156, 3705.7961812100325, 3984.302747019289, 4005.2990726622725, 4042.3734321180264, 6202.937970620326, 6241.0, 6252.906206406862, 6257.374262573751, 6265.8746825063245, 3681.0, 4087.4890638670167, 4094.7338423003007, 4096.754194748265, 4109.527404348538, 3657.817109144532, 3672.8614129619905, 3838.731288809812, 3852.9807350963065, 4171.749695018248, 3903.648671619511, 4831.710097394168, 4850.417949846041, 4861.295112208781, 4866.274886063816, 5469.453054694499, 5986.3714309997695, 5997.0, 5999.5800293979, 6036.6679832609625, 1085.1102096280974, 1132.3488993828582, 1166.3759888459633, 1276.9680757980939, 1327.7585457597177, 759.320408234638, 759.7530802489102, 889.6975028490344, 914.2092090341806, 918.4443411735937, 4839.588634965997, 4968.354113965233, 5124.256982737482, 5263.842084737464, 5331.520842808113, 4943.9864827710235, 5112.821051263188, 5197.479222577047, 5244.711540865289, 5832.737526811304, 4849.4908034656555, 5151.922721159186, 5316.521513063765, 5330.706811125426, 5343.477109023987, 2968.495355789521, 3002.324476992703, 3002.894898678536, 3018.607581014454, 3025.7276845084048, 5056.890012642272, 5317.813876514303, 5905.881882362329, 5969.522438204933, 6055.848603784941, 5088.160453525201, 5184.792608295701, 5256.947430525723, 5887.793927212527, 5908.164081241029, 5393.83818485446, 5890.6128975839065, 5898.8230353089475, 5954.642721436728, 5971.940280597225, 4691.1001044577, 5204.657903943165, 5598.832035038955, 5660.95272374612, 5718.656880587178, 4975.427825799935, 5309.991101690821, 5985.610935289193, 6011.969940150271, 6061.6666083365835, 5612.354579223442, 5876.41235876409, 6305.40098690642, 6335.402484981136, 6345.777897773556, 3948.9337878773144, 4023.0545821731284, 4042.6563742082253, 4048.676105911579, 4075.0, 5350.545203657577, 5601.439856014366, 5783.0, 5970.223870896755, 6112.847178820565, 5283.256525346703, 5473.781048758005, 5763.452472015152, 5879.5002424792665, 5889.466320207841, 4832.758362081811, 5010.674306170087, 5152.9742351288005, 5759.683217423082, 5865.824025279248, 4790.640701947298, 4826.0, 5795.0, 5803.912941305799, 5818.738156782871, 5930.7627694893445, 5937.554683398676, 5939.851503712442, 5973.193618861398, 5989.670568118795, 5543.556515478833, 5658.264425624642, 5701.287339082614, 5849.64902105875, 5849.678267695318], "value": 4212.442178010242, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.6505659811589, 738.2396131984058, 745.8433728916928, 800.6197056398212, 866.5493943149562, 15576.610584735387, 15949.282282297296, 16061.437849675263, 16101.194940252984, 16259.593510162236, 14765.0, 14910.254487275646, 14927.626809329773, 14942.850571494282, 16214.351425942948, 895.1138373010722, 908.1372695938851, 916.8951413546661, 919.8022425178585, 921.1341339141219, 900.2168113741054, 918.673870775875, 920.3787443475627, 920.6087412849512, 925.296774451415, 933.3653115881198, 950.4249928793084, 966.3815158298695, 970.0638883477443, 973.0561355485167, 945.6595625574822, 963.4556475591269, 963.720521048895, 963.7301555564418, 964.5563041001147, 685.3557655803529, 707.7416742888809, 718.6263143165577, 723.8009547374462, 724.3336130759714, 15033.398664053424, 15118.773218401733, 15415.383384664712, 15556.144412057332, 15615.45345912899, 14135.293235338191, 14262.28688565578, 14328.713425731532, 14380.137191768526, 14454.855451445455, 11572.877906686748, 11858.407079645984, 11873.406329683481, 11875.643730688093, 12529.122961392706, 3814.1036856338737, 3822.4648549203134, 3846.576876543578, 3872.593377695358, 3985.920281594381, 106388.0, 107611.46194269057, 107641.46179269132, 108126.99999999921, 108386.45806770994, 10481.42352170638, 10750.731231719114, 10771.407572583583, 11289.209755317213, 11334.43327833605, 23110.075596975934, 23131.0, 23147.652785208236, 23157.88421057884, 23216.41958951006, 7885.684572617146, 7896.565688887052, 7922.457245500598, 8042.638081286356, 8141.430099893069, 4376.452943382077, 4443.977780111079, 4471.0, 4472.418585583853, 4517.186906356887, 3615.5480564929385, 3689.9077523062138, 3725.385311423639, 3763.1532905096683, 3773.4339849022867, 706.2760670312867, 732.5604637217733, 761.9657115429819, 767.3170877918657, 771.7839005078587, 606.8877257707338, 695.6730336741723, 725.4704066031826, 735.7204262380368, 748.3638906929067, 8688.695895643623, 10268.33255838383, 10400.583976641, 10692.465376731132, 11128.554857805759, 703.1822738221653, 727.618000549705, 729.6716477585002, 739.1979702023365, 751.0799270893112, 4241.512226093977, 4351.3472979053395, 4710.364100846342, 4993.450720420751, 5099.158638824627, 91497.54251228701, 99763.50118249362, 110643.0, 113302.0, 116863.0, 97740.0, 99429.0, 99788.50105749424, 101218.49390753146, 101470.0, 63000.05499917505, 82226.58886705528, 85391.57304213439, 88936.0, 90849.54575227082, 9319.394239374418, 9489.718887950314, 10642.947093871331, 11136.276142050741, 11277.266977646426, 42473.5752642482, 49984.50015499944, 51190.97618047693, 51566.9971218428, 53170.936581267386, 69684.0, 69762.65118674374, 70616.0, 71452.64273678599, 72844.63577682078, 12878.0, 13235.933820330836, 13338.599842004756, 13445.126066805626, 13815.309234538032, 14944.0, 15174.93775435753, 15208.391664333303, 15651.530454086396, 15810.130442825295, 13236.470541178245, 13293.26887021223, 14192.219427931563, 14513.274336283355, 14715.484958026418, 13546.390412431267, 14018.0, 14364.569062928129, 14600.488982885548, 14779.408823647364, 13090.869091309345, 13913.234772087633, 13918.0, 14229.08014228098, 14349.64125896861, 11149.888501115209, 11266.380349080879, 11450.656480305604, 11846.526138954345, 11975.0, 8235.794105147419, 10013.987411329861, 10232.64185753495, 10270.486475676036, 11185.832212516656], "value": 7824.064071753636, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 120.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 119.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 110.0, 94.0, 172.0, 142.0, 141.0, 111.0, 112.0, 129.0, 111.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 201.0, 193.0, 195.0, 199.0, 196.0, 211.0, 196.0, 195.0, 198.0], "value": 198.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 87.0, 61.0, 59.0, 59.0, 58.0, 70.0, 58.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 85.0, 72.0, 70.0, 71.0, 80.0, 67.0, 70.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 124.0, 85.0, 90.0, 84.0, 88.0, 86.0, 97.0, 85.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 94.0, 96.0, 94.0, 94.0, 94.0, 95.0, 96.0, 94.0, 103.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 150.0, 93.0, 98.0, 100.0, 127.0, 99.0, 90.0, 94.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 59.0, 61.0, 62.0, 61.0, 62.0, 60.0, 63.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 68.0, 86.0, 76.0, 73.0, 67.0, 79.0, 104.0, 69.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 85.0, 99.0, 80.0, 81.0, 85.0, 84.0, 83.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 134.0, 134.0, 133.0, 159.0, 133.0, 147.0, 199.0, 144.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 186.0, 164.0, 165.0, 169.0, 167.0, 163.0, 162.0, 160.0, 225.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 89.0, 61.0, 60.0, 82.0, 57.0, 63.0, 66.0, 87.0], "value": 69.1, "unit": "score"}]}]} 13:58:17 INFO - Return code: 0 13:58:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:58:17 ERROR - # TBPL SUCCESS # 13:58:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:58:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:58:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:58:17 INFO - 2017-03-17 13:58:17.128 screenresolution[2194:28332] starting screenresolution argv=screenresolution get 13:58:17 INFO - 2017-03-17 13:58:17.131 screenresolution[2194:28332] Display 0: 1600x1200x32@60 13:58:17 INFO - 2017-03-17 13:58:17.137 screenresolution[2195:28335] starting screenresolution argv=screenresolution list 13:58:17 INFO - Available Modes on Display 0 13:58:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:58:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:58:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:58:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:58:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:58:17 INFO - Intel Iris: 13:58:17 INFO - Chipset Model: Intel Iris 13:58:17 INFO - Type: GPU 13:58:17 INFO - Bus: Built-In 13:58:17 INFO - VRAM (Dynamic, Max): 1536 MB 13:58:17 INFO - Vendor: Intel (0x8086) 13:58:17 INFO - Device ID: 0x0a2e 13:58:17 INFO - Revision ID: 0x0009 13:58:17 INFO - Displays: 13:58:17 INFO - Display: 13:58:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:58:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:58:17 INFO - Display Serial Number: 1600x1200 60 13:58:17 INFO - Main Display: Yes 13:58:17 INFO - Mirror: Off 13:58:17 INFO - Online: Yes 13:58:17 INFO - Rotation: Supported 13:58:17 INFO - Return code: 0 13:58:17 INFO - Running post-action listener: _resource_record_post_action 13:58:17 INFO - [mozharness: 2017-03-17 20:58:17.374617Z] Finished run-tests step (success) 13:58:17 INFO - Running post-run listener: _resource_record_post_run 13:58:17 INFO - Total resource usage - Wall time: 1188s; CPU: 55.0%; Read bytes: 831488; Write bytes: 424359936; Read time: 8; Write time: 1645 13:58:17 INFO - TinderboxPrint: CPU usage
54.6% 13:58:17 INFO - TinderboxPrint: I/O read bytes / time
831,488 / 8 13:58:17 INFO - TinderboxPrint: I/O write bytes / time
424,359,936 / 1,645 13:58:17 INFO - TinderboxPrint: CPU idle
2,160.1 (45.4%) 13:58:17 INFO - TinderboxPrint: CPU system
962.3 (20.2%) 13:58:17 INFO - TinderboxPrint: CPU user
1,631.2 (34.3%) 13:58:17 INFO - TinderboxPrint: Swap in / out
122,249,216 / 0 13:58:17 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 113535488; Write bytes: 114685440; Read time: 10090; Write time: 267 13:58:17 INFO - run-tests - Wall time: 1174s; CPU: 55.0%; Read bytes: 831488; Write bytes: 299840000; Read time: 8; Write time: 1344 13:58:17 INFO - Running post-run listener: _upload_blobber_files 13:58:17 INFO - Blob upload gear active. 13:58:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:58:17 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 13:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:58:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:58:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:19 INFO - (blobuploader) - INFO - Done attempting. 13:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:20 INFO - (blobuploader) - INFO - Done attempting. 13:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:21 INFO - (blobuploader) - INFO - Done attempting. 13:58:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:58:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:58:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:58:23 INFO - (blobuploader) - INFO - Done attempting. 13:58:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:58:23 INFO - Return code: 0 13:58:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:58:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:58:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac64f6d5004b877b96003639cbfd96b3c1a5a0f965ef089793ab84735aa15d0b3805b9a50dbe7cc2016ffbcba6b800419b75275367a11392107522e591b63f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1a840071bdfd84ce480a095de0b655fad927ea226c938266f53fb24b16ba4dfaa4d89d6e92a9e35ffb6b6bfc8606db8e734fdd458bf9c83ccd6acf2ed5b3a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54ede1ba6653d9bfbe201c06a79379e502dd3ab90cfb7e8a8c47dffc2a1d0179b50b2093267cf17413294382ac7fc9a1f108a2e851bef43cbf1e59caffc69219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b03c7574a57c2b6742c02c95518cfb8b5966914efd7188994186db386884d8fbce1458774e3f719a61a482bd1af828d289886ce7c304235c4071adf92482c4c"} 13:58:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:58:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:58:23 INFO - Contents: 13:58:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac64f6d5004b877b96003639cbfd96b3c1a5a0f965ef089793ab84735aa15d0b3805b9a50dbe7cc2016ffbcba6b800419b75275367a11392107522e591b63f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1a840071bdfd84ce480a095de0b655fad927ea226c938266f53fb24b16ba4dfaa4d89d6e92a9e35ffb6b6bfc8606db8e734fdd458bf9c83ccd6acf2ed5b3a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54ede1ba6653d9bfbe201c06a79379e502dd3ab90cfb7e8a8c47dffc2a1d0179b50b2093267cf17413294382ac7fc9a1f108a2e851bef43cbf1e59caffc69219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b03c7574a57c2b6742c02c95518cfb8b5966914efd7188994186db386884d8fbce1458774e3f719a61a482bd1af828d289886ce7c304235c4071adf92482c4c"} 13:58:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:58:23 INFO - Copying logs to upload dir... 13:58:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:58:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.134598 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-17 13:58:24.042073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 13:58:24.048040) ========= 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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac64f6d5004b877b96003639cbfd96b3c1a5a0f965ef089793ab84735aa15d0b3805b9a50dbe7cc2016ffbcba6b800419b75275367a11392107522e591b63f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1a840071bdfd84ce480a095de0b655fad927ea226c938266f53fb24b16ba4dfaa4d89d6e92a9e35ffb6b6bfc8606db8e734fdd458bf9c83ccd6acf2ed5b3a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54ede1ba6653d9bfbe201c06a79379e502dd3ab90cfb7e8a8c47dffc2a1d0179b50b2093267cf17413294382ac7fc9a1f108a2e851bef43cbf1e59caffc69219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b03c7574a57c2b6742c02c95518cfb8b5966914efd7188994186db386884d8fbce1458774e3f719a61a482bd1af828d289886ce7c304235c4071adf92482c4c"} build_url:https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/BUX58Gp6Ta6oy835WpdenQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ac64f6d5004b877b96003639cbfd96b3c1a5a0f965ef089793ab84735aa15d0b3805b9a50dbe7cc2016ffbcba6b800419b75275367a11392107522e591b63f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1a840071bdfd84ce480a095de0b655fad927ea226c938266f53fb24b16ba4dfaa4d89d6e92a9e35ffb6b6bfc8606db8e734fdd458bf9c83ccd6acf2ed5b3a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/54ede1ba6653d9bfbe201c06a79379e502dd3ab90cfb7e8a8c47dffc2a1d0179b50b2093267cf17413294382ac7fc9a1f108a2e851bef43cbf1e59caffc69219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b03c7574a57c2b6742c02c95518cfb8b5966914efd7188994186db386884d8fbce1458774e3f719a61a482bd1af828d289886ce7c304235c4071adf92482c4c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 13:58:24.087334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 13:58:24.087679) ========= 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.gpFkJrx1vy/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.e8PNAVPFhW/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.005266 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 13:58:24.145907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 13:58:24.146245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 13:58:24.146605) ========= ========= Total master_lag: 0.22 =========