builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0105 starttime: 1490045807.41 results: success (0) buildid: 20170320130924 builduid: 96ff4dc302a742c6908b59d39f16fc42 revision: a3d1f3dbc5bcae03bbe1340ff3711ca3b416030b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:47.405523) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:47.405988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:47.406282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:47.431591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:47.432091) ========= 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.OA2DbFciXh/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.mBFbkRgKyl/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-20 14:36:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.30M=0.002s 2017-03-20 14:36:47 (7.30 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:47.571979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-03-20 14:36:47.572308) ========= 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.OA2DbFciXh/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.mBFbkRgKyl/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.021131 ========= master_lag: 2.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-03-20 14:36:49.705290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 14:36:49.705664) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a3d1f3dbc5bcae03bbe1340ff3711ca3b416030b --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 a3d1f3dbc5bcae03bbe1340ff3711ca3b416030b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OA2DbFciXh/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.mBFbkRgKyl/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-20 14:36:49,794 truncating revision to first 12 chars 2017-03-20 14:36:49,794 Setting DEBUG logging. 2017-03-20 14:36:49,794 attempt 1/10 2017-03-20 14:36:49,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a3d1f3dbc5bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 14:36:50,528 unpacking tar archive at: mozilla-beta-a3d1f3dbc5bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.989692 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 14:36:50.724293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:50.724645) ========= script_repo_revision: a3d1f3dbc5bcae03bbe1340ff3711ca3b416030b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:50.725034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:50.725322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 14:36:50.837739) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-20 14:36:50.838121) ========= /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.OA2DbFciXh/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.mBFbkRgKyl/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:36:51 INFO - MultiFileLogger online at 20170320 14:36:51 in /builds/slave/test 14:36:51 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 14:36:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:36:51 INFO - {'append_to_log': False, 14:36:51 INFO - 'base_work_dir': '/builds/slave/test', 14:36:51 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:36:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:36:51 INFO - 'branch': 'Mozilla-Beta', 14:36:51 INFO - 'buildbot_json_path': 'buildprops.json', 14:36:51 INFO - 'config_files': ('talos/mac_config.py',), 14:36:51 INFO - 'default_actions': ('clobber', 14:36:51 INFO - 'read-buildbot-config', 14:36:51 INFO - 'download-and-extract', 14:36:51 INFO - 'populate-webroot', 14:36:51 INFO - 'create-virtualenv', 14:36:51 INFO - 'install', 14:36:51 INFO - 'run-tests'), 14:36:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:36:51 INFO - 'download_minidump_stackwalk': True, 14:36:51 INFO - 'download_symbols': 'ondemand', 14:36:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:36:51 INFO - 'tooltool.py': '/tools/tooltool.py', 14:36:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:36:51 INFO - '/tools/misc-python/virtualenv.py')}, 14:36:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:36:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:36:51 INFO - 'installer_path': 'installer.exe', 14:36:51 INFO - 'log_level': 'info', 14:36:51 INFO - 'log_name': 'talos', 14:36:51 INFO - 'log_to_console': True, 14:36:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:36:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:36:51 INFO - 'opt_config_files': (), 14:36:51 INFO - 'pip_index': False, 14:36:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:36:51 INFO - 'cmd': ('bash', 14:36:51 INFO - '-c', 14:36:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:36:51 INFO - 'enabled': True, 14:36:51 INFO - 'halt_on_failure': False, 14:36:51 INFO - 'name': 'check_screen_resolution'},), 14:36:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:36:51 INFO - 'cmd': ('bash', 14:36:51 INFO - '-c', 14:36:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:36:51 INFO - 'enabled': True, 14:36:51 INFO - 'halt_on_failure': False, 14:36:51 INFO - 'name': 'check_screen_resolution'},), 14:36:51 INFO - 'run_cmd_checks_enabled': True, 14:36:51 INFO - 'sps_profile': False, 14:36:51 INFO - 'sps_profile_interval': 0, 14:36:51 INFO - 'suite': 'dromaeojs-e10s', 14:36:51 INFO - 'system_bits': '32', 14:36:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:36:51 INFO - 'title': 't-yosemite-r7-0105', 14:36:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:36:51 INFO - 'use_talos_json': True, 14:36:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:36:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:36:51 INFO - 'work_dir': 'build'} 14:36:51 INFO - [mozharness: 2017-03-20 21:36:51.051272Z] Running clobber step. 14:36:51 INFO - Running pre-action listener: _resource_record_pre_action 14:36:51 INFO - Running main action method: clobber 14:36:51 INFO - rmtree: /builds/slave/test/build 14:36:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:36:53 INFO - Running post-action listener: _resource_record_post_action 14:36:53 INFO - [mozharness: 2017-03-20 21:36:53.224592Z] Finished clobber step (success) 14:36:53 INFO - [mozharness: 2017-03-20 21:36:53.224672Z] Running read-buildbot-config step. 14:36:53 INFO - Running pre-action listener: _resource_record_pre_action 14:36:53 INFO - Running main action method: read_buildbot_config 14:36:53 INFO - Using buildbot properties: 14:36:53 INFO - { 14:36:53 INFO - "project": "", 14:36:53 INFO - "product": "firefox", 14:36:53 INFO - "script_repo_revision": "production", 14:36:53 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:36:53 INFO - "repository": "", 14:36:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:36:53 INFO - "buildid": "20170320130924", 14:36:53 INFO - "pgo_build": "False", 14:36:53 INFO - "basedir": "/builds/slave/test", 14:36:53 INFO - "buildnumber": 30, 14:36:53 INFO - "slavename": "t-yosemite-r7-0105", 14:36:53 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:36:53 INFO - "platform": "yosemite_r7", 14:36:53 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:36:53 INFO - "branch": "mozilla-beta", 14:36:53 INFO - "repo_path": "releases/mozilla-beta", 14:36:53 INFO - "revision": "a3d1f3dbc5bcae03bbe1340ff3711ca3b416030b", 14:36:53 INFO - "stage_platform": "macosx64", 14:36:53 INFO - "builduid": "96ff4dc302a742c6908b59d39f16fc42", 14:36:53 INFO - "slavebuilddir": "test" 14:36:53 INFO - } 14:36:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 14:36:53 INFO - Running post-action listener: _resource_record_post_action 14:36:53 INFO - [mozharness: 2017-03-20 21:36:53.230472Z] Finished read-buildbot-config step (success) 14:36:53 INFO - [mozharness: 2017-03-20 21:36:53.230686Z] Running download-and-extract step. 14:36:53 INFO - Running pre-action listener: _resource_record_pre_action 14:36:53 INFO - Running main action method: download_and_extract 14:36:53 INFO - mkdir: /builds/slave/test/build/tests 14:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:36:53 INFO - trying https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 14:36:53 INFO - Downloading https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 14:36:54 INFO - Downloaded 1165 bytes. 14:36:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:36:54 INFO - Using the following test package requirements: 14:36:54 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:36:54 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:36:54 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 14:36:54 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:36:54 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 14:36:54 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:36:54 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:36:54 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 14:36:54 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:36:54 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:36:54 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 14:36:54 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:36:54 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 14:36:54 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:36:54 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 14:36:54 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:36:54 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 14:36:54 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 14:36:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:36:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:36:54 INFO - Fetch https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:36:55 INFO - Expected file size: 16108151 14:36:55 INFO - Obtained file size: 16108151 14:37:01 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:37:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:37:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:37:01 INFO - Fetch https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:37:02 INFO - Expected file size: 16108151 14:37:02 INFO - Obtained file size: 16108151 14:37:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 14:37:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 14:37:09 INFO - Fetch https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 14:37:10 INFO - Expected file size: 14403663 14:37:10 INFO - Obtained file size: 14403663 14:37: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')]} 14:37:10 INFO - trying https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:37:10 INFO - Downloading https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 14:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 14:37:12 INFO - Downloaded 58725077 bytes. 14:37:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:37:12 INFO - mkdir: /builds/slave/test/properties 14:37:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:12 INFO - Contents: 14:37:12 INFO - build_url:https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:37:13 INFO - Running post-action listener: _resource_record_post_action 14:37:13 INFO - Running post-action listener: set_extra_try_arguments 14:37:13 INFO - [mozharness: 2017-03-20 21:37:13.221325Z] Finished download-and-extract step (success) 14:37:13 INFO - [mozharness: 2017-03-20 21:37:13.221478Z] Running populate-webroot step. 14:37:13 INFO - Running pre-action listener: _resource_record_pre_action 14:37:13 INFO - Running main action method: populate_webroot 14:37:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:13 INFO - '--tppagecycles', 14:37:13 INFO - '7'], 14:37:13 INFO - 'tests': ['tsvgm']}}, 14:37:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:37:13 INFO - 'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:37:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:37:13 INFO - 'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['damp', 'tps']}, 14:37:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:37:13 INFO - 'tests': ['damp', 'tps']}, 14:37:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['dromaeo_dom']}, 14:37:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['basic_compositor_video']}, 14:37:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:37:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['a11yr', 14:37:13 INFO - 'ts_paint', 14:37:13 INFO - 'tpaint', 14:37:13 INFO - 'sessionrestore', 14:37:13 INFO - 'sessionrestore_no_auto_restore', 14:37:13 INFO - 'tabpaint']}, 14:37:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:13 INFO - 'ts_paint', 14:37:13 INFO - 'tpaint', 14:37:13 INFO - 'sessionrestore', 14:37:13 INFO - 'sessionrestore_no_auto_restore', 14:37:13 INFO - 'tabpaint']}, 14:37:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:13 INFO - 'ts_paint', 14:37:13 INFO - 'tpaint', 14:37:13 INFO - 'sessionrestore', 14:37:13 INFO - 'sessionrestore_no_auto_restore', 14:37:13 INFO - 'tabpaint']}, 14:37:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:13 INFO - 'ts_paint', 14:37:13 INFO - 'tpaint', 14:37:13 INFO - 'sessionrestore', 14:37:13 INFO - 'sessionrestore_no_auto_restore', 14:37:13 INFO - 'tabpaint']}, 14:37:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['a11yr', 14:37:13 INFO - 'ts_paint', 14:37:13 INFO - 'tpaint', 14:37:13 INFO - 'sessionrestore', 14:37:13 INFO - 'sessionrestore_no_auto_restore', 14:37:13 INFO - 'tabpaint']}, 14:37:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['a11yr', 14:37:13 INFO - 'ts_paint', 14:37:13 INFO - 'tpaint', 14:37:13 INFO - 'sessionrestore', 14:37:13 INFO - 'sessionrestore_no_auto_restore', 14:37:13 INFO - 'tabpaint']}, 14:37:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['tsvgx', 14:37:13 INFO - 'tsvgr_opacity', 14:37:13 INFO - 'tart', 14:37:13 INFO - 'tscrollx', 14:37:13 INFO - 'cart', 14:37:13 INFO - 'tsvg_static']}, 14:37:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:13 INFO - 'tsvgr_opacity', 14:37:13 INFO - 'tart', 14:37:13 INFO - 'tscrollx', 14:37:13 INFO - 'cart', 14:37:13 INFO - 'tsvg_static']}, 14:37:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:37:13 INFO - 'talos_options': ['--disable-e10s'], 14:37:13 INFO - 'tests': ['tp5o']}, 14:37:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:37:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:37:13 INFO - 'talos_options': ['--disable-e10s', 14:37:13 INFO - '--xperf_path', 14:37:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:13 INFO - 'tests': ['tp5n']}, 14:37:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:37:13 INFO - 'talos_options': ['--xperf_path', 14:37:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:13 INFO - 'tests': ['tp5n']}}, 14:37:13 INFO - 'talos.zip': {'path': '', 14:37:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:13 INFO - Running post-action listener: _resource_record_post_action 14:37:13 INFO - [mozharness: 2017-03-20 21:37:13.241420Z] Finished populate-webroot step (success) 14:37:13 INFO - [mozharness: 2017-03-20 21:37:13.241567Z] Running create-virtualenv step. 14:37:13 INFO - Running pre-action listener: _resource_record_pre_action 14:37:13 INFO - Running main action method: create_virtualenv 14:37:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:13 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 14:37:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:13 INFO - Using real prefix '/tools/python27' 14:37:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:16 INFO - Installing pip.................done. 14:37:16 INFO - Return code: 0 14:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:37:17 INFO - Reading from file tmpfile_stdout 14:37:17 INFO - Output received: 14:37:17 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) 14:37:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37: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', 'pip>=1.5'] in /builds/slave/test/build 14:37: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 pip>=1.5 14:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:17 INFO - 'HOME': '/Users/cltbld', 14:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:17 INFO - 'LOGNAME': 'cltbld', 14:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:17 INFO - 'MOZ_NO_REMOTE': '1', 14:37:17 INFO - 'NO_EM_RESTART': '1', 14:37:17 INFO - 'PAGER': '/bin/cat', 14:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:17 INFO - 'PWD': '/builds/slave/test', 14:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:17 INFO - 'SHELL': '/bin/bash', 14:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:17 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:17 INFO - 'USER': 'cltbld', 14:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:17 INFO - 'XPC_FLAGS': '0x0', 14:37:17 INFO - 'XPC_SERVICE_NAME': '0', 14:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:17 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 14:37:17 INFO - Cleaning up... 14:37:17 INFO - Return code: 0 14:37:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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', '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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:37: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 psutil>=3.1.1 14:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:17 INFO - 'HOME': '/Users/cltbld', 14:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:17 INFO - 'LOGNAME': 'cltbld', 14:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:17 INFO - 'MOZ_NO_REMOTE': '1', 14:37:17 INFO - 'NO_EM_RESTART': '1', 14:37:17 INFO - 'PAGER': '/bin/cat', 14:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:17 INFO - 'PWD': '/builds/slave/test', 14:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:17 INFO - 'SHELL': '/bin/bash', 14:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:17 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:17 INFO - 'USER': 'cltbld', 14:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:17 INFO - 'XPC_FLAGS': '0x0', 14:37:17 INFO - 'XPC_SERVICE_NAME': '0', 14:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:17 INFO - Downloading/unpacking psutil>=3.1.1 14:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:37:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:21 INFO - Installing collected packages: psutil 14:37:21 INFO - Running setup.py install for psutil 14:37:21 INFO - building 'psutil._psutil_osx' extension 14:37:21 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 14:37:21 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 14:37:21 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 14:37:21 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 14:37:21 INFO - building 'psutil._psutil_posix' extension 14:37:21 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 14:37:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:37:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:37:21 INFO - ^ 14:37:21 INFO - 1 warning generated. 14:37:21 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 14:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:22 INFO - Successfully installed psutil 14:37:22 INFO - Cleaning up... 14:37:22 INFO - Return code: 0 14:37:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:22 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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:22 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 14:37:22 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 14:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:22 INFO - 'HOME': '/Users/cltbld', 14:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:22 INFO - 'LOGNAME': 'cltbld', 14:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:22 INFO - 'MOZ_NO_REMOTE': '1', 14:37:22 INFO - 'NO_EM_RESTART': '1', 14:37:22 INFO - 'PAGER': '/bin/cat', 14:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:22 INFO - 'PWD': '/builds/slave/test', 14:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:22 INFO - 'SHELL': '/bin/bash', 14:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:22 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:22 INFO - 'USER': 'cltbld', 14:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:22 INFO - 'XPC_FLAGS': '0x0', 14:37:22 INFO - 'XPC_SERVICE_NAME': '0', 14:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:37:22 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 14:37:22 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 14:37:22 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 14:37:22 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 14:37:22 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 14:37:22 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 14:37:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:37:25 INFO - Installing collected packages: mozsystemmonitor 14:37:25 INFO - Running setup.py install for mozsystemmonitor 14:37:25 INFO - Successfully installed mozsystemmonitor 14:37:25 INFO - Cleaning up... 14:37:25 INFO - Return code: 0 14:37:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:37:25 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')]} 14:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:25 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')]} 14:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:25 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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:25 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 14:37:25 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 14:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:25 INFO - 'HOME': '/Users/cltbld', 14:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:25 INFO - 'LOGNAME': 'cltbld', 14:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:25 INFO - 'MOZ_NO_REMOTE': '1', 14:37:25 INFO - 'NO_EM_RESTART': '1', 14:37:25 INFO - 'PAGER': '/bin/cat', 14:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:25 INFO - 'PWD': '/builds/slave/test', 14:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:25 INFO - 'SHELL': '/bin/bash', 14:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:25 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:25 INFO - 'USER': 'cltbld', 14:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:25 INFO - 'XPC_FLAGS': '0x0', 14:37:25 INFO - 'XPC_SERVICE_NAME': '0', 14:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:37:25 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 14:37:25 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 14:37:25 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 14:37:25 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 14:37:25 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 14:37:25 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 14:37:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:37:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:37:28 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 14:37:28 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 14:37:28 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 14:37:28 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 14:37:28 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 14:37:28 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 14:37:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:37:28 INFO - warning: no files found matching '*.txt' 14:37:28 INFO - no previously-included directories found matching 'build' 14:37:28 INFO - no previously-included directories found matching 'dist' 14:37:28 INFO - no previously-included directories found matching '.git*' 14:37:28 INFO - Installing collected packages: jsonschema, functools32 14:37:28 INFO - Running setup.py install for functools32 14:37:28 INFO - warning: no files found matching '*.txt' 14:37:28 INFO - no previously-included directories found matching 'build' 14:37:28 INFO - no previously-included directories found matching 'dist' 14:37:28 INFO - no previously-included directories found matching '.git*' 14:37:28 INFO - Successfully installed jsonschema functools32 14:37:28 INFO - Cleaning up... 14:37:28 INFO - Return code: 0 14:37:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:28 INFO - 'HOME': '/Users/cltbld', 14:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:28 INFO - 'LOGNAME': 'cltbld', 14:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:28 INFO - 'MOZ_NO_REMOTE': '1', 14:37:28 INFO - 'NO_EM_RESTART': '1', 14:37:28 INFO - 'PAGER': '/bin/cat', 14:37:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:28 INFO - 'PWD': '/builds/slave/test', 14:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:28 INFO - 'SHELL': '/bin/bash', 14:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:28 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:28 INFO - 'USER': 'cltbld', 14:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:28 INFO - 'XPC_FLAGS': '0x0', 14:37:28 INFO - 'XPC_SERVICE_NAME': '0', 14:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:37:29 INFO - Cleaning up... 14:37:29 INFO - Return code: 0 14:37:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:29 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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:29 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 14:37:29 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 14:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:29 INFO - 'HOME': '/Users/cltbld', 14:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:29 INFO - 'LOGNAME': 'cltbld', 14:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:29 INFO - 'MOZ_NO_REMOTE': '1', 14:37:29 INFO - 'NO_EM_RESTART': '1', 14:37:29 INFO - 'PAGER': '/bin/cat', 14:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:29 INFO - 'PWD': '/builds/slave/test', 14:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:29 INFO - 'SHELL': '/bin/bash', 14:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:29 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:29 INFO - 'USER': 'cltbld', 14:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:29 INFO - 'XPC_FLAGS': '0x0', 14:37:29 INFO - 'XPC_SERVICE_NAME': '0', 14:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:37:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:37:32 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 14:37:32 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 14:37:32 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 14:37:32 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 14:37:32 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 14:37:32 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 14:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:37:32 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 14:37:32 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 14:37:32 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 14:37:32 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 14:37:32 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 14:37:32 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 14:37:33 INFO - Downloading docopt-0.6.1.tar.gz 14:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:37:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:37:33 INFO - Running setup.py install for blobuploader 14:37:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:37:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:37:33 INFO - Running setup.py install for requests 14:37:34 INFO - Running setup.py install for docopt 14:37:34 INFO - Successfully installed blobuploader requests docopt 14:37:34 INFO - Cleaning up... 14:37:34 INFO - Return code: 0 14:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:34 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')]} 14:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:34 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')]} 14:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:34 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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:34 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 14:37:34 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 14:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:34 INFO - 'HOME': '/Users/cltbld', 14:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:34 INFO - 'LOGNAME': 'cltbld', 14:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:34 INFO - 'MOZ_NO_REMOTE': '1', 14:37:34 INFO - 'NO_EM_RESTART': '1', 14:37:34 INFO - 'PAGER': '/bin/cat', 14:37:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:34 INFO - 'PWD': '/builds/slave/test', 14:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:34 INFO - 'SHELL': '/bin/bash', 14:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:34 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:34 INFO - 'USER': 'cltbld', 14:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:34 INFO - 'XPC_FLAGS': '0x0', 14:37:34 INFO - 'XPC_SERVICE_NAME': '0', 14:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-AdU4gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-xTB4Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-R3pXxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-G8ieaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Ksd3hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-oT2XIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-fHtiEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-WFq5wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-rul39I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-jYrrUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Qy8D2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-64WIpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-d6SHT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-K3w3Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Q1NfYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-7t7hxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:36 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-k9HMQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:37:36 INFO - Running setup.py install for manifestparser 14:37:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:37:36 INFO - Running setup.py install for mozcrash 14:37:36 INFO - Running setup.py install for mozdebug 14:37:36 INFO - Running setup.py install for mozdevice 14:37:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:37:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:37:36 INFO - Running setup.py install for mozfile 14:37:37 INFO - Running setup.py install for mozhttpd 14:37:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Running setup.py install for mozinfo 14:37:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Running setup.py install for mozInstall 14:37:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Running setup.py install for mozleak 14:37:37 INFO - Running setup.py install for mozlog 14:37:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Running setup.py install for moznetwork 14:37:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:37:37 INFO - Running setup.py install for mozprocess 14:37:38 INFO - Running setup.py install for mozprofile 14:37:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:37:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:37:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:37:38 INFO - Running setup.py install for mozrunner 14:37:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:37:38 INFO - Running setup.py install for mozscreenshot 14:37:38 INFO - Running setup.py install for moztest 14:37:38 INFO - Running setup.py install for mozversion 14:37:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:37:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:37:38 INFO - Cleaning up... 14:37:38 INFO - Return code: 0 14:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:38 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')]} 14:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 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')]} 14:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:38 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 14:37:38 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 14:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:38 INFO - 'HOME': '/Users/cltbld', 14:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:38 INFO - 'LOGNAME': 'cltbld', 14:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:38 INFO - 'MOZ_NO_REMOTE': '1', 14:37:38 INFO - 'NO_EM_RESTART': '1', 14:37:38 INFO - 'PAGER': '/bin/cat', 14:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:38 INFO - 'PWD': '/builds/slave/test', 14:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:38 INFO - 'SHELL': '/bin/bash', 14:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:38 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:38 INFO - 'USER': 'cltbld', 14:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:38 INFO - 'XPC_FLAGS': '0x0', 14:37:38 INFO - 'XPC_SERVICE_NAME': '0', 14:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-HpWeV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:39 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)) 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-XkgTeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:39 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)) 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-ZDtzwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:39 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)) 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-8S2K0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:39 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)) 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Vm3QCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:39 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)) 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-abS2Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:39 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)) 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-zIUmOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:39 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)) 14:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-CYwD2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-mpXn3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-kVgUux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-6z2_oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-dq7b_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-cdETwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-MUWcjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-lqFos1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-mdetqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:40 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)) 14:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-RrpeYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:41 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)) 14:37:41 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)) 14:37:41 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)) 14:37:41 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)) 14:37:41 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)) 14:37:41 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)) 14:37:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:41 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 14:37:41 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 14:37:41 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 14:37:41 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 14:37:41 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 14:37:41 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 14:37:43 INFO - Downloading blessings-1.6.tar.gz 14:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:37:43 INFO - Installing collected packages: blessings 14:37:43 INFO - Running setup.py install for blessings 14:37:43 INFO - Successfully installed blessings 14:37:43 INFO - Cleaning up... 14:37:44 INFO - Return code: 0 14:37:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:37:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:44 INFO - Reading from file tmpfile_stdout 14:37:44 INFO - Current package versions: 14:37:44 INFO - blessings == 1.6 14:37:44 INFO - blobuploader == 1.2.4 14:37:44 INFO - docopt == 0.6.1 14:37:44 INFO - functools32 == 3.2.3-2 14:37:44 INFO - jsonschema == 2.5.1 14:37:44 INFO - manifestparser == 1.1 14:37:44 INFO - mozInstall == 1.12 14:37:44 INFO - mozcrash == 1.0 14:37:44 INFO - mozdebug == 0.1 14:37:44 INFO - mozdevice == 0.49 14:37:44 INFO - mozfile == 1.2 14:37:44 INFO - mozhttpd == 0.7 14:37:44 INFO - mozinfo == 0.9 14:37:44 INFO - mozleak == 0.1 14:37:44 INFO - mozlog == 3.4 14:37:44 INFO - moznetwork == 0.27 14:37:44 INFO - mozprocess == 0.24 14:37:44 INFO - mozprofile == 0.28 14:37:44 INFO - mozrunner == 6.13 14:37:44 INFO - mozscreenshot == 0.1 14:37:44 INFO - mozsystemmonitor == 0.3 14:37:44 INFO - moztest == 0.8 14:37:44 INFO - mozversion == 1.4 14:37:44 INFO - psutil == 3.1.1 14:37:44 INFO - requests == 1.2.3 14:37:44 INFO - wsgiref == 0.1.2 14:37:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:45 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 14:37:45 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 14:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:45 INFO - 'HOME': '/Users/cltbld', 14:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:45 INFO - 'LOGNAME': 'cltbld', 14:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:45 INFO - 'MOZ_NO_REMOTE': '1', 14:37:45 INFO - 'NO_EM_RESTART': '1', 14:37:45 INFO - 'PAGER': '/bin/cat', 14:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:45 INFO - 'PWD': '/builds/slave/test', 14:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:45 INFO - 'SHELL': '/bin/bash', 14:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:45 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:45 INFO - 'USER': 'cltbld', 14:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:45 INFO - 'XPC_FLAGS': '0x0', 14:37:45 INFO - 'XPC_SERVICE_NAME': '0', 14:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 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)) 14:37:45 INFO - Cleaning up... 14:37:45 INFO - Return code: 0 14:37:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 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 0x101cefb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f8494390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, '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.OA2DbFciXh/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.mBFbkRgKyl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 14:37:45 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 14:37:45 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 14:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:45 INFO - 'HOME': '/Users/cltbld', 14:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:45 INFO - 'LOGNAME': 'cltbld', 14:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:45 INFO - 'MOZ_NO_REMOTE': '1', 14:37:45 INFO - 'NO_EM_RESTART': '1', 14:37:45 INFO - 'PAGER': '/bin/cat', 14:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:45 INFO - 'PWD': '/builds/slave/test', 14:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:45 INFO - 'SHELL': '/bin/bash', 14:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:37:45 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:45 INFO - 'USER': 'cltbld', 14:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:45 INFO - 'XPC_FLAGS': '0x0', 14:37:45 INFO - 'XPC_SERVICE_NAME': '0', 14:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:37:46 INFO - Cleaning up... 14:37:46 INFO - Return code: 0 14:37:46 INFO - Running post-action listener: _resource_record_post_action 14:37:46 INFO - Running post-action listener: _start_resource_monitoring 14:37:46 INFO - Starting resource monitoring. 14:37:46 INFO - [mozharness: 2017-03-20 21:37:46.086204Z] Finished create-virtualenv step (success) 14:37:46 INFO - [mozharness: 2017-03-20 21:37:46.087264Z] Running install step. 14:37:46 INFO - Running pre-action listener: _resource_record_pre_action 14:37:46 INFO - Running main action method: install 14:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:46 INFO - Reading from file tmpfile_stdout 14:37:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:37:46 INFO - Reading from file tmpfile_stdout 14:37:46 INFO - Output received: 14:37:46 INFO - Usage: mozinstall [options] installer 14:37:46 INFO - Options: 14:37:46 INFO - -h, --help show this help message and exit 14:37:46 INFO - -d DEST, --destination=DEST 14:37:46 INFO - Directory to install application into. [default: 14:37:46 INFO - "/builds/slave/test"] 14:37:46 INFO - --app=APP Application being installed. [default: firefox] 14:37:46 INFO - mkdir: /builds/slave/test/build/application 14:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:38:00 INFO - Reading from file tmpfile_stdout 14:38:00 INFO - Output received: 14:38:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:38:00 INFO - Running post-action listener: _resource_record_post_action 14:38:00 INFO - [mozharness: 2017-03-20 21:38:00.856445Z] Finished install step (success) 14:38:00 INFO - [mozharness: 2017-03-20 21:38:00.856583Z] Running run-tests step. 14:38:00 INFO - Running pre-action listener: _resource_record_pre_action 14:38:00 INFO - Running main action method: run_tests 14:38:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:38:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:38:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:38:00 INFO - 2017-03-20 14:38:00.870 screenresolution[1898:14460] starting screenresolution argv=screenresolution get 14:38:00 INFO - 2017-03-20 14:38:00.873 screenresolution[1898:14460] Display 0: 1600x1200x32@60 14:38:00 INFO - 2017-03-20 14:38:00.878 screenresolution[1899:14463] starting screenresolution argv=screenresolution list 14:38:00 INFO - Available Modes on Display 0 14:38:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:38:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:38:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:38:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:38:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:38:01 INFO - Intel Iris: 14:38:01 INFO - Chipset Model: Intel Iris 14:38:01 INFO - Type: GPU 14:38:01 INFO - Bus: Built-In 14:38:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:38:01 INFO - Vendor: Intel (0x8086) 14:38:01 INFO - Device ID: 0x0a2e 14:38:01 INFO - Revision ID: 0x0009 14:38:01 INFO - Displays: 14:38:01 INFO - Display: 14:38:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:38:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:38:01 INFO - Display Serial Number: 1600x1200 60 14:38:01 INFO - Main Display: Yes 14:38:01 INFO - Mirror: Off 14:38:01 INFO - Online: Yes 14:38:01 INFO - Rotation: Supported 14:38:01 INFO - Return code: 0 14:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:38:01 INFO - Python 2.7.3 14:38:01 INFO - Return code: 0 14:38:01 INFO - grabbing minidump binary from tooltool 14:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:01 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 0x101acdd30>, '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 0x1019f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ac2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:38:01 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 14:38:01 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 14:38:01 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 14:38:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:38:01 INFO - Return code: 0 14:38:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:38:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:38:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:38:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:38:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:38:01 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/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 14:38:01 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/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --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 14:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OA2DbFciXh/Render', 14:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:01 INFO - 'HOME': '/Users/cltbld', 14:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:01 INFO - 'LOGNAME': 'cltbld', 14:38:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:38:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:01 INFO - 'MOZ_NO_REMOTE': '1', 14:38:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:38:01 INFO - 'NO_EM_RESTART': '1', 14:38:01 INFO - 'PAGER': '/bin/cat', 14:38:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:01 INFO - 'PWD': '/builds/slave/test', 14:38:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:01 INFO - 'SHELL': '/bin/bash', 14:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBFbkRgKyl/Listeners', 14:38:01 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 14:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:01 INFO - 'USER': 'cltbld', 14:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:01 INFO - 'XPC_FLAGS': '0x0', 14:38:01 INFO - 'XPC_SERVICE_NAME': '0', 14:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:01 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/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 14:38:01 INFO - mozversion application_buildid: 20170320130924 14:38:01 INFO - mozversion application_changeset: a3d1f3dbc5bcae03bbe1340ff3711ca3b416030b 14:38:01 INFO - mozversion application_display_name: Firefox 14:38:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:38:01 INFO - mozversion application_name: Firefox 14:38:01 INFO - mozversion application_remotingname: firefox 14:38:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:38:01 INFO - mozversion application_vendor: Mozilla 14:38:01 INFO - mozversion application_version: 53.0 14:38:01 INFO - mozversion platform_buildid: 20170320130924 14:38:01 INFO - mozversion platform_changeset: a3d1f3dbc5bcae03bbe1340ff3711ca3b416030b 14:38:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:38:01 INFO - mozversion platform_version: 53.0 14:38:01 INFO - using testdate: 1490045881 14:38:01 INFO - actual date: 1490045881 14:38:01 INFO - starting webserver on 'localhost:49369' 14:38:01 INFO - SUITE-START | Running 2 tests 14:38:01 INFO - TEST-START | dromaeo_css 14:38:01 INFO - operating with platform_type : mac_ 14:38:01 INFO - Initialising browser for dromaeo_css test... 14:38:01 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpcOFJ5f/profile http://localhost:49369/getInfo.html) 14:38:04 INFO - PROCESS | 1909 | 2017-03-20 14:38:04.409 plugin-container[1912:14619] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.tsm.portname' 14:38:04 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:04 INFO - PROCESS | 1909 | 2017-03-20 14:38:04.409 plugin-container[1912:14619] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b23, name = 'com.apple.CFPasteboardClient' 14:38:04 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:04 INFO - PROCESS | 1909 | 2017-03-20 14:38:04.409 plugin-container[1912:14619] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:38:04 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 14:38:04 INFO - PROCESS | 1909 | colorDepth:24 14:38:04 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 14:38:04 INFO - PROCESS | 1909 | __metrics 14:38:04 ERROR - PROCESS | 1909 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 14:38:05 INFO - TEST-INFO | 1909: exit 0 14:38:05 INFO - Browser initialized. 14:38:05 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:05 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpcOFJ5f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:07 INFO - PROCESS | 1913 | 2017-03-20 14:38:07.424 plugin-container[1914:14755] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833b, name = 'com.apple.tsm.portname' 14:38:07 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:07 INFO - PROCESS | 1913 | 2017-03-20 14:38:07.424 plugin-container[1914:14755] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x860b, name = 'com.apple.CFPasteboardClient' 14:38:07 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:07 INFO - PROCESS | 1913 | 2017-03-20 14:38:07.424 plugin-container[1914:14755] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:38:17 INFO - PROCESS | 1913 | RSS: Main: 173158400 14:38:17 INFO - PROCESS | 1913 | 14:41:18 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49369/tests/dromaeo/cssquery-ext.html) 14:41:20 INFO - PROCESS | 1913 | RSS: Main: 189276160 14:41:20 INFO - PROCESS | 1913 | 14:44:22 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-ext.html (next: http://localhost:49369/tests/dromaeo/cssquery-jquery.html) 14:44:23 INFO - PROCESS | 1913 | RSS: Main: 199352320 14:44:23 INFO - PROCESS | 1913 | 14:47:25 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49369/tests/dromaeo/cssquery-mootools.html) 14:47:25 INFO - PROCESS | 1913 | RSS: Main: 202113024 14:47:25 INFO - PROCESS | 1913 | 14:50:27 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49369/tests/dromaeo/cssquery-prototype.html) 14:50:28 INFO - PROCESS | 1913 | RSS: Main: 206802944 14:50:28 INFO - PROCESS | 1913 | 14:53:31 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49369/tests/dromaeo/cssquery-yui.html) 14:53:31 INFO - PROCESS | 1913 | RSS: Main: 208891904 14:53:31 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-yui.html (next: http://localhost:49369/tests/dromaeo/cssquery-dojo.html) 14:56:34 INFO - PROCESS | 1913 | RSS: Main: 209231872 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | __start_tp_report 14:56:34 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 14:56:34 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 14:56:34 INFO - PROCESS | 1913 | |i|pagename|runs| 14:56:34 INFO - PROCESS | 1913 | |0;dojo.html;3325.251818340873;3443.001529556429;3455.9827200863992;3467.4798780182955;3501.8074005929666;5874.588778785482;5924.99275123229;5937.287525496936;5949.821505354836;5959.404059594039;5943.465088142067;6014.669193194372;6016.578839481238;6026.668533230671;6037.547183961198;5354.785808567653;5388.191771234327;5399.406065332811;5433;5498.917516237259;5457.317835270591;5461.890762184754;5476.315460567429;5481.479259470364;5518.089515229983;5294.311739473863;5306.655067420625;5353.892922141555;5473.2063850741815;5474.343078830526;4513.187626227278;4594.563516465931;5269.552088072518;5388.488093631118;5436.782528698847;5268.31511903454;5365.168398898177;5386.434424385422;5403.081476149064;5480.369757477902;5763.250777398953;5771.88456230873;5820.214271073393;5896.528277737771;6045.909311360333;6178.474829639486;6185.8144255672405;6214.285357183937;6296.842578935518;6309.432151106423;6320.273168585625;6336.96831515844;6347.555671103025;6351.714172862232;6355.396237357444;5955.731992060368;6009;6122.8775424491705;6136.417040381157;6153.2000839890525;4659.883502912454;5428.158635411518;6107.46191531438;6330.68346582669;6363.490920726424;4483.977580112144;6191.19514463117;6200.286966998763;6267.4045965633195;6278.686065696788;5170.71561064145;5488.780448782004;6018.458338749446;6311.715972781236;6320.209973753281;6175.59858609189;6221.2845522764555;6227.377262273736;6276.089966954766;6292.937070629327;6250.093736408196;6280.277768056732;6286.874262514724;6291.056341548713;6297.244330680348;5038.470960549163;5154.871128221749;5161.27742116104;5161.406438259648;5165.457626949192;4549.909001819945;4552.521985191507;4567.383403240587;4586.312053192048;4607.539246075366;5989.580729348903;6016.157737916695;6033.396660333931;6034.7284372202475;6045.395460454008;6161.84595385119;6341.302456729756;6390.0734393512685;6400.679966001681;6419.679016049179;5883.441073098049;5939.406059394112;5948.494377977834;5986.880262394815;6054.666993315322;5656.91514627281;5660.801871934463;5669.177969194444;5675.489205971482;5687.260656114679;6409.8718025640155;6439.323870993572;6442.48460123189;6452.935470645233;6462.0306953955405;6175.876482470415;6241.937580624136;6251.562390632612;6253.3121356651645;6278.246610406781;6352.110704501466;6392.488600912009;6413.8396540085005;6428.935710642833;6441.516886233645;5053.949460505495;6033.883731509684;6199.504039676905;6220.564560480723;6321.209848768904;6154.230721159855;6195.101710251898;6201.348858369986;6205.441510264098;6320.905186422116;6088.178095956989;6201.96899015502;6235.96882015587;6260.874782504234;6269.749210031548;6201.410865967726;6204.038374052029;6207.565470417027;6212.81361559154;6216.813495595139;5072.391313042459;5876.970615146897;5993.160957465871;6084.513238940963;6143.447089761943;6151;6194.287656919331;6213.347598502092;6216.937830621817;6241.344658810759;6207.782727604512;6222.09779581949;6222.439980401786;6233.376662333912;6253.187085679015 14:56:34 INFO - PROCESS | 1913 | |1;ext.html;526.126629794541;527.9599189596494;546.011718788992;569.2258528401373;573.5583600627514;38632.806835965814;41996.16007679845;42063.36904946428;42264.78867605662;42357.36463953035;42574.574254257524;42883.92790180247;42942.35586466206;43096.56903430965;43127.56872431275;8316.04365497968;9013.098690130968;9361.204297634675;9581.90418095817;9743.75640608987;10260.742636619969;10342.379457232553;11756.118291128158;12032.398380081006;12044.277343359383;10214.591416343337;11860;11916.821247681291;12015.339156346397;12018.278903265787;9991.90008099917;11898.048156147488;11964.94017529911;12013.93993030038;12017.218880772809;11970.521179152824;12004.279743215347;12015.93992030043;12087.153899227058;12134.150609457341;42756.78621606872;43111.56888431107;43144;43146.92132696676;43287.56712432867;3924.1170736584327;4160.521540022906;4203.285441474956;4209.095044565433;4233.576642335773;30876.691233087608;30905.381892362027;30917.22706932322;32729.509057364157;32986.34027319464;3268.7221586164965;3410.4031794435873;3444.48332750087;3521.0845180253064;3579.838907249154;497155;502373.99999999633;503668;503793;504136;62579.68710156511;62598.43503912348;62914;63159;63162.68418657969;67177.66411167913;67203;67540.66229668919;67800.66099669569;67821.98267025998;16885.915570422316;16941.830581694026;17092;17106.828931710774;17111.401100961408;12387.132900697045;12676.492940282285;13354.599362019155;13729.970252231122;13771.517996870061;16228.51314460568;16304.836951630568;16319.755203671955;16325.26536305869;16327.428540001043;5626.409227031185;6482.57863238888;6629.171353580802;6660.36915418407;6704.726102040694;776.5651235308245;865.8917635295588;903.385697725553;920.5443305563789;948.369334392635;30746.231344216125;31048.379032419227;31122.377552448823;31406;31542.211444714067;975.2246963663904;1096.6435908329665;1106.0985296982933;1155.0470861539263;1287.6394609509166;15519.37922483088;16092.597685057966;16178.27197776103;16222.675546489005;16484.423045193602;589441;606179;607318;607588;608644;62943;63223.05165422522;63330;63439.73120537563;63472.365276346645;1427.4432971141264;1442.1347191685115;1485.591462347863;1499.1379956524825;1513.8107736532934;29355.559666605444;30491;30688.539671905386;30701.846490767402;30978.845105775228;43599.78200108979;52248.69378265422;52258;52444;52548;527209;527318;528441;530890;530996;25511.617325739757;26223.60664590071;26392;27057;41977.580224197365;38675.806620966716;44262.11475770531;45476.09047819091;45656;47960.28059579039;36839.63160368469;36991;37481.81259093687;37900;38340.61659383482;28548.85725571359;36854.894353169446;37036.81481592575;37840.62159378371;38092.04769880775;29953.550696740003;31608.841955790074;36626;37349.62650373462;37384.626153739206;29253.976110836018;31078;33112.50331244985;33222.501662475566;33274;20069.29757458482;20994.790052099896;21462.24882129118;22460.32619021432;24724.43700167448 14:56:34 INFO - PROCESS | 1913 | |2;jquery.html;399.6183644619389;405.70180917026;407.64127567740394;411.45687692246236;433.9023719663076;16535.50393488196;19991.40025799228;21035.789642103573;22019.788911609834;22093.558128837412;21398.572028559418;21432.57134857302;21513.139474421045;21687.891560542215;22467.438314042116;5985.162077309169;6033.909491357633;6121.908171377433;6161.229846269216;6167.845803854917;5148.922766158511;5872.823815285548;6018.759249630009;6042.728077236513;6098;6076.878462430749;6080;6081;6084.2090528231265;6096.024636058231;5451.48210919962;6047.092936059582;6067.7572897084065;6094.329623741385;6114.052321890114;5353.38436079848;5353.437889021636;5358.089124848785;5362.731863406814;5374.7043912584795;21719.67420488694;25996.22011339663;26940.59589106165;27219.86390068037;27391.726082739315;2741.5613501839807;2785.637867077267;2794.3433293176085;2798.188525327673;2807.7192280771965;10211.79576408475;10309.742256443575;10836.295640783324;15835.762463563056;17084.914575427167;1903.1435853865817;1928.517870532367;1928.9807101929082;1945.2705235536673;1954.5211423201265;99684;121178;127985.36007319998;128392;132772;12482.126251162514;12557.686057848445;12702.174358666656;12768.425420856083;12848.678783030313;16051.277692503865;16155.919220403823;16341.019538827471;16344.427945021867;16410.097444640658;9091.363604547618;9296.07039296065;9340;9517.762055948519;9527.666531671359;9058.54707264634;9191.402558833654;9193.080691930887;9363.391379560308;9369.625214991323;4905.190643543847;5001.324821149171;5004.799808007711;5013.799448022111;5040.7731652075745;2105.2421128393767;2129.3186180422426;2139.3261122746285;2141.603803296395;2157.946051348729;1004.382304882492;1026.348268849271;1034.0693375961544;1034.5137785240925;1052.921030922684;17862.642747144986;19782.40652780419;21415.571688566142;21416.464588385414;21587.784122158893;1074.3768614203743;1087.9891201087887;1090.0353187429182;1114.1810769084716;1126.954921803135;9712.854307185398;10574.947125264325;11184.888151118548;11202.719932001603;11239.438028098726;742465;769962;770849;779977.1001145071;780608;120485;120524;142295.28852355672;149621;153040;839.8824164616836;1052.6473631333436;1057;1066.1151244467073;1066.3868275741324;19258.614827703088;20452.325419134027;20620.896895515427;20672.896635516725;20725.170993160104;63181;63921.680391599606;64860.67569662121;65450;66334.66832665999;77480.2251977473;91650.54174729083;92892;95223;96665.516672419;6390.808275751735;7805.102413222552;7880.2513761192595;8098.149694282016;8436.957815210884;11296.265742726697;11835.82246266324;13646.590602281947;13772.724545509234;14199.148051116967;9894.06006429388;11095.278806877526;11201.551937922392;12009.459574319351;12139.75720485603;10708.785824283626;11435.542578297107;11682.88317116818;11853.644390668294;12005.219660722025;6859.794206173823;9441.10309520622;11806.46870890829;11888;12184.147109702235;7830.92169078302;7989.001374828146;8065.83868322642;8069.7175598853755;8295.336373090258;11354.489047993025;11754.823677645014;11777.293362398283;12073.879261207627;12087.758244834878 14:56:34 INFO - PROCESS | 1913 | |3;mootools.html;1453.2443129572616;1466.794648749175;1471.065873170537;1474.6239708874236;1480.4152359817865;7752.263534964183;8026;8257.793555161124;8714.389992700506;8735.432196907204;8204.958975205116;8513.616887240074;8515.105913879046;8610.61252243649;8643.567821608925;2394.1141777542334;2435.8538487690707;2442.7557244275517;2447.877606119687;2452.5953217719057;2401.7238017627933;2405.518896220754;2446.8654224017673;2447.8164137689746;2457.9631305530434;2406.181898154627;2416.864073885271;2422.39440139965;2430.064425196303;2443.596806526921;2385.0459816073535;2393.3896856301617;2396.269137912936;2397.904083836653;2405.434722840131;2260.333201705501;2356.587597170488;2404.446977195237;2416.359664688859;2420.431198668329;7589.81025474362;8588.527630980294;8643.567821608895;8646.697365592237;8690.478571285743;5234.6335756497065;5390.245365648812;5401.567874570025;5430.456954304577;5431.51116399522;3552.928941421183;3651.7808931463933;3663.413853783382;3696.2053158571034;3718.4050551911564;1235.1600911380258;1265.367316341829;1265.544404014554;1297.2216669997927;1323.6690827293178;11168.994790468896;11223.270487418291;11231.21381503295;11243.66269011931;11312.943435282854;4738.849179411407;4802.447718512346;4865.927011094836;4871.196252618278;4928.359313289249;9671.323007389556;9778.07108324708;9780.706578802647;9784.412935223909;9838.06538378853;5445.2921120254905;5462.863428414242;5466.180072989084;5475.863103422446;5480.342358916955;4506.932396014063;4558.703684260512;4871.001444703898;4920;4953.752312384367;3672.412414013745;3868.168343806095;4076.5311989121037;4116.6912481564;4178.12259425524;1329.4482789642384;1339.04258455205;1354.3972932045144;1365.2900491744238;1366.7972184477596;809.6437567470294;825.7646570727314;833.3041910005213;833.9533884974439;840.6301227459898;5561.63849349791;5605.747741351649;5854.590178687451;5906.291245050621;5942.168096466498;572.7737543670311;583.8964357364584;590.200278622469;599.6162456028145;606.9484093851984;3393.8812141574926;3915.4909861718365;3919.843206271717;3959.3467077932396;3984.406237505021;9925.2059835213;10098.949505252427;10116.848247276297;10212.978702129876;10215.744606384751;10022.198224142052;10043.844957829797;10137.391756494633;10169.847452288222;10172.898271017195;7854.685812567547;8058.959705201437;8100.392470564731;8107.716229931924;8108.635111420001;5577.749001295033;5598.692071936082;5660.264165658438;5754.8849023018465;5795.82612521625;9389.061093890556;9413.29400294967;9422.62309507612;9552.188064014637;9589.18491928166;9218.677346292847;9313.34806563534;9490.193333566447;9668.468234247184;9672.08115229052;7061.540999834994;7137.643117843983;7273.9636301818155;7315.963420182865;7364.379836435975;8100.797480063045;8126.390520710852;8207.138250483853;8211.17888211198;8256.958715206385;7265.455090868311;7270.491065625567;7290.234525374759;7328.303811137934;7459.328660420588;7116.608586527791;7219.60292183935;7227.891581626385;7231.819204519718;7252.347288744038;5432.483914028161;6475.967620161869;6571.014347847861;6584.04531342943;6591.209054913441;4940.975295123501;5014.824481143142;5033.47148549397;5099.286099945936;5268.683878967274;4379.255526560429;4974.353334066548;5022.187574958035;5043.5712964398435;5249.317588713443 14:56:34 INFO - PROCESS | 1913 | |4;prototype.html;361.8154741082049;367.61033304697025;374.2309553866804;377.8998565380173;381.92170605025956;4335.328024156253;5215.400228973669;5297.337832770903;5471.753771080301;5620.622947377893;4563.56646118619;5477.3427188737405;5493.92868390663;5538.6122971392015;5563.833085007446;3444.1733983843824;3609.4766258892446;3663.890083297492;4162.1675664867;4299.247631664454;3324.434846076173;4180.393842892794;4262.407916327923;4357.041450880801;4358.542353052915;4054.2094291613;4200.928763165404;4239.618434340909;4241.533431322552;4259.936100958488;3916.9020774480723;4265.594768496988;4308.965848196442;4314.741115533078;4329.874232699489;3807.200487897545;3811.5235595550557;3837.6737977271687;3840.2127563849344;3844.7312386912254;5002.849914502571;5328.946710532922;5341.706206158659;5368.516833485005;5373.489518495737;4224.471941007374;4579.321097158167;4769.642276829217;4821.517848215186;4836.879078023077;5040.689420750595;5767.798127065575;5833.679147646878;5857.531397488191;6001.909971350433;3326.76712630116;3707;3918.784466854322;3974.940375894364;4010.1954120645532;6136.693165341715;6199.814005579839;6214.5649804513705;6215.502759779252;6237.500999920041;4016.397540368968;4031.475908131924;4033.4151548025957;4045.838166473367;4069.877903662895;3416.8462419191196;3956.7823769692945;3992.401139829049;4052.365962124584;4060.4315395844606;3789.7304403024746;4369.3227549729845;4371.278739008092;4747.715137091716;4776.570108690165;5227.869303267449;5862.530997520188;5865.413458654186;5886;5987.43119403656;1104.9723756906142;1182.3851597169423;1201.5794471934753;1255.0775180242515;1289.9032572556907;930.4510338900081;982.2387649571497;1018.6332920148741;1021.6322124035341;1024.1908891975404;4470.932936005963;4789.425268967677;4791.682287370932;5190.586377334557;5194.558462530652;5278.498542638443;5372.435894231127;5433.2936718227165;5653.349864765604;5814.127880817911;4863.465018847924;5118;5122.257272695439;5142.254373115878;5149.7940082397035;2690.614333618188;2695.9460810783676;2982.1500872251304;3002.168677106963;3004.5813120438256;4839.637027222972;5297.046531624344;5828.388019258002;5828.708564571754;5927.940720592739;5155.587552995751;5335.3864305604575;5462.590305727086;5813.883722325614;5886.470217680429;4601.987562736193;5082.576878474033;5765.481106700333;5787.65274083548;5813.360530341659;5112.821051263188;5183.844484665466;5318.282031925641;5686.038316780704;5756.797537797348;4826.420829500483;5204;5301.814436494704;5505.944940550543;5975.894459525001;6091.568481406955;6218.253809542884;6244.815144276361;6286.937130628635;6366.694827560432;3799.3920972644246;3919.0790164310793;3993.4409182715026;4028.8115006073863;4034.2939985501835;5299.019681358961;5659.830205093854;5843;5930.881382372415;6039.4367323279475;5711.971440142773;5716.714164291686;5753.223314852441;5846.649201047951;5895.20414744004;5093.363329583802;5474.768177160107;5735.713214339183;5799.4780469757925;5832.054812319751;5508.55931525485;5600.1918695287595;5656.3495198051105;5685.829425117253;5721.342045664802;5118.261729974446;5505.788726480168;5752.568557358131;5795.8551036224435;5807.94192058074;5393.730313484389;5519.724013799214;5592.965301419251;5694.800681976111;5752.9137062943255 14:56:34 INFO - PROCESS | 1913 | |5;yui.html;747.6784982457548;754.5397307642334;764.8393837294168;791.6279348706109;894.9776255593612;15356.846431535696;15850.920745396257;16378.672426551477;16550;16580.50258492244;14926.179060151715;14950.327235274412;15010.924945375285;15316.234188290597;15337.463188788395;870.9085546017672;888.933330000251;896.059137905197;896.847535918892;899.3120262998812;725.5501589014792;746.8767653337193;888.1340692824509;895.4314010603249;917.9908200918005;811.2739098506833;910.0399078971682;954.1603389017655;956.2923436656894;956.6077908057698;933.2254228989922;949.9667511637059;950.1875896108832;950.5912457643211;952.8046750416148;698.6122701900443;712.7505373119367;714.4141803720951;715.5563550598611;717.1107826295408;13252.668683282995;14578.854211457961;15311.464098756602;15939.96390234631;16225.756613650805;10670.733231669194;14042.419497209723;14463;14584.052036617586;14629.853701462956;11690.649280521598;11742.823857642143;11818.822717659243;11898.643040708792;12008.519659213622;3728.3102626014;3792.658660720521;3808.485854409647;3836.961630383716;3982.4026396040535;93488;96513;96993;97647;99243;10887.129029677606;10899.727506812234;11161;11167.441627918572;11552;22243.777562224495;22277.88861055717;22484.213052543084;22594.54810903773;22819.20132795344;7949.244821741925;7970.4819186752675;8183.099859015503;8209.220124088202;8251.051129120107;4462.241418958784;4485.910281794346;4529.275315949498;4551.3173024046655;4562.338460923214;3712.1090938174643;3754.249150169977;3757.4363845423404;3793.165503589206;3801.4107813288433;520.8906129712727;574.2649408756798;591.973361198747;605.8545948972303;607.1257389359308;578.3695771608882;683.2450142592463;697.3584302441766;702.9367356937901;710.9537880037781;10125.240606954509;10516;10632.681019569425;10683.465826708634;10830.916908309106;570.2444261353722;616.1240555401696;630.9558330916792;667.1893649216129;723.4935545118439;4896.36347274852;5057.658498793153;5082.057681503874;5139.408967968657;5145.511176438233;112907.3063904042;115241;115972;116540.41729791297;118148;84642.57678711567;98990.01009989952;100515;102393.48803255935;102729;66069;70809;76541.61729191318;80335;85148;9122.680706175252;9307.534623268673;10796.89203107959;11208.215424920178;11339.319640821577;45537.08925821531;51790;52477.163299284344;55046;56021.43978560162;68838.3116168852;70938.64530677313;71710.6217033714;72448.63775681087;74130.62934685292;13216.603501894959;13258.933705331412;13388.665283367995;13472.932635336761;13640.249786261851;14700.779488307899;14914.403423862925;14978.775318370015;15222.695546089237;15857.207139643202;13339.266340350985;13666.93166534161;13932.164070155823;13935.303234838015;14573.92713036428;11033.282836615594;13435;13923.860761392662;13928.373223205183;13929.651758706113;12817.615471535868;13626.318684065955;13654.317284135555;13800.654983625089;13905;10820.350778953289;11057.447127643425;11074.501647425725;11203;11442.485088170886;10013.995801259447;10098.646547370807;10393.324433911772;11780.175387722777;11888.129198992241 14:56:34 INFO - PROCESS | 1913 | __end_tp_report 14:56:34 INFO - PROCESS | 1913 | __start_cc_report 14:56:34 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,369 14:56:34 INFO - PROCESS | 1913 | __end_cc_report 14:56:34 INFO - PROCESS | 1913 | __startTimestamp1490046994491__endTimestamp 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | ------- Summary: start ------- 14:56:34 INFO - PROCESS | 1913 | Number of tests: 6 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | [#0] dojo.html Cycles:165 Average:5827.01 Median:6054.67 stddev:646.48 (10.7%) stddev-sans-first:617.96 14:56:34 INFO - PROCESS | 1913 | Values: 3325.3 3443.0 3456.0 3467.5 3501.8 5874.6 5925.0 5937.3 5949.8 5959.4 5943.5 6014.7 6016.6 6026.7 6037.5 5354.8 5388.2 5399.4 5433.0 5498.9 5457.3 5461.9 5476.3 5481.5 5518.1 5294.3 5306.7 5353.9 5473.2 5474.3 4513.2 4594.6 5269.6 5388.5 5436.8 5268.3 5365.2 5386.4 5403.1 5480.4 5763.3 5771.9 5820.2 5896.5 6045.9 6178.5 6185.8 6214.3 6296.8 6309.4 6320.3 6337.0 6347.6 6351.7 6355.4 5955.7 6009.0 6122.9 6136.4 6153.2 4659.9 5428.2 6107.5 6330.7 6363.5 4484.0 6191.2 6200.3 6267.4 6278.7 5170.7 5488.8 6018.5 6311.7 6320.2 6175.6 6221.3 6227.4 6276.1 6292.9 6250.1 6280.3 6286.9 6291.1 6297.2 5038.5 5154.9 5161.3 5161.4 5165.5 4549.9 4552.5 4567.4 4586.3 4607.5 5989.6 6016.2 6033.4 6034.7 6045.4 6161.8 6341.3 6390.1 6400.7 6419.7 5883.4 5939.4 5948.5 5986.9 6054.7 5656.9 5660.8 5669.2 5675.5 5687.3 6409.9 6439.3 6442.5 6452.9 6462.0 6175.9 6241.9 6251.6 6253.3 6278.2 6352.1 6392.5 6413.8 6428.9 6441.5 5053.9 6033.9 6199.5 6220.6 6321.2 6154.2 6195.1 6201.3 6205.4 6320.9 6088.2 6202.0 6236.0 6260.9 6269.7 6201.4 6204.0 6207.6 6212.8 6216.8 5072.4 5877.0 5993.2 6084.5 6143.4 6151.0 6194.3 6213.3 6216.9 6241.3 6207.8 6222.1 6222.4 6233.4 6253.2 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | [#1] ext.html Cycles:180 Average:68666.84 Median:37367.13 stddev:145737.99 (390.0%) stddev-sans-first:146057.03 14:56:34 INFO - PROCESS | 1913 | Values: 526.1 528.0 546.0 569.2 573.6 38632.8 41996.2 42063.4 42264.8 42357.4 42574.6 42883.9 42942.4 43096.6 43127.6 8316.0 9013.1 9361.2 9581.9 9743.8 10260.7 10342.4 11756.1 12032.4 12044.3 10214.6 11860.0 11916.8 12015.3 12018.3 9991.9 11898.0 11964.9 12013.9 12017.2 11970.5 12004.3 12015.9 12087.2 12134.2 42756.8 43111.6 43144.0 43146.9 43287.6 3924.1 4160.5 4203.3 4209.1 4233.6 30876.7 30905.4 30917.2 32729.5 32986.3 3268.7 3410.4 3444.5 3521.1 3579.8 497155.0 502374.0 503668.0 503793.0 504136.0 62579.7 62598.4 62914.0 63159.0 63162.7 67177.7 67203.0 67540.7 67800.7 67822.0 16885.9 16941.8 17092.0 17106.8 17111.4 12387.1 12676.5 13354.6 13730.0 13771.5 16228.5 16304.8 16319.8 16325.3 16327.4 5626.4 6482.6 6629.2 6660.4 6704.7 776.6 865.9 903.4 920.5 948.4 30746.2 31048.4 31122.4 31406.0 31542.2 975.2 1096.6 1106.1 1155.0 1287.6 15519.4 16092.6 16178.3 16222.7 16484.4 589441.0 606179.0 607318.0 607588.0 608644.0 62943.0 63223.1 63330.0 63439.7 63472.4 1427.4 1442.1 1485.6 1499.1 1513.8 29355.6 30491.0 30688.5 30701.8 30978.8 43599.8 52248.7 52258.0 52444.0 52548.0 527209.0 527318.0 528441.0 530890.0 530996.0 25511.6 26223.6 26392.0 27057.0 41977.6 38675.8 44262.1 45476.1 45656.0 47960.3 36839.6 36991.0 37481.8 37900.0 38340.6 28548.9 36854.9 37036.8 37840.6 38092.0 29953.6 31608.8 36626.0 37349.6 37384.6 29254.0 31078.0 33112.5 33222.5 33274.0 20069.3 20994.8 21462.2 22460.3 24724.4 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | [#2] jquery.html Cycles:180 Average:41161.48 Median:21703.78 stddev:127397.96 (587.0%) stddev-sans-first:127718.58 14:56:34 INFO - PROCESS | 1913 | Values: 399.6 405.7 407.6 411.5 433.9 16535.5 19991.4 21035.8 22019.8 22093.6 21398.6 21432.6 21513.1 21687.9 22467.4 5985.2 6033.9 6121.9 6161.2 6167.8 5148.9 5872.8 6018.8 6042.7 6098.0 6076.9 6080.0 6081.0 6084.2 6096.0 5451.5 6047.1 6067.8 6094.3 6114.1 5353.4 5353.4 5358.1 5362.7 5374.7 21719.7 25996.2 26940.6 27219.9 27391.7 2741.6 2785.6 2794.3 2798.2 2807.7 10211.8 10309.7 10836.3 15835.8 17084.9 1903.1 1928.5 1929.0 1945.3 1954.5 99684.0 121178.0 127985.4 128392.0 132772.0 12482.1 12557.7 12702.2 12768.4 12848.7 16051.3 16155.9 16341.0 16344.4 16410.1 9091.4 9296.1 9340.0 9517.8 9527.7 9058.5 9191.4 9193.1 9363.4 9369.6 4905.2 5001.3 5004.8 5013.8 5040.8 2105.2 2129.3 2139.3 2141.6 2157.9 1004.4 1026.3 1034.1 1034.5 1052.9 17862.6 19782.4 21415.6 21416.5 21587.8 1074.4 1088.0 1090.0 1114.2 1127.0 9712.9 10574.9 11184.9 11202.7 11239.4 742465.0 769962.0 770849.0 779977.1 780608.0 120485.0 120524.0 142295.3 149621.0 153040.0 839.9 1052.6 1057.0 1066.1 1066.4 19258.6 20452.3 20620.9 20672.9 20725.2 63181.0 63921.7 64860.7 65450.0 66334.7 77480.2 91650.5 92892.0 95223.0 96665.5 6390.8 7805.1 7880.3 8098.1 8437.0 11296.3 11835.8 13646.6 13772.7 14199.1 9894.1 11095.3 11201.6 12009.5 12139.8 10708.8 11435.5 11682.9 11853.6 12005.2 6859.8 9441.1 11806.5 11888.0 12184.1 7830.9 7989.0 8065.8 8069.7 8295.3 11354.5 11754.8 11777.3 12073.9 12087.8 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | [#3] mootools.html Cycles:180 Average:5574.30 Median:5395.91 stddev:3035.88 (56.3%) stddev-sans-first:3028.60 14:56:34 INFO - PROCESS | 1913 | Values: 1453.2 1466.8 1471.1 1474.6 1480.4 7752.3 8026.0 8257.8 8714.4 8735.4 8205.0 8513.6 8515.1 8610.6 8643.6 2394.1 2435.9 2442.8 2447.9 2452.6 2401.7 2405.5 2446.9 2447.8 2458.0 2406.2 2416.9 2422.4 2430.1 2443.6 2385.0 2393.4 2396.3 2397.9 2405.4 2260.3 2356.6 2404.4 2416.4 2420.4 7589.8 8588.5 8643.6 8646.7 8690.5 5234.6 5390.2 5401.6 5430.5 5431.5 3552.9 3651.8 3663.4 3696.2 3718.4 1235.2 1265.4 1265.5 1297.2 1323.7 11169.0 11223.3 11231.2 11243.7 11312.9 4738.8 4802.4 4865.9 4871.2 4928.4 9671.3 9778.1 9780.7 9784.4 9838.1 5445.3 5462.9 5466.2 5475.9 5480.3 4506.9 4558.7 4871.0 4920.0 4953.8 3672.4 3868.2 4076.5 4116.7 4178.1 1329.4 1339.0 1354.4 1365.3 1366.8 809.6 825.8 833.3 834.0 840.6 5561.6 5605.7 5854.6 5906.3 5942.2 572.8 583.9 590.2 599.6 606.9 3393.9 3915.5 3919.8 3959.3 3984.4 9925.2 10098.9 10116.8 10213.0 10215.7 10022.2 10043.8 10137.4 10169.8 10172.9 7854.7 8059.0 8100.4 8107.7 8108.6 5577.7 5598.7 5660.3 5754.9 5795.8 9389.1 9413.3 9422.6 9552.2 9589.2 9218.7 9313.3 9490.2 9668.5 9672.1 7061.5 7137.6 7274.0 7316.0 7364.4 8100.8 8126.4 8207.1 8211.2 8257.0 7265.5 7270.5 7290.2 7328.3 7459.3 7116.6 7219.6 7227.9 7231.8 7252.3 5432.5 6476.0 6571.0 6584.0 6591.2 4941.0 5014.8 5033.5 5099.3 5268.7 4379.3 4974.4 5022.2 5043.6 5249.3 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | [#4] prototype.html Cycles:180 Average:4632.32 Median:5146.02 stddev:1417.75 (27.6%) stddev-sans-first:1385.02 14:56:34 INFO - PROCESS | 1913 | Values: 361.8 367.6 374.2 377.9 381.9 4335.3 5215.4 5297.3 5471.8 5620.6 4563.6 5477.3 5493.9 5538.6 5563.8 3444.2 3609.5 3663.9 4162.2 4299.2 3324.4 4180.4 4262.4 4357.0 4358.5 4054.2 4200.9 4239.6 4241.5 4259.9 3916.9 4265.6 4309.0 4314.7 4329.9 3807.2 3811.5 3837.7 3840.2 3844.7 5002.8 5328.9 5341.7 5368.5 5373.5 4224.5 4579.3 4769.6 4821.5 4836.9 5040.7 5767.8 5833.7 5857.5 6001.9 3326.8 3707.0 3918.8 3974.9 4010.2 6136.7 6199.8 6214.6 6215.5 6237.5 4016.4 4031.5 4033.4 4045.8 4069.9 3416.8 3956.8 3992.4 4052.4 4060.4 3789.7 4369.3 4371.3 4747.7 4776.6 5227.9 5862.5 5865.4 5886.0 5987.4 1105.0 1182.4 1201.6 1255.1 1289.9 930.5 982.2 1018.6 1021.6 1024.2 4470.9 4789.4 4791.7 5190.6 5194.6 5278.5 5372.4 5433.3 5653.3 5814.1 4863.5 5118.0 5122.3 5142.3 5149.8 2690.6 2695.9 2982.2 3002.2 3004.6 4839.6 5297.0 5828.4 5828.7 5927.9 5155.6 5335.4 5462.6 5813.9 5886.5 4602.0 5082.6 5765.5 5787.7 5813.4 5112.8 5183.8 5318.3 5686.0 5756.8 4826.4 5204.0 5301.8 5505.9 5975.9 6091.6 6218.3 6244.8 6286.9 6366.7 3799.4 3919.1 3993.4 4028.8 4034.3 5299.0 5659.8 5843.0 5930.9 6039.4 5712.0 5716.7 5753.2 5846.6 5895.2 5093.4 5474.8 5735.7 5799.5 5832.1 5508.6 5600.2 5656.3 5685.8 5721.3 5118.3 5505.8 5752.6 5795.9 5807.9 5393.7 5519.7 5593.0 5694.8 5752.9 14:56:34 INFO - PROCESS | 1913 | 14:56:34 INFO - PROCESS | 1913 | [#5] yui.html Cycles:180 Average:21104.90 Median:3792.91 stddev:30480.70 (803.6%) stddev-sans-first:30527.88 14:56:34 INFO - PROCESS | 1913 | Values: 747.7 754.5 764.8 791.6 895.0 15356.8 15850.9 16378.7 16550.0 16580.5 14926.2 14950.3 15010.9 15316.2 15337.5 870.9 888.9 896.1 896.8 899.3 725.6 746.9 888.1 895.4 918.0 811.3 910.0 954.2 956.3 956.6 933.2 950.0 950.2 950.6 952.8 698.6 712.8 714.4 715.6 717.1 13252.7 14578.9 15311.5 15940.0 16225.8 10670.7 14042.4 14463.0 14584.1 14629.9 11690.6 11742.8 11818.8 11898.6 12008.5 3728.3 3792.7 3808.5 3837.0 3982.4 93488.0 96513.0 96993.0 97647.0 99243.0 10887.1 10899.7 11161.0 11167.4 11552.0 22243.8 22277.9 22484.2 22594.5 22819.2 7949.2 7970.5 8183.1 8209.2 8251.1 4462.2 4485.9 4529.3 4551.3 4562.3 3712.1 3754.2 3757.4 3793.2 3801.4 520.9 574.3 592.0 605.9 607.1 578.4 683.2 697.4 702.9 711.0 10125.2 10516.0 10632.7 10683.5 10830.9 570.2 616.1 631.0 667.2 723.5 4896.4 5057.7 5082.1 5139.4 5145.5 112907.3 115241.0 115972.0 116540.4 118148.0 84642.6 98990.0 100515.0 102393.5 102729.0 66069.0 70809.0 76541.6 80335.0 85148.0 9122.7 9307.5 10796.9 11208.2 11339.3 45537.1 51790.0 52477.2 55046.0 56021.4 68838.3 70938.6 71710.6 72448.6 74130.6 13216.6 13258.9 13388.7 13472.9 13640.2 14700.8 14914.4 14978.8 15222.7 15857.2 13339.3 13666.9 13932.2 13935.3 14573.9 11033.3 13435.0 13923.9 13928.4 13929.7 12817.6 13626.3 13654.3 13800.7 13905.0 10820.4 11057.4 11074.5 11203.0 11442.5 10014.0 10098.6 10393.3 11780.2 11888.1 14:56:34 INFO - PROCESS | 1913 | -------- Summary: end -------- 14:56:34 INFO - PROCESS | 1913 | 14:56:35 INFO - TEST-INFO | 1913: exit 0 14:56:35 INFO - TEST-OK | dromaeo_css | took 1113618ms 14:56:35 INFO - TEST-START | kraken 14:56:35 INFO - operating with platform_type : mac_ 14:56:35 INFO - Initialising browser for kraken test... 14:56:35 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp3bK_LN/profile http://localhost:49369/getInfo.html) 14:56:37 INFO - PROCESS | 1918 | 2017-03-20 14:56:37.835 plugin-container[1920:16639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8537, name = 'com.apple.tsm.portname' 14:56:37 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:37 INFO - PROCESS | 1918 | 2017-03-20 14:56:37.836 plugin-container[1920:16639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 14:56:37 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:37 INFO - PROCESS | 1918 | 2017-03-20 14:56:37.836 plugin-container[1920:16639] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:56:37 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 14:56:37 INFO - PROCESS | 1918 | colorDepth:24 14:56:37 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 14:56:37 INFO - PROCESS | 1918 | __metrics 14:56:37 ERROR - PROCESS | 1918 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 14:56:38 INFO - TEST-INFO | 1918: exit 0 14:56:38 INFO - Browser initialized. 14:56:38 INFO - Running cycle 1/1 for kraken test... 14:56:38 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp3bK_LN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:40 INFO - PROCESS | 1921 | 2017-03-20 14:56:40.857 plugin-container[1922:16767] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 14:56:40 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:40 INFO - PROCESS | 1921 | 2017-03-20 14:56:40.857 plugin-container[1922:16767] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8817, name = 'com.apple.CFPasteboardClient' 14:56:40 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:40 INFO - PROCESS | 1921 | 2017-03-20 14:56:40.857 plugin-container[1922:16767] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:56:50 INFO - PROCESS | 1921 | RSS: Main: 172863488 14:56:50 INFO - PROCESS | 1921 | 14:56:53 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-beat-detection) 14:56:54 INFO - PROCESS | 1921 | RSS: Main: 185872384 14:56:54 INFO - PROCESS | 1921 | 14:56:56 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-dft) 14:56:57 INFO - PROCESS | 1921 | RSS: Main: 193449984 14:56:57 INFO - PROCESS | 1921 | 14:57:01 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-fft) 14:57:01 INFO - PROCESS | 1921 | RSS: Main: 195637248 14:57:01 INFO - PROCESS | 1921 | 14:57:03 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-oscillator) 14:57:04 INFO - PROCESS | 1921 | RSS: Main: 196878336 14:57:04 INFO - PROCESS | 1921 | 14:57:06 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:07 INFO - PROCESS | 1921 | RSS: Main: 197746688 14:57:07 INFO - PROCESS | 1921 | 14:57:09 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49369/tests/kraken/driver.html?testName=imaging-darkroom) 14:57:10 INFO - PROCESS | 1921 | RSS: Main: 201506816 14:57:10 INFO - PROCESS | 1921 | 14:57:13 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49369/tests/kraken/driver.html?testName=imaging-desaturate) 14:57:14 INFO - PROCESS | 1921 | RSS: Main: 201777152 14:57:14 INFO - PROCESS | 1921 | 14:57:17 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49369/tests/kraken/driver.html?testName=json-parse-financial) 14:57:18 INFO - PROCESS | 1921 | RSS: Main: 201019392 14:57:18 INFO - PROCESS | 1921 | 14:57:19 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:57:20 INFO - PROCESS | 1921 | RSS: Main: 199749632 14:57:20 INFO - PROCESS | 1921 | 14:57:22 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:57:22 INFO - PROCESS | 1921 | RSS: Main: 201056256 14:57:22 INFO - PROCESS | 1921 | 14:57:24 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:57:25 INFO - PROCESS | 1921 | RSS: Main: 201281536 14:57:25 INFO - PROCESS | 1921 | 14:57:28 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:57:29 INFO - PROCESS | 1921 | RSS: Main: 201740288 14:57:29 INFO - PROCESS | 1921 | 14:57:32 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:57:32 INFO - PROCESS | 1921 | RSS: Main: 201818112 14:57:32 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49369/tests/kraken/driver.html?testName=ai-astar) 14:57:34 INFO - PROCESS | 1921 | RSS: Main: 203718656 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | __start_tp_report 14:57:34 INFO - PROCESS | 1921 | _x_x_mozilla_page_load 14:57:34 INFO - PROCESS | 1921 | _x_x_mozilla_page_load_details 14:57:34 INFO - PROCESS | 1921 | |i|pagename|runs| 14:57:34 INFO - PROCESS | 1921 | |0;ai-astar;105;118;117;118;118;117;117;115;120;118 14:57:34 INFO - PROCESS | 1921 | |1;audio-beat-detection;144;110;112;146;109;120;118;143;117;174 14:57:34 INFO - PROCESS | 1921 | |2;audio-dft;199;204;200;203;278;283;206;181;268;288 14:57:34 INFO - PROCESS | 1921 | |3;audio-fft;84;60;85;108;81;71;56;58;71;61 14:57:34 INFO - PROCESS | 1921 | |4;audio-oscillator;89;71;85;70;69;72;81;79;104;113 14:57:34 INFO - PROCESS | 1921 | |5;imaging-gaussian-blur;88;77;135;130;89;96;91;86;88;85 14:57:34 INFO - PROCESS | 1921 | |6;imaging-darkroom;100;100;98;100;112;129;100;98;99;99 14:57:34 INFO - PROCESS | 1921 | |7;imaging-desaturate;117;111;142;94;141;142;85;144;142;121 14:57:34 INFO - PROCESS | 1921 | |8;json-parse-financial;59;55;57;58;59;61;60;62;61;61 14:57:34 INFO - PROCESS | 1921 | |9;json-stringify-tinderbox;68;71;67;82;110;68;68;72;71;71 14:57:34 INFO - PROCESS | 1921 | |10;stanford-crypto-aes;85;81;83;81;85;81;84;83;81;84 14:57:34 INFO - PROCESS | 1921 | |11;stanford-crypto-ccm;156;155;151;134;143;139;153;161;197;149 14:57:34 INFO - PROCESS | 1921 | |12;stanford-crypto-pbkdf2;185;167;187;164;164;165;165;166;164;163 14:57:34 INFO - PROCESS | 1921 | |13;stanford-crypto-sha256-iterative;65;66;66;64;68;66;65;71;65;76 14:57:34 INFO - PROCESS | 1921 | __end_tp_report 14:57:34 INFO - PROCESS | 1921 | __start_cc_report 14:57:34 INFO - PROCESS | 1921 | _x_x_mozilla_cycle_collect,940 14:57:34 INFO - PROCESS | 1921 | __end_cc_report 14:57:34 INFO - PROCESS | 1921 | __startTimestamp1490047054570__endTimestamp 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | ------- Summary: start ------- 14:57:34 INFO - PROCESS | 1921 | Number of tests: 14 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#0] ai-astar Cycles:10 Average:116.30 Median:118.00 stddev:4.16 (3.5%) stddev-sans-first:1.33 14:57:34 INFO - PROCESS | 1921 | Values: 105.0 118.0 117.0 118.0 118.0 117.0 117.0 115.0 120.0 118.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:131.50 stddev:21.42 (16.3%) stddev-sans-first:22.05 14:57:34 INFO - PROCESS | 1921 | Values: 144.0 110.0 112.0 146.0 109.0 120.0 118.0 143.0 117.0 174.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#2] audio-dft Cycles:10 Average:231.00 Median:237.00 stddev:42.37 (17.9%) stddev-sans-first:43.32 14:57:34 INFO - PROCESS | 1921 | Values: 199.0 204.0 200.0 203.0 278.0 283.0 206.0 181.0 268.0 288.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#3] audio-fft Cycles:10 Average:73.50 Median:71.00 stddev:16.28 (22.9%) stddev-sans-first:16.82 14:57:34 INFO - PROCESS | 1921 | Values: 84.0 60.0 85.0 108.0 81.0 71.0 56.0 58.0 71.0 61.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:75.50 stddev:15.02 (19.9%) stddev-sans-first:15.79 14:57:34 INFO - PROCESS | 1921 | Values: 89.0 71.0 85.0 70.0 69.0 72.0 81.0 79.0 104.0 113.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:88.00 stddev:19.60 (22.3%) stddev-sans-first:20.55 14:57:34 INFO - PROCESS | 1921 | Values: 88.0 77.0 135.0 130.0 89.0 96.0 91.0 86.0 88.0 85.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:113.50 stddev:9.85 (8.7%) stddev-sans-first:10.36 14:57:34 INFO - PROCESS | 1921 | Values: 100.0 100.0 98.0 100.0 112.0 129.0 100.0 98.0 99.0 99.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#7] imaging-desaturate Cycles:10 Average:123.90 Median:142.00 stddev:21.88 (15.4%) stddev-sans-first:23.07 14:57:34 INFO - PROCESS | 1921 | Values: 117.0 111.0 142.0 94.0 141.0 142.0 85.0 144.0 142.0 121.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:60.50 stddev:2.16 (3.6%) stddev-sans-first:2.29 14:57:34 INFO - PROCESS | 1921 | Values: 59.0 55.0 57.0 58.0 59.0 61.0 60.0 62.0 61.0 61.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:71.00 stddev:13.09 (18.4%) stddev-sans-first:13.65 14:57:34 INFO - PROCESS | 1921 | Values: 68.0 71.0 67.0 82.0 110.0 68.0 68.0 72.0 71.0 71.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:1.69 (2.0%) stddev-sans-first:1.59 14:57:34 INFO - PROCESS | 1921 | Values: 85.0 81.0 83.0 81.0 85.0 81.0 84.0 83.0 81.0 84.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:154.00 stddev:17.27 (11.2%) stddev-sans-first:18.30 14:57:34 INFO - PROCESS | 1921 | Values: 156.0 155.0 151.0 134.0 143.0 139.0 153.0 161.0 197.0 149.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:165.50 stddev:9.04 (5.5%) stddev-sans-first:7.51 14:57:34 INFO - PROCESS | 1921 | Values: 185.0 167.0 187.0 164.0 164.0 165.0 165.0 166.0 164.0 163.0 14:57:34 INFO - PROCESS | 1921 | 14:57:34 INFO - PROCESS | 1921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.00 stddev:3.68 (5.6%) stddev-sans-first:3.81 14:57:34 INFO - PROCESS | 1921 | Values: 65.0 66.0 66.0 64.0 68.0 66.0 65.0 71.0 65.0 76.0 14:57:34 INFO - PROCESS | 1921 | -------- Summary: end -------- 14:57:34 INFO - PROCESS | 1921 | 14:57:35 INFO - TEST-INFO | 1921: exit 0 14:57:35 INFO - TEST-OK | kraken | took 60298ms 14:57:35 INFO - SUITE-END | took 1173s 14:57:35 INFO - Completed test suite (00:19:34) 14:57:35 INFO - javascript benchmark 14:57:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7480.407436458057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.251818340873, 3443.001529556429, 3455.9827200863992, 3467.4798780182955, 3501.8074005929666, 5874.588778785482, 5924.99275123229, 5937.287525496936, 5949.821505354836, 5959.404059594039, 5943.465088142067, 6014.669193194372, 6016.578839481238, 6026.668533230671, 6037.547183961198, 5354.785808567653, 5388.191771234327, 5399.406065332811, 5433.0, 5498.917516237259, 5457.317835270591, 5461.890762184754, 5476.315460567429, 5481.479259470364, 5518.089515229983, 5294.311739473863, 5306.655067420625, 5353.892922141555, 5473.2063850741815, 5474.343078830526, 4513.187626227278, 4594.563516465931, 5269.552088072518, 5388.488093631118, 5436.782528698847, 5268.31511903454, 5365.168398898177, 5386.434424385422, 5403.081476149064, 5480.369757477902, 5763.250777398953, 5771.88456230873, 5820.214271073393, 5896.528277737771, 6045.909311360333, 6178.474829639486, 6185.8144255672405, 6214.285357183937, 6296.842578935518, 6309.432151106423, 6320.273168585625, 6336.96831515844, 6347.555671103025, 6351.714172862232, 6355.396237357444, 5955.731992060368, 6009.0, 6122.8775424491705, 6136.417040381157, 6153.2000839890525, 4659.883502912454, 5428.158635411518, 6107.46191531438, 6330.68346582669, 6363.490920726424, 4483.977580112144, 6191.19514463117, 6200.286966998763, 6267.4045965633195, 6278.686065696788, 5170.71561064145, 5488.780448782004, 6018.458338749446, 6311.715972781236, 6320.209973753281, 6175.59858609189, 6221.2845522764555, 6227.377262273736, 6276.089966954766, 6292.937070629327, 6250.093736408196, 6280.277768056732, 6286.874262514724, 6291.056341548713, 6297.244330680348, 5038.470960549163, 5154.871128221749, 5161.27742116104, 5161.406438259648, 5165.457626949192, 4549.909001819945, 4552.521985191507, 4567.383403240587, 4586.312053192048, 4607.539246075366, 5989.580729348903, 6016.157737916695, 6033.396660333931, 6034.7284372202475, 6045.395460454008, 6161.84595385119, 6341.302456729756, 6390.0734393512685, 6400.679966001681, 6419.679016049179, 5883.441073098049, 5939.406059394112, 5948.494377977834, 5986.880262394815, 6054.666993315322, 5656.91514627281, 5660.801871934463, 5669.177969194444, 5675.489205971482, 5687.260656114679, 6409.8718025640155, 6439.323870993572, 6442.48460123189, 6452.935470645233, 6462.0306953955405, 6175.876482470415, 6241.937580624136, 6251.562390632612, 6253.3121356651645, 6278.246610406781, 6352.110704501466, 6392.488600912009, 6413.8396540085005, 6428.935710642833, 6441.516886233645, 5053.949460505495, 6033.883731509684, 6199.504039676905, 6220.564560480723, 6321.209848768904, 6154.230721159855, 6195.101710251898, 6201.348858369986, 6205.441510264098, 6320.905186422116, 6088.178095956989, 6201.96899015502, 6235.96882015587, 6260.874782504234, 6269.749210031548, 6201.410865967726, 6204.038374052029, 6207.565470417027, 6212.81361559154, 6216.813495595139, 5072.391313042459, 5876.970615146897, 5993.160957465871, 6084.513238940963, 6143.447089761943, 6151.0, 6194.287656919331, 6213.347598502092, 6216.937830621817, 6241.344658810759, 6207.782727604512, 6222.09779581949, 6222.439980401786, 6233.376662333912, 6253.187085679015], "value": 5789.3728073896555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.126629794541, 527.9599189596494, 546.011718788992, 569.2258528401373, 573.5583600627514, 38632.806835965814, 41996.16007679845, 42063.36904946428, 42264.78867605662, 42357.36463953035, 42574.574254257524, 42883.92790180247, 42942.35586466206, 43096.56903430965, 43127.56872431275, 8316.04365497968, 9013.098690130968, 9361.204297634675, 9581.90418095817, 9743.75640608987, 10260.742636619969, 10342.379457232553, 11756.118291128158, 12032.398380081006, 12044.277343359383, 10214.591416343337, 11860.0, 11916.821247681291, 12015.339156346397, 12018.278903265787, 9991.90008099917, 11898.048156147488, 11964.94017529911, 12013.93993030038, 12017.218880772809, 11970.521179152824, 12004.279743215347, 12015.93992030043, 12087.153899227058, 12134.150609457341, 42756.78621606872, 43111.56888431107, 43144.0, 43146.92132696676, 43287.56712432867, 3924.1170736584327, 4160.521540022906, 4203.285441474956, 4209.095044565433, 4233.576642335773, 30876.691233087608, 30905.381892362027, 30917.22706932322, 32729.509057364157, 32986.34027319464, 3268.7221586164965, 3410.4031794435873, 3444.48332750087, 3521.0845180253064, 3579.838907249154, 497155.0, 502373.99999999633, 503668.0, 503793.0, 504136.0, 62579.68710156511, 62598.43503912348, 62914.0, 63159.0, 63162.68418657969, 67177.66411167913, 67203.0, 67540.66229668919, 67800.66099669569, 67821.98267025998, 16885.915570422316, 16941.830581694026, 17092.0, 17106.828931710774, 17111.401100961408, 12387.132900697045, 12676.492940282285, 13354.599362019155, 13729.970252231122, 13771.517996870061, 16228.51314460568, 16304.836951630568, 16319.755203671955, 16325.26536305869, 16327.428540001043, 5626.409227031185, 6482.57863238888, 6629.171353580802, 6660.36915418407, 6704.726102040694, 776.5651235308245, 865.8917635295588, 903.385697725553, 920.5443305563789, 948.369334392635, 30746.231344216125, 31048.379032419227, 31122.377552448823, 31406.0, 31542.211444714067, 975.2246963663904, 1096.6435908329665, 1106.0985296982933, 1155.0470861539263, 1287.6394609509166, 15519.37922483088, 16092.597685057966, 16178.27197776103, 16222.675546489005, 16484.423045193602, 589441.0, 606179.0, 607318.0, 607588.0, 608644.0, 62943.0, 63223.05165422522, 63330.0, 63439.73120537563, 63472.365276346645, 1427.4432971141264, 1442.1347191685115, 1485.591462347863, 1499.1379956524825, 1513.8107736532934, 29355.559666605444, 30491.0, 30688.539671905386, 30701.846490767402, 30978.845105775228, 43599.78200108979, 52248.69378265422, 52258.0, 52444.0, 52548.0, 527209.0, 527318.0, 528441.0, 530890.0, 530996.0, 25511.617325739757, 26223.60664590071, 26392.0, 27057.0, 41977.580224197365, 38675.806620966716, 44262.11475770531, 45476.09047819091, 45656.0, 47960.28059579039, 36839.63160368469, 36991.0, 37481.81259093687, 37900.0, 38340.61659383482, 28548.85725571359, 36854.894353169446, 37036.81481592575, 37840.62159378371, 38092.04769880775, 29953.550696740003, 31608.841955790074, 36626.0, 37349.62650373462, 37384.626153739206, 29253.976110836018, 31078.0, 33112.50331244985, 33222.501662475566, 33274.0, 20069.29757458482, 20994.790052099896, 21462.24882129118, 22460.32619021432, 24724.43700167448], "value": 20461.830864743748, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.6183644619389, 405.70180917026, 407.64127567740394, 411.45687692246236, 433.9023719663076, 16535.50393488196, 19991.40025799228, 21035.789642103573, 22019.788911609834, 22093.558128837412, 21398.572028559418, 21432.57134857302, 21513.139474421045, 21687.891560542215, 22467.438314042116, 5985.162077309169, 6033.909491357633, 6121.908171377433, 6161.229846269216, 6167.845803854917, 5148.922766158511, 5872.823815285548, 6018.759249630009, 6042.728077236513, 6098.0, 6076.878462430749, 6080.0, 6081.0, 6084.2090528231265, 6096.024636058231, 5451.48210919962, 6047.092936059582, 6067.7572897084065, 6094.329623741385, 6114.052321890114, 5353.38436079848, 5353.437889021636, 5358.089124848785, 5362.731863406814, 5374.7043912584795, 21719.67420488694, 25996.22011339663, 26940.59589106165, 27219.86390068037, 27391.726082739315, 2741.5613501839807, 2785.637867077267, 2794.3433293176085, 2798.188525327673, 2807.7192280771965, 10211.79576408475, 10309.742256443575, 10836.295640783324, 15835.762463563056, 17084.914575427167, 1903.1435853865817, 1928.517870532367, 1928.9807101929082, 1945.2705235536673, 1954.5211423201265, 99684.0, 121178.0, 127985.36007319998, 128392.0, 132772.0, 12482.126251162514, 12557.686057848445, 12702.174358666656, 12768.425420856083, 12848.678783030313, 16051.277692503865, 16155.919220403823, 16341.019538827471, 16344.427945021867, 16410.097444640658, 9091.363604547618, 9296.07039296065, 9340.0, 9517.762055948519, 9527.666531671359, 9058.54707264634, 9191.402558833654, 9193.080691930887, 9363.391379560308, 9369.625214991323, 4905.190643543847, 5001.324821149171, 5004.799808007711, 5013.799448022111, 5040.7731652075745, 2105.2421128393767, 2129.3186180422426, 2139.3261122746285, 2141.603803296395, 2157.946051348729, 1004.382304882492, 1026.348268849271, 1034.0693375961544, 1034.5137785240925, 1052.921030922684, 17862.642747144986, 19782.40652780419, 21415.571688566142, 21416.464588385414, 21587.784122158893, 1074.3768614203743, 1087.9891201087887, 1090.0353187429182, 1114.1810769084716, 1126.954921803135, 9712.854307185398, 10574.947125264325, 11184.888151118548, 11202.719932001603, 11239.438028098726, 742465.0, 769962.0, 770849.0, 779977.1001145071, 780608.0, 120485.0, 120524.0, 142295.28852355672, 149621.0, 153040.0, 839.8824164616836, 1052.6473631333436, 1057.0, 1066.1151244467073, 1066.3868275741324, 19258.614827703088, 20452.325419134027, 20620.896895515427, 20672.896635516725, 20725.170993160104, 63181.0, 63921.680391599606, 64860.67569662121, 65450.0, 66334.66832665999, 77480.2251977473, 91650.54174729083, 92892.0, 95223.0, 96665.516672419, 6390.808275751735, 7805.102413222552, 7880.2513761192595, 8098.149694282016, 8436.957815210884, 11296.265742726697, 11835.82246266324, 13646.590602281947, 13772.724545509234, 14199.148051116967, 9894.06006429388, 11095.278806877526, 11201.551937922392, 12009.459574319351, 12139.75720485603, 10708.785824283626, 11435.542578297107, 11682.88317116818, 11853.644390668294, 12005.219660722025, 6859.794206173823, 9441.10309520622, 11806.46870890829, 11888.0, 12184.147109702235, 7830.92169078302, 7989.001374828146, 8065.83868322642, 8069.7175598853755, 8295.336373090258, 11354.489047993025, 11754.823677645014, 11777.293362398283, 12073.879261207627, 12087.758244834878], "value": 10215.311367018381, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.2443129572616, 1466.794648749175, 1471.065873170537, 1474.6239708874236, 1480.4152359817865, 7752.263534964183, 8026.0, 8257.793555161124, 8714.389992700506, 8735.432196907204, 8204.958975205116, 8513.616887240074, 8515.105913879046, 8610.61252243649, 8643.567821608925, 2394.1141777542334, 2435.8538487690707, 2442.7557244275517, 2447.877606119687, 2452.5953217719057, 2401.7238017627933, 2405.518896220754, 2446.8654224017673, 2447.8164137689746, 2457.9631305530434, 2406.181898154627, 2416.864073885271, 2422.39440139965, 2430.064425196303, 2443.596806526921, 2385.0459816073535, 2393.3896856301617, 2396.269137912936, 2397.904083836653, 2405.434722840131, 2260.333201705501, 2356.587597170488, 2404.446977195237, 2416.359664688859, 2420.431198668329, 7589.81025474362, 8588.527630980294, 8643.567821608895, 8646.697365592237, 8690.478571285743, 5234.6335756497065, 5390.245365648812, 5401.567874570025, 5430.456954304577, 5431.51116399522, 3552.928941421183, 3651.7808931463933, 3663.413853783382, 3696.2053158571034, 3718.4050551911564, 1235.1600911380258, 1265.367316341829, 1265.544404014554, 1297.2216669997927, 1323.6690827293178, 11168.994790468896, 11223.270487418291, 11231.21381503295, 11243.66269011931, 11312.943435282854, 4738.849179411407, 4802.447718512346, 4865.927011094836, 4871.196252618278, 4928.359313289249, 9671.323007389556, 9778.07108324708, 9780.706578802647, 9784.412935223909, 9838.06538378853, 5445.2921120254905, 5462.863428414242, 5466.180072989084, 5475.863103422446, 5480.342358916955, 4506.932396014063, 4558.703684260512, 4871.001444703898, 4920.0, 4953.752312384367, 3672.412414013745, 3868.168343806095, 4076.5311989121037, 4116.6912481564, 4178.12259425524, 1329.4482789642384, 1339.04258455205, 1354.3972932045144, 1365.2900491744238, 1366.7972184477596, 809.6437567470294, 825.7646570727314, 833.3041910005213, 833.9533884974439, 840.6301227459898, 5561.63849349791, 5605.747741351649, 5854.590178687451, 5906.291245050621, 5942.168096466498, 572.7737543670311, 583.8964357364584, 590.200278622469, 599.6162456028145, 606.9484093851984, 3393.8812141574926, 3915.4909861718365, 3919.843206271717, 3959.3467077932396, 3984.406237505021, 9925.2059835213, 10098.949505252427, 10116.848247276297, 10212.978702129876, 10215.744606384751, 10022.198224142052, 10043.844957829797, 10137.391756494633, 10169.847452288222, 10172.898271017195, 7854.685812567547, 8058.959705201437, 8100.392470564731, 8107.716229931924, 8108.635111420001, 5577.749001295033, 5598.692071936082, 5660.264165658438, 5754.8849023018465, 5795.82612521625, 9389.061093890556, 9413.29400294967, 9422.62309507612, 9552.188064014637, 9589.18491928166, 9218.677346292847, 9313.34806563534, 9490.193333566447, 9668.468234247184, 9672.08115229052, 7061.540999834994, 7137.643117843983, 7273.9636301818155, 7315.963420182865, 7364.379836435975, 8100.797480063045, 8126.390520710852, 8207.138250483853, 8211.17888211198, 8256.958715206385, 7265.455090868311, 7270.491065625567, 7290.234525374759, 7328.303811137934, 7459.328660420588, 7116.608586527791, 7219.60292183935, 7227.891581626385, 7231.819204519718, 7252.347288744038, 5432.483914028161, 6475.967620161869, 6571.014347847861, 6584.04531342943, 6591.209054913441, 4940.975295123501, 5014.824481143142, 5033.47148549397, 5099.286099945936, 5268.683878967274, 4379.255526560429, 4974.353334066548, 5022.187574958035, 5043.5712964398435, 5249.317588713443], "value": 4488.995982336554, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8154741082049, 367.61033304697025, 374.2309553866804, 377.8998565380173, 381.92170605025956, 4335.328024156253, 5215.400228973669, 5297.337832770903, 5471.753771080301, 5620.622947377893, 4563.56646118619, 5477.3427188737405, 5493.92868390663, 5538.6122971392015, 5563.833085007446, 3444.1733983843824, 3609.4766258892446, 3663.890083297492, 4162.1675664867, 4299.247631664454, 3324.434846076173, 4180.393842892794, 4262.407916327923, 4357.041450880801, 4358.542353052915, 4054.2094291613, 4200.928763165404, 4239.618434340909, 4241.533431322552, 4259.936100958488, 3916.9020774480723, 4265.594768496988, 4308.965848196442, 4314.741115533078, 4329.874232699489, 3807.200487897545, 3811.5235595550557, 3837.6737977271687, 3840.2127563849344, 3844.7312386912254, 5002.849914502571, 5328.946710532922, 5341.706206158659, 5368.516833485005, 5373.489518495737, 4224.471941007374, 4579.321097158167, 4769.642276829217, 4821.517848215186, 4836.879078023077, 5040.689420750595, 5767.798127065575, 5833.679147646878, 5857.531397488191, 6001.909971350433, 3326.76712630116, 3707.0, 3918.784466854322, 3974.940375894364, 4010.1954120645532, 6136.693165341715, 6199.814005579839, 6214.5649804513705, 6215.502759779252, 6237.500999920041, 4016.397540368968, 4031.475908131924, 4033.4151548025957, 4045.838166473367, 4069.877903662895, 3416.8462419191196, 3956.7823769692945, 3992.401139829049, 4052.365962124584, 4060.4315395844606, 3789.7304403024746, 4369.3227549729845, 4371.278739008092, 4747.715137091716, 4776.570108690165, 5227.869303267449, 5862.530997520188, 5865.413458654186, 5886.0, 5987.43119403656, 1104.9723756906142, 1182.3851597169423, 1201.5794471934753, 1255.0775180242515, 1289.9032572556907, 930.4510338900081, 982.2387649571497, 1018.6332920148741, 1021.6322124035341, 1024.1908891975404, 4470.932936005963, 4789.425268967677, 4791.682287370932, 5190.586377334557, 5194.558462530652, 5278.498542638443, 5372.435894231127, 5433.2936718227165, 5653.349864765604, 5814.127880817911, 4863.465018847924, 5118.0, 5122.257272695439, 5142.254373115878, 5149.7940082397035, 2690.614333618188, 2695.9460810783676, 2982.1500872251304, 3002.168677106963, 3004.5813120438256, 4839.637027222972, 5297.046531624344, 5828.388019258002, 5828.708564571754, 5927.940720592739, 5155.587552995751, 5335.3864305604575, 5462.590305727086, 5813.883722325614, 5886.470217680429, 4601.987562736193, 5082.576878474033, 5765.481106700333, 5787.65274083548, 5813.360530341659, 5112.821051263188, 5183.844484665466, 5318.282031925641, 5686.038316780704, 5756.797537797348, 4826.420829500483, 5204.0, 5301.814436494704, 5505.944940550543, 5975.894459525001, 6091.568481406955, 6218.253809542884, 6244.815144276361, 6286.937130628635, 6366.694827560432, 3799.3920972644246, 3919.0790164310793, 3993.4409182715026, 4028.8115006073863, 4034.2939985501835, 5299.019681358961, 5659.830205093854, 5843.0, 5930.881382372415, 6039.4367323279475, 5711.971440142773, 5716.714164291686, 5753.223314852441, 5846.649201047951, 5895.20414744004, 5093.363329583802, 5474.768177160107, 5735.713214339183, 5799.4780469757925, 5832.054812319751, 5508.55931525485, 5600.1918695287595, 5656.3495198051105, 5685.829425117253, 5721.342045664802, 5118.261729974446, 5505.788726480168, 5752.568557358131, 5795.8551036224435, 5807.94192058074, 5393.730313484389, 5519.724013799214, 5592.965301419251, 5694.800681976111, 5752.9137062943255], "value": 4197.225899085471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.6784982457548, 754.5397307642334, 764.8393837294168, 791.6279348706109, 894.9776255593612, 15356.846431535696, 15850.920745396257, 16378.672426551477, 16550.0, 16580.50258492244, 14926.179060151715, 14950.327235274412, 15010.924945375285, 15316.234188290597, 15337.463188788395, 870.9085546017672, 888.933330000251, 896.059137905197, 896.847535918892, 899.3120262998812, 725.5501589014792, 746.8767653337193, 888.1340692824509, 895.4314010603249, 917.9908200918005, 811.2739098506833, 910.0399078971682, 954.1603389017655, 956.2923436656894, 956.6077908057698, 933.2254228989922, 949.9667511637059, 950.1875896108832, 950.5912457643211, 952.8046750416148, 698.6122701900443, 712.7505373119367, 714.4141803720951, 715.5563550598611, 717.1107826295408, 13252.668683282995, 14578.854211457961, 15311.464098756602, 15939.96390234631, 16225.756613650805, 10670.733231669194, 14042.419497209723, 14463.0, 14584.052036617586, 14629.853701462956, 11690.649280521598, 11742.823857642143, 11818.822717659243, 11898.643040708792, 12008.519659213622, 3728.3102626014, 3792.658660720521, 3808.485854409647, 3836.961630383716, 3982.4026396040535, 93488.0, 96513.0, 96993.0, 97647.0, 99243.0, 10887.129029677606, 10899.727506812234, 11161.0, 11167.441627918572, 11552.0, 22243.777562224495, 22277.88861055717, 22484.213052543084, 22594.54810903773, 22819.20132795344, 7949.244821741925, 7970.4819186752675, 8183.099859015503, 8209.220124088202, 8251.051129120107, 4462.241418958784, 4485.910281794346, 4529.275315949498, 4551.3173024046655, 4562.338460923214, 3712.1090938174643, 3754.249150169977, 3757.4363845423404, 3793.165503589206, 3801.4107813288433, 520.8906129712727, 574.2649408756798, 591.973361198747, 605.8545948972303, 607.1257389359308, 578.3695771608882, 683.2450142592463, 697.3584302441766, 702.9367356937901, 710.9537880037781, 10125.240606954509, 10516.0, 10632.681019569425, 10683.465826708634, 10830.916908309106, 570.2444261353722, 616.1240555401696, 630.9558330916792, 667.1893649216129, 723.4935545118439, 4896.36347274852, 5057.658498793153, 5082.057681503874, 5139.408967968657, 5145.511176438233, 112907.3063904042, 115241.0, 115972.0, 116540.41729791297, 118148.0, 84642.57678711567, 98990.01009989952, 100515.0, 102393.48803255935, 102729.0, 66069.0, 70809.0, 76541.61729191318, 80335.0, 85148.0, 9122.680706175252, 9307.534623268673, 10796.89203107959, 11208.215424920178, 11339.319640821577, 45537.08925821531, 51790.0, 52477.163299284344, 55046.0, 56021.43978560162, 68838.3116168852, 70938.64530677313, 71710.6217033714, 72448.63775681087, 74130.62934685292, 13216.603501894959, 13258.933705331412, 13388.665283367995, 13472.932635336761, 13640.249786261851, 14700.779488307899, 14914.403423862925, 14978.775318370015, 15222.695546089237, 15857.207139643202, 13339.266340350985, 13666.93166534161, 13932.164070155823, 13935.303234838015, 14573.92713036428, 11033.282836615594, 13435.0, 13923.860761392662, 13928.373223205183, 13929.651758706113, 12817.615471535868, 13626.318684065955, 13654.317284135555, 13800.654983625089, 13905.0, 10820.350778953289, 11057.447127643425, 11074.501647425725, 11203.0, 11442.485088170886, 10013.995801259447, 10098.646547370807, 10393.324433911772, 11780.175387722777, 11888.129198992241], "value": 7683.608107624768, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 115.0, 120.0, 118.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 112.0, 146.0, 109.0, 120.0, 118.0, 143.0, 117.0, 174.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 204.0, 200.0, 203.0, 278.0, 283.0, 206.0, 181.0, 268.0, 288.0], "value": 231.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 85.0, 108.0, 81.0, 71.0, 56.0, 58.0, 71.0, 61.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 85.0, 70.0, 69.0, 72.0, 81.0, 79.0, 104.0, 113.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 77.0, 135.0, 130.0, 89.0, 96.0, 91.0, 86.0, 88.0, 85.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 98.0, 100.0, 112.0, 129.0, 100.0, 98.0, 99.0, 99.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 142.0, 94.0, 141.0, 142.0, 85.0, 144.0, 142.0, 121.0], "value": 123.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 57.0, 58.0, 59.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 82.0, 110.0, 68.0, 68.0, 72.0, 71.0, 71.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 83.0, 81.0, 85.0, 81.0, 84.0, 83.0, 81.0, 84.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 151.0, 134.0, 143.0, 139.0, 153.0, 161.0, 197.0, 149.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 167.0, 187.0, 164.0, 164.0, 165.0, 165.0, 166.0, 164.0, 163.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 64.0, 68.0, 66.0, 65.0, 71.0, 65.0, 76.0], "value": 67.2, "unit": "score"}]}]} 14:57:35 INFO - Return code: 0 14:57:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:57:35 ERROR - # TBPL SUCCESS # 14:57:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:57:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:57:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:57:35 INFO - 2017-03-20 14:57:35.874 screenresolution[1926:17143] starting screenresolution argv=screenresolution get 14:57:35 INFO - 2017-03-20 14:57:35.876 screenresolution[1926:17143] Display 0: 1600x1200x32@60 14:57:35 INFO - 2017-03-20 14:57:35.882 screenresolution[1927:17146] starting screenresolution argv=screenresolution list 14:57:35 INFO - Available Modes on Display 0 14:57:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:57:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:57:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:57:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:57:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:57:36 INFO - Intel Iris: 14:57:36 INFO - Chipset Model: Intel Iris 14:57:36 INFO - Type: GPU 14:57:36 INFO - Bus: Built-In 14:57:36 INFO - VRAM (Dynamic, Max): 1536 MB 14:57:36 INFO - Vendor: Intel (0x8086) 14:57:36 INFO - Device ID: 0x0a2e 14:57:36 INFO - Revision ID: 0x0009 14:57:36 INFO - Displays: 14:57:36 INFO - Display: 14:57:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:57:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:57:36 INFO - Display Serial Number: 1600x1200 60 14:57:36 INFO - Main Display: Yes 14:57:36 INFO - Mirror: Off 14:57:36 INFO - Online: Yes 14:57:36 INFO - Rotation: Supported 14:57:36 INFO - Return code: 0 14:57:36 INFO - Running post-action listener: _resource_record_post_action 14:57:36 INFO - [mozharness: 2017-03-20 21:57:36.122959Z] Finished run-tests step (success) 14:57:36 INFO - Running post-run listener: _resource_record_post_run 14:57:36 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 2068480; Write bytes: 424772096; Read time: 24; Write time: 1775 14:57:36 INFO - TinderboxPrint: CPU usage
54.4% 14:57:36 INFO - TinderboxPrint: I/O read bytes / time
2,068,480 / 24 14:57:36 INFO - TinderboxPrint: I/O write bytes / time
424,772,096 / 1,775 14:57:36 INFO - TinderboxPrint: CPU idle
2,171.6 (45.6%) 14:57:36 INFO - TinderboxPrint: CPU system
960.2 (20.2%) 14:57:36 INFO - TinderboxPrint: CPU user
1,626.0 (34.2%) 14:57:36 INFO - TinderboxPrint: Swap in / out
124,633,088 / 0 14:57:36 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 113562112; Write bytes: 115259392; Read time: 10073; Write time: 359 14:57:36 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 2068480; Write bytes: 299682304; Read time: 24; Write time: 1388 14:57:36 INFO - Running post-run listener: _upload_blobber_files 14:57:36 INFO - Blob upload gear active. 14:57:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:57:36 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 14:57:36 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'] 14:57:36 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 14:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 14:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:37 INFO - (blobuploader) - INFO - Done attempting. 14:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:38 INFO - (blobuploader) - INFO - Done attempting. 14:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:39 INFO - (blobuploader) - INFO - Done attempting. 14:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:57:42 INFO - (blobuploader) - INFO - Done attempting. 14:57:42 INFO - (blobuploader) - INFO - Iteration through files over. 14:57:42 INFO - Return code: 0 14:57:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:57:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:57:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97d10363f7636105b9f6533b03e7d1be328491378a431982e150dfa8c758bb1565a392a3ebb408115431977e9d24a0fbdfa0fd95271265f27a7403070cdb1c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13b396b05a3ca030aea4820791f64fa861489b165008e151c66f878fb75d18bcbdce4d71d1c7c52f2e0011fb617359de5fcd362ad791cc3959a1c56e358237e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/504af75fc8e6c72871c36cf47ae86dd069c4f055ac1ca308f7e68092e3942e075212bc0ec414159ad9abf57e7e66cde0d5c55e672cbc12145201eff1d5e027ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a8a95df2e0955335b58e9be880928daa450b3b56d4eda1f64477ac31a0ca12a04f416971bd9204dc8a02fe3b3d3c0bbefb2c9b06daf00fec58bd9722c0a0bced"} 14:57:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:57:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:57:42 INFO - Contents: 14:57:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97d10363f7636105b9f6533b03e7d1be328491378a431982e150dfa8c758bb1565a392a3ebb408115431977e9d24a0fbdfa0fd95271265f27a7403070cdb1c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13b396b05a3ca030aea4820791f64fa861489b165008e151c66f878fb75d18bcbdce4d71d1c7c52f2e0011fb617359de5fcd362ad791cc3959a1c56e358237e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/504af75fc8e6c72871c36cf47ae86dd069c4f055ac1ca308f7e68092e3942e075212bc0ec414159ad9abf57e7e66cde0d5c55e672cbc12145201eff1d5e027ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a8a95df2e0955335b58e9be880928daa450b3b56d4eda1f64477ac31a0ca12a04f416971bd9204dc8a02fe3b3d3c0bbefb2c9b06daf00fec58bd9722c0a0bced"} 14:57:42 INFO - Running post-run listener: copy_logs_to_upload_dir 14:57:42 INFO - Copying logs to upload dir... 14:57:42 INFO - mkdir: /builds/slave/test/build/upload/logs 14:57:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.191922 ========= master_lag: 1.75 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-20 14:57:43.782436) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 14:57:43.785331) ========= 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.OA2DbFciXh/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.mBFbkRgKyl/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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/97d10363f7636105b9f6533b03e7d1be328491378a431982e150dfa8c758bb1565a392a3ebb408115431977e9d24a0fbdfa0fd95271265f27a7403070cdb1c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13b396b05a3ca030aea4820791f64fa861489b165008e151c66f878fb75d18bcbdce4d71d1c7c52f2e0011fb617359de5fcd362ad791cc3959a1c56e358237e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/504af75fc8e6c72871c36cf47ae86dd069c4f055ac1ca308f7e68092e3942e075212bc0ec414159ad9abf57e7e66cde0d5c55e672cbc12145201eff1d5e027ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a8a95df2e0955335b58e9be880928daa450b3b56d4eda1f64477ac31a0ca12a04f416971bd9204dc8a02fe3b3d3c0bbefb2c9b06daf00fec58bd9722c0a0bced"} build_url:https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011555 build_url: 'https://queue.taskcluster.net/v1/task/T-xeMeuKQ6msfCPLvUB-mA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97d10363f7636105b9f6533b03e7d1be328491378a431982e150dfa8c758bb1565a392a3ebb408115431977e9d24a0fbdfa0fd95271265f27a7403070cdb1c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/13b396b05a3ca030aea4820791f64fa861489b165008e151c66f878fb75d18bcbdce4d71d1c7c52f2e0011fb617359de5fcd362ad791cc3959a1c56e358237e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/504af75fc8e6c72871c36cf47ae86dd069c4f055ac1ca308f7e68092e3942e075212bc0ec414159ad9abf57e7e66cde0d5c55e672cbc12145201eff1d5e027ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a8a95df2e0955335b58e9be880928daa450b3b56d4eda1f64477ac31a0ca12a04f416971bd9204dc8a02fe3b3d3c0bbefb2c9b06daf00fec58bd9722c0a0bced"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 14:57:43.832463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 14:57:43.832783) ========= 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.OA2DbFciXh/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.mBFbkRgKyl/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005298 ========= master_lag: 0.81 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 14:57:44.645755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 14:57:44.646063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 14:57:44.649368) ========= ========= Total master_lag: 4.76 =========