builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0207 starttime: 1484798606.76 results: success (0) buildid: 20170118154728 builduid: ea92ffadcba446e29a8089796f5a3ab2 revision: 68f28c9cae2d1d46567519f57825c3afbba48529 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:26.761680) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:26.762141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:26.762423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:26.790592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:26.790963) ========= 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.wizlMzdRAA/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.ZmlU07rteE/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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-01-18 20:03:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.9M=0s 2017-01-18 20:03:27 (24.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.377385 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:27.190102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:27.190427) ========= 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.wizlMzdRAA/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.ZmlU07rteE/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.025672 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:27.238615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 20:03:27.240986) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 68f28c9cae2d1d46567519f57825c3afbba48529 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 68f28c9cae2d1d46567519f57825c3afbba48529 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wizlMzdRAA/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.ZmlU07rteE/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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-01-18 20:03:27,348 truncating revision to first 12 chars 2017-01-18 20:03:27,348 Setting DEBUG logging. 2017-01-18 20:03:27,349 attempt 1/10 2017-01-18 20:03:27,349 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/68f28c9cae2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 20:03:28,341 unpacking tar archive at: graphics-68f28c9cae2d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.269673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 20:03:28.533493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:28.533812) ========= script_repo_revision: 68f28c9cae2d1d46567519f57825c3afbba48529 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:28.534204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:28.534468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 20:03:28.554186) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-18 20:03:28.554516) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wizlMzdRAA/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.ZmlU07rteE/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:03:28 INFO - MultiFileLogger online at 20170118 20:03:28 in /builds/slave/test 20:03:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 20:03:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:03:28 INFO - {'append_to_log': False, 20:03:28 INFO - 'base_work_dir': '/builds/slave/test', 20:03:28 INFO - 'blob_upload_branch': 'Graphics', 20:03:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:03:28 INFO - 'branch': 'Graphics', 20:03:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:03:28 INFO - 'config_files': ('talos/mac_config.py',), 20:03:28 INFO - 'default_actions': ('clobber', 20:03:28 INFO - 'read-buildbot-config', 20:03:28 INFO - 'download-and-extract', 20:03:28 INFO - 'populate-webroot', 20:03:28 INFO - 'create-virtualenv', 20:03:28 INFO - 'install', 20:03:28 INFO - 'run-tests'), 20:03:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:03:28 INFO - 'download_minidump_stackwalk': True, 20:03:28 INFO - 'download_symbols': 'ondemand', 20:03:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:03:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:03:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:03:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:03:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:03:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:03:28 INFO - 'installer_path': 'installer.exe', 20:03:28 INFO - 'log_level': 'info', 20:03:28 INFO - 'log_name': 'talos', 20:03:28 INFO - 'log_to_console': True, 20:03:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:03:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:03:28 INFO - 'opt_config_files': (), 20:03:28 INFO - 'pip_index': False, 20:03:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:03:28 INFO - 'cmd': ('bash', 20:03:28 INFO - '-c', 20:03:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:03:28 INFO - 'enabled': True, 20:03:28 INFO - 'halt_on_failure': False, 20:03:28 INFO - 'name': 'check_screen_resolution'},), 20:03:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:03:28 INFO - 'cmd': ('bash', 20:03:28 INFO - '-c', 20:03:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:03:28 INFO - 'enabled': True, 20:03:28 INFO - 'halt_on_failure': False, 20:03:28 INFO - 'name': 'check_screen_resolution'},), 20:03:28 INFO - 'run_cmd_checks_enabled': True, 20:03:28 INFO - 'sps_profile': False, 20:03:28 INFO - 'sps_profile_interval': 0, 20:03:28 INFO - 'suite': 'dromaeojs-e10s', 20:03:28 INFO - 'system_bits': '32', 20:03:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:03:28 INFO - 'title': 't-yosemite-r7-0207', 20:03:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:03:28 INFO - 'use_talos_json': True, 20:03:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:03:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:03:28 INFO - 'work_dir': 'build'} 20:03:28 INFO - [mozharness: 2017-01-19 04:03:28.769203Z] Running clobber step. 20:03:28 INFO - Running pre-action listener: _resource_record_pre_action 20:03:28 INFO - Running main action method: clobber 20:03:28 INFO - rmtree: /builds/slave/test/build 20:03:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:03:31 INFO - Running post-action listener: _resource_record_post_action 20:03:31 INFO - [mozharness: 2017-01-19 04:03:31.385432Z] Finished clobber step (success) 20:03:31 INFO - [mozharness: 2017-01-19 04:03:31.385701Z] Running read-buildbot-config step. 20:03:31 INFO - Running pre-action listener: _resource_record_pre_action 20:03:31 INFO - Running main action method: read_buildbot_config 20:03:31 INFO - Using buildbot properties: 20:03:31 INFO - { 20:03:31 INFO - "project": "", 20:03:31 INFO - "product": "firefox", 20:03:31 INFO - "script_repo_revision": "default", 20:03:31 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 20:03:31 INFO - "repository": "", 20:03:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 20:03:31 INFO - "buildid": "20170118154728", 20:03:31 INFO - "pgo_build": "False", 20:03:31 INFO - "basedir": "/builds/slave/test", 20:03:31 INFO - "buildnumber": 6, 20:03:31 INFO - "slavename": "t-yosemite-r7-0207", 20:03:31 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 20:03:31 INFO - "platform": "yosemite_r7", 20:03:31 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 20:03:31 INFO - "branch": "graphics", 20:03:31 INFO - "repo_path": "projects/graphics", 20:03:31 INFO - "revision": "68f28c9cae2d1d46567519f57825c3afbba48529", 20:03:31 INFO - "stage_platform": "macosx64", 20:03:31 INFO - "builduid": "ea92ffadcba446e29a8089796f5a3ab2", 20:03:31 INFO - "slavebuilddir": "test" 20:03:31 INFO - } 20:03:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 20:03:31 INFO - Running post-action listener: _resource_record_post_action 20:03:31 INFO - [mozharness: 2017-01-19 04:03:31.391455Z] Finished read-buildbot-config step (success) 20:03:31 INFO - [mozharness: 2017-01-19 04:03:31.391670Z] Running download-and-extract step. 20:03:31 INFO - Running pre-action listener: _resource_record_pre_action 20:03:31 INFO - Running main action method: download_and_extract 20:03:31 INFO - mkdir: /builds/slave/test/build/tests 20:03:31 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')]} 20:03:31 INFO - trying https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 20:03:31 INFO - Downloading https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 20:03:32 INFO - Downloaded 1199 bytes. 20:03:32 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:03:32 INFO - Using the following test package requirements: 20:03:32 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:03:32 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 20:03:32 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 20:03:32 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'jsshell-mac.zip'], 20:03:32 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 20:03:32 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:03:32 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 20:03:32 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 20:03:32 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 20:03:32 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:03:32 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 20:03:32 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:03:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:03:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:03:32 INFO - Fetch https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:03:33 INFO - Expected file size: 16328338 20:03:33 INFO - Obtained file size: 16328338 20:03:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:03:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:03:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:03:40 INFO - Fetch https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:03:41 INFO - Expected file size: 16328338 20:03:41 INFO - Obtained file size: 16328338 20:03:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 20:03:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:03:47 INFO - Fetch https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 20:03:48 INFO - Expected file size: 14403463 20:03:48 INFO - Obtained file size: 14403463 20:03:48 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')]} 20:03:48 INFO - trying https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:03:48 INFO - Downloading https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 20:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 20:03:51 INFO - Downloaded 70023416 bytes. 20:03:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:03:51 INFO - mkdir: /builds/slave/test/properties 20:03:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:51 INFO - Contents: 20:03:51 INFO - build_url:https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:03:51 INFO - Running post-action listener: _resource_record_post_action 20:03:51 INFO - Running post-action listener: set_extra_try_arguments 20:03:51 INFO - [mozharness: 2017-01-19 04:03:51.878087Z] Finished download-and-extract step (success) 20:03:51 INFO - [mozharness: 2017-01-19 04:03:51.878247Z] Running populate-webroot step. 20:03:51 INFO - Running pre-action listener: _resource_record_pre_action 20:03:51 INFO - Running main action method: populate_webroot 20:03:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:51 INFO - '--tppagecycles', 20:03:51 INFO - '7'], 20:03:51 INFO - 'tests': ['tsvgm']}}, 20:03:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:03:51 INFO - 'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:03:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:03:51 INFO - 'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['damp', 'tps']}, 20:03:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:03:51 INFO - 'tests': ['damp', 'tps']}, 20:03:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['dromaeo_dom']}, 20:03:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['basic_compositor_video']}, 20:03:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:03:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['a11yr', 20:03:51 INFO - 'ts_paint', 20:03:51 INFO - 'tpaint', 20:03:51 INFO - 'sessionrestore', 20:03:51 INFO - 'sessionrestore_no_auto_restore', 20:03:51 INFO - 'tabpaint']}, 20:03:51 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:51 INFO - 'ts_paint', 20:03:51 INFO - 'tpaint', 20:03:51 INFO - 'sessionrestore', 20:03:51 INFO - 'sessionrestore_no_auto_restore', 20:03:51 INFO - 'tabpaint']}, 20:03:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:51 INFO - 'ts_paint', 20:03:51 INFO - 'tpaint', 20:03:51 INFO - 'sessionrestore', 20:03:51 INFO - 'sessionrestore_no_auto_restore', 20:03:51 INFO - 'tabpaint']}, 20:03:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:51 INFO - 'ts_paint', 20:03:51 INFO - 'tpaint', 20:03:51 INFO - 'sessionrestore', 20:03:51 INFO - 'sessionrestore_no_auto_restore', 20:03:51 INFO - 'tabpaint']}, 20:03:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['a11yr', 20:03:51 INFO - 'ts_paint', 20:03:51 INFO - 'tpaint', 20:03:51 INFO - 'sessionrestore', 20:03:51 INFO - 'sessionrestore_no_auto_restore', 20:03:51 INFO - 'tabpaint']}, 20:03:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['a11yr', 20:03:51 INFO - 'ts_paint', 20:03:51 INFO - 'tpaint', 20:03:51 INFO - 'sessionrestore', 20:03:51 INFO - 'sessionrestore_no_auto_restore', 20:03:51 INFO - 'tabpaint']}, 20:03:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['tsvgx', 20:03:51 INFO - 'tsvgr_opacity', 20:03:51 INFO - 'tart', 20:03:51 INFO - 'tscrollx', 20:03:51 INFO - 'cart', 20:03:51 INFO - 'tsvg_static']}, 20:03:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:51 INFO - 'tsvgr_opacity', 20:03:51 INFO - 'tart', 20:03:51 INFO - 'tscrollx', 20:03:51 INFO - 'cart', 20:03:51 INFO - 'tsvg_static']}, 20:03:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:03:51 INFO - 'talos_options': ['--disable-e10s'], 20:03:51 INFO - 'tests': ['tp5o']}, 20:03:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:03:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:03:51 INFO - 'talos_options': ['--disable-e10s', 20:03:51 INFO - '--xperf_path', 20:03:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:51 INFO - 'tests': ['tp5n']}, 20:03:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:03:51 INFO - 'talos_options': ['--xperf_path', 20:03:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:51 INFO - 'tests': ['tp5n']}}, 20:03:51 INFO - 'talos.zip': {'path': '', 20:03:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:51 INFO - Running post-action listener: _resource_record_post_action 20:03:51 INFO - [mozharness: 2017-01-19 04:03:51.896170Z] Finished populate-webroot step (success) 20:03:51 INFO - [mozharness: 2017-01-19 04:03:51.896305Z] Running create-virtualenv step. 20:03:51 INFO - Running pre-action listener: _resource_record_pre_action 20:03:51 INFO - Running main action method: create_virtualenv 20:03:51 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:51 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 20:03:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:52 INFO - Using real prefix '/tools/python27' 20:03:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:55 INFO - Installing pip.................done. 20:03:55 INFO - Return code: 0 20:03:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:03:55 INFO - Reading from file tmpfile_stdout 20:03:55 INFO - Output received: 20:03:55 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) 20:03:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:03:55 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')]} 20:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:55 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')]} 20:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:55 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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:03:55 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 20:03:55 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 20:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:55 INFO - 'HOME': '/Users/cltbld', 20:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:55 INFO - 'LOGNAME': 'cltbld', 20:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:55 INFO - 'MOZ_NO_REMOTE': '1', 20:03:55 INFO - 'NO_EM_RESTART': '1', 20:03:55 INFO - 'PAGER': '/bin/cat', 20:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:55 INFO - 'PWD': '/builds/slave/test', 20:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:55 INFO - 'SHELL': '/bin/bash', 20:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:03:55 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:55 INFO - 'USER': 'cltbld', 20:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:55 INFO - 'XPC_FLAGS': '0x0', 20:03:55 INFO - 'XPC_SERVICE_NAME': '0', 20:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:56 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 20:03:56 INFO - Cleaning up... 20:03:56 INFO - Return code: 0 20:03:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:03:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:03:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:56 INFO - 'HOME': '/Users/cltbld', 20:03:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PAGER': '/bin/cat', 20:03:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test', 20:03:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:03:56 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:03:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - 'XPC_FLAGS': '0x0', 20:03:56 INFO - 'XPC_SERVICE_NAME': '0', 20:03:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:56 INFO - Downloading/unpacking psutil>=3.1.1 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:59 INFO - Installing collected packages: psutil 20:03:59 INFO - Running setup.py install for psutil 20:03:59 INFO - building 'psutil._psutil_osx' extension 20:03:59 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 20:04:00 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 20:04:00 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 20:04:00 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 20:04:00 INFO - building 'psutil._psutil_posix' extension 20:04:00 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 20:04:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:04:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:04:00 INFO - ^ 20:04:00 INFO - 1 warning generated. 20:04:00 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 20:04:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:00 INFO - Successfully installed psutil 20:04:00 INFO - Cleaning up... 20:04:01 INFO - Return code: 0 20:04:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:04:01 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')]} 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:01 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')]} 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:01 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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04:01 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 20:04:01 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 20:04:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:01 INFO - 'HOME': '/Users/cltbld', 20:04:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:01 INFO - 'LOGNAME': 'cltbld', 20:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:01 INFO - 'MOZ_NO_REMOTE': '1', 20:04:01 INFO - 'NO_EM_RESTART': '1', 20:04:01 INFO - 'PAGER': '/bin/cat', 20:04:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:01 INFO - 'PWD': '/builds/slave/test', 20:04:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:01 INFO - 'SHELL': '/bin/bash', 20:04:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:01 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:01 INFO - 'USER': 'cltbld', 20:04:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:01 INFO - 'XPC_FLAGS': '0x0', 20:04:01 INFO - 'XPC_SERVICE_NAME': '0', 20:04:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:04:03 INFO - Installing collected packages: mozsystemmonitor 20:04:03 INFO - Running setup.py install for mozsystemmonitor 20:04:04 INFO - Successfully installed mozsystemmonitor 20:04:04 INFO - Cleaning up... 20:04:04 INFO - Return code: 0 20:04:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:04 INFO - 'HOME': '/Users/cltbld', 20:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:04 INFO - 'LOGNAME': 'cltbld', 20:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:04 INFO - 'MOZ_NO_REMOTE': '1', 20:04:04 INFO - 'NO_EM_RESTART': '1', 20:04:04 INFO - 'PAGER': '/bin/cat', 20:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:04 INFO - 'PWD': '/builds/slave/test', 20:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:04 INFO - 'SHELL': '/bin/bash', 20:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:04 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:04 INFO - 'USER': 'cltbld', 20:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:04 INFO - 'XPC_FLAGS': '0x0', 20:04:04 INFO - 'XPC_SERVICE_NAME': '0', 20:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:04 INFO - Downloading/unpacking jsonschema==2.5.1 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:04:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:04:06 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 20:04:06 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 20:04:06 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 20:04:06 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 20:04:06 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 20:04:06 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 20:04:07 INFO - Downloading functools32-3.2.3-2.tar.gz 20:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:04:07 INFO - warning: no files found matching '*.txt' 20:04:07 INFO - no previously-included directories found matching 'build' 20:04:07 INFO - no previously-included directories found matching 'dist' 20:04:07 INFO - no previously-included directories found matching '.git*' 20:04:07 INFO - Installing collected packages: jsonschema, functools32 20:04:07 INFO - Running setup.py install for functools32 20:04:07 INFO - warning: no files found matching '*.txt' 20:04:07 INFO - no previously-included directories found matching 'build' 20:04:07 INFO - no previously-included directories found matching 'dist' 20:04:07 INFO - no previously-included directories found matching '.git*' 20:04:07 INFO - Successfully installed jsonschema functools32 20:04:07 INFO - Cleaning up... 20:04:07 INFO - Return code: 0 20:04:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:07 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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04:07 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 20:04:07 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 20:04:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:07 INFO - 'HOME': '/Users/cltbld', 20:04:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:07 INFO - 'LOGNAME': 'cltbld', 20:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:07 INFO - 'MOZ_NO_REMOTE': '1', 20:04:07 INFO - 'NO_EM_RESTART': '1', 20:04:07 INFO - 'PAGER': '/bin/cat', 20:04:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:07 INFO - 'PWD': '/builds/slave/test', 20:04:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:07 INFO - 'SHELL': '/bin/bash', 20:04:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:07 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:07 INFO - 'USER': 'cltbld', 20:04:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:07 INFO - 'XPC_FLAGS': '0x0', 20:04:07 INFO - 'XPC_SERVICE_NAME': '0', 20:04:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:04:08 INFO - Cleaning up... 20:04:08 INFO - Return code: 0 20:04:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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', '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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:04: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 blobuploader==1.2.4 20:04:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:08 INFO - 'HOME': '/Users/cltbld', 20:04:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:08 INFO - 'LOGNAME': 'cltbld', 20:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:08 INFO - 'MOZ_NO_REMOTE': '1', 20:04:08 INFO - 'NO_EM_RESTART': '1', 20:04:08 INFO - 'PAGER': '/bin/cat', 20:04:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:08 INFO - 'PWD': '/builds/slave/test', 20:04:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:08 INFO - 'SHELL': '/bin/bash', 20:04:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:08 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:08 INFO - 'USER': 'cltbld', 20:04:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:08 INFO - 'XPC_FLAGS': '0x0', 20:04:08 INFO - 'XPC_SERVICE_NAME': '0', 20:04:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:08 INFO - Downloading/unpacking blobuploader==1.2.4 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:10 INFO - Downloading blobuploader-1.2.4.tar.gz 20:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:04:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:04:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:12 INFO - Downloading docopt-0.6.1.tar.gz 20:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:04:12 INFO - Installing collected packages: blobuploader, requests, docopt 20:04:12 INFO - Running setup.py install for blobuploader 20:04:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:04:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:04:12 INFO - Running setup.py install for requests 20:04:12 INFO - Running setup.py install for docopt 20:04:13 INFO - Successfully installed blobuploader requests docopt 20:04:13 INFO - Cleaning up... 20:04:13 INFO - Return code: 0 20:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04:13 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 20:04:13 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 20:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:13 INFO - 'HOME': '/Users/cltbld', 20:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:13 INFO - 'LOGNAME': 'cltbld', 20:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:13 INFO - 'MOZ_NO_REMOTE': '1', 20:04:13 INFO - 'NO_EM_RESTART': '1', 20:04:13 INFO - 'PAGER': '/bin/cat', 20:04:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:13 INFO - 'PWD': '/builds/slave/test', 20:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:13 INFO - 'SHELL': '/bin/bash', 20:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:13 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:13 INFO - 'USER': 'cltbld', 20:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:13 INFO - 'XPC_FLAGS': '0x0', 20:04:13 INFO - 'XPC_SERVICE_NAME': '0', 20:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:13 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-WBOqdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:13 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-KzozOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:13 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Mn1TBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:13 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-VY_moA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:13 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-LeIko_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:13 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-IDGRgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-KU1scd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-yQH7bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-hSOGBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-nntnSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Att54W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-FODrnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-wJ2lOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-pjgtTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Krgihl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:14 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-iIAw18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:15 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-ICtNNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:04:15 INFO - Running setup.py install for manifestparser 20:04:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:04:15 INFO - Running setup.py install for mozcrash 20:04:15 INFO - Running setup.py install for mozdebug 20:04:15 INFO - Running setup.py install for mozdevice 20:04:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:04:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:04:15 INFO - Running setup.py install for mozfile 20:04:15 INFO - Running setup.py install for mozhttpd 20:04:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Running setup.py install for mozinfo 20:04:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Running setup.py install for mozInstall 20:04:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Running setup.py install for mozleak 20:04:16 INFO - Running setup.py install for mozlog 20:04:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Running setup.py install for moznetwork 20:04:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:04:16 INFO - Running setup.py install for mozprocess 20:04:16 INFO - Running setup.py install for mozprofile 20:04:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:04:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:04:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:04:17 INFO - Running setup.py install for mozrunner 20:04:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:04:17 INFO - Running setup.py install for mozscreenshot 20:04:17 INFO - Running setup.py install for moztest 20:04:17 INFO - Running setup.py install for mozversion 20:04:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:04:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:17 INFO - Cleaning up... 20:04:17 INFO - Return code: 0 20:04:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:17 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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04:17 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 20:04:17 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 20:04:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:17 INFO - 'HOME': '/Users/cltbld', 20:04:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:17 INFO - 'LOGNAME': 'cltbld', 20:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:17 INFO - 'MOZ_NO_REMOTE': '1', 20:04:17 INFO - 'NO_EM_RESTART': '1', 20:04:17 INFO - 'PAGER': '/bin/cat', 20:04:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:17 INFO - 'PWD': '/builds/slave/test', 20:04:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:17 INFO - 'SHELL': '/bin/bash', 20:04:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:17 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:17 INFO - 'USER': 'cltbld', 20:04:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:17 INFO - 'XPC_FLAGS': '0x0', 20:04:17 INFO - 'XPC_SERVICE_NAME': '0', 20:04:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-OK5vf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Qr7b0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-_v7_9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-aMXal5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-awkXKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-cFlHoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-S1No4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-7vJsdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:18 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)) 20:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:18 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-s0H4S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-8IdDvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-4bNlOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-rC6Lym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-uQhkwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-UyZNfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-vV7LMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-UDVfKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:19 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)) 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:19 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Bdm4zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:19 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)) 20:04:19 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)) 20:04:19 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)) 20:04:19 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)) 20:04:19 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)) 20:04:19 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)) 20:04:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:22 INFO - Downloading blessings-1.6.tar.gz 20:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:22 INFO - Installing collected packages: blessings 20:04:22 INFO - Running setup.py install for blessings 20:04:22 INFO - Successfully installed blessings 20:04:22 INFO - Cleaning up... 20:04:22 INFO - Return code: 0 20:04:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:04:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:23 INFO - Reading from file tmpfile_stdout 20:04:23 INFO - Current package versions: 20:04:23 INFO - blessings == 1.6 20:04:23 INFO - blobuploader == 1.2.4 20:04:23 INFO - docopt == 0.6.1 20:04:23 INFO - functools32 == 3.2.3-2 20:04:23 INFO - jsonschema == 2.5.1 20:04:23 INFO - manifestparser == 1.1 20:04:23 INFO - mozInstall == 1.12 20:04:23 INFO - mozcrash == 1.0 20:04:23 INFO - mozdebug == 0.1 20:04:23 INFO - mozdevice == 0.49 20:04:23 INFO - mozfile == 1.2 20:04:23 INFO - mozhttpd == 0.7 20:04:23 INFO - mozinfo == 0.9 20:04:23 INFO - mozleak == 0.1 20:04:23 INFO - mozlog == 3.4 20:04:23 INFO - moznetwork == 0.27 20:04:23 INFO - mozprocess == 0.24 20:04:23 INFO - mozprofile == 0.28 20:04:23 INFO - mozrunner == 6.13 20:04:23 INFO - mozscreenshot == 0.1 20:04:23 INFO - mozsystemmonitor == 0.3 20:04:23 INFO - moztest == 0.8 20:04:23 INFO - mozversion == 1.4 20:04:23 INFO - psutil == 3.1.1 20:04:23 INFO - requests == 1.2.3 20:04:23 INFO - wsgiref == 0.1.2 20:04:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:23 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 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04:23 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 20:04:23 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 20:04:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:23 INFO - 'HOME': '/Users/cltbld', 20:04:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:23 INFO - 'LOGNAME': 'cltbld', 20:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:23 INFO - 'MOZ_NO_REMOTE': '1', 20:04:23 INFO - 'NO_EM_RESTART': '1', 20:04:23 INFO - 'PAGER': '/bin/cat', 20:04:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:23 INFO - 'PWD': '/builds/slave/test', 20:04:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:23 INFO - 'SHELL': '/bin/bash', 20:04:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:23 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:23 INFO - 'USER': 'cltbld', 20:04:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:23 INFO - 'XPC_FLAGS': '0x0', 20:04:23 INFO - 'XPC_SERVICE_NAME': '0', 20:04:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 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)) 20:04:24 INFO - Cleaning up... 20:04:24 INFO - Return code: 0 20:04:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f0d67150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, '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.wizlMzdRAA/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.ZmlU07rteE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 20:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:04:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:24 INFO - 'HOME': '/Users/cltbld', 20:04:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:24 INFO - 'LOGNAME': 'cltbld', 20:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:24 INFO - 'MOZ_NO_REMOTE': '1', 20:04:24 INFO - 'NO_EM_RESTART': '1', 20:04:24 INFO - 'PAGER': '/bin/cat', 20:04:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:24 INFO - 'PWD': '/builds/slave/test', 20:04:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:24 INFO - 'SHELL': '/bin/bash', 20:04:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:24 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:24 INFO - 'USER': 'cltbld', 20:04:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:24 INFO - 'XPC_FLAGS': '0x0', 20:04:24 INFO - 'XPC_SERVICE_NAME': '0', 20:04:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:04:24 INFO - Cleaning up... 20:04:24 INFO - Return code: 0 20:04:24 INFO - Running post-action listener: _resource_record_post_action 20:04:24 INFO - Running post-action listener: _start_resource_monitoring 20:04:24 INFO - Starting resource monitoring. 20:04:24 INFO - [mozharness: 2017-01-19 04:04:24.736099Z] Finished create-virtualenv step (success) 20:04:24 INFO - [mozharness: 2017-01-19 04:04:24.737082Z] Running install step. 20:04:24 INFO - Running pre-action listener: _resource_record_pre_action 20:04:24 INFO - Running main action method: install 20:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:24 INFO - Reading from file tmpfile_stdout 20:04:24 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:04:25 INFO - Reading from file tmpfile_stdout 20:04:25 INFO - Output received: 20:04:25 INFO - Usage: mozinstall [options] installer 20:04:25 INFO - Options: 20:04:25 INFO - -h, --help show this help message and exit 20:04:25 INFO - -d DEST, --destination=DEST 20:04:25 INFO - Directory to install application into. [default: 20:04:25 INFO - "/builds/slave/test"] 20:04:25 INFO - --app=APP Application being installed. [default: firefox] 20:04:25 INFO - mkdir: /builds/slave/test/build/application 20:04:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:04:47 INFO - Reading from file tmpfile_stdout 20:04:47 INFO - Output received: 20:04:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:04:47 INFO - Running post-action listener: _resource_record_post_action 20:04:47 INFO - [mozharness: 2017-01-19 04:04:47.002538Z] Finished install step (success) 20:04:47 INFO - [mozharness: 2017-01-19 04:04:47.002699Z] Running run-tests step. 20:04:47 INFO - Running pre-action listener: _resource_record_pre_action 20:04:47 INFO - Running main action method: run_tests 20:04:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:04:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:04:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:04:47 INFO - 2017-01-18 20:04:47.017 screenresolution[1631:7404] starting screenresolution argv=screenresolution get 20:04:47 INFO - 2017-01-18 20:04:47.020 screenresolution[1631:7404] Display 0: 1600x1200x32@60 20:04:47 INFO - 2017-01-18 20:04:47.025 screenresolution[1632:7407] starting screenresolution argv=screenresolution list 20:04:47 INFO - Available Modes on Display 0 20:04:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:04:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:04:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:04:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:04:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:04:47 INFO - Intel Iris: 20:04:47 INFO - Chipset Model: Intel Iris 20:04:47 INFO - Type: GPU 20:04:47 INFO - Bus: Built-In 20:04:47 INFO - VRAM (Dynamic, Max): 1536 MB 20:04:47 INFO - Vendor: Intel (0x8086) 20:04:47 INFO - Device ID: 0x0a2e 20:04:47 INFO - Revision ID: 0x0009 20:04:47 INFO - Displays: 20:04:47 INFO - Display: 20:04:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:04:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:04:47 INFO - Display Serial Number: 1600x1200 60 20:04:47 INFO - Main Display: Yes 20:04:47 INFO - Mirror: Off 20:04:47 INFO - Online: Yes 20:04:47 INFO - Rotation: Supported 20:04:47 INFO - Return code: 0 20:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:04:47 INFO - Python 2.7.3 20:04:47 INFO - Return code: 0 20:04:47 INFO - grabbing minidump binary from tooltool 20:04:47 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')]} 20:04:47 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 0x10f4c0d30>, '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 0x10f3e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4b5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:04:47 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 20:04:47 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 20:04:47 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 20:04:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:47 INFO - Return code: 0 20:04:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:04:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:04:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:04:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:04:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:04:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 20:04:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0207 --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 20:04:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wizlMzdRAA/Render', 20:04:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:47 INFO - 'HOME': '/Users/cltbld', 20:04:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:47 INFO - 'LOGNAME': 'cltbld', 20:04:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:04:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:47 INFO - 'MOZ_NO_REMOTE': '1', 20:04:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:04:47 INFO - 'NO_EM_RESTART': '1', 20:04:47 INFO - 'PAGER': '/bin/cat', 20:04:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:47 INFO - 'PWD': '/builds/slave/test', 20:04:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:04:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:47 INFO - 'SHELL': '/bin/bash', 20:04:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmlU07rteE/Listeners', 20:04:47 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 20:04:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:47 INFO - 'USER': 'cltbld', 20:04:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:47 INFO - 'XPC_FLAGS': '0x0', 20:04:47 INFO - 'XPC_SERVICE_NAME': '0', 20:04:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 20:04:47 INFO - mozversion application_buildid: 20170118154728 20:04:47 INFO - mozversion application_changeset: 68f28c9cae2d1d46567519f57825c3afbba48529 20:04:47 INFO - mozversion application_display_name: Nightly 20:04:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:47 INFO - mozversion application_name: Firefox 20:04:47 INFO - mozversion application_remotingname: firefox 20:04:47 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 20:04:47 INFO - mozversion application_vendor: Mozilla 20:04:47 INFO - mozversion application_version: 53.0a1 20:04:47 INFO - mozversion platform_buildid: 20170118154728 20:04:47 INFO - mozversion platform_changeset: 68f28c9cae2d1d46567519f57825c3afbba48529 20:04:47 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 20:04:47 INFO - mozversion platform_version: 53.0a1 20:04:47 INFO - using testdate: 1484798687 20:04:47 INFO - actual date: 1484798687 20:04:47 INFO - starting webserver on 'localhost:49242' 20:04:47 INFO - SUITE-START | Running 2 tests 20:04:47 INFO - TEST-START | dromaeo_css 20:04:47 INFO - operating with platform_type : mac_ 20:04:47 INFO - Initialising browser for dromaeo_css test... 20:04:47 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpNbEbrC/profile http://localhost:49242/getInfo.html) 20:04:50 INFO - PROCESS | 1642 | 2017-01-18 20:04:50.572 plugin-container[1644:7576] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 20:04:50 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:50 INFO - PROCESS | 1642 | 2017-01-18 20:04:50.575 plugin-container[1644:7576] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 20:04:50 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:50 INFO - PROCESS | 1642 | 2017-01-18 20:04:50.575 plugin-container[1644:7576] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:04:50 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 20:04:50 INFO - PROCESS | 1642 | colorDepth:24 20:04:50 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 20:04:50 INFO - PROCESS | 1642 | __metrics 20:04:50 ERROR - PROCESS | 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 20:04:51 INFO - TEST-INFO | 1642: exit 0 20:04:51 INFO - Browser initialized. 20:04:51 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:51 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpNbEbrC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:53 INFO - PROCESS | 1645 | 2017-01-18 20:04:53.862 plugin-container[1646:7698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 20:04:53 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:53 INFO - PROCESS | 1645 | 2017-01-18 20:04:53.863 plugin-container[1646:7698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 20:04:53 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:53 INFO - PROCESS | 1645 | 2017-01-18 20:04:53.863 plugin-container[1646:7698] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:05:03 INFO - PROCESS | 1645 | RSS: Main: 231493632 20:05:03 INFO - PROCESS | 1645 | 20:08:04 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 20:08:05 INFO - PROCESS | 1645 | RSS: Main: 246755328 20:08:05 INFO - PROCESS | 1645 | 20:09:51 INFO - PROCESS | 1645 | ************************* 20:09:51 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 20:09:51 INFO - PROCESS | 1645 | 20:09:51 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:09:51 INFO - PROCESS | 1645 | Full stack: 20:09:51 INFO - PROCESS | 1645 | ************************* 20:11:08 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 20:11:09 INFO - PROCESS | 1645 | RSS: Main: 260304896 20:11:09 INFO - PROCESS | 1645 | 20:14:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 20:14:11 INFO - PROCESS | 1645 | RSS: Main: 268861440 20:14:11 INFO - PROCESS | 1645 | 20:17:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 20:17:13 INFO - PROCESS | 1645 | RSS: Main: 266137600 20:17:13 INFO - PROCESS | 1645 | 20:20:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 20:20:17 INFO - PROCESS | 1645 | RSS: Main: 270647296 20:20:17 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 20:23:20 INFO - PROCESS | 1645 | RSS: Main: 272715776 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | __start_tp_report 20:23:20 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 20:23:20 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 20:23:20 INFO - PROCESS | 1645 | |i|pagename|runs| 20:23:20 INFO - PROCESS | 1645 | |0;dojo.html;2839.914802555924;3361.8991430257092;3377.729781617469;3380.425327694292;3407.591089069312;4648.349231107648;5382.085045542258;5678.630888992213;5679.886402271957;5724.398938111501;4205.558416366283;4845.418549774032;5565.888682226353;5578.967890940179;5598.608097433182;5064.594832413407;5110.718910459923;5144.25408315794;5205.193195054753;5261.815836445725;5097.547199048272;5212.400573933989;5226.425093239741;5228.2680424740565;5292.311999440068;165.85786002051023;4609.608183304423;5265.052290587692;5268;5309.787608495655;4442.689011769177;4518.367428560005;4823.180059389877;5176.430592634807;5188.558972487343;5148.3821941366905;5168.250603662448;5176.404713457963;5177.37871455424;5195.896082078375;5503.642263252876;5582.581306401996;5691.601587888849;5739.16782066598;5764.16419619157;4970.428400733889;6115.205023346981;6131.89663773324;6141.393954534099;6259.499240060784;6237.906431403532;6247.125402443616;6276.309605943343;6291.182146320994;6307.400796924331;5695.7152142392715;5817.0983497557945;5838.970805145989;5873.735681894325;5880.235569375954;6197.194364732646;6214.9689251554355;6237.844053898689;6248.5313601480075;6304.275008374004;6165.784197553064;6172.660503672341;6208.9689551551955;6217.813465596039;6225.190725205694;6237.812865614039;6238.1266622672865;6257.9687101564205;6276.403741644536;6284.842878928063;4851.80592776285;5819.79630712923;6072.180255665517;6080.48315893154;6115.785947491817;6172.722227499773;6278.058291256348;6307.24313082433;6317.652529110943;6317.873642527124;4251.723637963522;4418.64650827933;4859.222524396079;4890.095332363453;4998.6750861193905;4391.275439552502;4396.538363471854;4433.689641725113;4455.997400584907;4550.362949187116;5861.238039054981;5862.384449632812;5881.823545293648;5931.436513531207;5972.402759723993;6208.084508580417;6254.124422580842;6275.121482992385;6279.340669229757;6295.433410993032;5441.347038355423;5655.660660360391;5842.941570584325;5890.3815099414805;5916.3787802281;5528.6406383585745;5538.224648549206;5541.750621222055;5541.9168712469345;5561.721913904288;6370.936290637127;6374.266959299647;6377.64922929234;6383.234011918506;6391.073294372383;4964.851054468371;6187.257529096537;6204.069389591416;6204.782832601018;6251.6874156292915;5412.972935135299;6214.9067763982675;6245.937540624717;6289.433950944437;6293.150424692608;6204.534659900435;6206.286277078194;6209.844753881189;6224.06639004153;6261.217347831521;6102.852830488404;6109.586862300561;6228.4705800007505;6236.604161059012;6297.433231009231;5889.764409423575;6107.401224262618;6109.389061093855;6146;6193.256809182927;6131;6132.294786099477;6146.416090471398;6170.136180934763;6178.66017369031;5778.335491418373;5889.116632505158;5961.642301461926;6053.681899820501;6092.025275955826;6102.883130681719;6121.483458747687;6137.346341658241;6191.288001879661;6244.937550624436;5706.714664266853;6031;6075.210222671025;6089.847753806191;6096.390360963868 20:23:20 INFO - PROCESS | 1645 | |1;ext.html;498.4641510376346;503.5342308364763;506.9239614057891;514.190150512942;519.283388923286;38959.61040389595;41825;41892;41906;41981.58018419819;42414.36378454325;43001.35497967533;43007.56992430075;43076;43141.784291078504;9294.814103717921;9498.430094194337;9501.097395747393;9508.096730810597;10933.234673572853;10989;11222.494987725531;11233.775324493505;11237.719057023558;11270.774584508305;11230.32618042916;11256.887431125666;11265;11266.211365204439;11304.547818087307;11130.220884538086;11158.218924675277;11209.271397359187;11211.551537938472;11233.550657973672;10780.784384312348;10861.456927153611;10865;10869.565217391295;10872;37697.24605507902;37873.24253514942;37990.81004594987;38105.856824295035;38186.045348866224;3963.1677347756718;4008.7995600220165;4022.839086436539;4056.553779084298;4140.127388535017;29396.853015735;29568.408631827457;29780.106596802132;29782.55326170109;29841;3144.827034513101;3207.294395233045;3304.4217261979056;3344;3345.5149003394613;488522;488931.21947073325;492827;493382;494568.5271573655;48371;57773;58330.416695833344;58343.70828145917;58375;53278.73360633172;59321;59789.40210597925;60060.39939600548;60140.39859601348;12993.610191694264;13688.384022719001;14604.050736702293;14616.853831461549;15540.222988850512;10531.57873685044;10742;10970.177236707279;12432.75134497305;12591.118621696576;17387.02163061564;18936.81063189378;19607.803921960884;20052.498687532636;20487.590248194952;8915.687950921687;9138.954305228432;9170.724878253663;9171.81656366869;9242.768930776785;737.3548145372799;856.3192262151605;903.3631289940577;907.1518130547959;913.3150137396952;29910.55134172989;30788;30870.845645772075;31002.0699379019;31468.055958321285;1000.1498726082772;1066.722652110457;1099.8845121262311;1110.783397237547;1190.0245592316712;16038.87727859062;16165.67668646644;16228.675426491403;16408.927859705203;16463.423780167876;658117.6070632227;659133.7043314753;661411;661578;663342;62703.37296627067;63346.683266584296;63348.68325658342;63444.731105377636;63670;1280.8270883430619;1395.5464474045975;1415.610707055568;1452.8111345525226;1453.404104317246;29061.417588915574;30136.84931575328;30415.54376684396;30615.54076688896;30691.846540768045;53655;54244.45755542394;54319.72840135932;54363;54388.72805635946;572105;574510;576834;577829;578006;36739.63260367362;43831;44017;44717.88205294894;44767.104657906006;47604.52395476001;48765.268520972924;49196.75401622969;49667.75166124146;50066;35999;39766.60233397629;40214.19571608493;40324.790256292355;41573.792131039154;40280.79157625276;40338;40349.39475907922;41225.38161927633;41353.586464134976;36329.45505817468;37079.6292037087;37097.44353834641;39140;39196.216075678894;31378.686213138488;33520.82677106289;33821.91205583019;33971;34154.65845341515;20542.79457205409;22987;24148.75851241465;24807;25421.11026114077 20:23:20 INFO - PROCESS | 1645 | |2;jquery.html;393.5120450641204;394.4911064726503;397.9880603581893;404.64795627803807;424.9915001699966;20034;20176.293829715964;20786.48033799152;21383.57232855342;21522;17647.823521764778;20777.16891324349;21628.2430114946;21785.346439606838;21802.345929622137;4683.812647494096;4691.671582989192;5316.016536940679;5422.864428389302;5424.728763561826;5065.758889072183;5251.789928402859;5308.6814791112465;5315.14957606783;5348.973255133719;5296.602754793406;5307.548858347045;5310.548603368718;5319.840404787863;5320.989012087691;5322.973385133069;5837.270341207349;5871.706414679249;5873.412658734135;5878.88242235155;5041.697498150123;5231.738413079369;5236.29310043147;5244.344456942882;5255.448177941337;21672.24147154858;26083.478330433285;26398.6040209397;26529.602055969175;26676;2173.923912663049;2645.2989957661043;2650.08572042645;2657.8671066446796;2670.6795184577977;8788.956055219747;10010.841348305705;10014.89985100147;10213.642522511676;10506.212034097472;1851.703727403609;1865.813418658137;1881.7271495633056;1909.2076788132908;1909.598984213317;139841;143104;144820.99999999895;145763.27118364445;147792.2610386952;11891.643250702493;11951.701207469883;12115.39423028845;12195.695107622381;12294.692632684255;15660.216989150726;15781.132037738034;15841;15846.841531584767;15846.841531584767;7475.8786182072035;7484.47608667399;8660.220580147818;8673;8763.605637746317;8445.493270403795;8462.87305690415;8487.236148746519;8541.829163416696;8590.484570925764;4809.879753006203;4843.975780121077;4852.816232695302;4878.414590249193;4928.408590969107;2036.4908772806798;2073.1914553324214;2078.646630072891;2084.6560317547737;2094.853360264797;999.4253304350028;1000.6097621927454;1001.4692213127055;1018.1244130048152;1056.2553399853084;17043;20545.280915167896;20795.792042079687;21122.260720874696;21442;905.2938707807789;1041.286718597763;1043.8903915088958;1068.9625863094755;1087.7335052912088;9300.627974881065;10496.212784041074;11022.834657480144;11067.833982490269;11134.665960021212;703792.4810375916;737071;746254;747515;767860;114641.13397165138;137067;160500;160524;163769;987.0622908237203;1006.4565134827111;1015.4313584392617;1024.9743756406149;1026.1790567545934;14915.627109322353;17699;18546.81453185505;18549.536261593566;18589.72115418243;53757.73121134369;56552.717236413555;59166.40833591609;59233.70383148057;59316.70341648264;77866;87266.5636671838;91636;95157.04842951758;96178.51910740402;7167.319104685047;8063.516189028677;8176.427650064438;8321.08468068524;8500.61747221389;12002.39988000579;12268.263904165422;12733.490660373482;12808.167469114851;12872.549460768829;10943.83584246253;10986.505607247853;11010.449477526252;11473.598424055119;11484.827727583926;9679.951600242235;10422.801377841342;10728.678139655824;10884.61903833362;11130.220884538328;9017.954910225408;11275;11399.031082358093;11617.302961822317;11652;8195.303399211134;8257.83484330322;8328.250457458858;8337.95775528059;8473.872891906749;9236.399634023766;11394.36710974222;11486.081113510732;11495.425228738362;11500.25248358854 20:23:20 INFO - PROCESS | 1645 | |3;mootools.html;1249.6750844780354;1323.894088472922;1440.661444560528;1455.2505459688257;1483.1323675649749;7514.586697731623;7717.382609391249;7989.5605741684185;8505.872411913819;8523.701670441536;7994.120646728855;8077.23266289703;8239.711610093647;8395.160483951617;8404.991401031884;1947.5325921778813;2279.794818466338;2323.8721870297127;2338.4153961509624;2344.120954642009;1803.5220666523317;2071.8031786980214;2138.315738963532;2223.911043558264;2343.5898717724417;2206.9668954965687;2279.259240746764;2284.451731584416;2293.9655905161435;2294.9426264343356;1967.7737060238042;2287.439577303563;2293.2776175504664;2300.942476438094;2329.312852708455;1960.9607807843906;2230.933072007826;2270.693456383384;2338.941526461835;2352.5765362234793;8416.579171041423;8469.407141500098;8479;8479.533625650587;8488.74533763988;5032.949670503284;5180.4042535108565;5197.7401129943355;5203.8178663746585;5210.557102646279;3375.51055097012;3433.7424693148114;3455.274392377604;3456.9308613827834;3512.8946131616094;1225.393430252022;1234.888860002595;1268.3721557828842;1279.5073896549802;1283.1467074395516;10718.356898586031;10787.83818242727;10791.730206744816;10803;10806.51370688313;4357.215701173755;4647.279671650899;4663.790129444184;4689.390379250675;4698.577128058491;7950.681972721142;9468.57391417388;9484.383515071499;9492.430454172772;9496.810063798684;5157.6647517911215;5220.190870415092;5235.136202526616;5241.659292146074;5244.239585260116;4618.515055919147;4704.364910737075;4754.595859351924;4799;4831.371921650163;3803.4294855771304;3881.3789793633446;3891.3968334907568;3973.264945985002;3974.4435778990965;1077.7359546911057;1167.5096459487036;1219.5792451604182;1269.9619011429672;1274.3564499927477;741.6662501874179;757.8332766791297;783.295034468971;807.5719868469721;819.2340161948597;5562.805301814417;5591.692456914828;5593.608447408724;5677.943220567824;5806.274215723035;841.7096101844854;843.3632607381388;965.8020105878278;982.8918818929913;992.9453880036523;3669.192777588926;3678.8528458861883;3739.5886452490204;3754.6057663944894;3759.605241449663;9395.107464790834;9972.700818975442;10055.849162262572;10065.094141527297;10286.588536458608;8478.406511544255;9989.40063596172;9992.25058120644;10029.498525073717;10047.748806279902;7649.31156195945;7827.569483678339;7832.647530861125;7846.058472983279;7847.450678452567;5306.734663266744;5454.127339625799;5517.834464966058;5543.52880005204;5559.555235581225;7661.961690191513;8547.846040784663;9131.406458580172;9142.588583513625;9201.723948281562;7443;7805.882911756442;9027;9229.400088994194;9431.821022372204;6866.622335771581;6954.617496037767;6967.233604303421;6978.057962175041;6985.764555342242;7554.395648348009;7606;7620.771376858703;7730.342920851791;7735.729249476466;6438.195225596801;6592.406683398325;7029.753958611424;7087.574745515286;7140.7143714252925;7119.6084215368655;7152.499325047197;7207.9639601801655;7297.452691048299;7427.628618569158;6254.124422580933;6375.840603984938;6391.424771770563;6441.774537891151;6470;3899.3760998240145;4919.532644398776;4949.307097006494;5089.033083714083;5099.92350114756;4960.206366981266;5063.3417655704525;5174.223866420067;5179.92230116541;5191.039657663345 20:23:20 INFO - PROCESS | 1645 | |4;prototype.html;360.644764906567;362.9618890016548;371.6636444018164;377.8847451527283;380.27747280167677;4469.575390337921;5154.974225128869;5286.286351342567;5490.780368785248;5589.7205139743055;4968.527989840959;5292.285541451903;5502.862428439291;5506.559475241981;5506.5682922440155;3795.4876091727538;4097.467329247193;4320.524742278339;4372.229247154907;4373.956260437387;3568.660977207161;3966.424868394081;4306.61240488356;4361.869143925687;4369.563043695637;3526.2242306692488;4154.376843473473;4254.446921900164;4267.7196840947745;4289.335153051282;3758.5489741231227;4246.8725938221905;4285.849995250152;4295;4302.913941721148;2883.3132617418837;2970.8960186393588;3483.930321393583;3707.980305416005;3816.9579275087694;5078.238264260353;5386.326709161355;5389.218563308298;5425.83722488326;5452.809151679712;3980.7810570418615;4336.783160841946;4795.304680821261;4801.663883528155;4841.8547443576745;4785.880352991168;4799.832005879777;5201.829588342631;5480.04099282624;5856.004479238497;3478.5130081788316;3705.8332375043187;3856.5179352580926;3875.427762262525;3956.9010774730573;5373.328333958255;5483.396826349099;5766.7981620643495;6139.478144357735;6142.938570614281;3830.9233815324096;4016.9196616068098;4029.6171863672903;4037.04203461321;4043.292423825819;3462.79223246606;3762.398016317376;3953.5058117735284;4029;4097.89755256115;4084.6528045116497;4742.367985767863;4768;4804.351412559329;4824.445188803333;5239.292695486137;5776;5833.80791095925;5975.790847320323;5987.580869339192;1117.6702872652586;1240.461749168446;1245.9036048277458;1256.1520973342956;1296.1574976265504;745.8216018690564;836.7698882807276;857.2927334948693;893.7810236491971;901.7745563609097;4955.331030310934;5097.592192624581;5149.716765577929;5268.550124192269;5285.709285989307;4988.251762235694;5283.101872681654;5462.945370546323;5523.309586301712;5815.365396627108;4550.974816206756;4886.169351210303;5081.339425874613;5290.391604965478;5293.841184764463;2879.6256486656603;2947.778916581265;2958.742534422862;3012;3031.893358924021;5323.813666521731;5434.184872269191;5602.039286249861;5937.287525496881;6046.758129674764;5295.922139952292;5422.996745602076;5436.130219164915;5536.4186760390385;5815.185873977646;5078.365204349457;5782.761653474068;6033.3664965178905;6033.879322413527;6089.2997305310455;4843.6367272454;5207.81772637971;5803.448672376117;5818.7090645466715;5865.912011319919;5468.425815289496;5480.451954804487;5511.079128062133;5778.479936805707;5783.826485205283;5357.223202635674;5586.0169639778915;5638.5489160867855;5991.820245392645;6066.696665166635;3250.740735189021;3314.6519615440034;3684.392075307544;3725.2921944830396;3830.7318487705593;4915;5732.369439361751;5745.712714364348;5753;5772.307323121252;5288.788448462018;5521.944780552143;5654.830355089354;5763.7982670606325;5885.293764748258;4473.731576105444;5535.529479994246;5797.9420205797405;5801.477866991991;5874.530037597067;4731.5741583256295;5503.789166383389;5630.943690563206;5757.193992840922;5833.300003999547;5684.914726279027;5858.7070646466655;5881.852953676193;5881.94118058831;5897.852553686193;5311.123664595299;5715.457031581993;5761.567882408753;5792.913106303493;5816.883662326645 20:23:20 INFO - PROCESS | 1645 | |5;yui.html;722.9855402891939;745.6793578761133;788.8264581792007;830.783996160998;850.3197442046363;15623.140727259995;16202.513924582252;16326.510204693863;16345.754813677804;16368.672626547463;14810.963232573724;14935.85064149361;14944.62638434037;14965.925170374132;14966.102033877947;685.4619123987645;715.1954051691847;843.241083025276;862.1077185113393;874.9912500874973;864.0970186155482;875.8073223890766;884.1114679746845;884.1997991817416;889.3641046651643;894.9910500894973;911.7766147293922;946.7538440005613;947.7062110745691;948.6300342866253;916.326500022483;930.16285343191;932.4638332958542;938.1790932933683;940.313571093099;661.8345413646589;689.1867596236439;694.9478789090839;700.915890093192;701.0465766557478;15026;15353.769693454607;15405;16011.439599614074;16337.34650613974;14504.709905801825;14729.779053314209;14761.26193690322;14835.184064876428;14899.478518251917;11896.405179741065;11923.926846583763;11985.700357491045;11992.880071199352;12013.887154382162;3782.205736795276;3797.411401232813;3809.238152369537;3823.9426408603895;3940.408938659224;109939;110508.29154647238;111933;111982;114692;11249;11402.65792026224;11419.257748246337;11456.713582160346;11578.189526733217;23210.3036908893;23379.649305260435;23384.415389615395;23401.76598233996;23444.64833027506;7767.184445633127;7854.803629909298;7871.448998570159;8077.990251218597;8093.473924194908;4328.956710432855;4377.4528183977;4392.3191905254735;4455.376247325377;4582.931256031162;3602.837872295753;3663.0476076219843;3669.9266014679556;3687.1519550503535;3701.148735790783;663.1279866974912;670.3464122480542;671.385682100882;671.7078071039114;672.1295921781305;671.7615246587488;700.6146619359332;701.0395757811831;717.9461540384492;738.7414404958222;9006.07346955046;9951.651692190884;10475.790484190273;10527.882221053726;10682.252242342962;697.9476539259474;717.5838013951895;722.7000794670258;724.77169691547;736.2122528894032;3602.747807653439;3736.084659258499;4188.832446702158;4888.95111048885;5018.774155163026;92600.53699731592;112132;113190;114412;120146.39926800485;93377;96205;98779.50610247046;99205;100501.49749251353;74846.8772968406;78791.60604196943;79594.80607790888;83096.58451707703;83423.16576834154;10646.84029739539;10886.020258176803;11090.44547772592;11294.43527823622;11490.138239631893;48929.5107048925;51666.22500662568;52712.94574108573;54868.72565637146;55678.72160639171;58913.70543147257;65300.67349663221;72478;72840.27159728335;73387.63306183649;13976.589560855295;14148.929255353658;14484.927575362055;14523.273836308354;14750.55748327552;14949.701005979601;15251.923740381228;15347.846521534642;15719.371225150866;15773.05361678303;13911.860881391056;13931.58205253844;14032.08791428554;14312.427502900184;14495.855041449451;13792.793108103186;14147.717045659236;14199.219042952736;14583.635409114857;14652.19412932299;13677.042607017413;14006;14051.718965620836;14522.636934076732;14544.781828272373;11431.256968297033;11493.425328733698;11540.94229528847;11938.22401543897;12077.39613019328;11118.221724479208;11164.33014019129;11408.885911140782;11416.31502109876;11451.25566838153 20:23:20 INFO - PROCESS | 1645 | __end_tp_report 20:23:20 INFO - PROCESS | 1645 | __start_cc_report 20:23:20 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,371 20:23:20 INFO - PROCESS | 1645 | __end_cc_report 20:23:20 INFO - PROCESS | 1645 | __startTimestamp1484799800879__endTimestamp 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | ------- Summary: start ------- 20:23:20 INFO - PROCESS | 1645 | Number of tests: 6 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5653.88 Median:5931.44 stddev:826.01 (13.9%) stddev-sans-first:798.50 20:23:20 INFO - PROCESS | 1645 | Values: 2839.9 3361.9 3377.7 3380.4 3407.6 4648.3 5382.1 5678.6 5679.9 5724.4 4205.6 4845.4 5565.9 5579.0 5598.6 5064.6 5110.7 5144.3 5205.2 5261.8 5097.5 5212.4 5226.4 5228.3 5292.3 165.9 4609.6 5265.1 5268.0 5309.8 4442.7 4518.4 4823.2 5176.4 5188.6 5148.4 5168.3 5176.4 5177.4 5195.9 5503.6 5582.6 5691.6 5739.2 5764.2 4970.4 6115.2 6131.9 6141.4 6259.5 6237.9 6247.1 6276.3 6291.2 6307.4 5695.7 5817.1 5839.0 5873.7 5880.2 6197.2 6215.0 6237.8 6248.5 6304.3 6165.8 6172.7 6209.0 6217.8 6225.2 6237.8 6238.1 6258.0 6276.4 6284.8 4851.8 5819.8 6072.2 6080.5 6115.8 6172.7 6278.1 6307.2 6317.7 6317.9 4251.7 4418.6 4859.2 4890.1 4998.7 4391.3 4396.5 4433.7 4456.0 4550.4 5861.2 5862.4 5881.8 5931.4 5972.4 6208.1 6254.1 6275.1 6279.3 6295.4 5441.3 5655.7 5842.9 5890.4 5916.4 5528.6 5538.2 5541.8 5541.9 5561.7 6370.9 6374.3 6377.6 6383.2 6391.1 4964.9 6187.3 6204.1 6204.8 6251.7 5413.0 6214.9 6245.9 6289.4 6293.2 6204.5 6206.3 6209.8 6224.1 6261.2 6102.9 6109.6 6228.5 6236.6 6297.4 5889.8 6107.4 6109.4 6146.0 6193.3 6131.0 6132.3 6146.4 6170.1 6178.7 5778.3 5889.1 5961.6 6053.7 6092.0 6102.9 6121.5 6137.3 6191.3 6244.9 5706.7 6031.0 6075.2 6089.8 6096.4 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:71557.46 Median:38572.83 stddev:154910.10 (401.6%) stddev-sans-first:155252.79 20:23:20 INFO - PROCESS | 1645 | Values: 498.5 503.5 506.9 514.2 519.3 38959.6 41825.0 41892.0 41906.0 41981.6 42414.4 43001.4 43007.6 43076.0 43141.8 9294.8 9498.4 9501.1 9508.1 10933.2 10989.0 11222.5 11233.8 11237.7 11270.8 11230.3 11256.9 11265.0 11266.2 11304.5 11130.2 11158.2 11209.3 11211.6 11233.6 10780.8 10861.5 10865.0 10869.6 10872.0 37697.2 37873.2 37990.8 38105.9 38186.0 3963.2 4008.8 4022.8 4056.6 4140.1 29396.9 29568.4 29780.1 29782.6 29841.0 3144.8 3207.3 3304.4 3344.0 3345.5 488522.0 488931.2 492827.0 493382.0 494568.5 48371.0 57773.0 58330.4 58343.7 58375.0 53278.7 59321.0 59789.4 60060.4 60140.4 12993.6 13688.4 14604.1 14616.9 15540.2 10531.6 10742.0 10970.2 12432.8 12591.1 17387.0 18936.8 19607.8 20052.5 20487.6 8915.7 9139.0 9170.7 9171.8 9242.8 737.4 856.3 903.4 907.2 913.3 29910.6 30788.0 30870.8 31002.1 31468.1 1000.1 1066.7 1099.9 1110.8 1190.0 16038.9 16165.7 16228.7 16408.9 16463.4 658117.6 659133.7 661411.0 661578.0 663342.0 62703.4 63346.7 63348.7 63444.7 63670.0 1280.8 1395.5 1415.6 1452.8 1453.4 29061.4 30136.8 30415.5 30615.5 30691.8 53655.0 54244.5 54319.7 54363.0 54388.7 572105.0 574510.0 576834.0 577829.0 578006.0 36739.6 43831.0 44017.0 44717.9 44767.1 47604.5 48765.3 49196.8 49667.8 50066.0 35999.0 39766.6 40214.2 40324.8 41573.8 40280.8 40338.0 40349.4 41225.4 41353.6 36329.5 37079.6 37097.4 39140.0 39196.2 31378.7 33520.8 33821.9 33971.0 34154.7 20542.8 22987.0 24148.8 24807.0 25421.1 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:40649.26 Median:11923.08 stddev:123667.18 (1037.2%) stddev-sans-first:123977.15 20:23:20 INFO - PROCESS | 1645 | Values: 393.5 394.5 398.0 404.6 425.0 20034.0 20176.3 20786.5 21383.6 21522.0 17647.8 20777.2 21628.2 21785.3 21802.3 4683.8 4691.7 5316.0 5422.9 5424.7 5065.8 5251.8 5308.7 5315.1 5349.0 5296.6 5307.5 5310.5 5319.8 5321.0 5323.0 5837.3 5871.7 5873.4 5878.9 5041.7 5231.7 5236.3 5244.3 5255.4 21672.2 26083.5 26398.6 26529.6 26676.0 2173.9 2645.3 2650.1 2657.9 2670.7 8789.0 10010.8 10014.9 10213.6 10506.2 1851.7 1865.8 1881.7 1909.2 1909.6 139841.0 143104.0 144821.0 145763.3 147792.3 11891.6 11951.7 12115.4 12195.7 12294.7 15660.2 15781.1 15841.0 15846.8 15846.8 7475.9 7484.5 8660.2 8673.0 8763.6 8445.5 8462.9 8487.2 8541.8 8590.5 4809.9 4844.0 4852.8 4878.4 4928.4 2036.5 2073.2 2078.6 2084.7 2094.9 999.4 1000.6 1001.5 1018.1 1056.3 17043.0 20545.3 20795.8 21122.3 21442.0 905.3 1041.3 1043.9 1069.0 1087.7 9300.6 10496.2 11022.8 11067.8 11134.7 703792.5 737071.0 746254.0 747515.0 767860.0 114641.1 137067.0 160500.0 160524.0 163769.0 987.1 1006.5 1015.4 1025.0 1026.2 14915.6 17699.0 18546.8 18549.5 18589.7 53757.7 56552.7 59166.4 59233.7 59316.7 77866.0 87266.6 91636.0 95157.0 96178.5 7167.3 8063.5 8176.4 8321.1 8500.6 12002.4 12268.3 12733.5 12808.2 12872.5 10943.8 10986.5 11010.4 11473.6 11484.8 9680.0 10422.8 10728.7 10884.6 11130.2 9018.0 11275.0 11399.0 11617.3 11652.0 8195.3 8257.8 8328.3 8338.0 8473.9 9236.4 11394.4 11486.1 11495.4 11500.3 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5363.03 Median:5215.37 stddev:2912.72 (55.8%) stddev-sans-first:2904.48 20:23:20 INFO - PROCESS | 1645 | Values: 1249.7 1323.9 1440.7 1455.3 1483.1 7514.6 7717.4 7989.6 8505.9 8523.7 7994.1 8077.2 8239.7 8395.2 8405.0 1947.5 2279.8 2323.9 2338.4 2344.1 1803.5 2071.8 2138.3 2223.9 2343.6 2207.0 2279.3 2284.5 2294.0 2294.9 1967.8 2287.4 2293.3 2300.9 2329.3 1961.0 2230.9 2270.7 2338.9 2352.6 8416.6 8469.4 8479.0 8479.5 8488.7 5032.9 5180.4 5197.7 5203.8 5210.6 3375.5 3433.7 3455.3 3456.9 3512.9 1225.4 1234.9 1268.4 1279.5 1283.1 10718.4 10787.8 10791.7 10803.0 10806.5 4357.2 4647.3 4663.8 4689.4 4698.6 7950.7 9468.6 9484.4 9492.4 9496.8 5157.7 5220.2 5235.1 5241.7 5244.2 4618.5 4704.4 4754.6 4799.0 4831.4 3803.4 3881.4 3891.4 3973.3 3974.4 1077.7 1167.5 1219.6 1270.0 1274.4 741.7 757.8 783.3 807.6 819.2 5562.8 5591.7 5593.6 5677.9 5806.3 841.7 843.4 965.8 982.9 992.9 3669.2 3678.9 3739.6 3754.6 3759.6 9395.1 9972.7 10055.8 10065.1 10286.6 8478.4 9989.4 9992.3 10029.5 10047.7 7649.3 7827.6 7832.6 7846.1 7847.5 5306.7 5454.1 5517.8 5543.5 5559.6 7662.0 8547.8 9131.4 9142.6 9201.7 7443.0 7805.9 9027.0 9229.4 9431.8 6866.6 6954.6 6967.2 6978.1 6985.8 7554.4 7606.0 7620.8 7730.3 7735.7 6438.2 6592.4 7029.8 7087.6 7140.7 7119.6 7152.5 7208.0 7297.5 7427.6 6254.1 6375.8 6391.4 6441.8 6470.0 3899.4 4919.5 4949.3 5089.0 5099.9 4960.2 5063.3 5174.2 5179.9 5191.0 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4598.32 Median:5253.92 stddev:1420.51 (27.0%) stddev-sans-first:1388.43 20:23:20 INFO - PROCESS | 1645 | Values: 360.6 363.0 371.7 377.9 380.3 4469.6 5155.0 5286.3 5490.8 5589.7 4968.5 5292.3 5502.9 5506.6 5506.6 3795.5 4097.5 4320.5 4372.2 4374.0 3568.7 3966.4 4306.6 4361.9 4369.6 3526.2 4154.4 4254.4 4267.7 4289.3 3758.5 4246.9 4285.8 4295.0 4302.9 2883.3 2970.9 3483.9 3708.0 3817.0 5078.2 5386.3 5389.2 5425.8 5452.8 3980.8 4336.8 4795.3 4801.7 4841.9 4785.9 4799.8 5201.8 5480.0 5856.0 3478.5 3705.8 3856.5 3875.4 3956.9 5373.3 5483.4 5766.8 6139.5 6142.9 3830.9 4016.9 4029.6 4037.0 4043.3 3462.8 3762.4 3953.5 4029.0 4097.9 4084.7 4742.4 4768.0 4804.4 4824.4 5239.3 5776.0 5833.8 5975.8 5987.6 1117.7 1240.5 1245.9 1256.2 1296.2 745.8 836.8 857.3 893.8 901.8 4955.3 5097.6 5149.7 5268.6 5285.7 4988.3 5283.1 5462.9 5523.3 5815.4 4551.0 4886.2 5081.3 5290.4 5293.8 2879.6 2947.8 2958.7 3012.0 3031.9 5323.8 5434.2 5602.0 5937.3 6046.8 5295.9 5423.0 5436.1 5536.4 5815.2 5078.4 5782.8 6033.4 6033.9 6089.3 4843.6 5207.8 5803.4 5818.7 5865.9 5468.4 5480.5 5511.1 5778.5 5783.8 5357.2 5586.0 5638.5 5991.8 6066.7 3250.7 3314.7 3684.4 3725.3 3830.7 4915.0 5732.4 5745.7 5753.0 5772.3 5288.8 5521.9 5654.8 5763.8 5885.3 4473.7 5535.5 5797.9 5801.5 5874.5 4731.6 5503.8 5630.9 5757.2 5833.3 5684.9 5858.7 5881.9 5881.9 5897.9 5311.1 5715.5 5761.6 5792.9 5816.9 20:23:20 INFO - PROCESS | 1645 | 20:23:20 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:21590.95 Median:3666.49 stddev:31233.03 (851.9%) stddev-sans-first:31281.34 20:23:20 INFO - PROCESS | 1645 | Values: 723.0 745.7 788.8 830.8 850.3 15623.1 16202.5 16326.5 16345.8 16368.7 14811.0 14935.9 14944.6 14965.9 14966.1 685.5 715.2 843.2 862.1 875.0 864.1 875.8 884.1 884.2 889.4 895.0 911.8 946.8 947.7 948.6 916.3 930.2 932.5 938.2 940.3 661.8 689.2 694.9 700.9 701.0 15026.0 15353.8 15405.0 16011.4 16337.3 14504.7 14729.8 14761.3 14835.2 14899.5 11896.4 11923.9 11985.7 11992.9 12013.9 3782.2 3797.4 3809.2 3823.9 3940.4 109939.0 110508.3 111933.0 111982.0 114692.0 11249.0 11402.7 11419.3 11456.7 11578.2 23210.3 23379.6 23384.4 23401.8 23444.6 7767.2 7854.8 7871.4 8078.0 8093.5 4329.0 4377.5 4392.3 4455.4 4582.9 3602.8 3663.0 3669.9 3687.2 3701.1 663.1 670.3 671.4 671.7 672.1 671.8 700.6 701.0 717.9 738.7 9006.1 9951.7 10475.8 10527.9 10682.3 697.9 717.6 722.7 724.8 736.2 3602.7 3736.1 4188.8 4889.0 5018.8 92600.5 112132.0 113190.0 114412.0 120146.4 93377.0 96205.0 98779.5 99205.0 100501.5 74846.9 78791.6 79594.8 83096.6 83423.2 10646.8 10886.0 11090.4 11294.4 11490.1 48929.5 51666.2 52712.9 54868.7 55678.7 58913.7 65300.7 72478.0 72840.3 73387.6 13976.6 14148.9 14484.9 14523.3 14750.6 14949.7 15251.9 15347.8 15719.4 15773.1 13911.9 13931.6 14032.1 14312.4 14495.9 13792.8 14147.7 14199.2 14583.6 14652.2 13677.0 14006.0 14051.7 14522.6 14544.8 11431.3 11493.4 11540.9 11938.2 12077.4 11118.2 11164.3 11408.9 11416.3 11451.3 20:23:20 INFO - PROCESS | 1645 | -------- Summary: end -------- 20:23:20 INFO - PROCESS | 1645 | 20:23:21 INFO - TEST-INFO | 1645: exit 0 20:23:21 INFO - TEST-OK | dromaeo_css | took 1113974ms 20:23:21 INFO - TEST-START | kraken 20:23:21 INFO - operating with platform_type : mac_ 20:23:21 INFO - Initialising browser for kraken test... 20:23:21 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpYCz5LG/profile http://localhost:49242/getInfo.html) 20:23:24 INFO - PROCESS | 1657 | 2017-01-18 20:23:24.251 plugin-container[1658:10087] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 20:23:24 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:24 INFO - PROCESS | 1657 | 2017-01-18 20:23:24.254 plugin-container[1658:10087] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 20:23:24 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:24 INFO - PROCESS | 1657 | 2017-01-18 20:23:24.254 plugin-container[1658:10087] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:23:24 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 20:23:24 INFO - PROCESS | 1657 | colorDepth:24 20:23:24 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 20:23:24 INFO - PROCESS | 1657 | __metrics 20:23:24 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 20:23:25 INFO - TEST-INFO | 1657: exit 0 20:23:25 INFO - Browser initialized. 20:23:25 INFO - Running cycle 1/1 for kraken test... 20:23:25 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpYCz5LG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:27 INFO - PROCESS | 1659 | 2017-01-18 20:23:27.427 plugin-container[1660:10204] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 20:23:27 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:27 INFO - PROCESS | 1659 | 2017-01-18 20:23:27.428 plugin-container[1660:10204] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 20:23:27 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:27 INFO - PROCESS | 1659 | 2017-01-18 20:23:27.428 plugin-container[1660:10204] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:23:37 INFO - PROCESS | 1659 | RSS: Main: 232075264 20:23:37 INFO - PROCESS | 1659 | 20:23:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:41 INFO - PROCESS | 1659 | RSS: Main: 245850112 20:23:41 INFO - PROCESS | 1659 | 20:23:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 20:23:44 INFO - PROCESS | 1659 | RSS: Main: 253263872 20:23:44 INFO - PROCESS | 1659 | 20:23:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 20:23:48 INFO - PROCESS | 1659 | RSS: Main: 255954944 20:23:48 INFO - PROCESS | 1659 | 20:23:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 20:23:51 INFO - PROCESS | 1659 | RSS: Main: 257736704 20:23:51 INFO - PROCESS | 1659 | 20:23:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:53 INFO - PROCESS | 1659 | RSS: Main: 258060288 20:23:53 INFO - PROCESS | 1659 | 20:23:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 20:23:57 INFO - PROCESS | 1659 | RSS: Main: 264433664 20:23:57 INFO - PROCESS | 1659 | 20:24:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 20:24:01 INFO - PROCESS | 1659 | RSS: Main: 261029888 20:24:01 INFO - PROCESS | 1659 | 20:24:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 20:24:05 INFO - PROCESS | 1659 | RSS: Main: 261988352 20:24:05 INFO - PROCESS | 1659 | 20:24:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:24:07 INFO - PROCESS | 1659 | RSS: Main: 261963776 20:24:07 INFO - PROCESS | 1659 | 20:24:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:24:09 INFO - PROCESS | 1659 | RSS: Main: 262242304 20:24:09 INFO - PROCESS | 1659 | 20:24:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:24:12 INFO - PROCESS | 1659 | RSS: Main: 262066176 20:24:12 INFO - PROCESS | 1659 | 20:24:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:24:16 INFO - PROCESS | 1659 | RSS: Main: 262471680 20:24:16 INFO - PROCESS | 1659 | 20:24:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:24:20 INFO - PROCESS | 1659 | RSS: Main: 262320128 20:24:20 INFO - PROCESS | 1659 | 20:24:21 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 20:24:22 INFO - PROCESS | 1659 | RSS: Main: 264343552 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | __start_tp_report 20:24:22 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 20:24:22 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 20:24:22 INFO - PROCESS | 1659 | |i|pagename|runs| 20:24:22 INFO - PROCESS | 1659 | |0;ai-astar;105;116;117;116;118;117;143;171;152;116 20:24:22 INFO - PROCESS | 1659 | |1;audio-beat-detection;159;133;100;166;150;143;98;106;164;143 20:24:22 INFO - PROCESS | 1659 | |2;audio-dft;201;199;215;196;198;193;192;193;197;194 20:24:22 INFO - PROCESS | 1659 | |3;audio-fft;84;60;74;110;52;84;84;89;66;73 20:24:22 INFO - PROCESS | 1659 | |4;audio-oscillator;88;74;95;59;95;60;81;56;90;76 20:24:22 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;92;87;81;131;78;94;136;132;78;131 20:24:22 INFO - PROCESS | 1659 | |6;imaging-darkroom;162;117;171;170;136;100;166;169;117;106 20:24:22 INFO - PROCESS | 1659 | |7;imaging-desaturate;93;95;92;92;95;93;85;106;86;143 20:24:22 INFO - PROCESS | 1659 | |8;json-parse-financial;60;61;60;58;62;62;60;63;61;61 20:24:22 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;77;90;65;103;77;76;57;59;64;66 20:24:22 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;99;112;117;88;89;87;84;91;90;87 20:24:22 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;142;158;147;150;153;147;165;151;200;148 20:24:22 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;172;175;177;182;178;178;235;215;175;177 20:24:22 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;68;69;67;67;70;67;69;67;64;68 20:24:22 INFO - PROCESS | 1659 | __end_tp_report 20:24:22 INFO - PROCESS | 1659 | __start_cc_report 20:24:22 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,906 20:24:22 INFO - PROCESS | 1659 | __end_cc_report 20:24:22 INFO - PROCESS | 1659 | __startTimestamp1484799862159__endTimestamp 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | ------- Summary: start ------- 20:24:22 INFO - PROCESS | 1659 | Number of tests: 14 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:127.10 Median:117.50 stddev:20.94 (17.8%) stddev-sans-first:20.62 20:24:22 INFO - PROCESS | 1659 | Values: 105.0 116.0 117.0 116.0 118.0 117.0 143.0 171.0 152.0 116.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:154.50 stddev:26.15 (16.9%) stddev-sans-first:26.41 20:24:22 INFO - PROCESS | 1659 | Values: 159.0 133.0 100.0 166.0 150.0 143.0 98.0 106.0 164.0 143.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:197.80 Median:197.50 stddev:6.71 (3.4%) stddev-sans-first:7.02 20:24:22 INFO - PROCESS | 1659 | Values: 201.0 199.0 215.0 196.0 198.0 193.0 192.0 193.0 197.0 194.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:77.60 Median:79.00 stddev:16.45 (20.8%) stddev-sans-first:17.29 20:24:22 INFO - PROCESS | 1659 | Values: 84.0 60.0 74.0 110.0 52.0 84.0 84.0 89.0 66.0 73.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:84.50 stddev:14.97 (17.7%) stddev-sans-first:15.38 20:24:22 INFO - PROCESS | 1659 | Values: 88.0 74.0 95.0 59.0 95.0 60.0 81.0 56.0 90.0 76.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:104.00 Median:79.50 stddev:25.12 (31.6%) stddev-sans-first:26.27 20:24:22 INFO - PROCESS | 1659 | Values: 92.0 87.0 81.0 131.0 78.0 94.0 136.0 132.0 78.0 131.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:141.40 Median:164.00 stddev:29.20 (17.8%) stddev-sans-first:30.00 20:24:22 INFO - PROCESS | 1659 | Values: 162.0 117.0 171.0 170.0 136.0 100.0 166.0 169.0 117.0 106.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:92.50 stddev:16.81 (18.2%) stddev-sans-first:17.73 20:24:22 INFO - PROCESS | 1659 | Values: 93.0 95.0 92.0 92.0 95.0 93.0 85.0 106.0 86.0 143.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:61.00 stddev:1.40 (2.3%) stddev-sans-first:1.45 20:24:22 INFO - PROCESS | 1659 | Values: 60.0 61.0 60.0 58.0 62.0 62.0 60.0 63.0 61.0 61.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:71.00 stddev:14.43 (20.3%) stddev-sans-first:15.25 20:24:22 INFO - PROCESS | 1659 | Values: 77.0 90.0 65.0 103.0 77.0 76.0 57.0 59.0 64.0 66.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:94.40 Median:88.50 stddev:11.35 (12.8%) stddev-sans-first:11.92 20:24:22 INFO - PROCESS | 1659 | Values: 99.0 112.0 117.0 88.0 89.0 87.0 84.0 91.0 90.0 87.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:152.00 stddev:16.71 (11.0%) stddev-sans-first:16.93 20:24:22 INFO - PROCESS | 1659 | Values: 142.0 158.0 147.0 150.0 153.0 147.0 165.0 151.0 200.0 148.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:178.00 stddev:21.04 (11.8%) stddev-sans-first:21.66 20:24:22 INFO - PROCESS | 1659 | Values: 172.0 175.0 177.0 182.0 178.0 178.0 235.0 215.0 175.0 177.0 20:24:22 INFO - PROCESS | 1659 | 20:24:22 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.74 20:24:22 INFO - PROCESS | 1659 | Values: 68.0 69.0 67.0 67.0 70.0 67.0 69.0 67.0 64.0 68.0 20:24:22 INFO - PROCESS | 1659 | -------- Summary: end -------- 20:24:22 INFO - PROCESS | 1659 | 20:24:23 INFO - TEST-INFO | 1659: exit 0 20:24:23 INFO - TEST-OK | kraken | took 61479ms 20:24:23 INFO - SUITE-END | took 1175s 20:24:23 INFO - Completed test suite (00:19:35) 20:24:23 INFO - javascript benchmark 20:24:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7372.348589174934, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2839.914802555924, 3361.8991430257092, 3377.729781617469, 3380.425327694292, 3407.591089069312, 4648.349231107648, 5382.085045542258, 5678.630888992213, 5679.886402271957, 5724.398938111501, 4205.558416366283, 4845.418549774032, 5565.888682226353, 5578.967890940179, 5598.608097433182, 5064.594832413407, 5110.718910459923, 5144.25408315794, 5205.193195054753, 5261.815836445725, 5097.547199048272, 5212.400573933989, 5226.425093239741, 5228.2680424740565, 5292.311999440068, 165.85786002051023, 4609.608183304423, 5265.052290587692, 5268.0, 5309.787608495655, 4442.689011769177, 4518.367428560005, 4823.180059389877, 5176.430592634807, 5188.558972487343, 5148.3821941366905, 5168.250603662448, 5176.404713457963, 5177.37871455424, 5195.896082078375, 5503.642263252876, 5582.581306401996, 5691.601587888849, 5739.16782066598, 5764.16419619157, 4970.428400733889, 6115.205023346981, 6131.89663773324, 6141.393954534099, 6259.499240060784, 6237.906431403532, 6247.125402443616, 6276.309605943343, 6291.182146320994, 6307.400796924331, 5695.7152142392715, 5817.0983497557945, 5838.970805145989, 5873.735681894325, 5880.235569375954, 6197.194364732646, 6214.9689251554355, 6237.844053898689, 6248.5313601480075, 6304.275008374004, 6165.784197553064, 6172.660503672341, 6208.9689551551955, 6217.813465596039, 6225.190725205694, 6237.812865614039, 6238.1266622672865, 6257.9687101564205, 6276.403741644536, 6284.842878928063, 4851.80592776285, 5819.79630712923, 6072.180255665517, 6080.48315893154, 6115.785947491817, 6172.722227499773, 6278.058291256348, 6307.24313082433, 6317.652529110943, 6317.873642527124, 4251.723637963522, 4418.64650827933, 4859.222524396079, 4890.095332363453, 4998.6750861193905, 4391.275439552502, 4396.538363471854, 4433.689641725113, 4455.997400584907, 4550.362949187116, 5861.238039054981, 5862.384449632812, 5881.823545293648, 5931.436513531207, 5972.402759723993, 6208.084508580417, 6254.124422580842, 6275.121482992385, 6279.340669229757, 6295.433410993032, 5441.347038355423, 5655.660660360391, 5842.941570584325, 5890.3815099414805, 5916.3787802281, 5528.6406383585745, 5538.224648549206, 5541.750621222055, 5541.9168712469345, 5561.721913904288, 6370.936290637127, 6374.266959299647, 6377.64922929234, 6383.234011918506, 6391.073294372383, 4964.851054468371, 6187.257529096537, 6204.069389591416, 6204.782832601018, 6251.6874156292915, 5412.972935135299, 6214.9067763982675, 6245.937540624717, 6289.433950944437, 6293.150424692608, 6204.534659900435, 6206.286277078194, 6209.844753881189, 6224.06639004153, 6261.217347831521, 6102.852830488404, 6109.586862300561, 6228.4705800007505, 6236.604161059012, 6297.433231009231, 5889.764409423575, 6107.401224262618, 6109.389061093855, 6146.0, 6193.256809182927, 6131.0, 6132.294786099477, 6146.416090471398, 6170.136180934763, 6178.66017369031, 5778.335491418373, 5889.116632505158, 5961.642301461926, 6053.681899820501, 6092.025275955826, 6102.883130681719, 6121.483458747687, 6137.346341658241, 6191.288001879661, 6244.937550624436, 5706.714664266853, 6031.0, 6075.210222671025, 6089.847753806191, 6096.390360963868], "value": 5600.941508909031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.4641510376346, 503.5342308364763, 506.9239614057891, 514.190150512942, 519.283388923286, 38959.61040389595, 41825.0, 41892.0, 41906.0, 41981.58018419819, 42414.36378454325, 43001.35497967533, 43007.56992430075, 43076.0, 43141.784291078504, 9294.814103717921, 9498.430094194337, 9501.097395747393, 9508.096730810597, 10933.234673572853, 10989.0, 11222.494987725531, 11233.775324493505, 11237.719057023558, 11270.774584508305, 11230.32618042916, 11256.887431125666, 11265.0, 11266.211365204439, 11304.547818087307, 11130.220884538086, 11158.218924675277, 11209.271397359187, 11211.551537938472, 11233.550657973672, 10780.784384312348, 10861.456927153611, 10865.0, 10869.565217391295, 10872.0, 37697.24605507902, 37873.24253514942, 37990.81004594987, 38105.856824295035, 38186.045348866224, 3963.1677347756718, 4008.7995600220165, 4022.839086436539, 4056.553779084298, 4140.127388535017, 29396.853015735, 29568.408631827457, 29780.106596802132, 29782.55326170109, 29841.0, 3144.827034513101, 3207.294395233045, 3304.4217261979056, 3344.0, 3345.5149003394613, 488522.0, 488931.21947073325, 492827.0, 493382.0, 494568.5271573655, 48371.0, 57773.0, 58330.416695833344, 58343.70828145917, 58375.0, 53278.73360633172, 59321.0, 59789.40210597925, 60060.39939600548, 60140.39859601348, 12993.610191694264, 13688.384022719001, 14604.050736702293, 14616.853831461549, 15540.222988850512, 10531.57873685044, 10742.0, 10970.177236707279, 12432.75134497305, 12591.118621696576, 17387.02163061564, 18936.81063189378, 19607.803921960884, 20052.498687532636, 20487.590248194952, 8915.687950921687, 9138.954305228432, 9170.724878253663, 9171.81656366869, 9242.768930776785, 737.3548145372799, 856.3192262151605, 903.3631289940577, 907.1518130547959, 913.3150137396952, 29910.55134172989, 30788.0, 30870.845645772075, 31002.0699379019, 31468.055958321285, 1000.1498726082772, 1066.722652110457, 1099.8845121262311, 1110.783397237547, 1190.0245592316712, 16038.87727859062, 16165.67668646644, 16228.675426491403, 16408.927859705203, 16463.423780167876, 658117.6070632227, 659133.7043314753, 661411.0, 661578.0, 663342.0, 62703.37296627067, 63346.683266584296, 63348.68325658342, 63444.731105377636, 63670.0, 1280.8270883430619, 1395.5464474045975, 1415.610707055568, 1452.8111345525226, 1453.404104317246, 29061.417588915574, 30136.84931575328, 30415.54376684396, 30615.54076688896, 30691.846540768045, 53655.0, 54244.45755542394, 54319.72840135932, 54363.0, 54388.72805635946, 572105.0, 574510.0, 576834.0, 577829.0, 578006.0, 36739.63260367362, 43831.0, 44017.0, 44717.88205294894, 44767.104657906006, 47604.52395476001, 48765.268520972924, 49196.75401622969, 49667.75166124146, 50066.0, 35999.0, 39766.60233397629, 40214.19571608493, 40324.790256292355, 41573.792131039154, 40280.79157625276, 40338.0, 40349.39475907922, 41225.38161927633, 41353.586464134976, 36329.45505817468, 37079.6292037087, 37097.44353834641, 39140.0, 39196.216075678894, 31378.686213138488, 33520.82677106289, 33821.91205583019, 33971.0, 34154.65845341515, 20542.79457205409, 22987.0, 24148.75851241465, 24807.0, 25421.11026114077], "value": 20721.174151586987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.5120450641204, 394.4911064726503, 397.9880603581893, 404.64795627803807, 424.9915001699966, 20034.0, 20176.293829715964, 20786.48033799152, 21383.57232855342, 21522.0, 17647.823521764778, 20777.16891324349, 21628.2430114946, 21785.346439606838, 21802.345929622137, 4683.812647494096, 4691.671582989192, 5316.016536940679, 5422.864428389302, 5424.728763561826, 5065.758889072183, 5251.789928402859, 5308.6814791112465, 5315.14957606783, 5348.973255133719, 5296.602754793406, 5307.548858347045, 5310.548603368718, 5319.840404787863, 5320.989012087691, 5322.973385133069, 5837.270341207349, 5871.706414679249, 5873.412658734135, 5878.88242235155, 5041.697498150123, 5231.738413079369, 5236.29310043147, 5244.344456942882, 5255.448177941337, 21672.24147154858, 26083.478330433285, 26398.6040209397, 26529.602055969175, 26676.0, 2173.923912663049, 2645.2989957661043, 2650.08572042645, 2657.8671066446796, 2670.6795184577977, 8788.956055219747, 10010.841348305705, 10014.89985100147, 10213.642522511676, 10506.212034097472, 1851.703727403609, 1865.813418658137, 1881.7271495633056, 1909.2076788132908, 1909.598984213317, 139841.0, 143104.0, 144820.99999999895, 145763.27118364445, 147792.2610386952, 11891.643250702493, 11951.701207469883, 12115.39423028845, 12195.695107622381, 12294.692632684255, 15660.216989150726, 15781.132037738034, 15841.0, 15846.841531584767, 15846.841531584767, 7475.8786182072035, 7484.47608667399, 8660.220580147818, 8673.0, 8763.605637746317, 8445.493270403795, 8462.87305690415, 8487.236148746519, 8541.829163416696, 8590.484570925764, 4809.879753006203, 4843.975780121077, 4852.816232695302, 4878.414590249193, 4928.408590969107, 2036.4908772806798, 2073.1914553324214, 2078.646630072891, 2084.6560317547737, 2094.853360264797, 999.4253304350028, 1000.6097621927454, 1001.4692213127055, 1018.1244130048152, 1056.2553399853084, 17043.0, 20545.280915167896, 20795.792042079687, 21122.260720874696, 21442.0, 905.2938707807789, 1041.286718597763, 1043.8903915088958, 1068.9625863094755, 1087.7335052912088, 9300.627974881065, 10496.212784041074, 11022.834657480144, 11067.833982490269, 11134.665960021212, 703792.4810375916, 737071.0, 746254.0, 747515.0, 767860.0, 114641.13397165138, 137067.0, 160500.0, 160524.0, 163769.0, 987.0622908237203, 1006.4565134827111, 1015.4313584392617, 1024.9743756406149, 1026.1790567545934, 14915.627109322353, 17699.0, 18546.81453185505, 18549.536261593566, 18589.72115418243, 53757.73121134369, 56552.717236413555, 59166.40833591609, 59233.70383148057, 59316.70341648264, 77866.0, 87266.5636671838, 91636.0, 95157.04842951758, 96178.51910740402, 7167.319104685047, 8063.516189028677, 8176.427650064438, 8321.08468068524, 8500.61747221389, 12002.39988000579, 12268.263904165422, 12733.490660373482, 12808.167469114851, 12872.549460768829, 10943.83584246253, 10986.505607247853, 11010.449477526252, 11473.598424055119, 11484.827727583926, 9679.951600242235, 10422.801377841342, 10728.678139655824, 10884.61903833362, 11130.220884538328, 9017.954910225408, 11275.0, 11399.031082358093, 11617.302961822317, 11652.0, 8195.303399211134, 8257.83484330322, 8328.250457458858, 8337.95775528059, 8473.872891906749, 9236.399634023766, 11394.36710974222, 11486.081113510732, 11495.425228738362, 11500.25248358854], "value": 9796.13835814619, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.6750844780354, 1323.894088472922, 1440.661444560528, 1455.2505459688257, 1483.1323675649749, 7514.586697731623, 7717.382609391249, 7989.5605741684185, 8505.872411913819, 8523.701670441536, 7994.120646728855, 8077.23266289703, 8239.711610093647, 8395.160483951617, 8404.991401031884, 1947.5325921778813, 2279.794818466338, 2323.8721870297127, 2338.4153961509624, 2344.120954642009, 1803.5220666523317, 2071.8031786980214, 2138.315738963532, 2223.911043558264, 2343.5898717724417, 2206.9668954965687, 2279.259240746764, 2284.451731584416, 2293.9655905161435, 2294.9426264343356, 1967.7737060238042, 2287.439577303563, 2293.2776175504664, 2300.942476438094, 2329.312852708455, 1960.9607807843906, 2230.933072007826, 2270.693456383384, 2338.941526461835, 2352.5765362234793, 8416.579171041423, 8469.407141500098, 8479.0, 8479.533625650587, 8488.74533763988, 5032.949670503284, 5180.4042535108565, 5197.7401129943355, 5203.8178663746585, 5210.557102646279, 3375.51055097012, 3433.7424693148114, 3455.274392377604, 3456.9308613827834, 3512.8946131616094, 1225.393430252022, 1234.888860002595, 1268.3721557828842, 1279.5073896549802, 1283.1467074395516, 10718.356898586031, 10787.83818242727, 10791.730206744816, 10803.0, 10806.51370688313, 4357.215701173755, 4647.279671650899, 4663.790129444184, 4689.390379250675, 4698.577128058491, 7950.681972721142, 9468.57391417388, 9484.383515071499, 9492.430454172772, 9496.810063798684, 5157.6647517911215, 5220.190870415092, 5235.136202526616, 5241.659292146074, 5244.239585260116, 4618.515055919147, 4704.364910737075, 4754.595859351924, 4799.0, 4831.371921650163, 3803.4294855771304, 3881.3789793633446, 3891.3968334907568, 3973.264945985002, 3974.4435778990965, 1077.7359546911057, 1167.5096459487036, 1219.5792451604182, 1269.9619011429672, 1274.3564499927477, 741.6662501874179, 757.8332766791297, 783.295034468971, 807.5719868469721, 819.2340161948597, 5562.805301814417, 5591.692456914828, 5593.608447408724, 5677.943220567824, 5806.274215723035, 841.7096101844854, 843.3632607381388, 965.8020105878278, 982.8918818929913, 992.9453880036523, 3669.192777588926, 3678.8528458861883, 3739.5886452490204, 3754.6057663944894, 3759.605241449663, 9395.107464790834, 9972.700818975442, 10055.849162262572, 10065.094141527297, 10286.588536458608, 8478.406511544255, 9989.40063596172, 9992.25058120644, 10029.498525073717, 10047.748806279902, 7649.31156195945, 7827.569483678339, 7832.647530861125, 7846.058472983279, 7847.450678452567, 5306.734663266744, 5454.127339625799, 5517.834464966058, 5543.52880005204, 5559.555235581225, 7661.961690191513, 8547.846040784663, 9131.406458580172, 9142.588583513625, 9201.723948281562, 7443.0, 7805.882911756442, 9027.0, 9229.400088994194, 9431.821022372204, 6866.622335771581, 6954.617496037767, 6967.233604303421, 6978.057962175041, 6985.764555342242, 7554.395648348009, 7606.0, 7620.771376858703, 7730.342920851791, 7735.729249476466, 6438.195225596801, 6592.406683398325, 7029.753958611424, 7087.574745515286, 7140.7143714252925, 7119.6084215368655, 7152.499325047197, 7207.9639601801655, 7297.452691048299, 7427.628618569158, 6254.124422580933, 6375.840603984938, 6391.424771770563, 6441.774537891151, 6470.0, 3899.3760998240145, 4919.532644398776, 4949.307097006494, 5089.033083714083, 5099.92350114756, 4960.206366981266, 5063.3417655704525, 5174.223866420067, 5179.92230116541, 5191.039657663345], "value": 4350.619946196977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.644764906567, 362.9618890016548, 371.6636444018164, 377.8847451527283, 380.27747280167677, 4469.575390337921, 5154.974225128869, 5286.286351342567, 5490.780368785248, 5589.7205139743055, 4968.527989840959, 5292.285541451903, 5502.862428439291, 5506.559475241981, 5506.5682922440155, 3795.4876091727538, 4097.467329247193, 4320.524742278339, 4372.229247154907, 4373.956260437387, 3568.660977207161, 3966.424868394081, 4306.61240488356, 4361.869143925687, 4369.563043695637, 3526.2242306692488, 4154.376843473473, 4254.446921900164, 4267.7196840947745, 4289.335153051282, 3758.5489741231227, 4246.8725938221905, 4285.849995250152, 4295.0, 4302.913941721148, 2883.3132617418837, 2970.8960186393588, 3483.930321393583, 3707.980305416005, 3816.9579275087694, 5078.238264260353, 5386.326709161355, 5389.218563308298, 5425.83722488326, 5452.809151679712, 3980.7810570418615, 4336.783160841946, 4795.304680821261, 4801.663883528155, 4841.8547443576745, 4785.880352991168, 4799.832005879777, 5201.829588342631, 5480.04099282624, 5856.004479238497, 3478.5130081788316, 3705.8332375043187, 3856.5179352580926, 3875.427762262525, 3956.9010774730573, 5373.328333958255, 5483.396826349099, 5766.7981620643495, 6139.478144357735, 6142.938570614281, 3830.9233815324096, 4016.9196616068098, 4029.6171863672903, 4037.04203461321, 4043.292423825819, 3462.79223246606, 3762.398016317376, 3953.5058117735284, 4029.0, 4097.89755256115, 4084.6528045116497, 4742.367985767863, 4768.0, 4804.351412559329, 4824.445188803333, 5239.292695486137, 5776.0, 5833.80791095925, 5975.790847320323, 5987.580869339192, 1117.6702872652586, 1240.461749168446, 1245.9036048277458, 1256.1520973342956, 1296.1574976265504, 745.8216018690564, 836.7698882807276, 857.2927334948693, 893.7810236491971, 901.7745563609097, 4955.331030310934, 5097.592192624581, 5149.716765577929, 5268.550124192269, 5285.709285989307, 4988.251762235694, 5283.101872681654, 5462.945370546323, 5523.309586301712, 5815.365396627108, 4550.974816206756, 4886.169351210303, 5081.339425874613, 5290.391604965478, 5293.841184764463, 2879.6256486656603, 2947.778916581265, 2958.742534422862, 3012.0, 3031.893358924021, 5323.813666521731, 5434.184872269191, 5602.039286249861, 5937.287525496881, 6046.758129674764, 5295.922139952292, 5422.996745602076, 5436.130219164915, 5536.4186760390385, 5815.185873977646, 5078.365204349457, 5782.761653474068, 6033.3664965178905, 6033.879322413527, 6089.2997305310455, 4843.6367272454, 5207.81772637971, 5803.448672376117, 5818.7090645466715, 5865.912011319919, 5468.425815289496, 5480.451954804487, 5511.079128062133, 5778.479936805707, 5783.826485205283, 5357.223202635674, 5586.0169639778915, 5638.5489160867855, 5991.820245392645, 6066.696665166635, 3250.740735189021, 3314.6519615440034, 3684.392075307544, 3725.2921944830396, 3830.7318487705593, 4915.0, 5732.369439361751, 5745.712714364348, 5753.0, 5772.307323121252, 5288.788448462018, 5521.944780552143, 5654.830355089354, 5763.7982670606325, 5885.293764748258, 4473.731576105444, 5535.529479994246, 5797.9420205797405, 5801.477866991991, 5874.530037597067, 4731.5741583256295, 5503.789166383389, 5630.943690563206, 5757.193992840922, 5833.300003999547, 5684.914726279027, 5858.7070646466655, 5881.852953676193, 5881.94118058831, 5897.852553686193, 5311.123664595299, 5715.457031581993, 5761.567882408753, 5792.913106303493, 5816.883662326645], "value": 4153.450204219283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.9855402891939, 745.6793578761133, 788.8264581792007, 830.783996160998, 850.3197442046363, 15623.140727259995, 16202.513924582252, 16326.510204693863, 16345.754813677804, 16368.672626547463, 14810.963232573724, 14935.85064149361, 14944.62638434037, 14965.925170374132, 14966.102033877947, 685.4619123987645, 715.1954051691847, 843.241083025276, 862.1077185113393, 874.9912500874973, 864.0970186155482, 875.8073223890766, 884.1114679746845, 884.1997991817416, 889.3641046651643, 894.9910500894973, 911.7766147293922, 946.7538440005613, 947.7062110745691, 948.6300342866253, 916.326500022483, 930.16285343191, 932.4638332958542, 938.1790932933683, 940.313571093099, 661.8345413646589, 689.1867596236439, 694.9478789090839, 700.915890093192, 701.0465766557478, 15026.0, 15353.769693454607, 15405.0, 16011.439599614074, 16337.34650613974, 14504.709905801825, 14729.779053314209, 14761.26193690322, 14835.184064876428, 14899.478518251917, 11896.405179741065, 11923.926846583763, 11985.700357491045, 11992.880071199352, 12013.887154382162, 3782.205736795276, 3797.411401232813, 3809.238152369537, 3823.9426408603895, 3940.408938659224, 109939.0, 110508.29154647238, 111933.0, 111982.0, 114692.0, 11249.0, 11402.65792026224, 11419.257748246337, 11456.713582160346, 11578.189526733217, 23210.3036908893, 23379.649305260435, 23384.415389615395, 23401.76598233996, 23444.64833027506, 7767.184445633127, 7854.803629909298, 7871.448998570159, 8077.990251218597, 8093.473924194908, 4328.956710432855, 4377.4528183977, 4392.3191905254735, 4455.376247325377, 4582.931256031162, 3602.837872295753, 3663.0476076219843, 3669.9266014679556, 3687.1519550503535, 3701.148735790783, 663.1279866974912, 670.3464122480542, 671.385682100882, 671.7078071039114, 672.1295921781305, 671.7615246587488, 700.6146619359332, 701.0395757811831, 717.9461540384492, 738.7414404958222, 9006.07346955046, 9951.651692190884, 10475.790484190273, 10527.882221053726, 10682.252242342962, 697.9476539259474, 717.5838013951895, 722.7000794670258, 724.77169691547, 736.2122528894032, 3602.747807653439, 3736.084659258499, 4188.832446702158, 4888.95111048885, 5018.774155163026, 92600.53699731592, 112132.0, 113190.0, 114412.0, 120146.39926800485, 93377.0, 96205.0, 98779.50610247046, 99205.0, 100501.49749251353, 74846.8772968406, 78791.60604196943, 79594.80607790888, 83096.58451707703, 83423.16576834154, 10646.84029739539, 10886.020258176803, 11090.44547772592, 11294.43527823622, 11490.138239631893, 48929.5107048925, 51666.22500662568, 52712.94574108573, 54868.72565637146, 55678.72160639171, 58913.70543147257, 65300.67349663221, 72478.0, 72840.27159728335, 73387.63306183649, 13976.589560855295, 14148.929255353658, 14484.927575362055, 14523.273836308354, 14750.55748327552, 14949.701005979601, 15251.923740381228, 15347.846521534642, 15719.371225150866, 15773.05361678303, 13911.860881391056, 13931.58205253844, 14032.08791428554, 14312.427502900184, 14495.855041449451, 13792.793108103186, 14147.717045659236, 14199.219042952736, 14583.635409114857, 14652.19412932299, 13677.042607017413, 14006.0, 14051.718965620836, 14522.636934076732, 14544.781828272373, 11431.256968297033, 11493.425328733698, 11540.94229528847, 11938.22401543897, 12077.39613019328, 11118.221724479208, 11164.33014019129, 11408.885911140782, 11416.31502109876, 11451.25566838153], "value": 7814.3953449086375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 117.0, 116.0, 118.0, 117.0, 143.0, 171.0, 152.0, 116.0], "value": 127.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 133.0, 100.0, 166.0, 150.0, 143.0, 98.0, 106.0, 164.0, 143.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 199.0, 215.0, 196.0, 198.0, 193.0, 192.0, 193.0, 197.0, 194.0], "value": 197.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 74.0, 110.0, 52.0, 84.0, 84.0, 89.0, 66.0, 73.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 74.0, 95.0, 59.0, 95.0, 60.0, 81.0, 56.0, 90.0, 76.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 81.0, 131.0, 78.0, 94.0, 136.0, 132.0, 78.0, 131.0], "value": 104.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 117.0, 171.0, 170.0, 136.0, 100.0, 166.0, 169.0, 117.0, 106.0], "value": 141.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 92.0, 92.0, 95.0, 93.0, 85.0, 106.0, 86.0, 143.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 58.0, 62.0, 62.0, 60.0, 63.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 90.0, 65.0, 103.0, 77.0, 76.0, 57.0, 59.0, 64.0, 66.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 117.0, 88.0, 89.0, 87.0, 84.0, 91.0, 90.0, 87.0], "value": 94.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 158.0, 147.0, 150.0, 153.0, 147.0, 165.0, 151.0, 200.0, 148.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 177.0, 182.0, 178.0, 178.0, 235.0, 215.0, 175.0, 177.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 67.0, 70.0, 67.0, 69.0, 67.0, 64.0, 68.0], "value": 67.6, "unit": "score"}]}]} 20:24:23 INFO - Return code: 0 20:24:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:24:23 ERROR - # TBPL SUCCESS # 20:24:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:24:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:24:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:24:23 INFO - 2017-01-18 20:24:23.477 screenresolution[1664:10589] starting screenresolution argv=screenresolution get 20:24:23 INFO - 2017-01-18 20:24:23.480 screenresolution[1664:10589] Display 0: 1600x1200x32@60 20:24:23 INFO - 2017-01-18 20:24:23.486 screenresolution[1665:10592] starting screenresolution argv=screenresolution list 20:24:23 INFO - Available Modes on Display 0 20:24:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:24:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:24:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:24:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:24:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:24:23 INFO - Intel Iris: 20:24:23 INFO - Chipset Model: Intel Iris 20:24:23 INFO - Type: GPU 20:24:23 INFO - Bus: Built-In 20:24:23 INFO - VRAM (Dynamic, Max): 1536 MB 20:24:23 INFO - Vendor: Intel (0x8086) 20:24:23 INFO - Device ID: 0x0a2e 20:24:23 INFO - Revision ID: 0x0009 20:24:23 INFO - Displays: 20:24:23 INFO - Display: 20:24:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:24:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:24:23 INFO - Display Serial Number: 1600x1200 60 20:24:23 INFO - Main Display: Yes 20:24:23 INFO - Mirror: Off 20:24:23 INFO - Online: Yes 20:24:23 INFO - Rotation: Supported 20:24:23 INFO - Return code: 0 20:24:23 INFO - Running post-action listener: _resource_record_post_action 20:24:23 INFO - [mozharness: 2017-01-19 04:24:23.722299Z] Finished run-tests step (success) 20:24:23 INFO - Running post-run listener: _resource_record_post_run 20:24:23 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 38631936; Write bytes: 556024832; Read time: 254; Write time: 1708 20:24:23 INFO - TinderboxPrint: CPU usage
54.6% 20:24:23 INFO - TinderboxPrint: I/O read bytes / time
38,631,936 / 254 20:24:23 INFO - TinderboxPrint: I/O write bytes / time
556,024,832 / 1,708 20:24:23 INFO - TinderboxPrint: CPU idle
2,178.4 (45.4%) 20:24:23 INFO - TinderboxPrint: CPU system
967.7 (20.2%) 20:24:23 INFO - TinderboxPrint: CPU user
1,647.6 (34.4%) 20:24:23 INFO - TinderboxPrint: Swap in / out
289,927,168 / 0 20:24:23 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249524736; Write bytes: 241782784; Read time: 18060; Write time: 514 20:24:23 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 35293696; Write bytes: 300563456; Read time: 224; Write time: 1150 20:24:24 INFO - Running post-run listener: _upload_blobber_files 20:24:24 INFO - Blob upload gear active. 20:24:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:24:24 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 20:24:24 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:24:24 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:24:24 INFO - (blobuploader) - INFO - Open directory for files ... 20:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:25 INFO - (blobuploader) - INFO - Done attempting. 20:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:24:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:24:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:26 INFO - (blobuploader) - INFO - Done attempting. 20:24:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:24:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:24:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:27 INFO - (blobuploader) - INFO - Done attempting. 20:24:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:24:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:24:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:29 INFO - (blobuploader) - INFO - Done attempting. 20:24:29 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:29 INFO - Return code: 0 20:24:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:24:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10ad7f991237cee1b374bb4f889dc01ac295458918cd55eeabbce0890017d816eaff32ea1a4c537480768ea5ba868ebd8b80acc8f90834cbc57b260aa08c3959", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7ba145e584d97469e240421cc5ff3d16d155c3ffde172f37e29aa3b7d2a75ff62c84e810ceaf6b03cc079043c2adc3037c46e745ebae82895290895b2aa0224b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e703f1b7a93fd3ee60e9db7c7a7e4e05679d7e3b2a67852ac7f92c7a0998afc3cb16ae1910d4dae535d7b207c87ccfabcc9f99eb2f3633b269f2ca44fcf28111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4bae6bb571275bf270f36aa6715f25bc63471fa4fe174eb1267b8d23da79233008f96cfbb3d611c928b58c7c711532eb3a69d186a71c2930abe786647d3cc843"} 20:24:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:24:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:24:29 INFO - Contents: 20:24:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10ad7f991237cee1b374bb4f889dc01ac295458918cd55eeabbce0890017d816eaff32ea1a4c537480768ea5ba868ebd8b80acc8f90834cbc57b260aa08c3959", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7ba145e584d97469e240421cc5ff3d16d155c3ffde172f37e29aa3b7d2a75ff62c84e810ceaf6b03cc079043c2adc3037c46e745ebae82895290895b2aa0224b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e703f1b7a93fd3ee60e9db7c7a7e4e05679d7e3b2a67852ac7f92c7a0998afc3cb16ae1910d4dae535d7b207c87ccfabcc9f99eb2f3633b269f2ca44fcf28111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4bae6bb571275bf270f36aa6715f25bc63471fa4fe174eb1267b8d23da79233008f96cfbb3d611c928b58c7c711532eb3a69d186a71c2930abe786647d3cc843"} 20:24:29 INFO - Running post-run listener: copy_logs_to_upload_dir 20:24:29 INFO - Copying logs to upload dir... 20:24:29 INFO - mkdir: /builds/slave/test/build/upload/logs 20:24:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.395159 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-18 20:24:29.993564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 20:24:29.997309) ========= 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.wizlMzdRAA/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.ZmlU07rteE/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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/Graphics/sha512/10ad7f991237cee1b374bb4f889dc01ac295458918cd55eeabbce0890017d816eaff32ea1a4c537480768ea5ba868ebd8b80acc8f90834cbc57b260aa08c3959", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7ba145e584d97469e240421cc5ff3d16d155c3ffde172f37e29aa3b7d2a75ff62c84e810ceaf6b03cc079043c2adc3037c46e745ebae82895290895b2aa0224b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e703f1b7a93fd3ee60e9db7c7a7e4e05679d7e3b2a67852ac7f92c7a0998afc3cb16ae1910d4dae535d7b207c87ccfabcc9f99eb2f3633b269f2ca44fcf28111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4bae6bb571275bf270f36aa6715f25bc63471fa4fe174eb1267b8d23da79233008f96cfbb3d611c928b58c7c711532eb3a69d186a71c2930abe786647d3cc843"} build_url:https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011050 build_url: 'https://queue.taskcluster.net/v1/task/aSXJD0OkTveRftHu0CuNsA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10ad7f991237cee1b374bb4f889dc01ac295458918cd55eeabbce0890017d816eaff32ea1a4c537480768ea5ba868ebd8b80acc8f90834cbc57b260aa08c3959", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7ba145e584d97469e240421cc5ff3d16d155c3ffde172f37e29aa3b7d2a75ff62c84e810ceaf6b03cc079043c2adc3037c46e745ebae82895290895b2aa0224b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e703f1b7a93fd3ee60e9db7c7a7e4e05679d7e3b2a67852ac7f92c7a0998afc3cb16ae1910d4dae535d7b207c87ccfabcc9f99eb2f3633b269f2ca44fcf28111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4bae6bb571275bf270f36aa6715f25bc63471fa4fe174eb1267b8d23da79233008f96cfbb3d611c928b58c7c711532eb3a69d186a71c2930abe786647d3cc843"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 20:24:30.031588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 20:24:30.031929) ========= 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.wizlMzdRAA/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.ZmlU07rteE/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.005235 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 20:24:30.080454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 20:24:30.080739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 20:24:30.081022) ========= ========= Total master_lag: 0.18 =========