builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0167 starttime: 1493393895.12 results: success (0) buildid: 20170428071321 builduid: c8f157b062b346bfac7781f0e4abe510 revision: fcc6c261b2c9df3684bc6cd347437dc336ab0335 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.122714) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.123150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.123429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.151424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.151884) ========= 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.DbWytlfJMk/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.49pIFhATea/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-28 08:38:15-- 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% 20.9M=0.001s 2017-04-28 08:38:15 (20.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.206865 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.482559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.482942) ========= 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.DbWytlfJMk/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.49pIFhATea/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.030942 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:15.537403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 08:38:15.537768) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fcc6c261b2c9df3684bc6cd347437dc336ab0335 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fcc6c261b2c9df3684bc6cd347437dc336ab0335 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DbWytlfJMk/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.49pIFhATea/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-28 08:38:15,641 truncating revision to first 12 chars 2017-04-28 08:38:15,642 Setting DEBUG logging. 2017-04-28 08:38:15,642 attempt 1/10 2017-04-28 08:38:15,642 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fcc6c261b2c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 08:38:16,694 unpacking tar archive at: mozilla-beta-fcc6c261b2c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.326828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 08:38:16.888969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:16.889301) ========= script_repo_revision: fcc6c261b2c9df3684bc6cd347437dc336ab0335 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:16.889698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:16.889964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 08:38:16.910920) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-28 08:38:16.911358) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DbWytlfJMk/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.49pIFhATea/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:38:17 INFO - MultiFileLogger online at 20170428 08:38:17 in /builds/slave/test 08:38:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:38:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:17 INFO - {'append_to_log': False, 08:38:17 INFO - 'base_work_dir': '/builds/slave/test', 08:38:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:38:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:17 INFO - 'branch': 'Mozilla-Beta', 08:38:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:17 INFO - 'config_files': ('talos/mac_config.py',), 08:38:17 INFO - 'default_actions': ('clobber', 08:38:17 INFO - 'read-buildbot-config', 08:38:17 INFO - 'download-and-extract', 08:38:17 INFO - 'populate-webroot', 08:38:17 INFO - 'create-virtualenv', 08:38:17 INFO - 'install', 08:38:17 INFO - 'run-tests'), 08:38:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:17 INFO - 'download_minidump_stackwalk': True, 08:38:17 INFO - 'download_symbols': 'ondemand', 08:38:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:17 INFO - 'gecko_profile': False, 08:38:17 INFO - 'gecko_profile_interval': 0, 08:38:17 INFO - 'installer_path': 'installer.exe', 08:38:17 INFO - 'log_level': 'info', 08:38:17 INFO - 'log_name': 'talos', 08:38:17 INFO - 'log_to_console': True, 08:38:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:38:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:38:17 INFO - 'opt_config_files': (), 08:38:17 INFO - 'pip_index': False, 08:38:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:17 INFO - 'cmd': ('bash', 08:38:17 INFO - '-c', 08:38:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:17 INFO - 'enabled': True, 08:38:17 INFO - 'halt_on_failure': False, 08:38:17 INFO - 'name': 'check_screen_resolution'},), 08:38:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:17 INFO - 'cmd': ('bash', 08:38:17 INFO - '-c', 08:38:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:17 INFO - 'enabled': True, 08:38:17 INFO - 'halt_on_failure': False, 08:38:17 INFO - 'name': 'check_screen_resolution'},), 08:38:17 INFO - 'run_cmd_checks_enabled': True, 08:38:17 INFO - 'suite': 'dromaeojs-e10s', 08:38:17 INFO - 'system_bits': '32', 08:38:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:17 INFO - 'title': 't-yosemite-r7-0167', 08:38:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:17 INFO - 'use_talos_json': True, 08:38:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:17 INFO - 'work_dir': 'build'} 08:38:17 INFO - [mozharness: 2017-04-28 15:38:17.127756Z] Running clobber step. 08:38:17 INFO - Running pre-action listener: _resource_record_pre_action 08:38:17 INFO - Running main action method: clobber 08:38:17 INFO - rmtree: /builds/slave/test/build 08:38:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:21 INFO - Running post-action listener: _resource_record_post_action 08:38:21 INFO - [mozharness: 2017-04-28 15:38:21.854156Z] Finished clobber step (success) 08:38:21 INFO - [mozharness: 2017-04-28 15:38:21.854411Z] Running read-buildbot-config step. 08:38:21 INFO - Running pre-action listener: _resource_record_pre_action 08:38:21 INFO - Running main action method: read_buildbot_config 08:38:21 INFO - Using buildbot properties: 08:38:21 INFO - { 08:38:21 INFO - "project": "", 08:38:21 INFO - "product": "firefox", 08:38:21 INFO - "script_repo_revision": "production", 08:38:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:38:21 INFO - "repository": "", 08:38:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:38:21 INFO - "buildid": "20170428071321", 08:38:21 INFO - "pgo_build": "False", 08:38:21 INFO - "basedir": "/builds/slave/test", 08:38:21 INFO - "buildnumber": 23, 08:38:21 INFO - "slavename": "t-yosemite-r7-0167", 08:38:21 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:38:21 INFO - "platform": "yosemite_r7", 08:38:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:38:21 INFO - "branch": "mozilla-beta", 08:38:21 INFO - "repo_path": "releases/mozilla-beta", 08:38:21 INFO - "revision": "fcc6c261b2c9df3684bc6cd347437dc336ab0335", 08:38:21 INFO - "stage_platform": "macosx64", 08:38:21 INFO - "builduid": "c8f157b062b346bfac7781f0e4abe510", 08:38:21 INFO - "slavebuilddir": "test" 08:38:21 INFO - } 08:38:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 08:38:21 INFO - Running post-action listener: _resource_record_post_action 08:38:21 INFO - [mozharness: 2017-04-28 15:38:21.860159Z] Finished read-buildbot-config step (success) 08:38:21 INFO - [mozharness: 2017-04-28 15:38:21.860363Z] Running download-and-extract step. 08:38:21 INFO - Running pre-action listener: _resource_record_pre_action 08:38:21 INFO - Running main action method: download_and_extract 08:38:21 INFO - mkdir: /builds/slave/test/build/tests 08:38: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')]} 08:38:21 INFO - trying https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 08:38:21 INFO - Downloading https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 08:38:23 INFO - Downloaded 1165 bytes. 08:38:23 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:38:23 INFO - Using the following test package requirements: 08:38:23 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:38:23 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:38:23 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 08:38:23 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:38:23 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 08:38:23 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:38:23 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:38:23 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 08:38:23 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:38:23 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:38:23 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 08:38:23 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:38:23 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 08:38:23 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:38:23 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 08:38:23 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:38:23 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 08:38:23 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 08:38:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:38:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:38:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:38:24 INFO - Expected file size: 51225729 08:38:24 INFO - Obtained file size: 51225729 08:38:40 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:38:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:38:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:38:40 INFO - Fetch https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:38:42 INFO - Expected file size: 51225729 08:38:42 INFO - Obtained file size: 51225729 08:38:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 08:38:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 08:38:56 INFO - Fetch https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 08:38:57 INFO - Expected file size: 14404449 08:38:57 INFO - Obtained file size: 14404449 08:38:58 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')]} 08:38:58 INFO - trying https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:38:58 INFO - Downloading https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 08:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 08:39:00 INFO - Downloaded 59541620 bytes. 08:39:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:39:00 INFO - mkdir: /builds/slave/test/properties 08:39:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:39:00 INFO - Writing to file /builds/slave/test/properties/build_url 08:39:00 INFO - Contents: 08:39:00 INFO - build_url:https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:39:01 INFO - Running post-action listener: _resource_record_post_action 08:39:01 INFO - Running post-action listener: set_extra_try_arguments 08:39:01 INFO - [mozharness: 2017-04-28 15:39:01.054505Z] Finished download-and-extract step (success) 08:39:01 INFO - [mozharness: 2017-04-28 15:39:01.054682Z] Running populate-webroot step. 08:39:01 INFO - Running pre-action listener: _resource_record_pre_action 08:39:01 INFO - Running main action method: populate_webroot 08:39:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:01 INFO - '--tppagecycles', 08:39:01 INFO - '7'], 08:39:01 INFO - 'tests': ['tsvgm']}}, 08:39:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:39:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:39:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:39:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:39:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:39:01 INFO - 'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:39:01 INFO - 'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['damp', 'tps']}, 08:39:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:39:01 INFO - 'tests': ['damp', 'tps']}, 08:39:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['dromaeo_dom']}, 08:39:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['basic_compositor_video']}, 08:39:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:39:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['a11yr', 08:39:01 INFO - 'ts_paint', 08:39:01 INFO - 'tpaint', 08:39:01 INFO - 'sessionrestore', 08:39:01 INFO - 'sessionrestore_no_auto_restore', 08:39:01 INFO - 'tabpaint']}, 08:39:01 INFO - 'other-e10s': {'tests': ['a11yr', 08:39:01 INFO - 'ts_paint', 08:39:01 INFO - 'tpaint', 08:39:01 INFO - 'sessionrestore', 08:39:01 INFO - 'sessionrestore_no_auto_restore', 08:39:01 INFO - 'tabpaint']}, 08:39:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:39:01 INFO - 'ts_paint', 08:39:01 INFO - 'tpaint', 08:39:01 INFO - 'sessionrestore', 08:39:01 INFO - 'sessionrestore_no_auto_restore', 08:39:01 INFO - 'tabpaint']}, 08:39:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:39:01 INFO - 'ts_paint', 08:39:01 INFO - 'tpaint', 08:39:01 INFO - 'sessionrestore', 08:39:01 INFO - 'sessionrestore_no_auto_restore', 08:39:01 INFO - 'tabpaint']}, 08:39:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['a11yr', 08:39:01 INFO - 'ts_paint', 08:39:01 INFO - 'tpaint', 08:39:01 INFO - 'sessionrestore', 08:39:01 INFO - 'sessionrestore_no_auto_restore', 08:39:01 INFO - 'tabpaint']}, 08:39:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['a11yr', 08:39:01 INFO - 'ts_paint', 08:39:01 INFO - 'tpaint', 08:39:01 INFO - 'sessionrestore', 08:39:01 INFO - 'sessionrestore_no_auto_restore', 08:39:01 INFO - 'tabpaint']}, 08:39:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['tsvgx', 08:39:01 INFO - 'tsvgr_opacity', 08:39:01 INFO - 'tart', 08:39:01 INFO - 'tscrollx', 08:39:01 INFO - 'cart', 08:39:01 INFO - 'tsvg_static']}, 08:39:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:39:01 INFO - 'tsvgr_opacity', 08:39:01 INFO - 'tart', 08:39:01 INFO - 'tscrollx', 08:39:01 INFO - 'cart', 08:39:01 INFO - 'tsvg_static']}, 08:39:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:39:01 INFO - 'talos_options': ['--disable-e10s'], 08:39:01 INFO - 'tests': ['tp5o']}, 08:39:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:39:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:39:01 INFO - 'talos_options': ['--disable-e10s', 08:39:01 INFO - '--xperf_path', 08:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:01 INFO - 'tests': ['tp5n']}, 08:39:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:39:01 INFO - 'talos_options': ['--xperf_path', 08:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:01 INFO - 'tests': ['tp5n']}}, 08:39:01 INFO - 'talos.zip': {'path': '', 08:39:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:01 INFO - Running post-action listener: _resource_record_post_action 08:39:01 INFO - [mozharness: 2017-04-28 15:39:01.073136Z] Finished populate-webroot step (success) 08:39:01 INFO - [mozharness: 2017-04-28 15:39:01.073256Z] Running create-virtualenv step. 08:39:01 INFO - Running pre-action listener: _resource_record_pre_action 08:39:01 INFO - Running main action method: create_virtualenv 08:39:01 INFO - Creating virtualenv /builds/slave/test/build/venv 08:39:01 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 08:39:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:39:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:01 INFO - Using real prefix '/tools/python27' 08:39:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:39:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:04 INFO - Installing pip.................done. 08:39:04 INFO - Return code: 0 08:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:39:05 INFO - Reading from file tmpfile_stdout 08:39:05 INFO - Output received: 08:39:05 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) 08:39:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:39:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:05 INFO - 'HOME': '/Users/cltbld', 08:39:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:05 INFO - 'LOGNAME': 'cltbld', 08:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:05 INFO - 'MOZ_NO_REMOTE': '1', 08:39:05 INFO - 'NO_EM_RESTART': '1', 08:39:05 INFO - 'PAGER': '/bin/cat', 08:39:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:05 INFO - 'PWD': '/builds/slave/test', 08:39:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:05 INFO - 'SHELL': '/bin/bash', 08:39:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:05 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:05 INFO - 'USER': 'cltbld', 08:39:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:05 INFO - 'XPC_FLAGS': '0x0', 08:39:05 INFO - 'XPC_SERVICE_NAME': '0', 08:39:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:05 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 08:39:05 INFO - Cleaning up... 08:39:05 INFO - Return code: 0 08:39:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:39:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:05 INFO - 'HOME': '/Users/cltbld', 08:39:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:05 INFO - 'LOGNAME': 'cltbld', 08:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:05 INFO - 'MOZ_NO_REMOTE': '1', 08:39:05 INFO - 'NO_EM_RESTART': '1', 08:39:05 INFO - 'PAGER': '/bin/cat', 08:39:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:05 INFO - 'PWD': '/builds/slave/test', 08:39:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:05 INFO - 'SHELL': '/bin/bash', 08:39:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:05 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:05 INFO - 'USER': 'cltbld', 08:39:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:05 INFO - 'XPC_FLAGS': '0x0', 08:39:05 INFO - 'XPC_SERVICE_NAME': '0', 08:39:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:05 INFO - Downloading/unpacking psutil>=3.1.1 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:09 INFO - Installing collected packages: psutil 08:39:09 INFO - Running setup.py install for psutil 08:39:09 INFO - building 'psutil._psutil_osx' extension 08:39:09 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 08:39:10 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 08:39:10 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 08:39:10 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 08:39:10 INFO - building 'psutil._psutil_posix' extension 08:39:10 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 08:39:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:39:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:39:10 INFO - ^ 08:39:10 INFO - 1 warning generated. 08:39:10 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 08:39:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:10 INFO - Successfully installed psutil 08:39:10 INFO - Cleaning up... 08:39:10 INFO - Return code: 0 08:39:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:10 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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:10 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 08:39:10 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 08:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:10 INFO - 'HOME': '/Users/cltbld', 08:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:10 INFO - 'LOGNAME': 'cltbld', 08:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:10 INFO - 'MOZ_NO_REMOTE': '1', 08:39:10 INFO - 'NO_EM_RESTART': '1', 08:39:10 INFO - 'PAGER': '/bin/cat', 08:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:10 INFO - 'PWD': '/builds/slave/test', 08:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:10 INFO - 'SHELL': '/bin/bash', 08:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:10 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:10 INFO - 'USER': 'cltbld', 08:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:10 INFO - 'XPC_FLAGS': '0x0', 08:39:10 INFO - 'XPC_SERVICE_NAME': '0', 08:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:39:10 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 08:39:10 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 08:39:10 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 08:39:10 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 08:39:10 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 08:39:10 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 08:39:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:13 INFO - Installing collected packages: mozsystemmonitor 08:39:13 INFO - Running setup.py install for mozsystemmonitor 08:39:13 INFO - Successfully installed mozsystemmonitor 08:39:13 INFO - Cleaning up... 08:39:13 INFO - Return code: 0 08:39:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:13 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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:13 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 08:39:13 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 08:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:13 INFO - 'HOME': '/Users/cltbld', 08:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:13 INFO - 'LOGNAME': 'cltbld', 08:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:13 INFO - 'MOZ_NO_REMOTE': '1', 08:39:13 INFO - 'NO_EM_RESTART': '1', 08:39:13 INFO - 'PAGER': '/bin/cat', 08:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:13 INFO - 'PWD': '/builds/slave/test', 08:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:13 INFO - 'SHELL': '/bin/bash', 08:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:13 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:13 INFO - 'USER': 'cltbld', 08:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:13 INFO - 'XPC_FLAGS': '0x0', 08:39:13 INFO - 'XPC_SERVICE_NAME': '0', 08:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:14 INFO - Downloading/unpacking jsonschema==2.5.1 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:17 INFO - warning: no files found matching '*.txt' 08:39:17 INFO - no previously-included directories found matching 'build' 08:39:17 INFO - no previously-included directories found matching 'dist' 08:39:17 INFO - no previously-included directories found matching '.git*' 08:39:17 INFO - Installing collected packages: jsonschema, functools32 08:39:17 INFO - Running setup.py install for functools32 08:39:17 INFO - warning: no files found matching '*.txt' 08:39:17 INFO - no previously-included directories found matching 'build' 08:39:17 INFO - no previously-included directories found matching 'dist' 08:39:17 INFO - no previously-included directories found matching '.git*' 08:39:17 INFO - Successfully installed jsonschema functools32 08:39:17 INFO - Cleaning up... 08:39:17 INFO - Return code: 0 08:39:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', '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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:39: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 functools32==3.2.3-2 08:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:17 INFO - 'HOME': '/Users/cltbld', 08:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:17 INFO - 'LOGNAME': 'cltbld', 08:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:17 INFO - 'MOZ_NO_REMOTE': '1', 08:39:17 INFO - 'NO_EM_RESTART': '1', 08:39:17 INFO - 'PAGER': '/bin/cat', 08:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:17 INFO - 'PWD': '/builds/slave/test', 08:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:17 INFO - 'SHELL': '/bin/bash', 08:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:17 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:17 INFO - 'USER': 'cltbld', 08:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:17 INFO - 'XPC_FLAGS': '0x0', 08:39:17 INFO - 'XPC_SERVICE_NAME': '0', 08:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:39:17 INFO - Cleaning up... 08:39:17 INFO - Return code: 0 08:39:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', '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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:39: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 blobuploader==1.2.4 08:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:17 INFO - 'HOME': '/Users/cltbld', 08:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:17 INFO - 'LOGNAME': 'cltbld', 08:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:17 INFO - 'MOZ_NO_REMOTE': '1', 08:39:17 INFO - 'NO_EM_RESTART': '1', 08:39:17 INFO - 'PAGER': '/bin/cat', 08:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:17 INFO - 'PWD': '/builds/slave/test', 08:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:17 INFO - 'SHELL': '/bin/bash', 08:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:17 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:17 INFO - 'USER': 'cltbld', 08:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:17 INFO - 'XPC_FLAGS': '0x0', 08:39:17 INFO - 'XPC_SERVICE_NAME': '0', 08:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:18 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 08:39:18 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 08:39:18 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 08:39:18 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 08:39:18 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 08:39:18 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 08:39:20 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:22 INFO - Downloading docopt-0.6.1.tar.gz 08:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:22 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:22 INFO - Running setup.py install for blobuploader 08:39:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:22 INFO - Running setup.py install for requests 08:39:22 INFO - Running setup.py install for docopt 08:39:22 INFO - Successfully installed blobuploader requests docopt 08:39:22 INFO - Cleaning up... 08:39:23 INFO - Return code: 0 08:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:23 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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:23 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 08:39:23 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 08:39:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:23 INFO - 'HOME': '/Users/cltbld', 08:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:23 INFO - 'LOGNAME': 'cltbld', 08:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:23 INFO - 'MOZ_NO_REMOTE': '1', 08:39:23 INFO - 'NO_EM_RESTART': '1', 08:39:23 INFO - 'PAGER': '/bin/cat', 08:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:23 INFO - 'PWD': '/builds/slave/test', 08:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:23 INFO - 'SHELL': '/bin/bash', 08:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:23 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:23 INFO - 'USER': 'cltbld', 08:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:23 INFO - 'XPC_FLAGS': '0x0', 08:39:23 INFO - 'XPC_SERVICE_NAME': '0', 08:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uewoRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-FN_efT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-QGbyXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-S6s9X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-AfuKDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-1szPzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-LwGvR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-eyINM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-o19nND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-68LAKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-YFyi_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-HOTxpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0G_aGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-rdMjyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-LTxxzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-nRjC6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uVXrDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:25 INFO - Running setup.py install for manifestparser 08:39:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:25 INFO - Running setup.py install for mozcrash 08:39:25 INFO - Running setup.py install for mozdebug 08:39:25 INFO - Running setup.py install for mozdevice 08:39:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:25 INFO - Running setup.py install for mozfile 08:39:25 INFO - Running setup.py install for mozhttpd 08:39:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:25 INFO - Running setup.py install for mozinfo 08:39:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:26 INFO - Running setup.py install for mozInstall 08:39:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:26 INFO - Running setup.py install for mozleak 08:39:26 INFO - Running setup.py install for mozlog 08:39:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:26 INFO - Running setup.py install for moznetwork 08:39:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:26 INFO - Running setup.py install for mozprocess 08:39:26 INFO - Running setup.py install for mozprofile 08:39:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:27 INFO - Running setup.py install for mozrunner 08:39:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:27 INFO - Running setup.py install for mozscreenshot 08:39:27 INFO - Running setup.py install for moztest 08:39:27 INFO - Running setup.py install for mozversion 08:39:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:27 INFO - Cleaning up... 08:39:27 INFO - Return code: 0 08:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:27 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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:27 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 08:39:27 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 08:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:27 INFO - 'HOME': '/Users/cltbld', 08:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:27 INFO - 'LOGNAME': 'cltbld', 08:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:27 INFO - 'MOZ_NO_REMOTE': '1', 08:39:27 INFO - 'NO_EM_RESTART': '1', 08:39:27 INFO - 'PAGER': '/bin/cat', 08:39:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:27 INFO - 'PWD': '/builds/slave/test', 08:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:27 INFO - 'SHELL': '/bin/bash', 08:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:27 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:27 INFO - 'USER': 'cltbld', 08:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:27 INFO - 'XPC_FLAGS': '0x0', 08:39:27 INFO - 'XPC_SERVICE_NAME': '0', 08:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:27 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zLRotK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-A6y9Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zSukH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-toPZC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-whLSpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-AUm_hT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-xBXecO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-qqeX3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-YPmAI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:28 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)) 08:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-OA77D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:29 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)) 08:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-HtUoFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:29 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)) 08:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-mrKn_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-rZKVwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:29 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)) 08:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-gA5UO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:29 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)) 08:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Fghs74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:29 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)) 08:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-mCJWWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-92UodK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:29 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)) 08:39:29 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)) 08:39:29 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)) 08:39:29 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)) 08:39:29 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)) 08:39:29 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)) 08:39:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:29 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 08:39:29 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 08:39:29 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 08:39:29 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 08:39:29 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 08:39:29 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 08:39:32 INFO - Downloading blessings-1.6.tar.gz 08:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:32 INFO - Installing collected packages: blessings 08:39:32 INFO - Running setup.py install for blessings 08:39:32 INFO - Successfully installed blessings 08:39:32 INFO - Cleaning up... 08:39:32 INFO - Return code: 0 08:39:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:33 INFO - Reading from file tmpfile_stdout 08:39:33 INFO - Current package versions: 08:39:33 INFO - blessings == 1.6 08:39:33 INFO - blobuploader == 1.2.4 08:39:33 INFO - docopt == 0.6.1 08:39:33 INFO - functools32 == 3.2.3-2 08:39:33 INFO - jsonschema == 2.5.1 08:39:33 INFO - manifestparser == 1.1 08:39:33 INFO - mozInstall == 1.12 08:39:33 INFO - mozcrash == 1.0 08:39:33 INFO - mozdebug == 0.1 08:39:33 INFO - mozdevice == 0.49 08:39:33 INFO - mozfile == 1.2 08:39:33 INFO - mozhttpd == 0.7 08:39:33 INFO - mozinfo == 0.9 08:39:33 INFO - mozleak == 0.1 08:39:33 INFO - mozlog == 3.4 08:39:33 INFO - moznetwork == 0.27 08:39:33 INFO - mozprocess == 0.25 08:39:33 INFO - mozprofile == 0.28 08:39:33 INFO - mozrunner == 6.13 08:39:33 INFO - mozscreenshot == 0.1 08:39:33 INFO - mozsystemmonitor == 0.3 08:39:33 INFO - moztest == 0.8 08:39:33 INFO - mozversion == 1.4 08:39:33 INFO - psutil == 3.1.1 08:39:33 INFO - requests == 1.2.3 08:39:33 INFO - wsgiref == 0.1.2 08:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:33 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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:33 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 08:39:33 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 08:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:33 INFO - 'HOME': '/Users/cltbld', 08:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:33 INFO - 'LOGNAME': 'cltbld', 08:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:33 INFO - 'MOZ_NO_REMOTE': '1', 08:39:33 INFO - 'NO_EM_RESTART': '1', 08:39:33 INFO - 'PAGER': '/bin/cat', 08:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:33 INFO - 'PWD': '/builds/slave/test', 08:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:33 INFO - 'SHELL': '/bin/bash', 08:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:33 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:33 INFO - 'USER': 'cltbld', 08:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:33 INFO - 'XPC_FLAGS': '0x0', 08:39:33 INFO - 'XPC_SERVICE_NAME': '0', 08:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 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)) 08:39:33 INFO - Cleaning up... 08:39:33 INFO - Return code: 0 08:39:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:33 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 0x1050d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80524d0ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, '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.DbWytlfJMk/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.49pIFhATea/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 08:39:33 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 08:39:33 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 08:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:33 INFO - 'HOME': '/Users/cltbld', 08:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:33 INFO - 'LOGNAME': 'cltbld', 08:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:33 INFO - 'MOZ_NO_REMOTE': '1', 08:39:33 INFO - 'NO_EM_RESTART': '1', 08:39:33 INFO - 'PAGER': '/bin/cat', 08:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:33 INFO - 'PWD': '/builds/slave/test', 08:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:33 INFO - 'SHELL': '/bin/bash', 08:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:33 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:33 INFO - 'USER': 'cltbld', 08:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:33 INFO - 'XPC_FLAGS': '0x0', 08:39:33 INFO - 'XPC_SERVICE_NAME': '0', 08:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:39:33 INFO - Cleaning up... 08:39:33 INFO - Return code: 0 08:39:33 INFO - Running post-action listener: _resource_record_post_action 08:39:33 INFO - Running post-action listener: _start_resource_monitoring 08:39:33 INFO - Starting resource monitoring. 08:39:33 INFO - [mozharness: 2017-04-28 15:39:33.587863Z] Finished create-virtualenv step (success) 08:39:33 INFO - [mozharness: 2017-04-28 15:39:33.588824Z] Running install step. 08:39:33 INFO - Running pre-action listener: _resource_record_pre_action 08:39:33 INFO - Running main action method: install 08:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:33 INFO - Reading from file tmpfile_stdout 08:39:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:33 INFO - Reading from file tmpfile_stdout 08:39:33 INFO - Output received: 08:39:33 INFO - Usage: mozinstall [options] installer 08:39:33 INFO - Options: 08:39:33 INFO - -h, --help show this help message and exit 08:39:33 INFO - -d DEST, --destination=DEST 08:39:33 INFO - Directory to install application into. [default: 08:39:33 INFO - "/builds/slave/test"] 08:39:33 INFO - --app=APP Application being installed. [default: firefox] 08:39:33 INFO - mkdir: /builds/slave/test/build/application 08:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:39:49 INFO - Reading from file tmpfile_stdout 08:39:49 INFO - Output received: 08:39:49 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:39:49 INFO - Running post-action listener: _resource_record_post_action 08:39:49 INFO - [mozharness: 2017-04-28 15:39:49.191418Z] Finished install step (success) 08:39:49 INFO - [mozharness: 2017-04-28 15:39:49.191544Z] Running run-tests step. 08:39:49 INFO - Running pre-action listener: _resource_record_pre_action 08:39:49 INFO - Running main action method: run_tests 08:39:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:39:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:39:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:39:49 INFO - 2017-04-28 08:39:49.205 screenresolution[1627:7664] starting screenresolution argv=screenresolution get 08:39:49 INFO - 2017-04-28 08:39:49.208 screenresolution[1627:7664] Display 0: 1600x1200x32@60 08:39:49 INFO - 2017-04-28 08:39:49.214 screenresolution[1628:7666] starting screenresolution argv=screenresolution list 08:39:49 INFO - Available Modes on Display 0 08:39:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:39:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:39:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:39:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:39:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:39:49 INFO - Intel Iris: 08:39:49 INFO - Chipset Model: Intel Iris 08:39:49 INFO - Type: GPU 08:39:49 INFO - Bus: Built-In 08:39:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:39:49 INFO - Vendor: Intel (0x8086) 08:39:49 INFO - Device ID: 0x0a2e 08:39:49 INFO - Revision ID: 0x0009 08:39:49 INFO - Displays: 08:39:49 INFO - Display: 08:39:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:39:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:39:49 INFO - Display Serial Number: 1600x1200 60 08:39:49 INFO - Main Display: Yes 08:39:49 INFO - Mirror: Off 08:39:49 INFO - Online: Yes 08:39:49 INFO - Rotation: Supported 08:39:49 INFO - Return code: 0 08:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:49 INFO - Python 2.7.3 08:39:49 INFO - Return code: 0 08:39:49 INFO - grabbing minidump binary from tooltool 08:39:49 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')]} 08:39:49 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 0x104eb2d30>, '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 0x104dd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ea7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:49 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 08:39:49 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 08:39:49 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 08:39:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:49 INFO - Return code: 0 08:39:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:39:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:49 INFO - ENV: RUST_BACKTRACE is now 1 08:39:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:39:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 08:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 08:39:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbWytlfJMk/Render', 08:39:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:49 INFO - 'HOME': '/Users/cltbld', 08:39:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:49 INFO - 'LOGNAME': 'cltbld', 08:39:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:49 INFO - 'MOZ_NO_REMOTE': '1', 08:39:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:49 INFO - 'NO_EM_RESTART': '1', 08:39:49 INFO - 'PAGER': '/bin/cat', 08:39:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:49 INFO - 'PWD': '/builds/slave/test', 08:39:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:49 INFO - 'RUST_BACKTRACE': '1', 08:39:49 INFO - 'SHELL': '/bin/bash', 08:39:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.49pIFhATea/Listeners', 08:39:49 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 08:39:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:49 INFO - 'USER': 'cltbld', 08:39:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:49 INFO - 'XPC_FLAGS': '0x0', 08:39:49 INFO - 'XPC_SERVICE_NAME': '0', 08:39:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 08:39:49 INFO - mozversion application_buildid: 20170428071321 08:39:49 INFO - mozversion application_changeset: fcc6c261b2c9df3684bc6cd347437dc336ab0335 08:39:49 INFO - mozversion application_display_name: Firefox 08:39:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:49 INFO - mozversion application_name: Firefox 08:39:49 INFO - mozversion application_remotingname: firefox 08:39:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:39:49 INFO - mozversion application_vendor: Mozilla 08:39:49 INFO - mozversion application_version: 54.0 08:39:49 INFO - mozversion platform_buildid: 20170428071321 08:39:49 INFO - mozversion platform_changeset: fcc6c261b2c9df3684bc6cd347437dc336ab0335 08:39:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:39:49 INFO - mozversion platform_version: 54.0 08:39:49 INFO - using testdate: 1493393989 08:39:49 INFO - actual date: 1493393989 08:39:49 INFO - starting webserver on 'localhost:49231' 08:39:49 INFO - SUITE-START | Running 2 tests 08:39:49 INFO - TEST-START | dromaeo_css 08:39:49 INFO - operating with platform_type : mac_ 08:39:49 INFO - Initialising browser for dromaeo_css test... 08:39:49 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpyhhRoG/profile http://localhost:49231/getInfo.html) 08:39:52 INFO - PROCESS | 1638 | 2017-04-28 08:39:52.796 plugin-container[1641:7849] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 08:39:52 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:39:52 INFO - PROCESS | 1638 | 2017-04-28 08:39:52.797 plugin-container[1641:7849] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x901b, name = 'com.apple.CFPasteboardClient' 08:39:52 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:39:52 INFO - PROCESS | 1638 | 2017-04-28 08:39:52.797 plugin-container[1641:7849] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:39:52 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 08:39:52 INFO - PROCESS | 1638 | colorDepth:24 08:39:52 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 08:39:52 INFO - PROCESS | 1638 | __metrics 08:39:52 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 08:39:53 INFO - TEST-INFO | 1638: exit 0 08:39:53 INFO - Browser initialized. 08:39:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:53 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpyhhRoG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:56 INFO - PROCESS | 1642 | 2017-04-28 08:39:56.082 plugin-container[1643:7976] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 08:39:56 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:39:56 INFO - PROCESS | 1642 | 2017-04-28 08:39:56.083 plugin-container[1643:7976] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460f, name = 'com.apple.CFPasteboardClient' 08:39:56 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:39:56 INFO - PROCESS | 1642 | 2017-04-28 08:39:56.083 plugin-container[1643:7976] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:40:05 INFO - PROCESS | 1642 | RSS: Main: 174530560 08:40:05 INFO - PROCESS | 1642 | 08:43:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49231/tests/dromaeo/cssquery-ext.html) 08:43:10 INFO - PROCESS | 1642 | RSS: Main: 189538304 08:43:10 INFO - PROCESS | 1642 | 08:46:13 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-ext.html (next: http://localhost:49231/tests/dromaeo/cssquery-jquery.html) 08:46:13 INFO - PROCESS | 1642 | RSS: Main: 201797632 08:46:13 INFO - PROCESS | 1642 | 08:49:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49231/tests/dromaeo/cssquery-mootools.html) 08:49:16 INFO - PROCESS | 1642 | RSS: Main: 204660736 08:49:16 INFO - PROCESS | 1642 | 08:52:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49231/tests/dromaeo/cssquery-prototype.html) 08:52:18 INFO - PROCESS | 1642 | RSS: Main: 207785984 08:52:18 INFO - PROCESS | 1642 | 08:55:21 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49231/tests/dromaeo/cssquery-yui.html) 08:55:22 INFO - PROCESS | 1642 | RSS: Main: 210231296 08:55:22 INFO - PROCESS | 1642 | 08:58:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-yui.html (next: http://localhost:49231/tests/dromaeo/cssquery-dojo.html) 08:58:25 INFO - PROCESS | 1642 | RSS: Main: 208220160 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | __start_tp_report 08:58:25 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 08:58:25 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 08:58:25 INFO - PROCESS | 1642 | |i|pagename|runs| 08:58:25 INFO - PROCESS | 1642 | |0;dojo.html;3565.679088882001;3649.069487280741;3675.3751862183426;3689.4834723138765;3698.1309392292815;6194.876102477948;6200.193974783283;6200.255969283687;6210.875782484359;6244.500439964803;5995.490383317423;6204.596701214418;6217.253929528451;6220.942439785236;6247.6251424914535;5539.806106786264;5587.273654424919;5589.972050139764;5616.354119276295;5677;5656.264685590867;5659.405762394951;5665.915011274834;5677.034904066319;5692.203091567184;5433.565314774828;5458.9454105459035;5638.887222255553;5656.434356564352;5686.971565142168;5585.525230355404;5629.380768115504;5637.900609381193;5660.094384898438;5675.5459563234845;5495.697736624484;5622.887542249173;5633.774649014034;5636;5684.147377893308;6007.639541627516;6232.968835155795;6254.562180647356;6286.434220920093;6305.96847015762;5270.92093618596;6394.200724909387;6606.93393066068;6627.039079333518;6642.003699445074;6796.762113326059;6803.761868334634;6812.386885180357;6815.897761533532;6827.044213810071;6290.370962903673;6309.337519560472;6338.714757835908;6342.048692696132;6353.142325786006;6592.9340706593275;6629.337066293332;6634.469242460592;6829.112215411965;6879.449644028466;6567.211934567882;6578.27638959714;6608.405243528009;6614.305497922649;6627.3372662733345;6659.134312539436;6773.8983915241315;6784.3554862288;6804.965975170093;6808.93191068083;6052.939470605325;6318.494520438354;6657.933420665731;6704.363085506869;6722.495812813961;6567.835804104936;6581.605103693793;6683.832904177434;6688.799336019927;6711.429528490035;5309.522143007148;5321.175217841241;5336.012837625051;5336.332958380202;5356.276902618097;4590.724556526619;4682.274247491644;4720.693154944917;4745.715257084517;4752.881177970509;6245.000799871998;6287.025511045796;6316.431521163117;6366.204224471941;6392.7123279452535;6810.148731408574;6818.795436136924;6840.828979275558;6846.760363387258;6862.416694581017;6213.65824879627;6239;6274.121622972787;6310.4005119514495;6363.681815909279;5495.175723641486;5558.221848941152;5997.910031349533;6028.638281703112;6064.181335519648;6961.93038069623;6983.755568554974;7015.403690686145;7030.648467576703;7052.400545953651;6069.423404776539;6178;6511.902321465276;6622.867542649024;6837.555558888656;6916;6967.442604591519;6968.721251149897;6985.615791131537;6990.126234220723;5665.235193248858;6653.700583473658;6661.4337781287195;6664.50016248793;6672.633005184762;6410.743570257324;6481.189851268591;6649.900251496135;6679.165104361955;6765;6433.613983161025;6469.644169570531;6470.223573171062;6483.902741458787;6498.155239818793;6546.312637173029;6561.80314590563;6572.079908812674;6585.308542603149;6596.901046484402;6108.4807791338235;6215.098810672337;6411.93588064132;6428.517861160525;6444.838879027874;6332.683365831782;6475.222973243241;6499.38255865692;6519.054737063194;6526.67366631657;6386.233651961795;6393.073004414427;6405.295417504164;6411.6153030818305;6449.677516124269 08:58:25 INFO - PROCESS | 1642 | |1;ext.html;780.3562061299426;817.4563914996528;836.9539675317859;986.8273052215865;987.9160271376933;35478;38374.80812595937;40417;40444;40623.59376406235;27875.442491150166;36102.8194859026;39288.607113928854;39394;39514.81455556338;8196.877046844302;8347.040090389592;11139.220254582142;11381.544738210461;11566.42167891602;11201.887981120206;11288.040516556062;11294.943525282362;11298.491567879466;11376.203665743402;9494.952525237364;11244.437778111103;11271.943640281786;11300.660980170607;11302.095832333394;11228.382438965853;11254.09967202626;11265.943670281678;11267.605633802777;11268.943655281711;10980.231383803137;10997.61508347212;11040.834387484194;11049.447527623586;11106.278091924;34042.6595734042;34195.82902085473;34198.316033679184;34380.48429273563;34392;3629.239305459326;3665.4685070664873;3896.2207558488417;3965.167314863882;3991.720579559432;25393.49213015748;25918;26664.46671066587;26833.46333073347;26857.73142268572;3152.1489197916662;3189.01140646398;3318.303156337172;3381.9492707609406;3387.4241378965635;319372.9999999977;363915;366016;381241;381695;42475;42568;42642.14715705669;42664;42696.35955460671;43488.78255608702;43609.56390436055;43978.56021439745;44129;44182.55817441849;13920.651983700285;14021.9483538735;14042.929785351007;14049.438022479191;14070.366833492517;12105.970992465738;12216.389180540937;12393.504259829686;12399.876001239872;12406.75186496265;9438;9998;11471.713207169887;11555.88444115565;11589.942050289694;4752.168370535212;5626.549876009909;5658.660480371191;5678.971605141948;5686.237266447414;1128.5090985421368;1155.8439610652454;1188.2276520261898;1200.6578125234441;1205.0901569315286;26010.86994565015;26262.080827170957;26301.47397052048;26340.60489092665;26444;1063.7659714862718;1276.4702648400996;1285.7878450055637;1330.7538105450524;1334.2794890758883;12833.550825721055;14533.78199327011;15971.520854374387;15972.361105555648;16016.75974860378;501768;503817;505350;505587;505750;57343.85312293731;57467.13799293014;57548.71225643845;57628.71185644045;57761;1466.8533146685459;1517.0442621148607;1523.535321726884;1532.9386824527116;1537.2928452911785;24078.638820417356;26367.07715229958;27421.58867617027;28325;30040.84979575088;43752.56247437612;43779.343309851014;43817.56182438135;43929;43980;500397;500889;501376.98623013304;502329;503505;26861.731382685924;27430.725692742817;31052.53421198729;31888.36223275568;32299.51550726788;38861.8341449757;42955;44098.77950610226;44719.329210062526;45967.85080373017;29056.418871622027;30410.087697369116;30657.386852262385;31484.89802856889;31746.523802142525;26308.605370919067;30618.387632247675;30696.07911762651;30756.538651919793;31511.684883151793;35730.928072157876;36561.26877462383;36815.44776828403;37079.814600926824;37187.628123718416;30433.543496847124;30443.695563044086;30456;31110;31436.528452073693;21518.354449366543;23979.28062158138;24413.63379549344;25065.373365666004;25108.24675259745 08:58:25 INFO - PROCESS | 1642 | |2;jquery.html;410.9650679692226;415.4702753988666;417.6262245290465;428.1223491841724;463.4137815663187;20927.895360523195;21007.894960525195;21662.566748665016;21922.342329730094;22454.663180052292;21741.45646358838;23182.840857957075;23602.055917763268;23879.641805372932;24085.15701950432;6207.944649409588;6775.59346439214;6897;7056.682449289769;7064;6835.658217089126;7004.474664400165;7017.929820701779;7023.82440438988;7026.43788496919;6634.369734875179;6893.276205998373;6953.652317384136;6956.165260168762;6970.54691445057;5517.862053448655;6802.931970680329;6842.65786710665;6848.486363522756;6938.653067346638;6715.7985260442265;6716.261211266757;6734.292899245606;6753.8649227015185;6754.155730533684;27179.592306115424;27862.721372786214;27865.16404507868;27900.720992790015;27920.464374459396;3022.3804120155314;3128.874845006197;3425.451927691582;3530.876419325337;3557.4485954677066;16408.67182656352;17253.577264936866;17391;17813.910930445396;17974.820251797577;2170.3505335944637;2279.293419040103;2408.783209511135;2425.6967879015124;2441.1944058460845;90460;136897;138820;162062;162436.75126497523;19587.314443994677;19788.802111978697;21043.790402007875;21102.864259028644;21258.25596104129;30115.849420752755;30812.38375232483;30830.075097747103;30831.383372332428;30937.8453107733;8783.516906570072;10726.570937162425;10738.550295710136;10741.51663175159;11068.833967490495;8090.624593819065;8703.608337624823;9047.230985366186;9176.6788162414;9356.95321523388;8564.843746094322;9434.528273586293;9664.855027174597;9708.417494950325;9785.755356116155;4153.210889930964;4244.278472659656;4260.936085958713;4262.211490874198;4280.914381712349;1034.043509753475;1038.5482315192914;1059.5179193467109;1080.8324709670014;1090.4983707494482;19174.61650766977;21782.89108554447;22122.33632991013;22226.777732222796;22240;1095.8739744929276;1100.3947828694186;1101.8898110188918;1142.6286456901373;1147.5753971030606;10839.916008399256;11405.714857128638;11438.771224575461;11506.827397589042;11570.826437603442;789754;795517;795991;813048;822766;125239.3738031304;126899;138670.53323666786;152176.2391188037;157254;1207.2334067866968;1226.9815952760537;1269.5620011096157;1273.8471383434048;1303.1464390824026;19673.21307147698;20715.58568828585;20719.378418647466;20768.273110441667;21369.465763356042;65795.67102164458;66701.33298666951;67018.66490667516;67654;67947;64676.353236468916;89606;96254;96910.03089969292;97775;11006.394648294421;11419.885801141882;11729.706757330794;11899.643010709693;12010.219335743148;13254.53609123676;13295.534656286984;13618.319084045559;13626.386812593259;13648.795268070788;9392.906070939203;11218.943905280421;11614.419279035845;11888.96831308011;12019.09856760764;10665.306755060896;10685.626003089854;10772.730681732706;10802.67591972242;10977.890221098007;11656.825147622962;11657.825132623188;11776.175667703179;11984.221025633306;12127.81808272859;11686.298822070703;11910;11945.4027298633;12004;12044.638660840188;11566;11619.883801161881;11755.647330580096;11881.643550693492;11947.94026029899 08:58:25 INFO - PROCESS | 1642 | |3;mootools.html;1497.326203208556;1622.2456557700666;1645.7037733208026;1648.9752653710195;1661.2773443552048;8518.787030324245;9877.753056173598;11375;12030.639080827566;12058.155929084956;11306.434678266094;11698.356590387526;11702.180847340669;11704.882951170486;11725.179237453382;2488.3281513991255;2516.748325167487;2517.446161844391;2519.59686450168;2534.797216222707;2469.0247352295924;2504.499100179962;2517.854376258798;2520.823542352036;2521.3318470605213;2467.925962221136;2492.476579918219;2494.1270555305587;2495.42605200803;2527.671402717644;2338.356951838241;2343.625019996801;2354.258408601302;2356.71719393673;2364.2788949370433;2018.777934427212;2371.4190023444194;2392.9760702392928;2398.0647547456506;2410.349205714447;11798.233114847508;11973.880261197452;12038.879611203864;12062.879371206263;12073.517059317617;5883.146943693183;6012.248468941382;6203.968980155116;6206.472449841769;6224.439800417938;3201.3917355702342;3696.6303369663087;3817.866374676873;3895.2793733159456;3917.843286268546;1244.296972210698;1262.1291308996763;1298.0135097326006;1308.542010296398;1310.3710219094887;13386.531471398454;16278.918605407016;16352.509424717278;16373.263203155886;16409;4736.621070314435;4927.605791536668;4970.602351811846;4975.253711943165;4996.400431948189;12120.878791212152;12131;12144.210626309437;12162.270263784201;12190.268583884817;5988.550858685616;6078.513718902477;6084.117802918552;6085.482733967574;6102.572819902564;5302.443243459381;5570.387257401763;5611.607187496836;5620.241267428926;5627.606067575312;3961.6053267930583;4081.285774989365;4098.364753463218;4138.710290279711;4142.357934520154;1084.7830433913248;1093.6882988348282;1096.4572536594437;1101.8292164714483;1107.1806862921542;944.1785646487463;958.3579002068631;964.19008033251;976.9853452198223;1003.5584342889251;6802.421794147553;6875.5874647521305;6934.861302773917;6988.650567471606;7042.507024508338;983.8524221366853;1021.1473419694638;1027.1782573940818;1046.0951277145366;1055.9736006599896;3342.3148254607745;4153.335466325434;4272.188284225987;4294;4364.1053584015835;13569.457221711022;14303.78544321836;14336.498222562368;14340.139591624327;14343.354549045318;11916.404179790976;13981.510647127505;14174.503892363718;14236.572902812932;14255.64360890986;10013.649522266685;10257.38455692646;10336.483175841178;10438.791224175475;10479.528421221063;6594.208694956636;6663.633500157538;6732.932670673426;6744.595324280559;6800.52396332252;12478.563250286197;12521.624351269476;12734.917532009882;12903.612891613267;12961.805572916603;12929.288889111189;13106.73786524245;13115.409806558919;13143.408546615616;13240.933795330962;9365.531723413666;9564.4739539326;9688.273379496424;9693.22454203648;9715.757106072404;9003.459792412476;10239.078482936571;10550.103241224582;10639.202059845387;10736.409497477402;8987.056359082202;9053.275737940818;9120.635174593208;9124.726258212264;9243.907560924305;8830.337724670548;8836.204741573289;8850.424722393023;8899.021107678022;8927.910720892707;6985.5808651481075;8147.3482121431325;8331.916680833114;8347.415680902279;8360.70737524208;6099.329073801967;6122.173506576555;6131.294901086254;6262.561620686691;6312.968435157978;6034.909476357946;6196.721147548281;6220.34686357944;6225.315215326401;6295.779647712308 08:58:25 INFO - PROCESS | 1642 | |4;prototype.html;385.1776457263743;386.89167033230706;390.43776961175905;402.05717592246174;402.2076509276724;4404.757738324391;5198.922016169756;5252.422233554311;5290.603204759644;5407.648502847313;4279.0799978004725;4820.084184005045;4837.709737415757;5084.949150508503;5097.362829646294;3854.5567259765207;4071.3332767037637;4263.786810659471;4272.974486123331;4349.586789255031;4328.913421731563;4345.283028300342;4352.368906508555;4352.912941741163;4370.3996122307335;3864.613538646127;4352.97823510882;4363.694541382105;4366.689993002103;4384.89037774055;3922.548906875703;4092.3247664135383;4173.061061261223;4279.646194592961;4322.913541729179;3385.779924304937;3953.604639536052;3972.642462178389;3974.1455587048636;3987.6211759882763;4082.326416141333;5091.567216786578;5109.948900511022;5126.308318254967;5185.818496352609;4433.800478978454;4797.6326746876975;5083.085044691954;5105.872353191163;5117.104506711348;4591.724496530219;5592.049351610236;5610;5619.634723742944;5660.547156227533;3552.8223588820715;3762.9623703762886;4343.131373725268;4482.7310361378095;4516.345129956138;4490.59584637381;5199.852146375099;5976.402359764033;5992.310884248323;6064.636121832704;4502.324651302265;4552.453705555288;4558.658100642465;4560.908781824345;4572.239687720185;3662.6154253802965;4625;4645.535446455395;4658.5293956003;4671.392718946515;4072.8778136655947;4141.52372477169;4509.616682581952;4593.586577208001;4700.6944548604915;4591.678582499259;4875.878103047452;5040;5299.29735834727;5430.5384042356845;1400.5938277899295;1453.4404254361934;1544.2278860569716;1558.680470503544;1579.6919600677757;1099.9230053896151;1127.6617014895662;1182.43243243242;1188.2276520261726;1227.864934857165;4430.601245887886;4644.86065418038;5306.469353064663;5310.221075939604;5386.649867758583;5297.807993201499;5367.409584945653;5487.9298536784945;5607.915881261784;5774.632400715686;4504.954950450519;4630.536946305342;4777.163996300634;4976.23818780573;5364.973175134178;2688.637034000424;2796.51061064317;2880.286229693371;3013.758899288052;3032.848357582112;5991.940080599225;5996.400359963969;6032.638041717511;6033.758649653964;6039.218430562994;5518.724063796794;5536.058869992111;5665.518430933417;5764.193012978187;5990.7004649768205;5734.283214598176;5738.9139162913425;5833.329167145747;6054.66699331541;6084.939150608526;4920.507949205051;5729.3984131665575;5829.358770535153;5830.62100963453;5994.9317485467445;4827.493113223201;5454.8909021818545;5665.405132461032;5671.136076281451;5725.770969161187;5551.861203469945;5611.943880561143;5781.682007489629;5996.910046349395;6034.409526331826;3891.9178239641656;4145.66834653221;4551.38556294896;4559.908801824011;4566.360709500606;5477.67133971963;5724.313082429969;5734.627249228787;5759.510441612342;5761.5102716269585;4753.786079626356;4976.328195693535;5581.302337207849;5631.267935168402;5655.434456554476;4707.4821769606;4855.927161092657;4861.9546797438725;5572.972135139298;5675.404082571271;4680.672352935262;4682.695624784378;5101.846944591668;5408.891822163613;5480.862978425571;5219.295395121761;5396.487333703292;5529.944700552943;5586.52514536269;5590.496855283044;4833.830815921426;4835.564799168092;4843.4430040545785;5294.814681486129;5454.727263636882 08:58:25 INFO - PROCESS | 1642 | |5;yui.html;764.4343186042327;769.6267310354481;793.5675057093887;885.6413152673167;893.991060089399;15807.525774226777;16491.505254842345;16906.577335566602;17154.313827446902;18219.18013689384;16322.183890805472;16394.754078688828;16415.868673050627;16707.248173832177;16725;978.5449765858874;1004.3471743366797;1007.7682133109389;1007.8891321954579;1013.3058854684527;968.8837339519267;992.5533509920529;996.5714742660653;997.7455748784087;1024.733569271991;903.336048004716;1045.9267851250415;1057.9418132002736;1062.3572738493217;1065.5524679634534;1053.5943661690267;1059.332620449116;1060.5810704771611;1060.6340812419703;1061.5912873543664;784.2823816208163;784.4626430894798;788.0425283280841;788.0740130346819;789.0373744032271;13988.370523326475;14567.854321456862;16897.15514224284;18372.17325220355;18619.255229790793;13334.333283335794;13356.666083347896;13503.852172565345;15037.699246015018;15455.845441545665;10087.193024558017;11364.602238921681;11812.468438920268;11949.522019119226;12448.439820208112;4394.4067550880545;4450.176717307276;4503.369528266046;4528.637708983273;4663.696859704142;97213;101109.49445252727;103190.48404758003;108104.4594777029;108969;10026.448545329931;11359.432028398547;11394.829077563843;11418.486168122288;11703.648890533297;19198.712019319722;22763.772362276497;23229.651555226686;23487.295381138592;23541.411464713517;8354.87467687973;8462.280706139923;8491.787705307417;8620.396572239883;8631.223189912938;4673.95326046742;4732.858014259577;4741.359916411309;4753.5959443447;4895.31465594817;3694.519712437366;3785.7917814520465;3788.6969042477085;3807.428885667117;3820.2932457495453;682.4335801284922;733.3802936518633;765.0933643632313;778.6184769462923;780.6409051836106;667.696198229814;692.840646651273;710.6127160697432;728.2971932085457;732.1287667675449;9981.301308908307;10776.94611526953;10981.39602321864;11121.110311175087;11225.270357426742;702.3187508117118;730.3718801830528;740.1250692630417;750.4296734481833;768.2739810878778;4833.854984350405;5284.286621306074;5323.86690332737;5363.973180134074;5388.622796404214;83987.16012839916;103352;106910.46544767226;107370;107474.64041635313;69843;91640.08359916316;92534.7612833561;93204;94097.58853617201;66391.66804165948;75389;80342.59828700936;82221.17778822254;82997.51007469786;7961.840763184588;8657.480551166951;10272.229582781172;10334.173266138841;10369.325993810378;43978.780106099264;54073;54145.45854541404;55242;55659.72170139123;67864.30339241559;68335;68339;68926.65536672284;71742.64128679324;12281.631551053482;12485.625431237077;12507.249565026128;12514.374281285716;12900.8064879025;13469.865301346861;13484.932575337061;13538.59384218475;13876.86123138796;14558.417663293772;12454.750904982031;12737.426815793497;12986.935065324613;13389.531366402129;13394.531191408254;12821.294828784507;12845.678858028625;12966.93516532449;13155.342232888508;13402.262875541548;12316.50733970667;12356.196847205263;12453.839042550751;12513.186642868184;12764.234145951272;7814.57019863913;9542.952285238807;9665.210197267308;9741.317424561343;10024.548895299875;10715.303505272132;10865.293755905841;10943;10994.34033957965;11020.724481888017 08:58:25 INFO - PROCESS | 1642 | __end_tp_report 08:58:25 INFO - PROCESS | 1642 | __start_cc_report 08:58:25 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,404 08:58:25 INFO - PROCESS | 1642 | __end_cc_report 08:58:25 INFO - PROCESS | 1642 | __startTimestamp1493395105230__endTimestamp 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | ------- Summary: start ------- 08:58:25 INFO - PROCESS | 1642 | Number of tests: 6 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:6183.12 Median:6366.20 stddev:693.82 (10.9%) stddev-sans-first:664.87 08:58:25 INFO - PROCESS | 1642 | Values: 3565.7 3649.1 3675.4 3689.5 3698.1 6194.9 6200.2 6200.3 6210.9 6244.5 5995.5 6204.6 6217.3 6220.9 6247.6 5539.8 5587.3 5590.0 5616.4 5677.0 5656.3 5659.4 5665.9 5677.0 5692.2 5433.6 5458.9 5638.9 5656.4 5687.0 5585.5 5629.4 5637.9 5660.1 5675.5 5495.7 5622.9 5633.8 5636.0 5684.1 6007.6 6233.0 6254.6 6286.4 6306.0 5270.9 6394.2 6606.9 6627.0 6642.0 6796.8 6803.8 6812.4 6815.9 6827.0 6290.4 6309.3 6338.7 6342.0 6353.1 6592.9 6629.3 6634.5 6829.1 6879.4 6567.2 6578.3 6608.4 6614.3 6627.3 6659.1 6773.9 6784.4 6805.0 6808.9 6052.9 6318.5 6657.9 6704.4 6722.5 6567.8 6581.6 6683.8 6688.8 6711.4 5309.5 5321.2 5336.0 5336.3 5356.3 4590.7 4682.3 4720.7 4745.7 4752.9 6245.0 6287.0 6316.4 6366.2 6392.7 6810.1 6818.8 6840.8 6846.8 6862.4 6213.7 6239.0 6274.1 6310.4 6363.7 5495.2 5558.2 5997.9 6028.6 6064.2 6961.9 6983.8 7015.4 7030.6 7052.4 6069.4 6178.0 6511.9 6622.9 6837.6 6916.0 6967.4 6968.7 6985.6 6990.1 5665.2 6653.7 6661.4 6664.5 6672.6 6410.7 6481.2 6649.9 6679.2 6765.0 6433.6 6469.6 6470.2 6483.9 6498.2 6546.3 6561.8 6572.1 6585.3 6596.9 6108.5 6215.1 6411.9 6428.5 6444.8 6332.7 6475.2 6499.4 6519.1 6526.7 6386.2 6393.1 6405.3 6411.6 6449.7 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:58213.69 Median:31460.71 stddev:122825.17 (390.4%) stddev-sans-first:123094.04 08:58:25 INFO - PROCESS | 1642 | Values: 780.4 817.5 837.0 986.8 987.9 35478.0 38374.8 40417.0 40444.0 40623.6 27875.4 36102.8 39288.6 39394.0 39514.8 8196.9 8347.0 11139.2 11381.5 11566.4 11201.9 11288.0 11294.9 11298.5 11376.2 9495.0 11244.4 11271.9 11300.7 11302.1 11228.4 11254.1 11265.9 11267.6 11268.9 10980.2 10997.6 11040.8 11049.4 11106.3 34042.7 34195.8 34198.3 34380.5 34392.0 3629.2 3665.5 3896.2 3965.2 3991.7 25393.5 25918.0 26664.5 26833.5 26857.7 3152.1 3189.0 3318.3 3381.9 3387.4 319373.0 363915.0 366016.0 381241.0 381695.0 42475.0 42568.0 42642.1 42664.0 42696.4 43488.8 43609.6 43978.6 44129.0 44182.6 13920.7 14021.9 14042.9 14049.4 14070.4 12106.0 12216.4 12393.5 12399.9 12406.8 9438.0 9998.0 11471.7 11555.9 11589.9 4752.2 5626.5 5658.7 5679.0 5686.2 1128.5 1155.8 1188.2 1200.7 1205.1 26010.9 26262.1 26301.5 26340.6 26444.0 1063.8 1276.5 1285.8 1330.8 1334.3 12833.6 14533.8 15971.5 15972.4 16016.8 501768.0 503817.0 505350.0 505587.0 505750.0 57343.9 57467.1 57548.7 57628.7 57761.0 1466.9 1517.0 1523.5 1532.9 1537.3 24078.6 26367.1 27421.6 28325.0 30040.8 43752.6 43779.3 43817.6 43929.0 43980.0 500397.0 500889.0 501377.0 502329.0 503505.0 26861.7 27430.7 31052.5 31888.4 32299.5 38861.8 42955.0 44098.8 44719.3 45967.9 29056.4 30410.1 30657.4 31484.9 31746.5 26308.6 30618.4 30696.1 30756.5 31511.7 35730.9 36561.3 36815.4 37079.8 37187.6 30433.5 30443.7 30456.0 31110.0 31436.5 21518.4 23979.3 24413.6 25065.4 25108.2 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:44209.87 Median:22174.56 stddev:133013.20 (599.8%) stddev-sans-first:133345.68 08:58:25 INFO - PROCESS | 1642 | Values: 411.0 415.5 417.6 428.1 463.4 20927.9 21007.9 21662.6 21922.3 22454.7 21741.5 23182.8 23602.1 23879.6 24085.2 6207.9 6775.6 6897.0 7056.7 7064.0 6835.7 7004.5 7017.9 7023.8 7026.4 6634.4 6893.3 6953.7 6956.2 6970.5 5517.9 6802.9 6842.7 6848.5 6938.7 6715.8 6716.3 6734.3 6753.9 6754.2 27179.6 27862.7 27865.2 27900.7 27920.5 3022.4 3128.9 3425.5 3530.9 3557.4 16408.7 17253.6 17391.0 17813.9 17974.8 2170.4 2279.3 2408.8 2425.7 2441.2 90460.0 136897.0 138820.0 162062.0 162436.8 19587.3 19788.8 21043.8 21102.9 21258.3 30115.8 30812.4 30830.1 30831.4 30937.8 8783.5 10726.6 10738.6 10741.5 11068.8 8090.6 8703.6 9047.2 9176.7 9357.0 8564.8 9434.5 9664.9 9708.4 9785.8 4153.2 4244.3 4260.9 4262.2 4280.9 1034.0 1038.5 1059.5 1080.8 1090.5 19174.6 21782.9 22122.3 22226.8 22240.0 1095.9 1100.4 1101.9 1142.6 1147.6 10839.9 11405.7 11438.8 11506.8 11570.8 789754.0 795517.0 795991.0 813048.0 822766.0 125239.4 126899.0 138670.5 152176.2 157254.0 1207.2 1227.0 1269.6 1273.8 1303.1 19673.2 20715.6 20719.4 20768.3 21369.5 65795.7 66701.3 67018.7 67654.0 67947.0 64676.4 89606.0 96254.0 96910.0 97775.0 11006.4 11419.9 11729.7 11899.6 12010.2 13254.5 13295.5 13618.3 13626.4 13648.8 9392.9 11218.9 11614.4 11889.0 12019.1 10665.3 10685.6 10772.7 10802.7 10977.9 11656.8 11657.8 11776.2 11984.2 12127.8 11686.3 11910.0 11945.4 12004.0 12044.6 11566.0 11619.9 11755.6 11881.6 11947.9 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6969.02 Median:2517.65 stddev:4367.62 (173.5%) stddev-sans-first:4360.52 08:58:25 INFO - PROCESS | 1642 | Values: 1497.3 1622.2 1645.7 1649.0 1661.3 8518.8 9877.8 11375.0 12030.6 12058.2 11306.4 11698.4 11702.2 11704.9 11725.2 2488.3 2516.7 2517.4 2519.6 2534.8 2469.0 2504.5 2517.9 2520.8 2521.3 2467.9 2492.5 2494.1 2495.4 2527.7 2338.4 2343.6 2354.3 2356.7 2364.3 2018.8 2371.4 2393.0 2398.1 2410.3 11798.2 11973.9 12038.9 12062.9 12073.5 5883.1 6012.2 6204.0 6206.5 6224.4 3201.4 3696.6 3817.9 3895.3 3917.8 1244.3 1262.1 1298.0 1308.5 1310.4 13386.5 16278.9 16352.5 16373.3 16409.0 4736.6 4927.6 4970.6 4975.3 4996.4 12120.9 12131.0 12144.2 12162.3 12190.3 5988.6 6078.5 6084.1 6085.5 6102.6 5302.4 5570.4 5611.6 5620.2 5627.6 3961.6 4081.3 4098.4 4138.7 4142.4 1084.8 1093.7 1096.5 1101.8 1107.2 944.2 958.4 964.2 977.0 1003.6 6802.4 6875.6 6934.9 6988.7 7042.5 983.9 1021.1 1027.2 1046.1 1056.0 3342.3 4153.3 4272.2 4294.0 4364.1 13569.5 14303.8 14336.5 14340.1 14343.4 11916.4 13981.5 14174.5 14236.6 14255.6 10013.6 10257.4 10336.5 10438.8 10479.5 6594.2 6663.6 6732.9 6744.6 6800.5 12478.6 12521.6 12734.9 12903.6 12961.8 12929.3 13106.7 13115.4 13143.4 13240.9 9365.5 9564.5 9688.3 9693.2 9715.8 9003.5 10239.1 10550.1 10639.2 10736.4 8987.1 9053.3 9120.6 9124.7 9243.9 8830.3 8836.2 8850.4 8899.0 8927.9 6985.6 8147.3 8331.9 8347.4 8360.7 6099.3 6122.2 6131.3 6262.6 6313.0 6034.9 6196.7 6220.3 6225.3 6295.8 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4611.80 Median:4836.64 stddev:1305.57 (27.0%) stddev-sans-first:1270.11 08:58:25 INFO - PROCESS | 1642 | Values: 385.2 386.9 390.4 402.1 402.2 4404.8 5198.9 5252.4 5290.6 5407.6 4279.1 4820.1 4837.7 5084.9 5097.4 3854.6 4071.3 4263.8 4273.0 4349.6 4328.9 4345.3 4352.4 4352.9 4370.4 3864.6 4353.0 4363.7 4366.7 4384.9 3922.5 4092.3 4173.1 4279.6 4322.9 3385.8 3953.6 3972.6 3974.1 3987.6 4082.3 5091.6 5109.9 5126.3 5185.8 4433.8 4797.6 5083.1 5105.9 5117.1 4591.7 5592.0 5610.0 5619.6 5660.5 3552.8 3763.0 4343.1 4482.7 4516.3 4490.6 5199.9 5976.4 5992.3 6064.6 4502.3 4552.5 4558.7 4560.9 4572.2 3662.6 4625.0 4645.5 4658.5 4671.4 4072.9 4141.5 4509.6 4593.6 4700.7 4591.7 4875.9 5040.0 5299.3 5430.5 1400.6 1453.4 1544.2 1558.7 1579.7 1099.9 1127.7 1182.4 1188.2 1227.9 4430.6 4644.9 5306.5 5310.2 5386.6 5297.8 5367.4 5487.9 5607.9 5774.6 4505.0 4630.5 4777.2 4976.2 5365.0 2688.6 2796.5 2880.3 3013.8 3032.8 5991.9 5996.4 6032.6 6033.8 6039.2 5518.7 5536.1 5665.5 5764.2 5990.7 5734.3 5738.9 5833.3 6054.7 6084.9 4920.5 5729.4 5829.4 5830.6 5994.9 4827.5 5454.9 5665.4 5671.1 5725.8 5551.9 5611.9 5781.7 5996.9 6034.4 3891.9 4145.7 4551.4 4559.9 4566.4 5477.7 5724.3 5734.6 5759.5 5761.5 4753.8 4976.3 5581.3 5631.3 5655.4 4707.5 4855.9 4862.0 5573.0 5675.4 4680.7 4682.7 5101.8 5408.9 5480.9 5219.3 5396.5 5529.9 5586.5 5590.5 4833.8 4835.6 4843.4 5294.8 5454.7 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20618.41 Median:20981.24 stddev:29243.94 (139.4%) stddev-sans-first:29287.98 08:58:25 INFO - PROCESS | 1642 | Values: 764.4 769.6 793.6 885.6 894.0 15807.5 16491.5 16906.6 17154.3 18219.2 16322.2 16394.8 16415.9 16707.2 16725.0 978.5 1004.3 1007.8 1007.9 1013.3 968.9 992.6 996.6 997.7 1024.7 903.3 1045.9 1057.9 1062.4 1065.6 1053.6 1059.3 1060.6 1060.6 1061.6 784.3 784.5 788.0 788.1 789.0 13988.4 14567.9 16897.2 18372.2 18619.3 13334.3 13356.7 13503.9 15037.7 15455.8 10087.2 11364.6 11812.5 11949.5 12448.4 4394.4 4450.2 4503.4 4528.6 4663.7 97213.0 101109.5 103190.5 108104.5 108969.0 10026.4 11359.4 11394.8 11418.5 11703.6 19198.7 22763.8 23229.7 23487.3 23541.4 8354.9 8462.3 8491.8 8620.4 8631.2 4674.0 4732.9 4741.4 4753.6 4895.3 3694.5 3785.8 3788.7 3807.4 3820.3 682.4 733.4 765.1 778.6 780.6 667.7 692.8 710.6 728.3 732.1 9981.3 10776.9 10981.4 11121.1 11225.3 702.3 730.4 740.1 750.4 768.3 4833.9 5284.3 5323.9 5364.0 5388.6 83987.2 103352.0 106910.5 107370.0 107474.6 69843.0 91640.1 92534.8 93204.0 94097.6 66391.7 75389.0 80342.6 82221.2 82997.5 7961.8 8657.5 10272.2 10334.2 10369.3 43978.8 54073.0 54145.5 55242.0 55659.7 67864.3 68335.0 68339.0 68926.7 71742.6 12281.6 12485.6 12507.2 12514.4 12900.8 13469.9 13484.9 13538.6 13876.9 14558.4 12454.8 12737.4 12986.9 13389.5 13394.5 12821.3 12845.7 12966.9 13155.3 13402.3 12316.5 12356.2 12453.8 12513.2 12764.2 7814.6 9543.0 9665.2 9741.3 10024.5 10715.3 10865.3 10943.0 10994.3 11020.7 08:58:25 INFO - PROCESS | 1642 | -------- Summary: end -------- 08:58:25 INFO - PROCESS | 1642 | 08:58:25 INFO - TEST-INFO | 1642: exit 0 08:58:25 INFO - TEST-OK | dromaeo_css | took 1115995ms 08:58:25 INFO - TEST-START | kraken 08:58:25 INFO - operating with platform_type : mac_ 08:58:25 INFO - Initialising browser for kraken test... 08:58:25 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpAxOIaO/profile http://localhost:49231/getInfo.html) 08:58:28 INFO - PROCESS | 1651 | 2017-04-28 08:58:28.214 plugin-container[1653:10464] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 08:58:28 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:28 INFO - PROCESS | 1651 | 2017-04-28 08:58:28.215 plugin-container[1653:10464] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 08:58:28 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:28 INFO - PROCESS | 1651 | 2017-04-28 08:58:28.215 plugin-container[1653:10464] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:58:28 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 08:58:28 INFO - PROCESS | 1651 | colorDepth:24 08:58:28 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 08:58:28 INFO - PROCESS | 1651 | __metrics 08:58:28 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 08:58:29 INFO - TEST-INFO | 1651: exit 0 08:58:29 INFO - Browser initialized. 08:58:29 INFO - Running cycle 1/1 for kraken test... 08:58:29 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpAxOIaO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:31 INFO - PROCESS | 1654 | 2017-04-28 08:58:31.184 plugin-container[1655:10592] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 08:58:31 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:31 INFO - PROCESS | 1654 | 2017-04-28 08:58:31.184 plugin-container[1655:10592] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x861f, name = 'com.apple.CFPasteboardClient' 08:58:31 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:31 INFO - PROCESS | 1654 | 2017-04-28 08:58:31.184 plugin-container[1655:10592] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:58:41 INFO - PROCESS | 1654 | RSS: Main: 174600192 08:58:41 INFO - PROCESS | 1654 | 08:58:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:44 INFO - PROCESS | 1654 | RSS: Main: 187875328 08:58:44 INFO - PROCESS | 1654 | 08:58:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-dft) 08:58:47 INFO - PROCESS | 1654 | RSS: Main: 195788800 08:58:47 INFO - PROCESS | 1654 | 08:58:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-fft) 08:58:51 INFO - PROCESS | 1654 | RSS: Main: 199569408 08:58:51 INFO - PROCESS | 1654 | 08:58:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-oscillator) 08:58:54 INFO - PROCESS | 1654 | RSS: Main: 199876608 08:58:54 INFO - PROCESS | 1654 | 08:58:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:57 INFO - PROCESS | 1654 | RSS: Main: 199929856 08:58:57 INFO - PROCESS | 1654 | 08:59:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49231/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:00 INFO - PROCESS | 1654 | RSS: Main: 205139968 08:59:00 INFO - PROCESS | 1654 | 08:59:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49231/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:04 INFO - PROCESS | 1654 | RSS: Main: 206184448 08:59:04 INFO - PROCESS | 1654 | 08:59:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49231/tests/kraken/driver.html?testName=json-parse-financial) 08:59:08 INFO - PROCESS | 1654 | RSS: Main: 205004800 08:59:08 INFO - PROCESS | 1654 | 08:59:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:10 INFO - PROCESS | 1654 | RSS: Main: 204554240 08:59:10 INFO - PROCESS | 1654 | 08:59:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:13 INFO - PROCESS | 1654 | RSS: Main: 204582912 08:59:13 INFO - PROCESS | 1654 | 08:59:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:16 INFO - PROCESS | 1654 | RSS: Main: 204587008 08:59:16 INFO - PROCESS | 1654 | 08:59:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:19 INFO - PROCESS | 1654 | RSS: Main: 204820480 08:59:19 INFO - PROCESS | 1654 | 08:59:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:23 INFO - PROCESS | 1654 | RSS: Main: 204967936 08:59:23 INFO - PROCESS | 1654 | 08:59:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49231/tests/kraken/driver.html?testName=ai-astar) 08:59:25 INFO - PROCESS | 1654 | RSS: Main: 206757888 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | __start_tp_report 08:59:25 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 08:59:25 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 08:59:25 INFO - PROCESS | 1654 | |i|pagename|runs| 08:59:25 INFO - PROCESS | 1654 | |0;ai-astar;108;119;120;119;122;117;118;120;132;176 08:59:25 INFO - PROCESS | 1654 | |1;audio-beat-detection;140;110;110;148;112;112;110;111;127;111 08:59:25 INFO - PROCESS | 1654 | |2;audio-dft;288;249;210;196;197;195;196;195;195;220 08:59:25 INFO - PROCESS | 1654 | |3;audio-fft;83;58;61;87;60;61;51;75;100;51 08:59:25 INFO - PROCESS | 1654 | |4;audio-oscillator;88;69;111;70;77;69;83;69;70;83 08:59:25 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;82;121;134;95;77;126;77;135;88 08:59:25 INFO - PROCESS | 1654 | |6;imaging-darkroom;116;116;96;98;97;97;98;97;95;143 08:59:25 INFO - PROCESS | 1654 | |7;imaging-desaturate;90;114;134;104;89;92;113;108;91;90 08:59:25 INFO - PROCESS | 1654 | |8;json-parse-financial;55;51;92;59;66;81;98;103;101;87 08:59:25 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;59;61;58;71;65;60;61;60;61;62 08:59:25 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;86;73;87;100;72;72;94;100;102;79 08:59:25 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;136;137;148;149;136;137;151;162;178;149 08:59:25 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;165;169;206;217;222;170;166;177;170;169 08:59:25 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;67;63;67;65;68;65;64;63;65;67 08:59:25 INFO - PROCESS | 1654 | __end_tp_report 08:59:25 INFO - PROCESS | 1654 | __start_cc_report 08:59:25 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,996 08:59:25 INFO - PROCESS | 1654 | __end_cc_report 08:59:25 INFO - PROCESS | 1654 | __startTimestamp1493395165181__endTimestamp 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | ------- Summary: start ------- 08:59:25 INFO - PROCESS | 1654 | Number of tests: 14 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:125.10 Median:120.00 stddev:18.81 (15.7%) stddev-sans-first:18.90 08:59:25 INFO - PROCESS | 1654 | Values: 108.0 119.0 120.0 119.0 122.0 117.0 118.0 120.0 132.0 176.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:112.00 stddev:14.20 (12.7%) stddev-sans-first:12.89 08:59:25 INFO - PROCESS | 1654 | Values: 140.0 110.0 110.0 148.0 112.0 112.0 110.0 111.0 127.0 111.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:214.10 Median:203.50 stddev:31.22 (15.3%) stddev-sans-first:18.39 08:59:25 INFO - PROCESS | 1654 | Values: 288.0 249.0 210.0 196.0 197.0 195.0 196.0 195.0 195.0 220.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:68.70 Median:61.00 stddev:16.65 (27.3%) stddev-sans-first:16.83 08:59:25 INFO - PROCESS | 1654 | Values: 83.0 58.0 61.0 87.0 60.0 61.0 51.0 75.0 100.0 51.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:73.50 stddev:13.35 (18.2%) stddev-sans-first:13.74 08:59:25 INFO - PROCESS | 1654 | Values: 88.0 69.0 111.0 70.0 77.0 69.0 83.0 69.0 70.0 83.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:102.30 Median:79.50 stddev:23.90 (30.1%) stddev-sans-first:24.78 08:59:25 INFO - PROCESS | 1654 | Values: 88.0 82.0 121.0 134.0 95.0 77.0 126.0 77.0 135.0 88.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:97.00 stddev:15.48 (16.0%) stddev-sans-first:15.93 08:59:25 INFO - PROCESS | 1654 | Values: 116.0 116.0 96.0 98.0 97.0 97.0 98.0 97.0 95.0 143.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:102.50 Median:89.50 stddev:14.92 (16.7%) stddev-sans-first:15.13 08:59:25 INFO - PROCESS | 1654 | Values: 90.0 114.0 134.0 104.0 89.0 92.0 113.0 108.0 91.0 90.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:79.30 Median:73.50 stddev:19.96 (27.2%) stddev-sans-first:19.14 08:59:25 INFO - PROCESS | 1654 | Values: 55.0 51.0 92.0 59.0 66.0 81.0 98.0 103.0 101.0 87.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.00 stddev:3.74 (6.1%) stddev-sans-first:3.82 08:59:25 INFO - PROCESS | 1654 | Values: 59.0 61.0 58.0 71.0 65.0 60.0 61.0 60.0 61.0 62.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:76.00 stddev:12.11 (15.9%) stddev-sans-first:12.85 08:59:25 INFO - PROCESS | 1654 | Values: 86.0 73.0 87.0 100.0 72.0 72.0 94.0 100.0 102.0 79.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:149.00 stddev:13.48 (9.0%) stddev-sans-first:13.55 08:59:25 INFO - PROCESS | 1654 | Values: 136.0 137.0 148.0 149.0 136.0 137.0 151.0 162.0 178.0 149.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:173.50 stddev:22.57 (13.0%) stddev-sans-first:22.97 08:59:25 INFO - PROCESS | 1654 | Values: 165.0 169.0 206.0 217.0 222.0 170.0 166.0 177.0 170.0 169.0 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.78 (2.7%) stddev-sans-first:1.79 08:59:25 INFO - PROCESS | 1654 | Values: 67.0 63.0 67.0 65.0 68.0 65.0 64.0 63.0 65.0 67.0 08:59:25 INFO - PROCESS | 1654 | -------- Summary: end -------- 08:59:25 INFO - PROCESS | 1654 | 08:59:25 INFO - TEST-INFO | 1654: exit 0 08:59:26 INFO - TEST-OK | kraken | took 60220ms 08:59:26 INFO - SUITE-END | took 1176s 08:59:26 INFO - Completed test suite (00:19:36) 08:59:26 INFO - javascript benchmark 08:59:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7910.821393866576, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3565.679088882001, 3649.069487280741, 3675.3751862183426, 3689.4834723138765, 3698.1309392292815, 6194.876102477948, 6200.193974783283, 6200.255969283687, 6210.875782484359, 6244.500439964803, 5995.490383317423, 6204.596701214418, 6217.253929528451, 6220.942439785236, 6247.6251424914535, 5539.806106786264, 5587.273654424919, 5589.972050139764, 5616.354119276295, 5677.0, 5656.264685590867, 5659.405762394951, 5665.915011274834, 5677.034904066319, 5692.203091567184, 5433.565314774828, 5458.9454105459035, 5638.887222255553, 5656.434356564352, 5686.971565142168, 5585.525230355404, 5629.380768115504, 5637.900609381193, 5660.094384898438, 5675.5459563234845, 5495.697736624484, 5622.887542249173, 5633.774649014034, 5636.0, 5684.147377893308, 6007.639541627516, 6232.968835155795, 6254.562180647356, 6286.434220920093, 6305.96847015762, 5270.92093618596, 6394.200724909387, 6606.93393066068, 6627.039079333518, 6642.003699445074, 6796.762113326059, 6803.761868334634, 6812.386885180357, 6815.897761533532, 6827.044213810071, 6290.370962903673, 6309.337519560472, 6338.714757835908, 6342.048692696132, 6353.142325786006, 6592.9340706593275, 6629.337066293332, 6634.469242460592, 6829.112215411965, 6879.449644028466, 6567.211934567882, 6578.27638959714, 6608.405243528009, 6614.305497922649, 6627.3372662733345, 6659.134312539436, 6773.8983915241315, 6784.3554862288, 6804.965975170093, 6808.93191068083, 6052.939470605325, 6318.494520438354, 6657.933420665731, 6704.363085506869, 6722.495812813961, 6567.835804104936, 6581.605103693793, 6683.832904177434, 6688.799336019927, 6711.429528490035, 5309.522143007148, 5321.175217841241, 5336.012837625051, 5336.332958380202, 5356.276902618097, 4590.724556526619, 4682.274247491644, 4720.693154944917, 4745.715257084517, 4752.881177970509, 6245.000799871998, 6287.025511045796, 6316.431521163117, 6366.204224471941, 6392.7123279452535, 6810.148731408574, 6818.795436136924, 6840.828979275558, 6846.760363387258, 6862.416694581017, 6213.65824879627, 6239.0, 6274.121622972787, 6310.4005119514495, 6363.681815909279, 5495.175723641486, 5558.221848941152, 5997.910031349533, 6028.638281703112, 6064.181335519648, 6961.93038069623, 6983.755568554974, 7015.403690686145, 7030.648467576703, 7052.400545953651, 6069.423404776539, 6178.0, 6511.902321465276, 6622.867542649024, 6837.555558888656, 6916.0, 6967.442604591519, 6968.721251149897, 6985.615791131537, 6990.126234220723, 5665.235193248858, 6653.700583473658, 6661.4337781287195, 6664.50016248793, 6672.633005184762, 6410.743570257324, 6481.189851268591, 6649.900251496135, 6679.165104361955, 6765.0, 6433.613983161025, 6469.644169570531, 6470.223573171062, 6483.902741458787, 6498.155239818793, 6546.312637173029, 6561.80314590563, 6572.079908812674, 6585.308542603149, 6596.901046484402, 6108.4807791338235, 6215.098810672337, 6411.93588064132, 6428.517861160525, 6444.838879027874, 6332.683365831782, 6475.222973243241, 6499.38255865692, 6519.054737063194, 6526.67366631657, 6386.233651961795, 6393.073004414427, 6405.295417504164, 6411.6153030818305, 6449.677516124269], "value": 6139.310606611446, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.3562061299426, 817.4563914996528, 836.9539675317859, 986.8273052215865, 987.9160271376933, 35478.0, 38374.80812595937, 40417.0, 40444.0, 40623.59376406235, 27875.442491150166, 36102.8194859026, 39288.607113928854, 39394.0, 39514.81455556338, 8196.877046844302, 8347.040090389592, 11139.220254582142, 11381.544738210461, 11566.42167891602, 11201.887981120206, 11288.040516556062, 11294.943525282362, 11298.491567879466, 11376.203665743402, 9494.952525237364, 11244.437778111103, 11271.943640281786, 11300.660980170607, 11302.095832333394, 11228.382438965853, 11254.09967202626, 11265.943670281678, 11267.605633802777, 11268.943655281711, 10980.231383803137, 10997.61508347212, 11040.834387484194, 11049.447527623586, 11106.278091924, 34042.6595734042, 34195.82902085473, 34198.316033679184, 34380.48429273563, 34392.0, 3629.239305459326, 3665.4685070664873, 3896.2207558488417, 3965.167314863882, 3991.720579559432, 25393.49213015748, 25918.0, 26664.46671066587, 26833.46333073347, 26857.73142268572, 3152.1489197916662, 3189.01140646398, 3318.303156337172, 3381.9492707609406, 3387.4241378965635, 319372.9999999977, 363915.0, 366016.0, 381241.0, 381695.0, 42475.0, 42568.0, 42642.14715705669, 42664.0, 42696.35955460671, 43488.78255608702, 43609.56390436055, 43978.56021439745, 44129.0, 44182.55817441849, 13920.651983700285, 14021.9483538735, 14042.929785351007, 14049.438022479191, 14070.366833492517, 12105.970992465738, 12216.389180540937, 12393.504259829686, 12399.876001239872, 12406.75186496265, 9438.0, 9998.0, 11471.713207169887, 11555.88444115565, 11589.942050289694, 4752.168370535212, 5626.549876009909, 5658.660480371191, 5678.971605141948, 5686.237266447414, 1128.5090985421368, 1155.8439610652454, 1188.2276520261898, 1200.6578125234441, 1205.0901569315286, 26010.86994565015, 26262.080827170957, 26301.47397052048, 26340.60489092665, 26444.0, 1063.7659714862718, 1276.4702648400996, 1285.7878450055637, 1330.7538105450524, 1334.2794890758883, 12833.550825721055, 14533.78199327011, 15971.520854374387, 15972.361105555648, 16016.75974860378, 501768.0, 503817.0, 505350.0, 505587.0, 505750.0, 57343.85312293731, 57467.13799293014, 57548.71225643845, 57628.71185644045, 57761.0, 1466.8533146685459, 1517.0442621148607, 1523.535321726884, 1532.9386824527116, 1537.2928452911785, 24078.638820417356, 26367.07715229958, 27421.58867617027, 28325.0, 30040.84979575088, 43752.56247437612, 43779.343309851014, 43817.56182438135, 43929.0, 43980.0, 500397.0, 500889.0, 501376.98623013304, 502329.0, 503505.0, 26861.731382685924, 27430.725692742817, 31052.53421198729, 31888.36223275568, 32299.51550726788, 38861.8341449757, 42955.0, 44098.77950610226, 44719.329210062526, 45967.85080373017, 29056.418871622027, 30410.087697369116, 30657.386852262385, 31484.89802856889, 31746.523802142525, 26308.605370919067, 30618.387632247675, 30696.07911762651, 30756.538651919793, 31511.684883151793, 35730.928072157876, 36561.26877462383, 36815.44776828403, 37079.814600926824, 37187.628123718416, 30433.543496847124, 30443.695563044086, 30456.0, 31110.0, 31436.528452073693, 21518.354449366543, 23979.28062158138, 24413.63379549344, 25065.373365666004, 25108.24675259745], "value": 18817.44930304041, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.9650679692226, 415.4702753988666, 417.6262245290465, 428.1223491841724, 463.4137815663187, 20927.895360523195, 21007.894960525195, 21662.566748665016, 21922.342329730094, 22454.663180052292, 21741.45646358838, 23182.840857957075, 23602.055917763268, 23879.641805372932, 24085.15701950432, 6207.944649409588, 6775.59346439214, 6897.0, 7056.682449289769, 7064.0, 6835.658217089126, 7004.474664400165, 7017.929820701779, 7023.82440438988, 7026.43788496919, 6634.369734875179, 6893.276205998373, 6953.652317384136, 6956.165260168762, 6970.54691445057, 5517.862053448655, 6802.931970680329, 6842.65786710665, 6848.486363522756, 6938.653067346638, 6715.7985260442265, 6716.261211266757, 6734.292899245606, 6753.8649227015185, 6754.155730533684, 27179.592306115424, 27862.721372786214, 27865.16404507868, 27900.720992790015, 27920.464374459396, 3022.3804120155314, 3128.874845006197, 3425.451927691582, 3530.876419325337, 3557.4485954677066, 16408.67182656352, 17253.577264936866, 17391.0, 17813.910930445396, 17974.820251797577, 2170.3505335944637, 2279.293419040103, 2408.783209511135, 2425.6967879015124, 2441.1944058460845, 90460.0, 136897.0, 138820.0, 162062.0, 162436.75126497523, 19587.314443994677, 19788.802111978697, 21043.790402007875, 21102.864259028644, 21258.25596104129, 30115.849420752755, 30812.38375232483, 30830.075097747103, 30831.383372332428, 30937.8453107733, 8783.516906570072, 10726.570937162425, 10738.550295710136, 10741.51663175159, 11068.833967490495, 8090.624593819065, 8703.608337624823, 9047.230985366186, 9176.6788162414, 9356.95321523388, 8564.843746094322, 9434.528273586293, 9664.855027174597, 9708.417494950325, 9785.755356116155, 4153.210889930964, 4244.278472659656, 4260.936085958713, 4262.211490874198, 4280.914381712349, 1034.043509753475, 1038.5482315192914, 1059.5179193467109, 1080.8324709670014, 1090.4983707494482, 19174.61650766977, 21782.89108554447, 22122.33632991013, 22226.777732222796, 22240.0, 1095.8739744929276, 1100.3947828694186, 1101.8898110188918, 1142.6286456901373, 1147.5753971030606, 10839.916008399256, 11405.714857128638, 11438.771224575461, 11506.827397589042, 11570.826437603442, 789754.0, 795517.0, 795991.0, 813048.0, 822766.0, 125239.3738031304, 126899.0, 138670.53323666786, 152176.2391188037, 157254.0, 1207.2334067866968, 1226.9815952760537, 1269.5620011096157, 1273.8471383434048, 1303.1464390824026, 19673.21307147698, 20715.58568828585, 20719.378418647466, 20768.273110441667, 21369.465763356042, 65795.67102164458, 66701.33298666951, 67018.66490667516, 67654.0, 67947.0, 64676.353236468916, 89606.0, 96254.0, 96910.03089969292, 97775.0, 11006.394648294421, 11419.885801141882, 11729.706757330794, 11899.643010709693, 12010.219335743148, 13254.53609123676, 13295.534656286984, 13618.319084045559, 13626.386812593259, 13648.795268070788, 9392.906070939203, 11218.943905280421, 11614.419279035845, 11888.96831308011, 12019.09856760764, 10665.306755060896, 10685.626003089854, 10772.730681732706, 10802.67591972242, 10977.890221098007, 11656.825147622962, 11657.825132623188, 11776.175667703179, 11984.221025633306, 12127.81808272859, 11686.298822070703, 11910.0, 11945.4027298633, 12004.0, 12044.638660840188, 11566.0, 11619.883801161881, 11755.647330580096, 11881.643550693492, 11947.94026029899], "value": 11946.088732183682, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.326203208556, 1622.2456557700666, 1645.7037733208026, 1648.9752653710195, 1661.2773443552048, 8518.787030324245, 9877.753056173598, 11375.0, 12030.639080827566, 12058.155929084956, 11306.434678266094, 11698.356590387526, 11702.180847340669, 11704.882951170486, 11725.179237453382, 2488.3281513991255, 2516.748325167487, 2517.446161844391, 2519.59686450168, 2534.797216222707, 2469.0247352295924, 2504.499100179962, 2517.854376258798, 2520.823542352036, 2521.3318470605213, 2467.925962221136, 2492.476579918219, 2494.1270555305587, 2495.42605200803, 2527.671402717644, 2338.356951838241, 2343.625019996801, 2354.258408601302, 2356.71719393673, 2364.2788949370433, 2018.777934427212, 2371.4190023444194, 2392.9760702392928, 2398.0647547456506, 2410.349205714447, 11798.233114847508, 11973.880261197452, 12038.879611203864, 12062.879371206263, 12073.517059317617, 5883.146943693183, 6012.248468941382, 6203.968980155116, 6206.472449841769, 6224.439800417938, 3201.3917355702342, 3696.6303369663087, 3817.866374676873, 3895.2793733159456, 3917.843286268546, 1244.296972210698, 1262.1291308996763, 1298.0135097326006, 1308.542010296398, 1310.3710219094887, 13386.531471398454, 16278.918605407016, 16352.509424717278, 16373.263203155886, 16409.0, 4736.621070314435, 4927.605791536668, 4970.602351811846, 4975.253711943165, 4996.400431948189, 12120.878791212152, 12131.0, 12144.210626309437, 12162.270263784201, 12190.268583884817, 5988.550858685616, 6078.513718902477, 6084.117802918552, 6085.482733967574, 6102.572819902564, 5302.443243459381, 5570.387257401763, 5611.607187496836, 5620.241267428926, 5627.606067575312, 3961.6053267930583, 4081.285774989365, 4098.364753463218, 4138.710290279711, 4142.357934520154, 1084.7830433913248, 1093.6882988348282, 1096.4572536594437, 1101.8292164714483, 1107.1806862921542, 944.1785646487463, 958.3579002068631, 964.19008033251, 976.9853452198223, 1003.5584342889251, 6802.421794147553, 6875.5874647521305, 6934.861302773917, 6988.650567471606, 7042.507024508338, 983.8524221366853, 1021.1473419694638, 1027.1782573940818, 1046.0951277145366, 1055.9736006599896, 3342.3148254607745, 4153.335466325434, 4272.188284225987, 4294.0, 4364.1053584015835, 13569.457221711022, 14303.78544321836, 14336.498222562368, 14340.139591624327, 14343.354549045318, 11916.404179790976, 13981.510647127505, 14174.503892363718, 14236.572902812932, 14255.64360890986, 10013.649522266685, 10257.38455692646, 10336.483175841178, 10438.791224175475, 10479.528421221063, 6594.208694956636, 6663.633500157538, 6732.932670673426, 6744.595324280559, 6800.52396332252, 12478.563250286197, 12521.624351269476, 12734.917532009882, 12903.612891613267, 12961.805572916603, 12929.288889111189, 13106.73786524245, 13115.409806558919, 13143.408546615616, 13240.933795330962, 9365.531723413666, 9564.4739539326, 9688.273379496424, 9693.22454203648, 9715.757106072404, 9003.459792412476, 10239.078482936571, 10550.103241224582, 10639.202059845387, 10736.409497477402, 8987.056359082202, 9053.275737940818, 9120.635174593208, 9124.726258212264, 9243.907560924305, 8830.337724670548, 8836.204741573289, 8850.424722393023, 8899.021107678022, 8927.910720892707, 6985.5808651481075, 8147.3482121431325, 8331.916680833114, 8347.415680902279, 8360.70737524208, 6099.329073801967, 6122.173506576555, 6131.294901086254, 6262.561620686691, 6312.968435157978, 6034.909476357946, 6196.721147548281, 6220.34686357944, 6225.315215326401, 6295.779647712308], "value": 5316.928659328535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1776457263743, 386.89167033230706, 390.43776961175905, 402.05717592246174, 402.2076509276724, 4404.757738324391, 5198.922016169756, 5252.422233554311, 5290.603204759644, 5407.648502847313, 4279.0799978004725, 4820.084184005045, 4837.709737415757, 5084.949150508503, 5097.362829646294, 3854.5567259765207, 4071.3332767037637, 4263.786810659471, 4272.974486123331, 4349.586789255031, 4328.913421731563, 4345.283028300342, 4352.368906508555, 4352.912941741163, 4370.3996122307335, 3864.613538646127, 4352.97823510882, 4363.694541382105, 4366.689993002103, 4384.89037774055, 3922.548906875703, 4092.3247664135383, 4173.061061261223, 4279.646194592961, 4322.913541729179, 3385.779924304937, 3953.604639536052, 3972.642462178389, 3974.1455587048636, 3987.6211759882763, 4082.326416141333, 5091.567216786578, 5109.948900511022, 5126.308318254967, 5185.818496352609, 4433.800478978454, 4797.6326746876975, 5083.085044691954, 5105.872353191163, 5117.104506711348, 4591.724496530219, 5592.049351610236, 5610.0, 5619.634723742944, 5660.547156227533, 3552.8223588820715, 3762.9623703762886, 4343.131373725268, 4482.7310361378095, 4516.345129956138, 4490.59584637381, 5199.852146375099, 5976.402359764033, 5992.310884248323, 6064.636121832704, 4502.324651302265, 4552.453705555288, 4558.658100642465, 4560.908781824345, 4572.239687720185, 3662.6154253802965, 4625.0, 4645.535446455395, 4658.5293956003, 4671.392718946515, 4072.8778136655947, 4141.52372477169, 4509.616682581952, 4593.586577208001, 4700.6944548604915, 4591.678582499259, 4875.878103047452, 5040.0, 5299.29735834727, 5430.5384042356845, 1400.5938277899295, 1453.4404254361934, 1544.2278860569716, 1558.680470503544, 1579.6919600677757, 1099.9230053896151, 1127.6617014895662, 1182.43243243242, 1188.2276520261726, 1227.864934857165, 4430.601245887886, 4644.86065418038, 5306.469353064663, 5310.221075939604, 5386.649867758583, 5297.807993201499, 5367.409584945653, 5487.9298536784945, 5607.915881261784, 5774.632400715686, 4504.954950450519, 4630.536946305342, 4777.163996300634, 4976.23818780573, 5364.973175134178, 2688.637034000424, 2796.51061064317, 2880.286229693371, 3013.758899288052, 3032.848357582112, 5991.940080599225, 5996.400359963969, 6032.638041717511, 6033.758649653964, 6039.218430562994, 5518.724063796794, 5536.058869992111, 5665.518430933417, 5764.193012978187, 5990.7004649768205, 5734.283214598176, 5738.9139162913425, 5833.329167145747, 6054.66699331541, 6084.939150608526, 4920.507949205051, 5729.3984131665575, 5829.358770535153, 5830.62100963453, 5994.9317485467445, 4827.493113223201, 5454.8909021818545, 5665.405132461032, 5671.136076281451, 5725.770969161187, 5551.861203469945, 5611.943880561143, 5781.682007489629, 5996.910046349395, 6034.409526331826, 3891.9178239641656, 4145.66834653221, 4551.38556294896, 4559.908801824011, 4566.360709500606, 5477.67133971963, 5724.313082429969, 5734.627249228787, 5759.510441612342, 5761.5102716269585, 4753.786079626356, 4976.328195693535, 5581.302337207849, 5631.267935168402, 5655.434456554476, 4707.4821769606, 4855.927161092657, 4861.9546797438725, 5572.972135139298, 5675.404082571271, 4680.672352935262, 4682.695624784378, 5101.846944591668, 5408.891822163613, 5480.862978425571, 5219.295395121761, 5396.487333703292, 5529.944700552943, 5586.52514536269, 5590.496855283044, 4833.830815921426, 4835.564799168092, 4843.4430040545785, 5294.814681486129, 5454.727263636882], "value": 4237.585747123432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.4343186042327, 769.6267310354481, 793.5675057093887, 885.6413152673167, 893.991060089399, 15807.525774226777, 16491.505254842345, 16906.577335566602, 17154.313827446902, 18219.18013689384, 16322.183890805472, 16394.754078688828, 16415.868673050627, 16707.248173832177, 16725.0, 978.5449765858874, 1004.3471743366797, 1007.7682133109389, 1007.8891321954579, 1013.3058854684527, 968.8837339519267, 992.5533509920529, 996.5714742660653, 997.7455748784087, 1024.733569271991, 903.336048004716, 1045.9267851250415, 1057.9418132002736, 1062.3572738493217, 1065.5524679634534, 1053.5943661690267, 1059.332620449116, 1060.5810704771611, 1060.6340812419703, 1061.5912873543664, 784.2823816208163, 784.4626430894798, 788.0425283280841, 788.0740130346819, 789.0373744032271, 13988.370523326475, 14567.854321456862, 16897.15514224284, 18372.17325220355, 18619.255229790793, 13334.333283335794, 13356.666083347896, 13503.852172565345, 15037.699246015018, 15455.845441545665, 10087.193024558017, 11364.602238921681, 11812.468438920268, 11949.522019119226, 12448.439820208112, 4394.4067550880545, 4450.176717307276, 4503.369528266046, 4528.637708983273, 4663.696859704142, 97213.0, 101109.49445252727, 103190.48404758003, 108104.4594777029, 108969.0, 10026.448545329931, 11359.432028398547, 11394.829077563843, 11418.486168122288, 11703.648890533297, 19198.712019319722, 22763.772362276497, 23229.651555226686, 23487.295381138592, 23541.411464713517, 8354.87467687973, 8462.280706139923, 8491.787705307417, 8620.396572239883, 8631.223189912938, 4673.95326046742, 4732.858014259577, 4741.359916411309, 4753.5959443447, 4895.31465594817, 3694.519712437366, 3785.7917814520465, 3788.6969042477085, 3807.428885667117, 3820.2932457495453, 682.4335801284922, 733.3802936518633, 765.0933643632313, 778.6184769462923, 780.6409051836106, 667.696198229814, 692.840646651273, 710.6127160697432, 728.2971932085457, 732.1287667675449, 9981.301308908307, 10776.94611526953, 10981.39602321864, 11121.110311175087, 11225.270357426742, 702.3187508117118, 730.3718801830528, 740.1250692630417, 750.4296734481833, 768.2739810878778, 4833.854984350405, 5284.286621306074, 5323.86690332737, 5363.973180134074, 5388.622796404214, 83987.16012839916, 103352.0, 106910.46544767226, 107370.0, 107474.64041635313, 69843.0, 91640.08359916316, 92534.7612833561, 93204.0, 94097.58853617201, 66391.66804165948, 75389.0, 80342.59828700936, 82221.17778822254, 82997.51007469786, 7961.840763184588, 8657.480551166951, 10272.229582781172, 10334.173266138841, 10369.325993810378, 43978.780106099264, 54073.0, 54145.45854541404, 55242.0, 55659.72170139123, 67864.30339241559, 68335.0, 68339.0, 68926.65536672284, 71742.64128679324, 12281.631551053482, 12485.625431237077, 12507.249565026128, 12514.374281285716, 12900.8064879025, 13469.865301346861, 13484.932575337061, 13538.59384218475, 13876.86123138796, 14558.417663293772, 12454.750904982031, 12737.426815793497, 12986.935065324613, 13389.531366402129, 13394.531191408254, 12821.294828784507, 12845.678858028625, 12966.93516532449, 13155.342232888508, 13402.262875541548, 12316.50733970667, 12356.196847205263, 12453.839042550751, 12513.186642868184, 12764.234145951272, 7814.57019863913, 9542.952285238807, 9665.210197267308, 9741.317424561343, 10024.548895299875, 10715.303505272132, 10865.293755905841, 10943.0, 10994.34033957965, 11020.724481888017], "value": 7881.411523462957, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 120.0, 119.0, 122.0, 117.0, 118.0, 120.0, 132.0, 176.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 110.0, 148.0, 112.0, 112.0, 110.0, 111.0, 127.0, 111.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [288.0, 249.0, 210.0, 196.0, 197.0, 195.0, 196.0, 195.0, 195.0, 220.0], "value": 214.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 61.0, 87.0, 60.0, 61.0, 51.0, 75.0, 100.0, 51.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 111.0, 70.0, 77.0, 69.0, 83.0, 69.0, 70.0, 83.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 121.0, 134.0, 95.0, 77.0, 126.0, 77.0, 135.0, 88.0], "value": 102.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 96.0, 98.0, 97.0, 97.0, 98.0, 97.0, 95.0, 143.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 114.0, 134.0, 104.0, 89.0, 92.0, 113.0, 108.0, 91.0, 90.0], "value": 102.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 92.0, 59.0, 66.0, 81.0, 98.0, 103.0, 101.0, 87.0], "value": 79.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 58.0, 71.0, 65.0, 60.0, 61.0, 60.0, 61.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 73.0, 87.0, 100.0, 72.0, 72.0, 94.0, 100.0, 102.0, 79.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 148.0, 149.0, 136.0, 137.0, 151.0, 162.0, 178.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 206.0, 217.0, 222.0, 170.0, 166.0, 177.0, 170.0, 169.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 67.0, 65.0, 68.0, 65.0, 64.0, 63.0, 65.0, 67.0], "value": 65.4, "unit": "score"}]}]} 08:59:26 INFO - Return code: 0 08:59:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:59:26 ERROR - # TBPL SUCCESS # 08:59:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:26 INFO - 2017-04-28 08:59:26.518 screenresolution[1659:10963] starting screenresolution argv=screenresolution get 08:59:26 INFO - 2017-04-28 08:59:26.521 screenresolution[1659:10963] Display 0: 1600x1200x32@60 08:59:26 INFO - 2017-04-28 08:59:26.527 screenresolution[1660:10966] starting screenresolution argv=screenresolution list 08:59:26 INFO - Available Modes on Display 0 08:59:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:26 INFO - Intel Iris: 08:59:26 INFO - Chipset Model: Intel Iris 08:59:26 INFO - Type: GPU 08:59:26 INFO - Bus: Built-In 08:59:26 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:26 INFO - Vendor: Intel (0x8086) 08:59:26 INFO - Device ID: 0x0a2e 08:59:26 INFO - Revision ID: 0x0009 08:59:26 INFO - Displays: 08:59:26 INFO - Display: 08:59:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:26 INFO - Display Serial Number: 1600x1200 60 08:59:26 INFO - Main Display: Yes 08:59:26 INFO - Mirror: Off 08:59:26 INFO - Online: Yes 08:59:26 INFO - Rotation: Supported 08:59:26 INFO - Return code: 0 08:59:26 INFO - Running post-action listener: _resource_record_post_action 08:59:26 INFO - [mozharness: 2017-04-28 15:59:26.765913Z] Finished run-tests step (success) 08:59:26 INFO - Running post-run listener: _resource_record_post_run 08:59:26 INFO - Total resource usage - Wall time: 1192s; CPU: 55.0%; Read bytes: 40392704; Write bytes: 423922176; Read time: 387; Write time: 1558 08:59:26 INFO - TinderboxPrint: CPU usage
54.7% 08:59:26 INFO - TinderboxPrint: I/O read bytes / time
40,392,704 / 387 08:59:26 INFO - TinderboxPrint: I/O write bytes / time
423,922,176 / 1,558 08:59:26 INFO - TinderboxPrint: CPU idle
2,163.0 (45.3%) 08:59:26 INFO - TinderboxPrint: CPU system
957.3 (20.1%) 08:59:26 INFO - TinderboxPrint: CPU user
1,649.4 (34.6%) 08:59:26 INFO - TinderboxPrint: Swap in / out
162,861,056 / 0 08:59:26 INFO - install - Wall time: 16s; CPU: 55.0%; Read bytes: 120623616; Write bytes: 112885760; Read time: 10556; Write time: 218 08:59:26 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 33292288; Write bytes: 297808384; Read time: 306; Write time: 1255 08:59:27 INFO - Running post-run listener: _upload_blobber_files 08:59:27 INFO - Blob upload gear active. 08:59:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:27 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 08:59:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:59:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:59:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:28 INFO - (blobuploader) - INFO - Done attempting. 08:59:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:59:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:59:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:29 INFO - (blobuploader) - INFO - Done attempting. 08:59:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:59:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:30 INFO - (blobuploader) - INFO - Done attempting. 08:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:59:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:32 INFO - (blobuploader) - INFO - Done attempting. 08:59:32 INFO - (blobuploader) - INFO - Iteration through files over. 08:59:32 INFO - Return code: 0 08:59:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:59:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:59:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9b01bbcaeb0956c8344a8fe068a0bd6b2c4f879d27c29089e5ca83186727fab09077b62ba82b2063ad3f7f0ce563ea9fa75a9541d8b360a899667d5aebadd5e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f27091b572bcdc31da0dea1e43efe94040330b30a3ed25c9a6df3de5e63bdac6c511073f1e2dd3889d29ee621857aa4784fcb9e645107327397fb677e0138e1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8138a2359495d8a5eedc6a52432fcb12f921aa0688cd40f0706791b6452daf8a7ba970410e9e950a00a2d3b4ebc118ab1a10c478b8110e0dfb21d64f5922362e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81d775ea89d68204a449a627918348f9602f35251cc2f21c4337b8eb201ad902b84585c17651ed2b5506607bee0e73e029dc9701d775c4871599b5b01c6ad671"} 08:59:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:32 INFO - Contents: 08:59:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9b01bbcaeb0956c8344a8fe068a0bd6b2c4f879d27c29089e5ca83186727fab09077b62ba82b2063ad3f7f0ce563ea9fa75a9541d8b360a899667d5aebadd5e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f27091b572bcdc31da0dea1e43efe94040330b30a3ed25c9a6df3de5e63bdac6c511073f1e2dd3889d29ee621857aa4784fcb9e645107327397fb677e0138e1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8138a2359495d8a5eedc6a52432fcb12f921aa0688cd40f0706791b6452daf8a7ba970410e9e950a00a2d3b4ebc118ab1a10c478b8110e0dfb21d64f5922362e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81d775ea89d68204a449a627918348f9602f35251cc2f21c4337b8eb201ad902b84585c17651ed2b5506607bee0e73e029dc9701d775c4871599b5b01c6ad671"} 08:59:32 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:32 INFO - Copying logs to upload dir... 08:59:32 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.794295 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-28 08:59:32.760418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 08:59:32.767952) ========= 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.DbWytlfJMk/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.49pIFhATea/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9b01bbcaeb0956c8344a8fe068a0bd6b2c4f879d27c29089e5ca83186727fab09077b62ba82b2063ad3f7f0ce563ea9fa75a9541d8b360a899667d5aebadd5e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f27091b572bcdc31da0dea1e43efe94040330b30a3ed25c9a6df3de5e63bdac6c511073f1e2dd3889d29ee621857aa4784fcb9e645107327397fb677e0138e1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8138a2359495d8a5eedc6a52432fcb12f921aa0688cd40f0706791b6452daf8a7ba970410e9e950a00a2d3b4ebc118ab1a10c478b8110e0dfb21d64f5922362e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81d775ea89d68204a449a627918348f9602f35251cc2f21c4337b8eb201ad902b84585c17651ed2b5506607bee0e73e029dc9701d775c4871599b5b01c6ad671"} build_url:https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/LIVy--GESYa0Eie6yoq8lw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f9b01bbcaeb0956c8344a8fe068a0bd6b2c4f879d27c29089e5ca83186727fab09077b62ba82b2063ad3f7f0ce563ea9fa75a9541d8b360a899667d5aebadd5e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f27091b572bcdc31da0dea1e43efe94040330b30a3ed25c9a6df3de5e63bdac6c511073f1e2dd3889d29ee621857aa4784fcb9e645107327397fb677e0138e1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8138a2359495d8a5eedc6a52432fcb12f921aa0688cd40f0706791b6452daf8a7ba970410e9e950a00a2d3b4ebc118ab1a10c478b8110e0dfb21d64f5922362e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81d775ea89d68204a449a627918348f9602f35251cc2f21c4337b8eb201ad902b84585c17651ed2b5506607bee0e73e029dc9701d775c4871599b5b01c6ad671"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 08:59:32.806375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:59:32.806735) ========= 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.DbWytlfJMk/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.49pIFhATea/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005100 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 08:59:32.855241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 08:59:32.856178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 08:59:32.856522) ========= ========= Total master_lag: 0.30 =========