builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0165 starttime: 1481117199.64 results: success (0) buildid: 20161207020338 builduid: 6e4685cf06084f25a25249df5d4a0783 revision: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:39.643231) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:39.643648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:39.643920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:39.774868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:39.775175) ========= 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.EaeAMSeuz2/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.90tB1q09TG/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-07 05:26:39-- 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% 184M=0s 2016-12-07 05:26:40 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.507780 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:40.309692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:40.309981) ========= 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.EaeAMSeuz2/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.90tB1q09TG/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.026740 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:40.359535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:40.359842) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 983a7399df86ff30a8a8b45f44ccdc6727ac4477 --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 983a7399df86ff30a8a8b45f44ccdc6727ac4477 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EaeAMSeuz2/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.90tB1q09TG/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-07 05:26:40,455 truncating revision to first 12 chars 2016-12-07 05:26:40,456 Setting DEBUG logging. 2016-12-07 05:26:40,456 attempt 1/10 2016-12-07 05:26:40,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/983a7399df86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 05:26:41,152 unpacking tar archive at: graphics-983a7399df86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949157 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:41.333072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:41.333434) ========= script_repo_revision: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:41.333840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:41.334139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 05:26:41.354194) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-07 05:26:41.354612) ========= /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.EaeAMSeuz2/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.90tB1q09TG/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:26:41 INFO - MultiFileLogger online at 20161207 05:26:41 in /builds/slave/test 05:26:41 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 05:26:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:41 INFO - {'append_to_log': False, 05:26:41 INFO - 'base_work_dir': '/builds/slave/test', 05:26:41 INFO - 'blob_upload_branch': 'Graphics', 05:26:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:41 INFO - 'branch': 'Graphics', 05:26:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:41 INFO - 'config_files': ('talos/mac_config.py',), 05:26:41 INFO - 'default_actions': ('clobber', 05:26:41 INFO - 'read-buildbot-config', 05:26:41 INFO - 'download-and-extract', 05:26:41 INFO - 'populate-webroot', 05:26:41 INFO - 'create-virtualenv', 05:26:41 INFO - 'install', 05:26:41 INFO - 'run-tests'), 05:26:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:41 INFO - 'download_minidump_stackwalk': True, 05:26:41 INFO - 'download_symbols': 'ondemand', 05:26:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:41 INFO - 'installer_path': 'installer.exe', 05:26:41 INFO - 'log_level': 'info', 05:26:41 INFO - 'log_name': 'talos', 05:26:41 INFO - 'log_to_console': True, 05:26:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:26:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:26:41 INFO - 'opt_config_files': (), 05:26:41 INFO - 'pip_index': False, 05:26:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:41 INFO - 'cmd': ('bash', 05:26:41 INFO - '-c', 05:26:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:41 INFO - 'enabled': True, 05:26:41 INFO - 'halt_on_failure': False, 05:26:41 INFO - 'name': 'check_screen_resolution'},), 05:26:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:41 INFO - 'cmd': ('bash', 05:26:41 INFO - '-c', 05:26:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:41 INFO - 'enabled': True, 05:26:41 INFO - 'halt_on_failure': False, 05:26:41 INFO - 'name': 'check_screen_resolution'},), 05:26:41 INFO - 'run_cmd_checks_enabled': True, 05:26:41 INFO - 'sps_profile': False, 05:26:41 INFO - 'sps_profile_interval': 0, 05:26:41 INFO - 'suite': 'dromaeojs-e10s', 05:26:41 INFO - 'system_bits': '32', 05:26:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:41 INFO - 'title': 't-yosemite-r7-0165', 05:26:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:41 INFO - 'use_talos_json': True, 05:26:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:41 INFO - 'work_dir': 'build'} 05:26:41 INFO - [mozharness: 2016-12-07 13:26:41.564762Z] Running clobber step. 05:26:41 INFO - Running pre-action listener: _resource_record_pre_action 05:26:41 INFO - Running main action method: clobber 05:26:41 INFO - rmtree: /builds/slave/test/build 05:26:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:44 INFO - Running post-action listener: _resource_record_post_action 05:26:44 INFO - [mozharness: 2016-12-07 13:26:44.010063Z] Finished clobber step (success) 05:26:44 INFO - [mozharness: 2016-12-07 13:26:44.010192Z] Running read-buildbot-config step. 05:26:44 INFO - Running pre-action listener: _resource_record_pre_action 05:26:44 INFO - Running main action method: read_buildbot_config 05:26:44 INFO - Using buildbot properties: 05:26:44 INFO - { 05:26:44 INFO - "project": "", 05:26:44 INFO - "product": "firefox", 05:26:44 INFO - "script_repo_revision": "default", 05:26:44 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 05:26:44 INFO - "repository": "", 05:26:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 05:26:44 INFO - "buildid": "20161207020338", 05:26:44 INFO - "pgo_build": "False", 05:26:44 INFO - "basedir": "/builds/slave/test", 05:26:44 INFO - "buildnumber": 5, 05:26:44 INFO - "slavename": "t-yosemite-r7-0165", 05:26:44 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:26:44 INFO - "platform": "yosemite_r7", 05:26:44 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 05:26:44 INFO - "branch": "graphics", 05:26:44 INFO - "repo_path": "projects/graphics", 05:26:44 INFO - "revision": "983a7399df86ff30a8a8b45f44ccdc6727ac4477", 05:26:44 INFO - "stage_platform": "macosx64", 05:26:44 INFO - "builduid": "6e4685cf06084f25a25249df5d4a0783", 05:26:44 INFO - "slavebuilddir": "test" 05:26:44 INFO - } 05:26:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:26:44 INFO - Running post-action listener: _resource_record_post_action 05:26:44 INFO - [mozharness: 2016-12-07 13:26:44.013691Z] Finished read-buildbot-config step (success) 05:26:44 INFO - [mozharness: 2016-12-07 13:26:44.013832Z] Running download-and-extract step. 05:26:44 INFO - Running pre-action listener: _resource_record_pre_action 05:26:44 INFO - Running main action method: download_and_extract 05:26:44 INFO - mkdir: /builds/slave/test/build/tests 05:26:44 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')]} 05:26:44 INFO - trying https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:26:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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 05:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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 05:26:44 INFO - Downloaded 1199 bytes. 05:26:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:26:44 INFO - Using the following test package requirements: 05:26:44 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:26:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:26:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:26:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'jsshell-mac.zip'], 05:26:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:26:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:26:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:26:44 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:26:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:26:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:26:44 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:26:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:26:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:26:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:26:45 INFO - Expected file size: 16284331 05:26:45 INFO - Obtained file size: 16284331 05:26:52 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 05:26:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:26:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:26:53 INFO - Expected file size: 16284331 05:26:53 INFO - Obtained file size: 16284331 05:26:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:26:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:26:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:27:00 INFO - Expected file size: 14409734 05:27:00 INFO - Obtained file size: 14409734 05:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:00 INFO - trying https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:27:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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 05:27:03 INFO - Downloaded 107692468 bytes. 05:27:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:27:03 INFO - mkdir: /builds/slave/test/properties 05:27:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:03 INFO - Contents: 05:27:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:27:04 INFO - Running post-action listener: _resource_record_post_action 05:27:04 INFO - Running post-action listener: set_extra_try_arguments 05:27:04 INFO - [mozharness: 2016-12-07 13:27:04.520252Z] Finished download-and-extract step (success) 05:27:04 INFO - [mozharness: 2016-12-07 13:27:04.520372Z] Running populate-webroot step. 05:27:04 INFO - Running pre-action listener: _resource_record_pre_action 05:27:04 INFO - Running main action method: populate_webroot 05:27:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:04 INFO - '--tppagecycles', 05:27:04 INFO - '7'], 05:27:04 INFO - 'tests': ['tsvgm']}}, 05:27:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:27:04 INFO - 'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:27:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:27:04 INFO - 'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['damp', 'tps']}, 05:27:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:27:04 INFO - 'tests': ['damp', 'tps']}, 05:27:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['dromaeo_dom']}, 05:27:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['basic_compositor_video']}, 05:27:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:27:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['a11yr', 05:27:04 INFO - 'ts_paint', 05:27:04 INFO - 'tpaint', 05:27:04 INFO - 'sessionrestore', 05:27:04 INFO - 'sessionrestore_no_auto_restore', 05:27:04 INFO - 'tabpaint']}, 05:27:04 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:04 INFO - 'ts_paint', 05:27:04 INFO - 'tpaint', 05:27:04 INFO - 'sessionrestore', 05:27:04 INFO - 'sessionrestore_no_auto_restore', 05:27:04 INFO - 'tabpaint']}, 05:27:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:04 INFO - 'ts_paint', 05:27:04 INFO - 'tpaint', 05:27:04 INFO - 'sessionrestore', 05:27:04 INFO - 'sessionrestore_no_auto_restore', 05:27:04 INFO - 'tabpaint']}, 05:27:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:04 INFO - 'ts_paint', 05:27:04 INFO - 'tpaint', 05:27:04 INFO - 'sessionrestore', 05:27:04 INFO - 'sessionrestore_no_auto_restore', 05:27:04 INFO - 'tabpaint']}, 05:27:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['a11yr', 05:27:04 INFO - 'ts_paint', 05:27:04 INFO - 'tpaint', 05:27:04 INFO - 'sessionrestore', 05:27:04 INFO - 'sessionrestore_no_auto_restore', 05:27:04 INFO - 'tabpaint']}, 05:27:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['a11yr', 05:27:04 INFO - 'ts_paint', 05:27:04 INFO - 'tpaint', 05:27:04 INFO - 'sessionrestore', 05:27:04 INFO - 'sessionrestore_no_auto_restore', 05:27:04 INFO - 'tabpaint']}, 05:27:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['tsvgx', 05:27:04 INFO - 'tsvgr_opacity', 05:27:04 INFO - 'tart', 05:27:04 INFO - 'tscrollx', 05:27:04 INFO - 'cart', 05:27:04 INFO - 'tsvg_static']}, 05:27:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:04 INFO - 'tsvgr_opacity', 05:27:04 INFO - 'tart', 05:27:04 INFO - 'tscrollx', 05:27:04 INFO - 'cart', 05:27:04 INFO - 'tsvg_static']}, 05:27:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:27:04 INFO - 'talos_options': ['--disable-e10s'], 05:27:04 INFO - 'tests': ['tp5o']}, 05:27:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:27:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:27:04 INFO - 'talos_options': ['--disable-e10s', 05:27:04 INFO - '--xperf_path', 05:27:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:04 INFO - 'tests': ['tp5n']}, 05:27:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:27:04 INFO - 'talos_options': ['--xperf_path', 05:27:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:04 INFO - 'tests': ['tp5n']}}, 05:27:04 INFO - 'talos.zip': {'path': '', 05:27:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:04 INFO - Running post-action listener: _resource_record_post_action 05:27:04 INFO - [mozharness: 2016-12-07 13:27:04.538739Z] Finished populate-webroot step (success) 05:27:04 INFO - [mozharness: 2016-12-07 13:27:04.538869Z] Running create-virtualenv step. 05:27:04 INFO - Running pre-action listener: _resource_record_pre_action 05:27:04 INFO - Running main action method: create_virtualenv 05:27:04 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:04 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 05:27:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:04 INFO - Using real prefix '/tools/python27' 05:27:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:08 INFO - Installing pip.................done. 05:27:08 INFO - Return code: 0 05:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:27:08 INFO - Reading from file tmpfile_stdout 05:27:08 INFO - Output received: 05:27:08 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) 05:27:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27: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', 'pip>=1.5'] in /builds/slave/test/build 05:27: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 pip>=1.5 05:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:08 INFO - 'HOME': '/Users/cltbld', 05:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:08 INFO - 'LOGNAME': 'cltbld', 05:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:08 INFO - 'MOZ_NO_REMOTE': '1', 05:27:08 INFO - 'NO_EM_RESTART': '1', 05:27:08 INFO - 'PAGER': '/bin/cat', 05:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:08 INFO - 'PWD': '/builds/slave/test', 05:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:08 INFO - 'SHELL': '/bin/bash', 05:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:08 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:08 INFO - 'USER': 'cltbld', 05:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:08 INFO - 'XPC_FLAGS': '0x0', 05:27:08 INFO - 'XPC_SERVICE_NAME': '0', 05:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:08 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 05:27:08 INFO - Cleaning up... 05:27:08 INFO - Return code: 0 05:27:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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', '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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:27: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 psutil>=3.1.1 05:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:08 INFO - 'HOME': '/Users/cltbld', 05:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:08 INFO - 'LOGNAME': 'cltbld', 05:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:08 INFO - 'MOZ_NO_REMOTE': '1', 05:27:08 INFO - 'NO_EM_RESTART': '1', 05:27:08 INFO - 'PAGER': '/bin/cat', 05:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:08 INFO - 'PWD': '/builds/slave/test', 05:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:08 INFO - 'SHELL': '/bin/bash', 05:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:08 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:08 INFO - 'USER': 'cltbld', 05:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:08 INFO - 'XPC_FLAGS': '0x0', 05:27:08 INFO - 'XPC_SERVICE_NAME': '0', 05:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:09 INFO - Downloading/unpacking psutil>=3.1.1 05:27:09 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 05:27:09 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 05:27:09 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 05:27:09 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 05:27:09 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 05:27:09 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 05:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:13 INFO - Installing collected packages: psutil 05:27:13 INFO - Running setup.py install for psutil 05:27:13 INFO - building 'psutil._psutil_osx' extension 05:27:13 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 05:27:13 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 05:27:13 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 05:27:13 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 05:27:13 INFO - building 'psutil._psutil_posix' extension 05:27:13 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 05:27:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:27:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:27:14 INFO - ^ 05:27:14 INFO - 1 warning generated. 05:27:14 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 05:27:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:14 INFO - Successfully installed psutil 05:27:14 INFO - Cleaning up... 05:27:14 INFO - Return code: 0 05:27:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:14 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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:14 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 05:27:14 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 05:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:14 INFO - 'HOME': '/Users/cltbld', 05:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:14 INFO - 'LOGNAME': 'cltbld', 05:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:14 INFO - 'MOZ_NO_REMOTE': '1', 05:27:14 INFO - 'NO_EM_RESTART': '1', 05:27:14 INFO - 'PAGER': '/bin/cat', 05:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:14 INFO - 'PWD': '/builds/slave/test', 05:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:14 INFO - 'SHELL': '/bin/bash', 05:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:14 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:14 INFO - 'USER': 'cltbld', 05:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:14 INFO - 'XPC_FLAGS': '0x0', 05:27:14 INFO - 'XPC_SERVICE_NAME': '0', 05:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:27:14 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 05:27:14 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 05:27:14 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 05:27:14 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 05:27:14 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 05:27:14 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 05:27:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:27:17 INFO - Installing collected packages: mozsystemmonitor 05:27:17 INFO - Running setup.py install for mozsystemmonitor 05:27:17 INFO - Successfully installed mozsystemmonitor 05:27:17 INFO - Cleaning up... 05:27:17 INFO - Return code: 0 05:27:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:17 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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:17 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 05:27:17 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 05:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:17 INFO - 'HOME': '/Users/cltbld', 05:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:17 INFO - 'LOGNAME': 'cltbld', 05:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:17 INFO - 'MOZ_NO_REMOTE': '1', 05:27:17 INFO - 'NO_EM_RESTART': '1', 05:27:17 INFO - 'PAGER': '/bin/cat', 05:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:17 INFO - 'PWD': '/builds/slave/test', 05:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:17 INFO - 'SHELL': '/bin/bash', 05:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:17 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:17 INFO - 'USER': 'cltbld', 05:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:17 INFO - 'XPC_FLAGS': '0x0', 05:27:17 INFO - 'XPC_SERVICE_NAME': '0', 05:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:27:17 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 05:27:17 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 05:27:17 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 05:27:17 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 05:27:17 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 05:27:17 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 05:27:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27:20 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 05:27:20 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 05:27:20 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 05:27:20 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 05:27:20 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 05:27:20 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 05:27:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:20 INFO - warning: no files found matching '*.txt' 05:27:20 INFO - no previously-included directories found matching 'build' 05:27:20 INFO - no previously-included directories found matching 'dist' 05:27:20 INFO - no previously-included directories found matching '.git*' 05:27:20 INFO - Installing collected packages: jsonschema, functools32 05:27:20 INFO - Running setup.py install for functools32 05:27:20 INFO - warning: no files found matching '*.txt' 05:27:20 INFO - no previously-included directories found matching 'build' 05:27:20 INFO - no previously-included directories found matching 'dist' 05:27:20 INFO - no previously-included directories found matching '.git*' 05:27:21 INFO - Successfully installed jsonschema functools32 05:27:21 INFO - Cleaning up... 05:27:21 INFO - Return code: 0 05:27:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:21 INFO - 'HOME': '/Users/cltbld', 05:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:21 INFO - 'LOGNAME': 'cltbld', 05:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:21 INFO - 'MOZ_NO_REMOTE': '1', 05:27:21 INFO - 'NO_EM_RESTART': '1', 05:27:21 INFO - 'PAGER': '/bin/cat', 05:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:21 INFO - 'PWD': '/builds/slave/test', 05:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:21 INFO - 'SHELL': '/bin/bash', 05:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:21 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:21 INFO - 'USER': 'cltbld', 05:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:21 INFO - 'XPC_FLAGS': '0x0', 05:27:21 INFO - 'XPC_SERVICE_NAME': '0', 05:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:27:21 INFO - Cleaning up... 05:27:21 INFO - Return code: 0 05:27:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:21 INFO - 'HOME': '/Users/cltbld', 05:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:21 INFO - 'LOGNAME': 'cltbld', 05:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:21 INFO - 'MOZ_NO_REMOTE': '1', 05:27:21 INFO - 'NO_EM_RESTART': '1', 05:27:21 INFO - 'PAGER': '/bin/cat', 05:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:21 INFO - 'PWD': '/builds/slave/test', 05:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:21 INFO - 'SHELL': '/bin/bash', 05:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:21 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:21 INFO - 'USER': 'cltbld', 05:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:21 INFO - 'XPC_FLAGS': '0x0', 05:27:21 INFO - 'XPC_SERVICE_NAME': '0', 05:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:25 INFO - Downloading docopt-0.6.1.tar.gz 05:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:25 INFO - Running setup.py install for blobuploader 05:27:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:25 INFO - Running setup.py install for requests 05:27:26 INFO - Running setup.py install for docopt 05:27:26 INFO - Successfully installed blobuploader requests docopt 05:27:26 INFO - Cleaning up... 05:27:26 INFO - Return code: 0 05:27:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:26 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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:26 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 05:27:26 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 05:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:26 INFO - 'HOME': '/Users/cltbld', 05:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:26 INFO - 'LOGNAME': 'cltbld', 05:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:26 INFO - 'MOZ_NO_REMOTE': '1', 05:27:26 INFO - 'NO_EM_RESTART': '1', 05:27:26 INFO - 'PAGER': '/bin/cat', 05:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:26 INFO - 'PWD': '/builds/slave/test', 05:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:26 INFO - 'SHELL': '/bin/bash', 05:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:26 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:26 INFO - 'USER': 'cltbld', 05:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:26 INFO - 'XPC_FLAGS': '0x0', 05:27:26 INFO - 'XPC_SERVICE_NAME': '0', 05:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:26 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-olRTZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:26 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-FYWvKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:26 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-MwK6mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:26 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-bLEvsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-mR_Eas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-STxpCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-W0Q2iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-sXxUgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-USvUTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-mHdTCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-vyahUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-hQlMPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-vlEotM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:27 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ur9wYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:28 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-VBKmZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:28 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ScDFQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:28 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-pbk98u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:28 INFO - Running setup.py install for manifestparser 05:27:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:28 INFO - Running setup.py install for mozcrash 05:27:28 INFO - Running setup.py install for mozdebug 05:27:28 INFO - Running setup.py install for mozdevice 05:27:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Running setup.py install for mozfile 05:27:29 INFO - Running setup.py install for mozhttpd 05:27:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Running setup.py install for mozinfo 05:27:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Running setup.py install for mozInstall 05:27:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Running setup.py install for mozleak 05:27:29 INFO - Running setup.py install for mozlog 05:27:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:29 INFO - Running setup.py install for moznetwork 05:27:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:30 INFO - Running setup.py install for mozprocess 05:27:30 INFO - Running setup.py install for mozprofile 05:27:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:30 INFO - Running setup.py install for mozrunner 05:27:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:30 INFO - Running setup.py install for mozscreenshot 05:27:30 INFO - Running setup.py install for moztest 05:27:30 INFO - Running setup.py install for mozversion 05:27:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:30 INFO - Cleaning up... 05:27:30 INFO - Return code: 0 05:27:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:30 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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:30 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 05:27:30 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 05:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:30 INFO - 'HOME': '/Users/cltbld', 05:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:30 INFO - 'LOGNAME': 'cltbld', 05:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:30 INFO - 'MOZ_NO_REMOTE': '1', 05:27:30 INFO - 'NO_EM_RESTART': '1', 05:27:30 INFO - 'PAGER': '/bin/cat', 05:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:30 INFO - 'PWD': '/builds/slave/test', 05:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:31 INFO - 'SHELL': '/bin/bash', 05:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:31 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:31 INFO - 'USER': 'cltbld', 05:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:31 INFO - 'XPC_FLAGS': '0x0', 05:27:31 INFO - 'XPC_SERVICE_NAME': '0', 05:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:31 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-4ZNKJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:31 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)) 05:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:31 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-7sKm90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:31 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)) 05:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:31 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-KCXNCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:31 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)) 05:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:31 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-2ikeCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:31 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)) 05:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:31 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-tBVUhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:31 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)) 05:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:31 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-5ysfM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:31 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)) 05:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:31 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rX7SD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-AkBcXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-wudG5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-f3vSFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-bq6kkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-8c9UbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-3Wyvq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ObEv0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-EHSavR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:32 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)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-oLxmTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:32 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-gLRS78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:33 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)) 05:27:33 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)) 05:27:33 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)) 05:27:33 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)) 05:27:33 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)) 05:27:33 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)) 05:27:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:33 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 05:27:33 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 05:27:33 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 05:27:33 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 05:27:33 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 05:27:33 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 05:27:35 INFO - Downloading blessings-1.6.tar.gz 05:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:35 INFO - Installing collected packages: blessings 05:27:35 INFO - Running setup.py install for blessings 05:27:35 INFO - Successfully installed blessings 05:27:35 INFO - Cleaning up... 05:27:36 INFO - Return code: 0 05:27:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:36 INFO - Reading from file tmpfile_stdout 05:27:36 INFO - Current package versions: 05:27:36 INFO - blessings == 1.6 05:27:36 INFO - blobuploader == 1.2.4 05:27:36 INFO - docopt == 0.6.1 05:27:36 INFO - functools32 == 3.2.3-2 05:27:36 INFO - jsonschema == 2.5.1 05:27:36 INFO - manifestparser == 1.1 05:27:36 INFO - mozInstall == 1.12 05:27:36 INFO - mozcrash == 1.0 05:27:36 INFO - mozdebug == 0.1 05:27:36 INFO - mozdevice == 0.49 05:27:36 INFO - mozfile == 1.2 05:27:36 INFO - mozhttpd == 0.7 05:27:36 INFO - mozinfo == 0.9 05:27:36 INFO - mozleak == 0.1 05:27:36 INFO - mozlog == 3.4 05:27:36 INFO - moznetwork == 0.27 05:27:36 INFO - mozprocess == 0.23 05:27:36 INFO - mozprofile == 0.28 05:27:36 INFO - mozrunner == 6.13 05:27:36 INFO - mozscreenshot == 0.1 05:27:36 INFO - mozsystemmonitor == 0.3 05:27:36 INFO - moztest == 0.7 05:27:36 INFO - mozversion == 1.4 05:27:36 INFO - psutil == 3.1.1 05:27:36 INFO - requests == 1.2.3 05:27:36 INFO - wsgiref == 0.1.2 05:27:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:36 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')]} 05:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:36 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')]} 05:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:36 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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:36 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 05:27:36 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 05:27:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:36 INFO - 'HOME': '/Users/cltbld', 05:27:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:36 INFO - 'LOGNAME': 'cltbld', 05:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:36 INFO - 'MOZ_NO_REMOTE': '1', 05:27:36 INFO - 'NO_EM_RESTART': '1', 05:27:36 INFO - 'PAGER': '/bin/cat', 05:27:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:36 INFO - 'PWD': '/builds/slave/test', 05:27:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:36 INFO - 'SHELL': '/bin/bash', 05:27:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:36 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:36 INFO - 'USER': 'cltbld', 05:27:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:36 INFO - 'XPC_FLAGS': '0x0', 05:27:36 INFO - 'XPC_SERVICE_NAME': '0', 05:27:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 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)) 05:27:36 INFO - Cleaning up... 05:27:36 INFO - Return code: 0 05:27:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:36 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')]} 05:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:36 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')]} 05:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:36 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 0x10c8d23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c848570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ec2d5b4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, '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.EaeAMSeuz2/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.90tB1q09TG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 05:27:36 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 05:27:36 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 05:27:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:27:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:36 INFO - 'HOME': '/Users/cltbld', 05:27:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:36 INFO - 'LOGNAME': 'cltbld', 05:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:36 INFO - 'MOZ_NO_REMOTE': '1', 05:27:36 INFO - 'NO_EM_RESTART': '1', 05:27:36 INFO - 'PAGER': '/bin/cat', 05:27:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:36 INFO - 'PWD': '/builds/slave/test', 05:27:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:36 INFO - 'SHELL': '/bin/bash', 05:27:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:27:36 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:27:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:36 INFO - 'USER': 'cltbld', 05:27:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:36 INFO - 'XPC_FLAGS': '0x0', 05:27:36 INFO - 'XPC_SERVICE_NAME': '0', 05:27:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:36 INFO - Cleaning up... 05:27:36 INFO - Return code: 0 05:27:36 INFO - Running post-action listener: _resource_record_post_action 05:27:36 INFO - Running post-action listener: _start_resource_monitoring 05:27:36 INFO - Starting resource monitoring. 05:27:36 INFO - [mozharness: 2016-12-07 13:27:36.854336Z] Finished create-virtualenv step (success) 05:27:36 INFO - [mozharness: 2016-12-07 13:27:36.855301Z] Running install step. 05:27:36 INFO - Running pre-action listener: _resource_record_pre_action 05:27:36 INFO - Running main action method: install 05:27:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:37 INFO - Reading from file tmpfile_stdout 05:27:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:37 INFO - Reading from file tmpfile_stdout 05:27:37 INFO - Output received: 05:27:37 INFO - Usage: mozinstall [options] installer 05:27:37 INFO - Options: 05:27:37 INFO - -h, --help show this help message and exit 05:27:37 INFO - -d DEST, --destination=DEST 05:27:37 INFO - Directory to install application into. [default: 05:27:37 INFO - "/builds/slave/test"] 05:27:37 INFO - --app=APP Application being installed. [default: firefox] 05:27:37 INFO - mkdir: /builds/slave/test/build/application 05:27:37 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'] 05:27:37 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 05:28:09 INFO - Reading from file tmpfile_stdout 05:28:09 INFO - Output received: 05:28:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:28:09 INFO - Running post-action listener: _resource_record_post_action 05:28:09 INFO - [mozharness: 2016-12-07 13:28:09.871620Z] Finished install step (success) 05:28:09 INFO - [mozharness: 2016-12-07 13:28:09.871740Z] Running run-tests step. 05:28:09 INFO - Running pre-action listener: _resource_record_pre_action 05:28:09 INFO - Running main action method: run_tests 05:28:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:09 INFO - 2016-12-07 05:28:09.884 screenresolution[1625:9186] starting screenresolution argv=screenresolution get 05:28:09 INFO - 2016-12-07 05:28:09.887 screenresolution[1625:9186] Display 0: 1600x1200x32@60 05:28:09 INFO - 2016-12-07 05:28:09.892 screenresolution[1626:9188] starting screenresolution argv=screenresolution list 05:28:09 INFO - Available Modes on Display 0 05:28:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:10 INFO - Intel Iris: 05:28:10 INFO - Chipset Model: Intel Iris 05:28:10 INFO - Type: GPU 05:28:10 INFO - Bus: Built-In 05:28:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:10 INFO - Vendor: Intel (0x8086) 05:28:10 INFO - Device ID: 0x0a2e 05:28:10 INFO - Revision ID: 0x0009 05:28:10 INFO - Displays: 05:28:10 INFO - Display: 05:28:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:10 INFO - Display Serial Number: 1600x1200 60 05:28:10 INFO - Main Display: Yes 05:28:10 INFO - Mirror: Off 05:28:10 INFO - Online: Yes 05:28:10 INFO - Rotation: Supported 05:28:10 INFO - Return code: 0 05:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:10 INFO - Python 2.7.3 05:28:10 INFO - Return code: 0 05:28:10 INFO - grabbing minidump binary from tooltool 05:28:10 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')]} 05:28:10 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 0x10c6e7d30>, '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 0x10c54edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6dfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:10 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 05:28:10 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 05:28:10 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 05:28:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:10 INFO - Return code: 0 05:28:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:28:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:28:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:10 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/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--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 05:28:10 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/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0165 --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 05:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EaeAMSeuz2/Render', 05:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:10 INFO - 'HOME': '/Users/cltbld', 05:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:10 INFO - 'LOGNAME': 'cltbld', 05:28:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:10 INFO - 'MOZ_NO_REMOTE': '1', 05:28:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:10 INFO - 'NO_EM_RESTART': '1', 05:28:10 INFO - 'PAGER': '/bin/cat', 05:28:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:10 INFO - 'PWD': '/builds/slave/test', 05:28:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:10 INFO - 'SHELL': '/bin/bash', 05:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.90tB1q09TG/Listeners', 05:28:10 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 05:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:10 INFO - 'USER': 'cltbld', 05:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:10 INFO - 'XPC_FLAGS': '0x0', 05:28:10 INFO - 'XPC_SERVICE_NAME': '0', 05:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:10 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/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--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 05:28:10 INFO - mozversion application_buildid: 20161207020338 05:28:10 INFO - mozversion application_changeset: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 05:28:10 INFO - mozversion application_display_name: Nightly 05:28:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:10 INFO - mozversion application_name: Firefox 05:28:10 INFO - mozversion application_remotingname: firefox 05:28:10 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 05:28:10 INFO - mozversion application_vendor: Mozilla 05:28:10 INFO - mozversion application_version: 53.0a1 05:28:10 INFO - mozversion platform_buildid: 20161207020338 05:28:10 INFO - mozversion platform_changeset: 983a7399df86ff30a8a8b45f44ccdc6727ac4477 05:28:10 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 05:28:10 INFO - mozversion platform_version: 53.0a1 05:28:10 INFO - using testdate: 1481117290 05:28:10 INFO - actual date: 1481117290 05:28:10 INFO - starting webserver on 'localhost:49235' 05:28:10 INFO - SUITE-START | Running 2 tests 05:28:10 INFO - TEST-START | dromaeo_css 05:28:10 INFO - operating with platform_type : mac_ 05:28:10 INFO - Initialising browser for dromaeo_css test... 05:28:10 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmp1z35OC/profile http://localhost:49235/getInfo.html) 05:28:13 INFO - PROCESS | 1636 | 2016-12-07 05:28:13.900 plugin-container[1638:9365] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 05:28:13 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:13 INFO - PROCESS | 1636 | 2016-12-07 05:28:13.903 plugin-container[1638:9365] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c4b, name = 'com.apple.CFPasteboardClient' 05:28:13 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:13 INFO - PROCESS | 1636 | 2016-12-07 05:28:13.903 plugin-container[1638:9365] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:28:13 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 05:28:13 INFO - PROCESS | 1636 | colorDepth:24 05:28:13 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 05:28:13 INFO - PROCESS | 1636 | __metrics 05:28:14 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 05:28:14 INFO - TEST-INFO | 1636: exit 0 05:28:14 INFO - Browser initialized. 05:28:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:14 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmp1z35OC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:17 INFO - PROCESS | 1640 | 2016-12-07 05:28:17.481 plugin-container[1641:9492] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 05:28:17 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:17 INFO - PROCESS | 1640 | 2016-12-07 05:28:17.481 plugin-container[1641:9492] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 05:28:17 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:17 INFO - PROCESS | 1640 | 2016-12-07 05:28:17.482 plugin-container[1641:9492] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:28:27 INFO - PROCESS | 1640 | RSS: Main: 242126848 05:28:27 INFO - PROCESS | 1640 | 05:29:16 INFO - PROCESS | 1640 | 1481117356835 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:31:30 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 05:31:31 INFO - PROCESS | 1640 | RSS: Main: 248569856 05:31:31 INFO - PROCESS | 1640 | 05:34:34 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 05:34:34 INFO - PROCESS | 1640 | RSS: Main: 262754304 05:34:34 INFO - PROCESS | 1640 | 05:37:36 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 05:37:37 INFO - PROCESS | 1640 | RSS: Main: 267976704 05:37:37 INFO - PROCESS | 1640 | 05:40:39 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 05:40:39 INFO - PROCESS | 1640 | RSS: Main: 266592256 05:40:39 INFO - PROCESS | 1640 | 05:43:42 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 05:43:43 INFO - PROCESS | 1640 | RSS: Main: 274432000 05:43:43 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 05:46:46 INFO - PROCESS | 1640 | RSS: Main: 276643840 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | __start_tp_report 05:46:46 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 05:46:46 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 05:46:46 INFO - PROCESS | 1640 | |i|pagename|runs| 05:46:46 INFO - PROCESS | 1640 | |0;dojo.html;3352.9329413411733;3380.121168496193;3398.49022646603;3414.675605817448;3431.19366948767;5588.469095435938;5655.745491452884;5701.771929122835;5714.742836572354;5767.682777447239;5630.1554766785;5667.121596152592;5707;5739.512141467981;5786.68173250471;5114.693118412898;5133.383993920735;5142.177251639739;5171.327727395434;5253.44838791927;5137.12668846297;5211.739413029352;5283.313169288006;5295.947040529603;5317.707526086064;5120.539151476385;5190.480951904817;5213.478652134775;5246.554042906358;5252.080885845;5072.2391641253735;5143.3313669223135;5150.407703114115;5199.4800519948085;5248.21276808478;4362.585554372329;5032.823851165192;5156.252343410222;5179.300794392784;5254.054270231357;4658.930116048262;5385.569154467633;5714.571407144481;5719.084946408555;5723.370429252779;6136.509079273647;6138.664296166084;6140.381550880938;6193.628382297032;6249.343818899041;6123.510119190499;6139.032198454742;6146.89355915935;6149.046897730859;6157.353477884847;5743;5743.3395159557185;5746.454086861783;5757.539396848242;5762.510186634099;6142.099766648122;6173.166622505904;6224.844378890473;6239.126522286883;6240.438360547481;6049.213602231682;6073.392660733891;6105.053716673922;6105.065535583899;6172.98145805937;6258.15514905491;6279.434850863444;6298.464630506367;6312;6313.652749098752;6035.909461358083;6094.542909281821;6104.216637118914;6104.542159338067;6228.6574238416415;6052.364501727256;6270.153529273581;6274.309825919146;6285.182926219653;6306.936930630635;4726.007538416971;4849.854504364875;4859.173940430064;4878.975605121952;4898.755062246873;3389.8305084745666;3479.9826000869834;3593.802340871277;3613.2773445311045;3943.8759953413714;5046.142155833517;5600.831975040755;5938.940610593925;5989.490893274034;5996.430339117776;6244.594101383486;6273.654948977759;6285.371462853678;6302.338254483305;6303.968480157661;5697.344805347355;5765.250517432707;5887.0580707086665;5917.822465326047;5922.082077278029;4209.137126888981;4413.44831896013;4727.598154156935;5363.785448582013;5381.515663590296;5240;6263.843403914848;6274.372562743689;6300.180976473121;6304.432601065926;5224.869378265574;6270.592411493239;6282.534374765979;6296.5277604178955;6313.43179113882;6198.845028874314;6244.5316601256;6281.654509001866;6310.84222894413;6386.074019267087;6124.2588809726185;6147.784827531015;6151.354107818794;6257.311695713377;6271.43557079865;6235.127082208403;6277.246730392382;6302.086197501245;6305.432511074026;6311.621302721851;5951.285845698544;6084.695765211633;6153;6165.982612868826;6173.660448675366;5881.088431293157;6022.367651396716;6084.574079814548;6088.786892458743;6113.14415981754;5799.710014499174;5840.328362238397;5902.675352855634;5979.551533634908;6004.519638429003;6128.908066378919;6146.5390095742105;6167.5682702210415;6174.783882564088;6177.073438984008;5986.161937328865;5999.1901093351835;6008.339082700812;6009.248843894513;6019.976603977422 05:46:46 INFO - PROCESS | 1640 | |1;ext.html;476.9833055843046;524.1639584862144;527.7440441385929;528.8545649946266;561.7387914619701;38923.02692432687;40635.9841003975;40764.796176019154;40858.97852553688;42875.14249715004;41483.79258103713;42284.78857605715;42292.788536057276;42440.36339454903;42447.3632895506;8518.787030324229;9134.543272836348;9414.952925235399;9446.197073248783;9453.480058596775;8518.27594654455;11159.218854680175;11408.144389170804;11423.314601123959;11594.826077608843;11430.085593152528;11486;11486.483108260149;11490.885091149106;11507.3095614263;11286.548538058469;11314.151438642053;11316.547338106466;11348.602798902082;11382.146339024564;11181.105511559055;11230.719232019183;11253.212275140744;11264.94367528157;11266.267692599955;39337.60662393396;39448.802755986326;39596.802015990026;39605.80197099025;39690.20619587592;3303.6861498157637;3517.66582174693;3538.575370955502;3778.622137786227;3995.3407687731487;30250.243743906358;30894.691053089406;30897.845510772302;30898.382032359452;30961;3121.438141134595;3299.373119107362;3332.450145725952;3333.799972001688;3339.716124129452;478056;482218;483223.58388208185;485036;485438;59636.701816491506;59879.80240395255;59905.400945990856;59981.70009149926;60098.699506503064;55149.72425137849;62643;62977.37022629715;63042.68478657669;65395;15593.142377169137;15605.843941560666;15607.361227071222;15679.843201567839;15793.842061579237;9207.40151890125;10577.84133238002;10799.56801727922;11112.833307500394;12007.219530730474;18445.678779890844;18758.1558829853;19352.32266870653;19494.52736318408;19649.508762281057;7935.682572697027;8091;8105.474118758241;8113.8377232456205;8216.46592971455;828.3787159630277;929.6467342409841;932.2169377722745;1007.8337074382791;1020.7907378987289;28844.711552884623;29140.417191656474;29475.705242947726;30121;30146.095617131523;984.478226539935;994.7413672445216;1005.5324274212526;1025.2566889005411;1096.0354887698775;15032.549023529311;15529.922350388175;15530.990485618398;15738.763918541232;15836.941197644233;545799.2710036425;605820.9417905853;609107;609825;621312;57472.137917931264;57694.42305576891;58384.4161558379;58405.70797145987;58498.41501585015;1302.2707283921034;1319.2150670351125;1324.6886981559326;1331.6138319887318;1333.979990300127;29354.55968160522;29468.852655736584;29564.260893477836;30140.69859301379;30266.24334391658;50610.49389506058;53212.46787532075;54653.45346546484;54837.725811370685;57720.422795771505;563290;566231.1688441532;568573;568851.1557442186;569806.1509692424;35470;37246.813765930994;42021.78989105035;42075.89620519023;42329.1534169321;44198.77900610476;45362.77318613518;46223;46519.30221046755;46736.53263467322;36671;38098.428523571616;38173;38364.61635383611;38548.6145138545;38215.808920956326;38406.80796595999;38952.80523597364;39239;39597.2080558393;35991.460128098624;36421.635783641825;37205.62794372022;37723.81138094292;37813.62186378211;30923;31525.369492610476;32848.34303313968;34543.827280863436;34728.305433891685;24999.12503062384;25229.747702523473;25324.24027279111;25489.758579142337;25668.358291042874 05:46:46 INFO - PROCESS | 1640 | |2;jquery.html;347.5256275184374;348.9441689329708;349.72721277403633;351.0626626906161;376.04109520722153;18029.909850450746;18721;19504.317348892793;19729.408117756455;19746.60506789867;19090.090990900902;19291;19317.613647727037;19359.935203563797;19787.70318445221;5553.111502159645;5819.301683797929;5822.737976791054;5824.970875145618;5829.038208695561;5637.943620563803;5759.568032397566;5949.940500595004;5994.730237139317;6051.6671583063135;6021.819345419644;6024.066269728177;6035.577509574332;6051.334353221164;6059.242594675666;5634.915476267859;5963.821085367446;6005.729742161591;6034.818955431344;6046.939530604682;4819.710817350935;5488.945110548923;5786.566007549451;5823.330317013555;5823.737931793079;12763.106582539225;12836.358182090951;12960.416781244772;13011.284379359131;13129.212247265195;2183.443221978401;2274.590573696734;2283.817294616443;2286.416963674269;2850.82895026297;9720.929311335154;10253;10289.279750417474;12305.015598752168;13995.720085598332;1572.559683288681;1760.049573230454;1879.8778079424794;1890.4895678166956;1895.1755986145934;86261.56869215677;104852;113600.99999999917;113924.31643310329;114485;11117.888821111846;11273.943630281796;11539.48072336747;11602.825957610643;11731.589394371156;14121.929390352983;14129.081609695542;14137.575872723835;14138;14173.291335433187;8098.190180981973;8232.958835205905;8236.917630823735;8372.832543349099;8384.035835878953;7987.241212084843;8099.473534220257;8117.350611951029;8230.588470576447;8300.294474969574;4352.107817897323;4419.425474688334;4453.487848897418;4485.0805584855025;4521.344405061248;1892.9337473188373;1919.3570153998287;1921.154691935544;1926.1621194780034;1929.8552608554135;794.7893808140848;826.0129145670986;835.5279267214005;862.9956850215834;872.9607167677469;19367.8063219366;20124.899375503323;20154.596908061758;20307.593848122953;20594.38216853497;774.3959711424985;850.7787975126388;884.712468447757;925.3522534226069;962.6438217859297;8584.74245772628;9974.002599739968;10489.055984961391;10527.894721052691;10638.574457021787;511041;520406;520441;526092;562980;108202;110930;114363.42818286021;114823;117647;873.122511875561;932.6735642525061;972.2173650211506;1001.7445551384351;1006.1447769395954;18017.369392071214;18235.45293641193;18265.817341826412;18274.817251827313;18458.630827383644;25001.12496062629;33189;33776;38775.03062423462;47410.241757148775;43569.78215109031;73995.63002184955;74275.62862185655;75753;76153.23846761462;7486.251374862471;7679.3856491481665;7806.0632724073475;7954.125046244792;7985.281324680806;10745;12009.699757506132;12410.069244806857;12569.93715031419;12885.871141288468;10175.185985121025;10613.9469302653;10667.253292269466;10996.395198264172;11062.446877656246;10715.464226788785;10879.07527860109;10895.291806032583;11059.612913547988;11079.790657413578;11324.6036388726;11334;11340.036261743939;11470.885291146982;11634.069274457854;6295.748170073146;7775.92224077752;7859.882101768592;7970.202979702215;8100.554469504234;10740.570377184826;10875.238733288594;11000.22998390105;11059.668209953714;11126.942940420648 05:46:46 INFO - PROCESS | 1640 | |3;mootools.html;1301.6095171448562;1446.4720377062372;1589.880758943079;1760.568660678134;1780.4658602419272;7279.126504819429;7515.924840751591;7592.810179745502;7965.442419030663;7980.521168729881;7718.421118416127;7978.521288722681;8022.398320125999;8038.959805200981;8050.6779728810925;1931.864769466138;2218.179273668745;2246.067881829039;2247.6853240546257;2255.4474153832334;2220.7890250426262;2252.0991603358625;2261.4685548895995;2270.0919632147106;2270.761570035147;2178.2811672148155;2201.3395981205576;2205.658122990931;2222.1111555377897;2223.8665680059166;2182.847200695952;2186.7813218678084;2200.3398980306006;2201.933941981735;2208.3816531371162;1880.2009146112848;2213.9446513837283;2228.9888550557307;2229.4649284171683;2238.675392068157;6840.144981877265;7836.882446763303;7913.96043019787;7934.642941067608;8024.077231118437;4792.832250871237;4953.232249001375;4960.181570040939;4965.180745177042;4965.751712414365;3132.483140281851;3241.7082462578483;3350.8324583770714;3408.216110294621;3413.7781044232293;961.567294717373;1007.0936157458347;1012.4077414712402;1023.3194925374617;1027.275770581738;10346.948265258701;10392.220583456272;10434.843477347846;10465.581376744922;10472.109870661003;4218.472690913636;4435.556444355539;4467.218236808546;4474.798634061475;4485.686001979895;8976.281897448189;9042.909570904338;9046.81906361869;9049;9078.092190781;4430.136123455895;4827.179379505493;4984.5513903748115;4990.476000019946;4993.975030124826;4451.465824101128;4578.702384345007;4584.954150458453;4592.2193227151465;4621.19129152397;3546.680798728127;3588.9102772430897;3609.4044482660593;3654.031681604377;3664.76179048361;940.3981451870808;1002.7643503776607;1112.9204671468663;1132.2810015640127;1186.8160435132568;746.0301607909696;750.0287128169034;756.2324240895496;784.9097353804272;812.626191951697;5395;5433.26650902131;5610.410906854803;5688.573356998241;5693.430656934273;792.647271963982;925.6806401791371;926.749777560055;936.9718908432758;963.5856581669949;3107.7513798896034;3284.261041265696;3704.129529560551;3768.6231376862092;3809.6190380961684;9304.441733496013;9524.666636667684;9634.13292803651;9663.951680241695;9666.130048295687;8728.170823771732;9167.816643667089;9592.712218633453;9607.663731769355;9648.807023859483;7528.209537998541;7652.311291983749;7676.771716525329;7686.269804368576;7716.344110750649;4894.262536799385;5315.415304316445;5381.838544843661;5424.050791111461;5437.755301011385;8067.959660201662;8875.73372798817;9062.954685226532;9145.817083658423;9157.66479547711;8187.918120818954;9029.954850225708;9097.681581144629;9248.491332976751;9278;5762.4525670061275;6339.144215531029;6508.056331831953;6596.5052621052655;6601.174853143357;7512.624368781649;7546.622668866425;7594.126675432396;7601.923980760122;7618.5809780462605;6879.3120687930805;6911.101556797584;6911.896321555281;6919.550229235084;6950.652467376712;6731.259561448334;6808.9659551701925;6821.863562728817;6823.69293381809;6832.692528836114;6349.841253968688;6469.191351081115;6476.352364763486;6485.44873685742;6520.673966301761;3973.900652483711;4697.412823397075;4705.623550116051;4750.643701722453;4785.258284965836;4179.811908464066;4281.015366465668;4307.590778876001;4366.803493842721;4432.534583868647 05:46:46 INFO - PROCESS | 1640 | |4;prototype.html;249.75274478266516;297.8436320931511;300.7084571764273;305.79053348456307;306.84197638216307;4615.376924115243;5460.78156873725;5570.637908535942;5604.859878503034;5606.943930560698;5218.017153481672;5423.186522021699;5481.314835645544;5481.588880833943;5546.639468434549;3189.904302870906;3910.432987216859;4007.2167885291055;4018.45750823638;4107.732997355162;3795.430685397185;3917.843286268546;4100.63094321511;4155.563665815092;4170.791460426982;4008.97995510022;4088.407180958759;4101.487314085739;4102.774347410891;4128.772917489537;3996.760194388346;4075.1238483725847;4125.039961636832;4126.546079931205;4133.855315063958;3474.9305013899834;3548.361294966905;3550.1184372282733;3552.8045957472327;3554.680078792895;4587.564181402761;4870.780814863339;4884.3650325457465;5313.38896026958;5317.574594032507;3882.8058597070317;4015.5181378234506;4238.004069043773;4576.695641742121;4718.4809670936165;4328.805203765806;5489.560835133219;5758.568107391962;5787.623804452739;5811.982902992002;3423.400904841643;3526.823658817049;3927.8821635350987;3934.1344904121047;3958.168784555247;5797.275340582427;6108.236470441195;6116.684912743737;6127.816165515042;6127.938720612781;3388.373150967079;3915.4126880968083;3931.68546516278;3932.941005884914;3938.960610393917;4014.157027024299;4018.3570628699267;4032.3749818778138;4053.777042262645;4064.918701625951;4641.907161856744;4678.602318802872;4711.916259260389;4725.929111063337;4730.692504987165;5062.341895553554;5774.769009239583;5813.732644268739;5862.472377486047;5934.258217722785;1299.707565797688;1307.2809954524973;1307.9607611771662;1310.3751348328194;1310.8689131087006;827.9567744641674;863.3913091270639;867.197841996151;871.1593312453513;876.5573385440439;4974.900501990012;5266.578673706094;5350.705711185922;5478.726063696799;5510.504054635102;4761.547652972962;4985.725785081855;5516;5649.943500565024;6086.482648974798;4298.302170642579;4535.886602834889;4639.9536004640195;4653.930191047137;5266.420693723688;2456.1087962268953;2720.863956802152;2994.3262765877503;3063.341381602966;3087.9156569315624;4950.158473059589;5229.686218826807;5673.404292549223;5795.565332600072;5924.555658325643;5003.24951257307;5748.45389687979;5851.795187168429;6246.75012999484;6283.3402492737605;5616.787409442918;5796.768129274782;5866.8533286667325;6204.053074789529;6224.408681175281;5150.103131914012;5320.334958130234;5704.515116215002;5770.990076736471;5805.303363596396;5140.637731001213;5465.699386533779;5487.8048780488125;5982.312034115958;5985.551083668655;5217.843464696065;5310.9734451327495;6008.909866352095;6279.949432616028;6296.905546416716;3705.81470926458;3896.233674091427;3902.785346805953;3928.4696565963227;3940.527136743609;5029.038674916858;5234.947650523446;6009.819705408845;6055.457557329012;6062.757489700362;5874.030784920611;5886.6173698709445;5892.145638882424;5893.852653683693;5897.321807991964;4992.951480189201;5014.849554513225;5584.7050240358385;5758.078707406795;5872.559558033079;4768.380110585602;5523.890401378629;5562.638428502134;5783.681897495678;5787.652740835563;5593.86743423684;5771.5671324649975;5810.6513609183585;5882.823515294548;5894.38108998549;4823.300621409806;5453.7818487260065;5762.4525670061275;5763.7982670606325;5814.709264536841 05:46:46 INFO - PROCESS | 1640 | |5;yui.html;641.2657507154307;659.8119535932258;662.1425254295686;743.8437928035113;759.3848982324316;14852.40590376385;15766.132862692548;15775.211239438011;15781.763273550905;15820.129892855903;11644.767104657923;14073.437062517512;14141.646458838533;14173;14245.857541424582;510.8901586158975;536.8657835541114;646.5668002438377;720.5820624038058;760.8435178528633;678.972841086356;749.8350362920149;809.6842231529708;826.5247482697444;829.6888666749969;885.8848349714528;889.5152142082549;892.0321451225428;893.0444424465824;894.8970868350125;873.2359185712502;878.1745159550067;883.7746374674481;884.2793123604274;887.1483375959087;646.0954663471131;659.6503852957892;659.7328082126746;661.1273119482286;663.0981864664053;14762.114273143538;15223.847761522355;15381.384744610203;15412.768808467881;15658.68682626341;14034.719305613831;14157.433702651882;14241.18964150183;14278.500252491216;14416.567502974927;11710.765784684343;11788.46951887167;11970.581029664007;11971.521139154424;12053;3092;3665.6700896919406;3742.4760533525327;3806.8286927088348;3815.7138214633737;92560.53719731426;106777;119823;121433;128366.3581682095;10944.057165383356;11012;11024.614138505114;11157.944210278896;11299.435028248554;22342.776572234394;22361.10555577791;22363.552728945655;22369.776302237096;22398.664020039712;7181.569105853666;7820.648070836826;7923.524588524707;7997;8117.391195660349;3802.9429558556644;4310.741355518679;4364.4980827204645;4370.409994650745;4476.37330773692;3174.6507884132725;3256.1371236622313;3262.9836850815595;3264.6082470103265;3270.035339574831;596.2397942623104;607.3895734786511;614.3027663601755;617.7806878558047;627.6234259444296;566.6288580979465;567.3730527766841;590.1943846649293;604.7429842316998;606.169547719627;8969.50667713282;9024.954875225581;9031.81936361269;9076.954615226881;9184.219341355925;588.9970550147308;594.7561499785154;598.4314900844215;604.3956043956044;612.185792895448;4240.491141063092;4285.892852678646;4289.742615443083;4294.6153731765535;4543.659225558096;91720.54139729259;102758;109615.45192274147;111783;112156;88471.55764221266;89349.55325223332;90115.54942225247;91284.54357728301;93719;57799.71100144556;78175.82736258961;78275.60862195652;78707;79593.45894845216;9604.95197524008;9895;9976.152027077489;9993.400395976265;9996.950015249877;44241.55758442375;47618.33335833229;50622.74688626533;51933.48066519287;52099.21851172311;59720.70139649274;69597.65201173961;74956.25043749492;75323;76178.23821761711;12323.466148718084;12575.622731318075;12730.936345318585;13098.607041788762;13219.801702974655;10936.945315273373;14664.120152790867;14951.271927632391;15177.468788592347;15257.694846103237;13597.116187447784;13685.521006764715;13877.097988630707;14437.06159099655;14461.313097592869;13286.734265314446;13713.177209367072;13895.652608684864;13975.161490310615;14097.295135242992;10270.613467181834;12929.676758081123;13583.728325433634;13591.184528928296;13596.728065438438;8840.778980525538;9144.954275228582;10031.799364012824;10147.949260253652;10342.32774869631;9964.900350996688;10535.789284214427;11331.136951548586;11611.187216894736;11648.475818588015 05:46:46 INFO - PROCESS | 1640 | __end_tp_report 05:46:46 INFO - PROCESS | 1640 | __start_cc_report 05:46:46 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,358 05:46:46 INFO - PROCESS | 1640 | __end_cc_report 05:46:46 INFO - PROCESS | 1640 | __startTimestamp1481118406590__endTimestamp 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | ------- Summary: start ------- 05:46:46 INFO - PROCESS | 1640 | Number of tests: 6 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5674.13 Median:5989.49 stddev:735.27 (12.3%) stddev-sans-first:714.62 05:46:46 INFO - PROCESS | 1640 | Values: 3352.9 3380.1 3398.5 3414.7 3431.2 5588.5 5655.7 5701.8 5714.7 5767.7 5630.2 5667.1 5707.0 5739.5 5786.7 5114.7 5133.4 5142.2 5171.3 5253.4 5137.1 5211.7 5283.3 5295.9 5317.7 5120.5 5190.5 5213.5 5246.6 5252.1 5072.2 5143.3 5150.4 5199.5 5248.2 4362.6 5032.8 5156.3 5179.3 5254.1 4658.9 5385.6 5714.6 5719.1 5723.4 6136.5 6138.7 6140.4 6193.6 6249.3 6123.5 6139.0 6146.9 6149.0 6157.4 5743.0 5743.3 5746.5 5757.5 5762.5 6142.1 6173.2 6224.8 6239.1 6240.4 6049.2 6073.4 6105.1 6105.1 6173.0 6258.2 6279.4 6298.5 6312.0 6313.7 6035.9 6094.5 6104.2 6104.5 6228.7 6052.4 6270.2 6274.3 6285.2 6306.9 4726.0 4849.9 4859.2 4879.0 4898.8 3389.8 3480.0 3593.8 3613.3 3943.9 5046.1 5600.8 5938.9 5989.5 5996.4 6244.6 6273.7 6285.4 6302.3 6304.0 5697.3 5765.3 5887.1 5917.8 5922.1 4209.1 4413.4 4727.6 5363.8 5381.5 5240.0 6263.8 6274.4 6300.2 6304.4 5224.9 6270.6 6282.5 6296.5 6313.4 6198.8 6244.5 6281.7 6310.8 6386.1 6124.3 6147.8 6151.4 6257.3 6271.4 6235.1 6277.2 6302.1 6305.4 6311.6 5951.3 6084.7 6153.0 6166.0 6173.7 5881.1 6022.4 6084.6 6088.8 6113.1 5799.7 5840.3 5902.7 5979.6 6004.5 6128.9 6146.5 6167.6 6174.8 6177.1 5986.2 5999.2 6008.3 6009.2 6020.0 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:69080.75 Median:38135.71 stddev:147115.71 (385.8%) stddev-sans-first:147438.24 05:46:46 INFO - PROCESS | 1640 | Values: 477.0 524.2 527.7 528.9 561.7 38923.0 40636.0 40764.8 40859.0 42875.1 41483.8 42284.8 42292.8 42440.4 42447.4 8518.8 9134.5 9415.0 9446.2 9453.5 8518.3 11159.2 11408.1 11423.3 11594.8 11430.1 11486.0 11486.5 11490.9 11507.3 11286.5 11314.2 11316.5 11348.6 11382.1 11181.1 11230.7 11253.2 11264.9 11266.3 39337.6 39448.8 39596.8 39605.8 39690.2 3303.7 3517.7 3538.6 3778.6 3995.3 30250.2 30894.7 30897.8 30898.4 30961.0 3121.4 3299.4 3332.5 3333.8 3339.7 478056.0 482218.0 483223.6 485036.0 485438.0 59636.7 59879.8 59905.4 59981.7 60098.7 55149.7 62643.0 62977.4 63042.7 65395.0 15593.1 15605.8 15607.4 15679.8 15793.8 9207.4 10577.8 10799.6 11112.8 12007.2 18445.7 18758.2 19352.3 19494.5 19649.5 7935.7 8091.0 8105.5 8113.8 8216.5 828.4 929.6 932.2 1007.8 1020.8 28844.7 29140.4 29475.7 30121.0 30146.1 984.5 994.7 1005.5 1025.3 1096.0 15032.5 15529.9 15531.0 15738.8 15836.9 545799.3 605820.9 609107.0 609825.0 621312.0 57472.1 57694.4 58384.4 58405.7 58498.4 1302.3 1319.2 1324.7 1331.6 1334.0 29354.6 29468.9 29564.3 30140.7 30266.2 50610.5 53212.5 54653.5 54837.7 57720.4 563290.0 566231.2 568573.0 568851.2 569806.2 35470.0 37246.8 42021.8 42075.9 42329.2 44198.8 45362.8 46223.0 46519.3 46736.5 36671.0 38098.4 38173.0 38364.6 38548.6 38215.8 38406.8 38952.8 39239.0 39597.2 35991.5 36421.6 37205.6 37723.8 37813.6 30923.0 31525.4 32848.3 34543.8 34728.3 24999.1 25229.7 25324.2 25489.8 25668.4 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:31106.26 Median:2285.12 stddev:88168.65 (3858.4%) stddev-sans-first:88385.74 05:46:46 INFO - PROCESS | 1640 | Values: 347.5 348.9 349.7 351.1 376.0 18029.9 18721.0 19504.3 19729.4 19746.6 19090.1 19291.0 19317.6 19359.9 19787.7 5553.1 5819.3 5822.7 5825.0 5829.0 5637.9 5759.6 5949.9 5994.7 6051.7 6021.8 6024.1 6035.6 6051.3 6059.2 5634.9 5963.8 6005.7 6034.8 6046.9 4819.7 5488.9 5786.6 5823.3 5823.7 12763.1 12836.4 12960.4 13011.3 13129.2 2183.4 2274.6 2283.8 2286.4 2850.8 9720.9 10253.0 10289.3 12305.0 13995.7 1572.6 1760.0 1879.9 1890.5 1895.2 86261.6 104852.0 113601.0 113924.3 114485.0 11117.9 11273.9 11539.5 11602.8 11731.6 14121.9 14129.1 14137.6 14138.0 14173.3 8098.2 8233.0 8236.9 8372.8 8384.0 7987.2 8099.5 8117.4 8230.6 8300.3 4352.1 4419.4 4453.5 4485.1 4521.3 1892.9 1919.4 1921.2 1926.2 1929.9 794.8 826.0 835.5 863.0 873.0 19367.8 20124.9 20154.6 20307.6 20594.4 774.4 850.8 884.7 925.4 962.6 8584.7 9974.0 10489.1 10527.9 10638.6 511041.0 520406.0 520441.0 526092.0 562980.0 108202.0 110930.0 114363.4 114823.0 117647.0 873.1 932.7 972.2 1001.7 1006.1 18017.4 18235.5 18265.8 18274.8 18458.6 25001.1 33189.0 33776.0 38775.0 47410.2 43569.8 73995.6 74275.6 75753.0 76153.2 7486.3 7679.4 7806.1 7954.1 7985.3 10745.0 12009.7 12410.1 12569.9 12885.9 10175.2 10613.9 10667.3 10996.4 11062.4 10715.5 10879.1 10895.3 11059.6 11079.8 11324.6 11334.0 11340.0 11470.9 11634.1 6295.7 7775.9 7859.9 7970.2 8100.6 10740.6 10875.2 11000.2 11059.7 11126.9 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5183.30 Median:5388.42 stddev:2843.20 (52.8%) stddev-sans-first:2836.21 05:46:46 INFO - PROCESS | 1640 | Values: 1301.6 1446.5 1589.9 1760.6 1780.5 7279.1 7515.9 7592.8 7965.4 7980.5 7718.4 7978.5 8022.4 8039.0 8050.7 1931.9 2218.2 2246.1 2247.7 2255.4 2220.8 2252.1 2261.5 2270.1 2270.8 2178.3 2201.3 2205.7 2222.1 2223.9 2182.8 2186.8 2200.3 2201.9 2208.4 1880.2 2213.9 2229.0 2229.5 2238.7 6840.1 7836.9 7914.0 7934.6 8024.1 4792.8 4953.2 4960.2 4965.2 4965.8 3132.5 3241.7 3350.8 3408.2 3413.8 961.6 1007.1 1012.4 1023.3 1027.3 10346.9 10392.2 10434.8 10465.6 10472.1 4218.5 4435.6 4467.2 4474.8 4485.7 8976.3 9042.9 9046.8 9049.0 9078.1 4430.1 4827.2 4984.6 4990.5 4994.0 4451.5 4578.7 4585.0 4592.2 4621.2 3546.7 3588.9 3609.4 3654.0 3664.8 940.4 1002.8 1112.9 1132.3 1186.8 746.0 750.0 756.2 784.9 812.6 5395.0 5433.3 5610.4 5688.6 5693.4 792.6 925.7 926.7 937.0 963.6 3107.8 3284.3 3704.1 3768.6 3809.6 9304.4 9524.7 9634.1 9664.0 9666.1 8728.2 9167.8 9592.7 9607.7 9648.8 7528.2 7652.3 7676.8 7686.3 7716.3 4894.3 5315.4 5381.8 5424.1 5437.8 8068.0 8875.7 9063.0 9145.8 9157.7 8187.9 9030.0 9097.7 9248.5 9278.0 5762.5 6339.1 6508.1 6596.5 6601.2 7512.6 7546.6 7594.1 7601.9 7618.6 6879.3 6911.1 6911.9 6919.6 6950.7 6731.3 6809.0 6821.9 6823.7 6832.7 6349.8 6469.2 6476.4 6485.4 6520.7 3973.9 4697.4 4705.6 4750.6 4785.3 4179.8 4281.0 4307.6 4366.8 4432.5 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4606.59 Median:5145.37 stddev:1445.99 (28.1%) stddev-sans-first:1412.58 05:46:46 INFO - PROCESS | 1640 | Values: 249.8 297.8 300.7 305.8 306.8 4615.4 5460.8 5570.6 5604.9 5606.9 5218.0 5423.2 5481.3 5481.6 5546.6 3189.9 3910.4 4007.2 4018.5 4107.7 3795.4 3917.8 4100.6 4155.6 4170.8 4009.0 4088.4 4101.5 4102.8 4128.8 3996.8 4075.1 4125.0 4126.5 4133.9 3474.9 3548.4 3550.1 3552.8 3554.7 4587.6 4870.8 4884.4 5313.4 5317.6 3882.8 4015.5 4238.0 4576.7 4718.5 4328.8 5489.6 5758.6 5787.6 5812.0 3423.4 3526.8 3927.9 3934.1 3958.2 5797.3 6108.2 6116.7 6127.8 6127.9 3388.4 3915.4 3931.7 3932.9 3939.0 4014.2 4018.4 4032.4 4053.8 4064.9 4641.9 4678.6 4711.9 4725.9 4730.7 5062.3 5774.8 5813.7 5862.5 5934.3 1299.7 1307.3 1308.0 1310.4 1310.9 828.0 863.4 867.2 871.2 876.6 4974.9 5266.6 5350.7 5478.7 5510.5 4761.5 4985.7 5516.0 5649.9 6086.5 4298.3 4535.9 4640.0 4653.9 5266.4 2456.1 2720.9 2994.3 3063.3 3087.9 4950.2 5229.7 5673.4 5795.6 5924.6 5003.2 5748.5 5851.8 6246.8 6283.3 5616.8 5796.8 5866.9 6204.1 6224.4 5150.1 5320.3 5704.5 5771.0 5805.3 5140.6 5465.7 5487.8 5982.3 5985.6 5217.8 5311.0 6008.9 6279.9 6296.9 3705.8 3896.2 3902.8 3928.5 3940.5 5029.0 5234.9 6009.8 6055.5 6062.8 5874.0 5886.6 5892.1 5893.9 5897.3 4993.0 5014.8 5584.7 5758.1 5872.6 4768.4 5523.9 5562.6 5783.7 5787.7 5593.9 5771.6 5810.7 5882.8 5894.4 4823.3 5453.8 5762.5 5763.8 5814.7 05:46:46 INFO - PROCESS | 1640 | 05:46:46 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20720.72 Median:4337.62 stddev:30504.56 (703.3%) stddev-sans-first:30552.87 05:46:46 INFO - PROCESS | 1640 | Values: 641.3 659.8 662.1 743.8 759.4 14852.4 15766.1 15775.2 15781.8 15820.1 11644.8 14073.4 14141.6 14173.0 14245.9 510.9 536.9 646.6 720.6 760.8 679.0 749.8 809.7 826.5 829.7 885.9 889.5 892.0 893.0 894.9 873.2 878.2 883.8 884.3 887.1 646.1 659.7 659.7 661.1 663.1 14762.1 15223.8 15381.4 15412.8 15658.7 14034.7 14157.4 14241.2 14278.5 14416.6 11710.8 11788.5 11970.6 11971.5 12053.0 3092.0 3665.7 3742.5 3806.8 3815.7 92560.5 106777.0 119823.0 121433.0 128366.4 10944.1 11012.0 11024.6 11157.9 11299.4 22342.8 22361.1 22363.6 22369.8 22398.7 7181.6 7820.6 7923.5 7997.0 8117.4 3802.9 4310.7 4364.5 4370.4 4476.4 3174.7 3256.1 3263.0 3264.6 3270.0 596.2 607.4 614.3 617.8 627.6 566.6 567.4 590.2 604.7 606.2 8969.5 9025.0 9031.8 9077.0 9184.2 589.0 594.8 598.4 604.4 612.2 4240.5 4285.9 4289.7 4294.6 4543.7 91720.5 102758.0 109615.5 111783.0 112156.0 88471.6 89349.6 90115.5 91284.5 93719.0 57799.7 78175.8 78275.6 78707.0 79593.5 9605.0 9895.0 9976.2 9993.4 9997.0 44241.6 47618.3 50622.7 51933.5 52099.2 59720.7 69597.7 74956.3 75323.0 76178.2 12323.5 12575.6 12730.9 13098.6 13219.8 10936.9 14664.1 14951.3 15177.5 15257.7 13597.1 13685.5 13877.1 14437.1 14461.3 13286.7 13713.2 13895.7 13975.2 14097.3 10270.6 12929.7 13583.7 13591.2 13596.7 8840.8 9145.0 10031.8 10147.9 10342.3 9964.9 10535.8 11331.1 11611.2 11648.5 05:46:46 INFO - PROCESS | 1640 | -------- Summary: end -------- 05:46:46 INFO - PROCESS | 1640 | 05:46:47 INFO - TEST-INFO | 1640: exit 0 05:46:47 INFO - TEST-OK | dromaeo_css | took 1116754ms 05:46:47 INFO - TEST-START | kraken 05:46:47 INFO - operating with platform_type : mac_ 05:46:47 INFO - Initialising browser for kraken test... 05:46:47 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpU9gosV/profile http://localhost:49235/getInfo.html) 05:46:50 INFO - PROCESS | 1648 | 2016-12-07 05:46:50.232 plugin-container[1649:11749] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:46:50 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:50 INFO - PROCESS | 1648 | 2016-12-07 05:46:50.234 plugin-container[1649:11749] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 05:46:50 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:50 INFO - PROCESS | 1648 | 2016-12-07 05:46:50.234 plugin-container[1649:11749] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:46:50 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:46:50 INFO - PROCESS | 1648 | colorDepth:24 05:46:50 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:46:50 INFO - PROCESS | 1648 | __metrics 05:46:50 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 05:46:51 INFO - TEST-INFO | 1648: exit 0 05:46:51 INFO - Browser initialized. 05:46:51 INFO - Running cycle 1/1 for kraken test... 05:46:51 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpU9gosV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:53 INFO - PROCESS | 1650 | 2016-12-07 05:46:53.897 plugin-container[1651:11874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 05:46:53 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:53 INFO - PROCESS | 1650 | 2016-12-07 05:46:53.897 plugin-container[1651:11874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441f, name = 'com.apple.CFPasteboardClient' 05:46:53 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:53 INFO - PROCESS | 1650 | 2016-12-07 05:46:53.897 plugin-container[1651:11874] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:47:03 INFO - PROCESS | 1650 | RSS: Main: 241942528 05:47:03 INFO - PROCESS | 1650 | 05:47:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:07 INFO - PROCESS | 1650 | RSS: Main: 254070784 05:47:07 INFO - PROCESS | 1650 | 05:47:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 05:47:11 INFO - PROCESS | 1650 | RSS: Main: 261701632 05:47:11 INFO - PROCESS | 1650 | 05:47:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 05:47:15 INFO - PROCESS | 1650 | RSS: Main: 264228864 05:47:15 INFO - PROCESS | 1650 | 05:47:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 05:47:17 INFO - PROCESS | 1650 | RSS: Main: 266477568 05:47:17 INFO - PROCESS | 1650 | 05:47:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:20 INFO - PROCESS | 1650 | RSS: Main: 267067392 05:47:20 INFO - PROCESS | 1650 | 05:47:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:23 INFO - PROCESS | 1650 | RSS: Main: 272703488 05:47:23 INFO - PROCESS | 1650 | 05:47:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:27 INFO - PROCESS | 1650 | RSS: Main: 272572416 05:47:27 INFO - PROCESS | 1650 | 05:47:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 05:47:31 INFO - PROCESS | 1650 | RSS: Main: 272605184 05:47:31 INFO - PROCESS | 1650 | 05:47:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:33 INFO - PROCESS | 1650 | RSS: Main: 271704064 05:47:33 INFO - PROCESS | 1650 | 05:47:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:36 INFO - PROCESS | 1650 | RSS: Main: 271749120 05:47:36 INFO - PROCESS | 1650 | 05:47:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:39 INFO - PROCESS | 1650 | RSS: Main: 271876096 05:47:39 INFO - PROCESS | 1650 | 05:47:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:42 INFO - PROCESS | 1650 | RSS: Main: 272011264 05:47:42 INFO - PROCESS | 1650 | 05:47:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:46 INFO - PROCESS | 1650 | RSS: Main: 271896576 05:47:46 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 05:47:48 INFO - PROCESS | 1650 | RSS: Main: 272982016 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | __start_tp_report 05:47:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 05:47:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 05:47:48 INFO - PROCESS | 1650 | |i|pagename|runs| 05:47:48 INFO - PROCESS | 1650 | |0;ai-astar;107;117;126;179;175;122;132;151;118;117 05:47:48 INFO - PROCESS | 1650 | |1;audio-beat-detection;149;113;119;136;121;110;105;145;167;142 05:47:48 INFO - PROCESS | 1650 | |2;audio-dft;197;205;194;231;274;202;193;194;198;195 05:47:48 INFO - PROCESS | 1650 | |3;audio-fft;81;58;59;84;60;60;61;80;66;86 05:47:48 INFO - PROCESS | 1650 | |4;audio-oscillator;89;71;85;71;71;71;81;71;72;83 05:47:48 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;121;89;97;117;90;87;90;105;136;87 05:47:48 INFO - PROCESS | 1650 | |6;imaging-darkroom;98;101;152;153;111;152;107;96;94;107 05:47:48 INFO - PROCESS | 1650 | |7;imaging-desaturate;94;101;79;142;147;121;93;92;93;92 05:47:48 INFO - PROCESS | 1650 | |8;json-parse-financial;57;56;57;58;59;59;58;59;57;59 05:47:48 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;66;73;69;89;112;101;78;69;71;70 05:47:48 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;88;93;110;109;92;91;91;85;110;109 05:47:48 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;158;146;158;167;158;167;155;158;209;178 05:47:48 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;222;231;180;175;177;174;180;172;174;178 05:47:48 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;82;88;72;60;90;89;59;73;90;86 05:47:48 INFO - PROCESS | 1650 | __end_tp_report 05:47:48 INFO - PROCESS | 1650 | __start_cc_report 05:47:48 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,923 05:47:48 INFO - PROCESS | 1650 | __end_cc_report 05:47:48 INFO - PROCESS | 1650 | __startTimestamp1481118468692__endTimestamp 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | ------- Summary: start ------- 05:47:48 INFO - PROCESS | 1650 | Number of tests: 14 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:134.40 Median:129.00 stddev:25.32 (19.6%) stddev-sans-first:24.84 05:47:48 INFO - PROCESS | 1650 | Values: 107.0 117.0 126.0 179.0 175.0 122.0 132.0 151.0 118.0 117.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:139.00 stddev:20.13 (14.5%) stddev-sans-first:20.23 05:47:48 INFO - PROCESS | 1650 | Values: 149.0 113.0 119.0 136.0 121.0 110.0 105.0 145.0 167.0 142.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:208.30 Median:200.00 stddev:25.68 (12.8%) stddev-sans-first:26.91 05:47:48 INFO - PROCESS | 1650 | Values: 197.0 205.0 194.0 231.0 274.0 202.0 193.0 194.0 198.0 195.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:69.50 Median:73.00 stddev:11.70 (16.0%) stddev-sans-first:11.65 05:47:48 INFO - PROCESS | 1650 | Values: 81.0 58.0 59.0 84.0 60.0 60.0 61.0 80.0 66.0 86.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:76.50 stddev:7.17 (9.4%) stddev-sans-first:6.01 05:47:48 INFO - PROCESS | 1650 | Values: 89.0 71.0 85.0 71.0 71.0 71.0 81.0 71.0 72.0 83.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:88.00 stddev:17.27 (19.6%) stddev-sans-first:16.87 05:47:48 INFO - PROCESS | 1650 | Values: 121.0 89.0 97.0 117.0 90.0 87.0 90.0 105.0 136.0 87.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:117.10 Median:152.50 stddev:24.88 (16.3%) stddev-sans-first:25.41 05:47:48 INFO - PROCESS | 1650 | Values: 98.0 101.0 152.0 153.0 111.0 152.0 107.0 96.0 94.0 107.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:105.40 Median:92.00 stddev:23.16 (25.2%) stddev-sans-first:24.19 05:47:48 INFO - PROCESS | 1650 | Values: 94.0 101.0 79.0 142.0 147.0 121.0 93.0 92.0 93.0 92.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:1.10 (1.9%) stddev-sans-first:1.12 05:47:48 INFO - PROCESS | 1650 | Values: 57.0 56.0 57.0 58.0 59.0 59.0 58.0 59.0 57.0 59.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:79.80 Median:70.50 stddev:15.70 (22.3%) stddev-sans-first:15.84 05:47:48 INFO - PROCESS | 1650 | Values: 66.0 73.0 69.0 89.0 112.0 101.0 78.0 69.0 71.0 70.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:97.80 Median:89.50 stddev:10.32 (11.5%) stddev-sans-first:10.31 05:47:48 INFO - PROCESS | 1650 | Values: 88.0 93.0 110.0 109.0 92.0 91.0 91.0 85.0 110.0 109.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:165.40 Median:162.50 stddev:17.54 (10.8%) stddev-sans-first:18.40 05:47:48 INFO - PROCESS | 1650 | Values: 158.0 146.0 158.0 167.0 158.0 167.0 155.0 158.0 209.0 178.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:179.00 stddev:21.45 (12.0%) stddev-sans-first:18.46 05:47:48 INFO - PROCESS | 1650 | Values: 222.0 231.0 180.0 175.0 177.0 174.0 180.0 172.0 174.0 178.0 05:47:48 INFO - PROCESS | 1650 | 05:47:48 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.90 Median:87.00 stddev:12.14 (14.0%) stddev-sans-first:12.83 05:47:48 INFO - PROCESS | 1650 | Values: 82.0 88.0 72.0 60.0 90.0 89.0 59.0 73.0 90.0 86.0 05:47:48 INFO - PROCESS | 1650 | -------- Summary: end -------- 05:47:48 INFO - PROCESS | 1650 | 05:47:49 INFO - TEST-INFO | 1650: exit 0 05:47:49 INFO - TEST-OK | kraken | took 62510ms 05:47:49 INFO - SUITE-END | took 1179s 05:47:49 INFO - Completed test suite (00:19:39) 05:47:49 INFO - javascript benchmark 05:47:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7119.580328246415, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.9329413411733, 3380.121168496193, 3398.49022646603, 3414.675605817448, 3431.19366948767, 5588.469095435938, 5655.745491452884, 5701.771929122835, 5714.742836572354, 5767.682777447239, 5630.1554766785, 5667.121596152592, 5707.0, 5739.512141467981, 5786.68173250471, 5114.693118412898, 5133.383993920735, 5142.177251639739, 5171.327727395434, 5253.44838791927, 5137.12668846297, 5211.739413029352, 5283.313169288006, 5295.947040529603, 5317.707526086064, 5120.539151476385, 5190.480951904817, 5213.478652134775, 5246.554042906358, 5252.080885845, 5072.2391641253735, 5143.3313669223135, 5150.407703114115, 5199.4800519948085, 5248.21276808478, 4362.585554372329, 5032.823851165192, 5156.252343410222, 5179.300794392784, 5254.054270231357, 4658.930116048262, 5385.569154467633, 5714.571407144481, 5719.084946408555, 5723.370429252779, 6136.509079273647, 6138.664296166084, 6140.381550880938, 6193.628382297032, 6249.343818899041, 6123.510119190499, 6139.032198454742, 6146.89355915935, 6149.046897730859, 6157.353477884847, 5743.0, 5743.3395159557185, 5746.454086861783, 5757.539396848242, 5762.510186634099, 6142.099766648122, 6173.166622505904, 6224.844378890473, 6239.126522286883, 6240.438360547481, 6049.213602231682, 6073.392660733891, 6105.053716673922, 6105.065535583899, 6172.98145805937, 6258.15514905491, 6279.434850863444, 6298.464630506367, 6312.0, 6313.652749098752, 6035.909461358083, 6094.542909281821, 6104.216637118914, 6104.542159338067, 6228.6574238416415, 6052.364501727256, 6270.153529273581, 6274.309825919146, 6285.182926219653, 6306.936930630635, 4726.007538416971, 4849.854504364875, 4859.173940430064, 4878.975605121952, 4898.755062246873, 3389.8305084745666, 3479.9826000869834, 3593.802340871277, 3613.2773445311045, 3943.8759953413714, 5046.142155833517, 5600.831975040755, 5938.940610593925, 5989.490893274034, 5996.430339117776, 6244.594101383486, 6273.654948977759, 6285.371462853678, 6302.338254483305, 6303.968480157661, 5697.344805347355, 5765.250517432707, 5887.0580707086665, 5917.822465326047, 5922.082077278029, 4209.137126888981, 4413.44831896013, 4727.598154156935, 5363.785448582013, 5381.515663590296, 5240.0, 6263.843403914848, 6274.372562743689, 6300.180976473121, 6304.432601065926, 5224.869378265574, 6270.592411493239, 6282.534374765979, 6296.5277604178955, 6313.43179113882, 6198.845028874314, 6244.5316601256, 6281.654509001866, 6310.84222894413, 6386.074019267087, 6124.2588809726185, 6147.784827531015, 6151.354107818794, 6257.311695713377, 6271.43557079865, 6235.127082208403, 6277.246730392382, 6302.086197501245, 6305.432511074026, 6311.621302721851, 5951.285845698544, 6084.695765211633, 6153.0, 6165.982612868826, 6173.660448675366, 5881.088431293157, 6022.367651396716, 6084.574079814548, 6088.786892458743, 6113.14415981754, 5799.710014499174, 5840.328362238397, 5902.675352855634, 5979.551533634908, 6004.519638429003, 6128.908066378919, 6146.5390095742105, 6167.5682702210415, 6174.783882564088, 6177.073438984008, 5986.161937328865, 5999.1901093351835, 6008.339082700812, 6009.248843894513, 6019.976603977422], "value": 5620.7358927153155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.9833055843046, 524.1639584862144, 527.7440441385929, 528.8545649946266, 561.7387914619701, 38923.02692432687, 40635.9841003975, 40764.796176019154, 40858.97852553688, 42875.14249715004, 41483.79258103713, 42284.78857605715, 42292.788536057276, 42440.36339454903, 42447.3632895506, 8518.787030324229, 9134.543272836348, 9414.952925235399, 9446.197073248783, 9453.480058596775, 8518.27594654455, 11159.218854680175, 11408.144389170804, 11423.314601123959, 11594.826077608843, 11430.085593152528, 11486.0, 11486.483108260149, 11490.885091149106, 11507.3095614263, 11286.548538058469, 11314.151438642053, 11316.547338106466, 11348.602798902082, 11382.146339024564, 11181.105511559055, 11230.719232019183, 11253.212275140744, 11264.94367528157, 11266.267692599955, 39337.60662393396, 39448.802755986326, 39596.802015990026, 39605.80197099025, 39690.20619587592, 3303.6861498157637, 3517.66582174693, 3538.575370955502, 3778.622137786227, 3995.3407687731487, 30250.243743906358, 30894.691053089406, 30897.845510772302, 30898.382032359452, 30961.0, 3121.438141134595, 3299.373119107362, 3332.450145725952, 3333.799972001688, 3339.716124129452, 478056.0, 482218.0, 483223.58388208185, 485036.0, 485438.0, 59636.701816491506, 59879.80240395255, 59905.400945990856, 59981.70009149926, 60098.699506503064, 55149.72425137849, 62643.0, 62977.37022629715, 63042.68478657669, 65395.0, 15593.142377169137, 15605.843941560666, 15607.361227071222, 15679.843201567839, 15793.842061579237, 9207.40151890125, 10577.84133238002, 10799.56801727922, 11112.833307500394, 12007.219530730474, 18445.678779890844, 18758.1558829853, 19352.32266870653, 19494.52736318408, 19649.508762281057, 7935.682572697027, 8091.0, 8105.474118758241, 8113.8377232456205, 8216.46592971455, 828.3787159630277, 929.6467342409841, 932.2169377722745, 1007.8337074382791, 1020.7907378987289, 28844.711552884623, 29140.417191656474, 29475.705242947726, 30121.0, 30146.095617131523, 984.478226539935, 994.7413672445216, 1005.5324274212526, 1025.2566889005411, 1096.0354887698775, 15032.549023529311, 15529.922350388175, 15530.990485618398, 15738.763918541232, 15836.941197644233, 545799.2710036425, 605820.9417905853, 609107.0, 609825.0, 621312.0, 57472.137917931264, 57694.42305576891, 58384.4161558379, 58405.70797145987, 58498.41501585015, 1302.2707283921034, 1319.2150670351125, 1324.6886981559326, 1331.6138319887318, 1333.979990300127, 29354.55968160522, 29468.852655736584, 29564.260893477836, 30140.69859301379, 30266.24334391658, 50610.49389506058, 53212.46787532075, 54653.45346546484, 54837.725811370685, 57720.422795771505, 563290.0, 566231.1688441532, 568573.0, 568851.1557442186, 569806.1509692424, 35470.0, 37246.813765930994, 42021.78989105035, 42075.89620519023, 42329.1534169321, 44198.77900610476, 45362.77318613518, 46223.0, 46519.30221046755, 46736.53263467322, 36671.0, 38098.428523571616, 38173.0, 38364.61635383611, 38548.6145138545, 38215.808920956326, 38406.80796595999, 38952.80523597364, 39239.0, 39597.2080558393, 35991.460128098624, 36421.635783641825, 37205.62794372022, 37723.81138094292, 37813.62186378211, 30923.0, 31525.369492610476, 32848.34303313968, 34543.827280863436, 34728.305433891685, 24999.12503062384, 25229.747702523473, 25324.24027279111, 25489.758579142337, 25668.358291042874], "value": 20390.502004090566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.5256275184374, 348.9441689329708, 349.72721277403633, 351.0626626906161, 376.04109520722153, 18029.909850450746, 18721.0, 19504.317348892793, 19729.408117756455, 19746.60506789867, 19090.090990900902, 19291.0, 19317.613647727037, 19359.935203563797, 19787.70318445221, 5553.111502159645, 5819.301683797929, 5822.737976791054, 5824.970875145618, 5829.038208695561, 5637.943620563803, 5759.568032397566, 5949.940500595004, 5994.730237139317, 6051.6671583063135, 6021.819345419644, 6024.066269728177, 6035.577509574332, 6051.334353221164, 6059.242594675666, 5634.915476267859, 5963.821085367446, 6005.729742161591, 6034.818955431344, 6046.939530604682, 4819.710817350935, 5488.945110548923, 5786.566007549451, 5823.330317013555, 5823.737931793079, 12763.106582539225, 12836.358182090951, 12960.416781244772, 13011.284379359131, 13129.212247265195, 2183.443221978401, 2274.590573696734, 2283.817294616443, 2286.416963674269, 2850.82895026297, 9720.929311335154, 10253.0, 10289.279750417474, 12305.015598752168, 13995.720085598332, 1572.559683288681, 1760.049573230454, 1879.8778079424794, 1890.4895678166956, 1895.1755986145934, 86261.56869215677, 104852.0, 113600.99999999917, 113924.31643310329, 114485.0, 11117.888821111846, 11273.943630281796, 11539.48072336747, 11602.825957610643, 11731.589394371156, 14121.929390352983, 14129.081609695542, 14137.575872723835, 14138.0, 14173.291335433187, 8098.190180981973, 8232.958835205905, 8236.917630823735, 8372.832543349099, 8384.035835878953, 7987.241212084843, 8099.473534220257, 8117.350611951029, 8230.588470576447, 8300.294474969574, 4352.107817897323, 4419.425474688334, 4453.487848897418, 4485.0805584855025, 4521.344405061248, 1892.9337473188373, 1919.3570153998287, 1921.154691935544, 1926.1621194780034, 1929.8552608554135, 794.7893808140848, 826.0129145670986, 835.5279267214005, 862.9956850215834, 872.9607167677469, 19367.8063219366, 20124.899375503323, 20154.596908061758, 20307.593848122953, 20594.38216853497, 774.3959711424985, 850.7787975126388, 884.712468447757, 925.3522534226069, 962.6438217859297, 8584.74245772628, 9974.002599739968, 10489.055984961391, 10527.894721052691, 10638.574457021787, 511041.0, 520406.0, 520441.0, 526092.0, 562980.0, 108202.0, 110930.0, 114363.42818286021, 114823.0, 117647.0, 873.122511875561, 932.6735642525061, 972.2173650211506, 1001.7445551384351, 1006.1447769395954, 18017.369392071214, 18235.45293641193, 18265.817341826412, 18274.817251827313, 18458.630827383644, 25001.12496062629, 33189.0, 33776.0, 38775.03062423462, 47410.241757148775, 43569.78215109031, 73995.63002184955, 74275.62862185655, 75753.0, 76153.23846761462, 7486.251374862471, 7679.3856491481665, 7806.0632724073475, 7954.125046244792, 7985.281324680806, 10745.0, 12009.699757506132, 12410.069244806857, 12569.93715031419, 12885.871141288468, 10175.185985121025, 10613.9469302653, 10667.253292269466, 10996.395198264172, 11062.446877656246, 10715.464226788785, 10879.07527860109, 10895.291806032583, 11059.612913547988, 11079.790657413578, 11324.6036388726, 11334.0, 11340.036261743939, 11470.885291146982, 11634.069274457854, 6295.748170073146, 7775.92224077752, 7859.882101768592, 7970.202979702215, 8100.554469504234, 10740.570377184826, 10875.238733288594, 11000.22998390105, 11059.668209953714, 11126.942940420648], "value": 8996.00445935664, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.6095171448562, 1446.4720377062372, 1589.880758943079, 1760.568660678134, 1780.4658602419272, 7279.126504819429, 7515.924840751591, 7592.810179745502, 7965.442419030663, 7980.521168729881, 7718.421118416127, 7978.521288722681, 8022.398320125999, 8038.959805200981, 8050.6779728810925, 1931.864769466138, 2218.179273668745, 2246.067881829039, 2247.6853240546257, 2255.4474153832334, 2220.7890250426262, 2252.0991603358625, 2261.4685548895995, 2270.0919632147106, 2270.761570035147, 2178.2811672148155, 2201.3395981205576, 2205.658122990931, 2222.1111555377897, 2223.8665680059166, 2182.847200695952, 2186.7813218678084, 2200.3398980306006, 2201.933941981735, 2208.3816531371162, 1880.2009146112848, 2213.9446513837283, 2228.9888550557307, 2229.4649284171683, 2238.675392068157, 6840.144981877265, 7836.882446763303, 7913.96043019787, 7934.642941067608, 8024.077231118437, 4792.832250871237, 4953.232249001375, 4960.181570040939, 4965.180745177042, 4965.751712414365, 3132.483140281851, 3241.7082462578483, 3350.8324583770714, 3408.216110294621, 3413.7781044232293, 961.567294717373, 1007.0936157458347, 1012.4077414712402, 1023.3194925374617, 1027.275770581738, 10346.948265258701, 10392.220583456272, 10434.843477347846, 10465.581376744922, 10472.109870661003, 4218.472690913636, 4435.556444355539, 4467.218236808546, 4474.798634061475, 4485.686001979895, 8976.281897448189, 9042.909570904338, 9046.81906361869, 9049.0, 9078.092190781, 4430.136123455895, 4827.179379505493, 4984.5513903748115, 4990.476000019946, 4993.975030124826, 4451.465824101128, 4578.702384345007, 4584.954150458453, 4592.2193227151465, 4621.19129152397, 3546.680798728127, 3588.9102772430897, 3609.4044482660593, 3654.031681604377, 3664.76179048361, 940.3981451870808, 1002.7643503776607, 1112.9204671468663, 1132.2810015640127, 1186.8160435132568, 746.0301607909696, 750.0287128169034, 756.2324240895496, 784.9097353804272, 812.626191951697, 5395.0, 5433.26650902131, 5610.410906854803, 5688.573356998241, 5693.430656934273, 792.647271963982, 925.6806401791371, 926.749777560055, 936.9718908432758, 963.5856581669949, 3107.7513798896034, 3284.261041265696, 3704.129529560551, 3768.6231376862092, 3809.6190380961684, 9304.441733496013, 9524.666636667684, 9634.13292803651, 9663.951680241695, 9666.130048295687, 8728.170823771732, 9167.816643667089, 9592.712218633453, 9607.663731769355, 9648.807023859483, 7528.209537998541, 7652.311291983749, 7676.771716525329, 7686.269804368576, 7716.344110750649, 4894.262536799385, 5315.415304316445, 5381.838544843661, 5424.050791111461, 5437.755301011385, 8067.959660201662, 8875.73372798817, 9062.954685226532, 9145.817083658423, 9157.66479547711, 8187.918120818954, 9029.954850225708, 9097.681581144629, 9248.491332976751, 9278.0, 5762.4525670061275, 6339.144215531029, 6508.056331831953, 6596.5052621052655, 6601.174853143357, 7512.624368781649, 7546.622668866425, 7594.126675432396, 7601.923980760122, 7618.5809780462605, 6879.3120687930805, 6911.101556797584, 6911.896321555281, 6919.550229235084, 6950.652467376712, 6731.259561448334, 6808.9659551701925, 6821.863562728817, 6823.69293381809, 6832.692528836114, 6349.841253968688, 6469.191351081115, 6476.352364763486, 6485.44873685742, 6520.673966301761, 3973.900652483711, 4697.412823397075, 4705.623550116051, 4750.643701722453, 4785.258284965836, 4179.811908464066, 4281.015366465668, 4307.590778876001, 4366.803493842721, 4432.534583868647], "value": 4192.764239040386, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.75274478266516, 297.8436320931511, 300.7084571764273, 305.79053348456307, 306.84197638216307, 4615.376924115243, 5460.78156873725, 5570.637908535942, 5604.859878503034, 5606.943930560698, 5218.017153481672, 5423.186522021699, 5481.314835645544, 5481.588880833943, 5546.639468434549, 3189.904302870906, 3910.432987216859, 4007.2167885291055, 4018.45750823638, 4107.732997355162, 3795.430685397185, 3917.843286268546, 4100.63094321511, 4155.563665815092, 4170.791460426982, 4008.97995510022, 4088.407180958759, 4101.487314085739, 4102.774347410891, 4128.772917489537, 3996.760194388346, 4075.1238483725847, 4125.039961636832, 4126.546079931205, 4133.855315063958, 3474.9305013899834, 3548.361294966905, 3550.1184372282733, 3552.8045957472327, 3554.680078792895, 4587.564181402761, 4870.780814863339, 4884.3650325457465, 5313.38896026958, 5317.574594032507, 3882.8058597070317, 4015.5181378234506, 4238.004069043773, 4576.695641742121, 4718.4809670936165, 4328.805203765806, 5489.560835133219, 5758.568107391962, 5787.623804452739, 5811.982902992002, 3423.400904841643, 3526.823658817049, 3927.8821635350987, 3934.1344904121047, 3958.168784555247, 5797.275340582427, 6108.236470441195, 6116.684912743737, 6127.816165515042, 6127.938720612781, 3388.373150967079, 3915.4126880968083, 3931.68546516278, 3932.941005884914, 3938.960610393917, 4014.157027024299, 4018.3570628699267, 4032.3749818778138, 4053.777042262645, 4064.918701625951, 4641.907161856744, 4678.602318802872, 4711.916259260389, 4725.929111063337, 4730.692504987165, 5062.341895553554, 5774.769009239583, 5813.732644268739, 5862.472377486047, 5934.258217722785, 1299.707565797688, 1307.2809954524973, 1307.9607611771662, 1310.3751348328194, 1310.8689131087006, 827.9567744641674, 863.3913091270639, 867.197841996151, 871.1593312453513, 876.5573385440439, 4974.900501990012, 5266.578673706094, 5350.705711185922, 5478.726063696799, 5510.504054635102, 4761.547652972962, 4985.725785081855, 5516.0, 5649.943500565024, 6086.482648974798, 4298.302170642579, 4535.886602834889, 4639.9536004640195, 4653.930191047137, 5266.420693723688, 2456.1087962268953, 2720.863956802152, 2994.3262765877503, 3063.341381602966, 3087.9156569315624, 4950.158473059589, 5229.686218826807, 5673.404292549223, 5795.565332600072, 5924.555658325643, 5003.24951257307, 5748.45389687979, 5851.795187168429, 6246.75012999484, 6283.3402492737605, 5616.787409442918, 5796.768129274782, 5866.8533286667325, 6204.053074789529, 6224.408681175281, 5150.103131914012, 5320.334958130234, 5704.515116215002, 5770.990076736471, 5805.303363596396, 5140.637731001213, 5465.699386533779, 5487.8048780488125, 5982.312034115958, 5985.551083668655, 5217.843464696065, 5310.9734451327495, 6008.909866352095, 6279.949432616028, 6296.905546416716, 3705.81470926458, 3896.233674091427, 3902.785346805953, 3928.4696565963227, 3940.527136743609, 5029.038674916858, 5234.947650523446, 6009.819705408845, 6055.457557329012, 6062.757489700362, 5874.030784920611, 5886.6173698709445, 5892.145638882424, 5893.852653683693, 5897.321807991964, 4992.951480189201, 5014.849554513225, 5584.7050240358385, 5758.078707406795, 5872.559558033079, 4768.380110585602, 5523.890401378629, 5562.638428502134, 5783.681897495678, 5787.652740835563, 5593.86743423684, 5771.5671324649975, 5810.6513609183585, 5882.823515294548, 5894.38108998549, 4823.300621409806, 5453.7818487260065, 5762.4525670061275, 5763.7982670606325, 5814.709264536841], "value": 4136.952292036265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.2657507154307, 659.8119535932258, 662.1425254295686, 743.8437928035113, 759.3848982324316, 14852.40590376385, 15766.132862692548, 15775.211239438011, 15781.763273550905, 15820.129892855903, 11644.767104657923, 14073.437062517512, 14141.646458838533, 14173.0, 14245.857541424582, 510.8901586158975, 536.8657835541114, 646.5668002438377, 720.5820624038058, 760.8435178528633, 678.972841086356, 749.8350362920149, 809.6842231529708, 826.5247482697444, 829.6888666749969, 885.8848349714528, 889.5152142082549, 892.0321451225428, 893.0444424465824, 894.8970868350125, 873.2359185712502, 878.1745159550067, 883.7746374674481, 884.2793123604274, 887.1483375959087, 646.0954663471131, 659.6503852957892, 659.7328082126746, 661.1273119482286, 663.0981864664053, 14762.114273143538, 15223.847761522355, 15381.384744610203, 15412.768808467881, 15658.68682626341, 14034.719305613831, 14157.433702651882, 14241.18964150183, 14278.500252491216, 14416.567502974927, 11710.765784684343, 11788.46951887167, 11970.581029664007, 11971.521139154424, 12053.0, 3092.0, 3665.6700896919406, 3742.4760533525327, 3806.8286927088348, 3815.7138214633737, 92560.53719731426, 106777.0, 119823.0, 121433.0, 128366.3581682095, 10944.057165383356, 11012.0, 11024.614138505114, 11157.944210278896, 11299.435028248554, 22342.776572234394, 22361.10555577791, 22363.552728945655, 22369.776302237096, 22398.664020039712, 7181.569105853666, 7820.648070836826, 7923.524588524707, 7997.0, 8117.391195660349, 3802.9429558556644, 4310.741355518679, 4364.4980827204645, 4370.409994650745, 4476.37330773692, 3174.6507884132725, 3256.1371236622313, 3262.9836850815595, 3264.6082470103265, 3270.035339574831, 596.2397942623104, 607.3895734786511, 614.3027663601755, 617.7806878558047, 627.6234259444296, 566.6288580979465, 567.3730527766841, 590.1943846649293, 604.7429842316998, 606.169547719627, 8969.50667713282, 9024.954875225581, 9031.81936361269, 9076.954615226881, 9184.219341355925, 588.9970550147308, 594.7561499785154, 598.4314900844215, 604.3956043956044, 612.185792895448, 4240.491141063092, 4285.892852678646, 4289.742615443083, 4294.6153731765535, 4543.659225558096, 91720.54139729259, 102758.0, 109615.45192274147, 111783.0, 112156.0, 88471.55764221266, 89349.55325223332, 90115.54942225247, 91284.54357728301, 93719.0, 57799.71100144556, 78175.82736258961, 78275.60862195652, 78707.0, 79593.45894845216, 9604.95197524008, 9895.0, 9976.152027077489, 9993.400395976265, 9996.950015249877, 44241.55758442375, 47618.33335833229, 50622.74688626533, 51933.48066519287, 52099.21851172311, 59720.70139649274, 69597.65201173961, 74956.25043749492, 75323.0, 76178.23821761711, 12323.466148718084, 12575.622731318075, 12730.936345318585, 13098.607041788762, 13219.801702974655, 10936.945315273373, 14664.120152790867, 14951.271927632391, 15177.468788592347, 15257.694846103237, 13597.116187447784, 13685.521006764715, 13877.097988630707, 14437.06159099655, 14461.313097592869, 13286.734265314446, 13713.177209367072, 13895.652608684864, 13975.161490310615, 14097.295135242992, 10270.613467181834, 12929.676758081123, 13583.728325433634, 13591.184528928296, 13596.728065438438, 8840.778980525538, 9144.954275228582, 10031.799364012824, 10147.949260253652, 10342.32774869631, 9964.900350996688, 10535.789284214427, 11331.136951548586, 11611.187216894736, 11648.475818588015], "value": 7281.579909304196, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 126.0, 179.0, 175.0, 122.0, 132.0, 151.0, 118.0, 117.0], "value": 134.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 113.0, 119.0, 136.0, 121.0, 110.0, 105.0, 145.0, 167.0, 142.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 205.0, 194.0, 231.0, 274.0, 202.0, 193.0, 194.0, 198.0, 195.0], "value": 208.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 84.0, 60.0, 60.0, 61.0, 80.0, 66.0, 86.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 85.0, 71.0, 71.0, 71.0, 81.0, 71.0, 72.0, 83.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 89.0, 97.0, 117.0, 90.0, 87.0, 90.0, 105.0, 136.0, 87.0], "value": 101.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 101.0, 152.0, 153.0, 111.0, 152.0, 107.0, 96.0, 94.0, 107.0], "value": 117.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 79.0, 142.0, 147.0, 121.0, 93.0, 92.0, 93.0, 92.0], "value": 105.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 58.0, 59.0, 59.0, 58.0, 59.0, 57.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 69.0, 89.0, 112.0, 101.0, 78.0, 69.0, 71.0, 70.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 110.0, 109.0, 92.0, 91.0, 91.0, 85.0, 110.0, 109.0], "value": 97.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 146.0, 158.0, 167.0, 158.0, 167.0, 155.0, 158.0, 209.0, 178.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 231.0, 180.0, 175.0, 177.0, 174.0, 180.0, 172.0, 174.0, 178.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 72.0, 60.0, 90.0, 89.0, 59.0, 73.0, 90.0, 86.0], "value": 78.9, "unit": "score"}]}]} 05:47:49 INFO - Return code: 0 05:47:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:49 ERROR - # TBPL SUCCESS # 05:47:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:49 INFO - 2016-12-07 05:47:49.996 screenresolution[1655:12260] starting screenresolution argv=screenresolution get 05:47:49 INFO - 2016-12-07 05:47:49.999 screenresolution[1655:12260] Display 0: 1600x1200x32@60 05:47:50 INFO - 2016-12-07 05:47:50.005 screenresolution[1656:12263] starting screenresolution argv=screenresolution list 05:47:50 INFO - Available Modes on Display 0 05:47:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:50 INFO - Intel Iris: 05:47:50 INFO - Chipset Model: Intel Iris 05:47:50 INFO - Type: GPU 05:47:50 INFO - Bus: Built-In 05:47:50 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:50 INFO - Vendor: Intel (0x8086) 05:47:50 INFO - Device ID: 0x0a2e 05:47:50 INFO - Revision ID: 0x0009 05:47:50 INFO - Displays: 05:47:50 INFO - Display: 05:47:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:50 INFO - Display Serial Number: 1600x1200 60 05:47:50 INFO - Main Display: Yes 05:47:50 INFO - Mirror: Off 05:47:50 INFO - Online: Yes 05:47:50 INFO - Rotation: Supported 05:47:50 INFO - Return code: 0 05:47:50 INFO - Running post-action listener: _resource_record_post_action 05:47:50 INFO - [mozharness: 2016-12-07 13:47:50.256993Z] Finished run-tests step (success) 05:47:50 INFO - Running post-run listener: _resource_record_post_run 05:47:50 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 34157056; Write bytes: 695493120; Read time: 427; Write time: 2202 05:47:50 INFO - TinderboxPrint: CPU usage
54.3% 05:47:50 INFO - TinderboxPrint: I/O read bytes / time
34,157,056 / 427 05:47:50 INFO - TinderboxPrint: I/O write bytes / time
695,493,120 / 2,202 05:47:50 INFO - TinderboxPrint: CPU idle
2,215.2 (45.7%) 05:47:50 INFO - TinderboxPrint: CPU system
975.6 (20.1%) 05:47:50 INFO - TinderboxPrint: CPU user
1,658.9 (34.2%) 05:47:50 INFO - TinderboxPrint: Swap in / out
414,318,592 / 0 05:47:50 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 266240; Write bytes: 388378112; Read time: 7; Write time: 721 05:47:50 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30151168; Write bytes: 305775616; Read time: 393; Write time: 1476 05:47:50 INFO - Running post-run listener: _upload_blobber_files 05:47:50 INFO - Blob upload gear active. 05:47:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:50 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 05:47:50 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'] 05:47:50 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 05:47:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:47:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:47:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:52 INFO - (blobuploader) - INFO - Done attempting. 05:47:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:47:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:54 INFO - (blobuploader) - INFO - Done attempting. 05:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:56 INFO - (blobuploader) - INFO - Done attempting. 05:47:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:56 INFO - Return code: 0 05:47:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dcfa3f8c2bfeffc6f7ec710cbeae9b3823ac4ac32fddd12e10f1cead79bc500ec696af5387b7166f251c1d3d97c10b3ca2e5860d906b43883e6d45bc73786ae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c30b64521e9652e9e644df280ca7144369cf3ff59b7f10ccfbf0991d4a4b0fc75f037bec98fcf46ef477e4c478ae24208884d2a05220401414c87c02fd244cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b6851c5d458105e7d94f1808f0a1992a912447b64c1e1b348433a078f98e8e358d0e1075f83b607e86bfac4ddad718366c0a1a18d94ebcb3da64b344efedb7fd"} 05:47:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:56 INFO - Contents: 05:47:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dcfa3f8c2bfeffc6f7ec710cbeae9b3823ac4ac32fddd12e10f1cead79bc500ec696af5387b7166f251c1d3d97c10b3ca2e5860d906b43883e6d45bc73786ae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c30b64521e9652e9e644df280ca7144369cf3ff59b7f10ccfbf0991d4a4b0fc75f037bec98fcf46ef477e4c478ae24208884d2a05220401414c87c02fd244cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b6851c5d458105e7d94f1808f0a1992a912447b64c1e1b348433a078f98e8e358d0e1075f83b607e86bfac4ddad718366c0a1a18d94ebcb3da64b344efedb7fd"} 05:47:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:56 INFO - Copying logs to upload dir... 05:47:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.988720 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-07 05:47:56.528605) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 05:47:56.533510) ========= 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.EaeAMSeuz2/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.90tB1q09TG/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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/dcfa3f8c2bfeffc6f7ec710cbeae9b3823ac4ac32fddd12e10f1cead79bc500ec696af5387b7166f251c1d3d97c10b3ca2e5860d906b43883e6d45bc73786ae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c30b64521e9652e9e644df280ca7144369cf3ff59b7f10ccfbf0991d4a4b0fc75f037bec98fcf46ef477e4c478ae24208884d2a05220401414c87c02fd244cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b6851c5d458105e7d94f1808f0a1992a912447b64c1e1b348433a078f98e8e358d0e1075f83b607e86bfac4ddad718366c0a1a18d94ebcb3da64b344efedb7fd"} build_url:https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/Ehn3jgDcTN6dc-54eMF7yg/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/dcfa3f8c2bfeffc6f7ec710cbeae9b3823ac4ac32fddd12e10f1cead79bc500ec696af5387b7166f251c1d3d97c10b3ca2e5860d906b43883e6d45bc73786ae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c30b64521e9652e9e644df280ca7144369cf3ff59b7f10ccfbf0991d4a4b0fc75f037bec98fcf46ef477e4c478ae24208884d2a05220401414c87c02fd244cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b6851c5d458105e7d94f1808f0a1992a912447b64c1e1b348433a078f98e8e358d0e1075f83b607e86bfac4ddad718366c0a1a18d94ebcb3da64b344efedb7fd"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 05:47:56.626811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:47:56.627167) ========= 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.EaeAMSeuz2/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.90tB1q09TG/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.004957 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 05:47:56.684170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 05:47:56.684479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 05:47:56.692372) ========= ========= Total master_lag: 0.39 =========