builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0134 starttime: 1472039438.52 results: success (0) buildid: 20160823230014 builduid: 210559543a0142338c596ba2e445cde6 revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.518842) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.519905) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.520643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.549123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.549926) ========= 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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-24 04:50:38-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.44M=0.001s 2016-08-24 04:50:38 (9.44 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.670232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.670592) ========= 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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.035718 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:38.729137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 04:50:38.729530) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-24 04:50:38,803 truncating revision to first 12 chars 2016-08-24 04:50:38,803 Setting DEBUG logging. 2016-08-24 04:50:38,803 attempt 1/10 2016-08-24 04:50:38,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb8d56badefe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 04:50:40,231 unpacking tar archive at: fx-team-eb8d56badefe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.670934 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 04:50:40.428080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:40.428898) ========= script_repo_revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:40.429858) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:40.430571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 04:50:40.450769) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-24 04:50:40.451530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:50:40 INFO - MultiFileLogger online at 20160824 04:50:40 in /builds/slave/test 04:50:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:50:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:40 INFO - {'append_to_log': False, 04:50:40 INFO - 'base_work_dir': '/builds/slave/test', 04:50:40 INFO - 'blob_upload_branch': 'Fx-Team', 04:50:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:40 INFO - 'branch': 'Fx-Team', 04:50:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:40 INFO - 'config_files': ('talos/mac_config.py',), 04:50:40 INFO - 'default_actions': ('clobber', 04:50:40 INFO - 'read-buildbot-config', 04:50:40 INFO - 'download-and-extract', 04:50:40 INFO - 'populate-webroot', 04:50:40 INFO - 'create-virtualenv', 04:50:40 INFO - 'install', 04:50:40 INFO - 'run-tests'), 04:50:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:40 INFO - 'download_minidump_stackwalk': True, 04:50:40 INFO - 'download_symbols': 'ondemand', 04:50:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:40 INFO - 'installer_path': 'installer.exe', 04:50:40 INFO - 'log_level': 'info', 04:50:40 INFO - 'log_name': 'talos', 04:50:40 INFO - 'log_to_console': True, 04:50:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:50:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:50:40 INFO - 'opt_config_files': (), 04:50:40 INFO - 'pip_index': False, 04:50:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:40 INFO - 'cmd': ('bash', 04:50:40 INFO - '-c', 04:50:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:40 INFO - 'enabled': True, 04:50:40 INFO - 'halt_on_failure': False, 04:50:40 INFO - 'name': 'check_screen_resolution'},), 04:50:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:40 INFO - 'cmd': ('bash', 04:50:40 INFO - '-c', 04:50:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:40 INFO - 'enabled': True, 04:50:40 INFO - 'halt_on_failure': False, 04:50:40 INFO - 'name': 'check_screen_resolution'},), 04:50:40 INFO - 'run_cmd_checks_enabled': True, 04:50:40 INFO - 'sps_profile': False, 04:50:40 INFO - 'sps_profile_interval': 0, 04:50:40 INFO - 'suite': 'dromaeojs-e10s', 04:50:40 INFO - 'system_bits': '32', 04:50:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:40 INFO - 'title': 't-yosemite-r7-0134', 04:50:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:40 INFO - 'use_talos_json': True, 04:50:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:40 INFO - 'work_dir': 'build'} 04:50:40 INFO - [mozharness: 2016-08-24 11:50:40.648702Z] Running clobber step. 04:50:40 INFO - Running pre-action listener: _resource_record_pre_action 04:50:40 INFO - Running main action method: clobber 04:50:40 INFO - rmtree: /builds/slave/test/build 04:50:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:42 INFO - Running post-action listener: _resource_record_post_action 04:50:42 INFO - [mozharness: 2016-08-24 11:50:42.752607Z] Finished clobber step (success) 04:50:42 INFO - [mozharness: 2016-08-24 11:50:42.752782Z] Running read-buildbot-config step. 04:50:42 INFO - Running pre-action listener: _resource_record_pre_action 04:50:42 INFO - Running main action method: read_buildbot_config 04:50:42 INFO - Using buildbot properties: 04:50:42 INFO - { 04:50:42 INFO - "project": "", 04:50:42 INFO - "product": "firefox", 04:50:42 INFO - "script_repo_revision": "production", 04:50:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:50:42 INFO - "repository": "", 04:50:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:50:42 INFO - "buildid": "20160823230014", 04:50:42 INFO - "pgo_build": "False", 04:50:42 INFO - "basedir": "/builds/slave/test", 04:50:42 INFO - "buildnumber": 769, 04:50:42 INFO - "slavename": "t-yosemite-r7-0134", 04:50:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:50:42 INFO - "platform": "yosemite_r7", 04:50:42 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 04:50:42 INFO - "branch": "fx-team", 04:50:42 INFO - "repo_path": "integration/fx-team", 04:50:42 INFO - "revision": "eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc", 04:50:42 INFO - "stage_platform": "macosx64", 04:50:42 INFO - "builduid": "210559543a0142338c596ba2e445cde6", 04:50:42 INFO - "slavebuilddir": "test" 04:50:42 INFO - } 04:50:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:50:42 INFO - Running post-action listener: _resource_record_post_action 04:50:42 INFO - [mozharness: 2016-08-24 11:50:42.755868Z] Finished read-buildbot-config step (success) 04:50:42 INFO - [mozharness: 2016-08-24 11:50:42.755968Z] Running download-and-extract step. 04:50:42 INFO - Running pre-action listener: _resource_record_pre_action 04:50:42 INFO - Running main action method: download_and_extract 04:50:42 INFO - mkdir: /builds/slave/test/build/tests 04:50:42 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')]} 04:50:42 INFO - trying https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:50:42 INFO - Downloading https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 04:50:43 INFO - Downloaded 1199 bytes. 04:50:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:50:43 INFO - Using the following test package requirements: 04:50:43 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:50:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:50:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:50:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'jsshell-mac.zip'], 04:50:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:50:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:50:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:50:43 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:50:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:50:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:50:43 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:50:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:43 INFO - trying https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:50:43 INFO - Downloading https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:50:44 INFO - Downloaded 16346140 bytes. 04:50:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:50:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:50:51 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')]} 04:50:51 INFO - trying https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:50:51 INFO - Downloading https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:50:52 INFO - Downloaded 16346140 bytes. 04:50:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:58 INFO - trying https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:50:58 INFO - Downloading https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:51:00 INFO - Downloaded 14413981 bytes. 04:51:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:00 INFO - trying https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 04:51:03 INFO - Downloaded 111437717 bytes. 04:51:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:51:03 INFO - mkdir: /builds/slave/test/properties 04:51:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:03 INFO - Contents: 04:51:03 INFO - build_url:https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:51:03 INFO - Running post-action listener: _resource_record_post_action 04:51:03 INFO - Running post-action listener: set_extra_try_arguments 04:51:03 INFO - [mozharness: 2016-08-24 11:51:03.956386Z] Finished download-and-extract step (success) 04:51:03 INFO - [mozharness: 2016-08-24 11:51:03.956523Z] Running populate-webroot step. 04:51:03 INFO - Running pre-action listener: _resource_record_pre_action 04:51:03 INFO - Running main action method: populate_webroot 04:51:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:51:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:51:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:51:03 INFO - '--tppagecycles', 04:51:03 INFO - '7'], 04:51:03 INFO - 'tests': ['tsvgm']}}, 04:51:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:51:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:51:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:51:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:51:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['damp', 'tps']}, 04:51:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'tests': ['damp', 'tps']}, 04:51:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['dromaeo_dom']}, 04:51:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['basic_compositor_video']}, 04:51:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:51:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['a11yr', 04:51:03 INFO - 'ts_paint', 04:51:03 INFO - 'tpaint', 04:51:03 INFO - 'sessionrestore', 04:51:03 INFO - 'sessionrestore_no_auto_restore', 04:51:03 INFO - 'tabpaint']}, 04:51:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:51:03 INFO - 'ts_paint', 04:51:03 INFO - 'tpaint', 04:51:03 INFO - 'sessionrestore', 04:51:03 INFO - 'sessionrestore_no_auto_restore', 04:51:03 INFO - 'tabpaint']}, 04:51:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:51:03 INFO - 'ts_paint', 04:51:03 INFO - 'tpaint', 04:51:03 INFO - 'sessionrestore', 04:51:03 INFO - 'sessionrestore_no_auto_restore', 04:51:03 INFO - 'tabpaint']}, 04:51:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:51:03 INFO - 'ts_paint', 04:51:03 INFO - 'tpaint', 04:51:03 INFO - 'sessionrestore', 04:51:03 INFO - 'sessionrestore_no_auto_restore', 04:51:03 INFO - 'tabpaint']}, 04:51:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['a11yr', 04:51:03 INFO - 'ts_paint', 04:51:03 INFO - 'tpaint', 04:51:03 INFO - 'sessionrestore', 04:51:03 INFO - 'sessionrestore_no_auto_restore', 04:51:03 INFO - 'tabpaint']}, 04:51:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['a11yr', 04:51:03 INFO - 'ts_paint', 04:51:03 INFO - 'tpaint', 04:51:03 INFO - 'sessionrestore', 04:51:03 INFO - 'sessionrestore_no_auto_restore', 04:51:03 INFO - 'tabpaint']}, 04:51:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['tsvgx', 04:51:03 INFO - 'tsvgr_opacity', 04:51:03 INFO - 'tart', 04:51:03 INFO - 'tscrollx', 04:51:03 INFO - 'cart']}, 04:51:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:51:03 INFO - 'tsvgr_opacity', 04:51:03 INFO - 'tart', 04:51:03 INFO - 'tscrollx', 04:51:03 INFO - 'cart']}, 04:51:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'talos_options': ['--disable-e10s'], 04:51:03 INFO - 'tests': ['tp5o']}, 04:51:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'tests': ['tp5o']}, 04:51:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'talos_options': ['--disable-e10s', 04:51:03 INFO - '--xperf_path', 04:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:03 INFO - 'tests': ['tp5n']}, 04:51:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:03 INFO - 'talos_options': ['--xperf_path', 04:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:03 INFO - 'tests': ['tp5n']}}, 04:51:03 INFO - 'talos.zip': {'path': '', 04:51:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:51:03 INFO - Running post-action listener: _resource_record_post_action 04:51:03 INFO - [mozharness: 2016-08-24 11:51:03.975428Z] Finished populate-webroot step (success) 04:51:03 INFO - [mozharness: 2016-08-24 11:51:03.975560Z] Running create-virtualenv step. 04:51:03 INFO - Running pre-action listener: _resource_record_pre_action 04:51:03 INFO - Running main action method: create_virtualenv 04:51:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:03 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 04:51:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:04 INFO - Using real prefix '/tools/python27' 04:51:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:07 INFO - Installing pip.................done. 04:51:07 INFO - Return code: 0 04:51:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:07 INFO - 'HOME': '/Users/cltbld', 04:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:07 INFO - 'LOGNAME': 'cltbld', 04:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:07 INFO - 'MOZ_NO_REMOTE': '1', 04:51:07 INFO - 'NO_EM_RESTART': '1', 04:51:07 INFO - 'PAGER': '/bin/cat', 04:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:07 INFO - 'PWD': '/builds/slave/test', 04:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:07 INFO - 'SHELL': '/bin/bash', 04:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:07 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:07 INFO - 'USER': 'cltbld', 04:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:07 INFO - 'XPC_FLAGS': '0x0', 04:51:07 INFO - 'XPC_SERVICE_NAME': '0', 04:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:07 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 04:51:07 INFO - Cleaning up... 04:51:07 INFO - Return code: 0 04:51:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:07 INFO - 'HOME': '/Users/cltbld', 04:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:07 INFO - 'LOGNAME': 'cltbld', 04:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:07 INFO - 'MOZ_NO_REMOTE': '1', 04:51:07 INFO - 'NO_EM_RESTART': '1', 04:51:07 INFO - 'PAGER': '/bin/cat', 04:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:07 INFO - 'PWD': '/builds/slave/test', 04:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:07 INFO - 'SHELL': '/bin/bash', 04:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:07 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:07 INFO - 'USER': 'cltbld', 04:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:07 INFO - 'XPC_FLAGS': '0x0', 04:51:07 INFO - 'XPC_SERVICE_NAME': '0', 04:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:08 INFO - Downloading/unpacking psutil>=3.1.1 04:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:11 INFO - Installing collected packages: psutil 04:51:11 INFO - Running setup.py install for psutil 04:51:11 INFO - building 'psutil._psutil_osx' extension 04:51:11 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 04:51:12 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 04:51:12 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 04:51:12 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 04:51:12 INFO - building 'psutil._psutil_posix' extension 04:51:12 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 04:51:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:51:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:51:12 INFO - ^ 04:51:12 INFO - 1 warning generated. 04:51:12 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 04:51:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:12 INFO - Successfully installed psutil 04:51:12 INFO - Cleaning up... 04:51:12 INFO - Return code: 0 04:51:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:12 INFO - 'HOME': '/Users/cltbld', 04:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:12 INFO - 'LOGNAME': 'cltbld', 04:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:12 INFO - 'MOZ_NO_REMOTE': '1', 04:51:12 INFO - 'NO_EM_RESTART': '1', 04:51:12 INFO - 'PAGER': '/bin/cat', 04:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:12 INFO - 'PWD': '/builds/slave/test', 04:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:12 INFO - 'SHELL': '/bin/bash', 04:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:12 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:12 INFO - 'USER': 'cltbld', 04:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:12 INFO - 'XPC_FLAGS': '0x0', 04:51:12 INFO - 'XPC_SERVICE_NAME': '0', 04:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:51:13 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 04:51:13 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 04:51:13 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 04:51:13 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 04:51:13 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 04:51:13 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 04:51:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:51:15 INFO - Installing collected packages: mozsystemmonitor 04:51:15 INFO - Running setup.py install for mozsystemmonitor 04:51:15 INFO - Successfully installed mozsystemmonitor 04:51:15 INFO - Cleaning up... 04:51:15 INFO - Return code: 0 04:51:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:51:15 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')]} 04:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:15 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')]} 04:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:15 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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:15 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 04:51:15 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 04:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:15 INFO - 'HOME': '/Users/cltbld', 04:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:15 INFO - 'LOGNAME': 'cltbld', 04:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:15 INFO - 'MOZ_NO_REMOTE': '1', 04:51:15 INFO - 'NO_EM_RESTART': '1', 04:51:15 INFO - 'PAGER': '/bin/cat', 04:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:15 INFO - 'PWD': '/builds/slave/test', 04:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:15 INFO - 'SHELL': '/bin/bash', 04:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:15 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:15 INFO - 'USER': 'cltbld', 04:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:15 INFO - 'XPC_FLAGS': '0x0', 04:51:15 INFO - 'XPC_SERVICE_NAME': '0', 04:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:16 INFO - Downloading/unpacking jsonschema==2.5.1 04:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:51:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:51:19 INFO - warning: no files found matching '*.txt' 04:51:19 INFO - no previously-included directories found matching 'build' 04:51:19 INFO - no previously-included directories found matching 'dist' 04:51:19 INFO - no previously-included directories found matching '.git*' 04:51:19 INFO - Installing collected packages: jsonschema, functools32 04:51:19 INFO - Running setup.py install for functools32 04:51:19 INFO - warning: no files found matching '*.txt' 04:51:19 INFO - no previously-included directories found matching 'build' 04:51:19 INFO - no previously-included directories found matching 'dist' 04:51:19 INFO - no previously-included directories found matching '.git*' 04:51:19 INFO - Successfully installed jsonschema functools32 04:51:19 INFO - Cleaning up... 04:51:19 INFO - Return code: 0 04:51:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:51:19 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')]} 04:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:19 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')]} 04:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:19 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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:19 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 04:51:19 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 04:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:19 INFO - 'HOME': '/Users/cltbld', 04:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:19 INFO - 'LOGNAME': 'cltbld', 04:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:19 INFO - 'MOZ_NO_REMOTE': '1', 04:51:19 INFO - 'NO_EM_RESTART': '1', 04:51:19 INFO - 'PAGER': '/bin/cat', 04:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:19 INFO - 'PWD': '/builds/slave/test', 04:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:19 INFO - 'SHELL': '/bin/bash', 04:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:19 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:19 INFO - 'USER': 'cltbld', 04:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:19 INFO - 'XPC_FLAGS': '0x0', 04:51:19 INFO - 'XPC_SERVICE_NAME': '0', 04:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:51:19 INFO - Cleaning up... 04:51:19 INFO - Return code: 0 04:51:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:51:19 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')]} 04:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:19 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')]} 04:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:19 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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:19 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 04:51:19 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 04:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:19 INFO - 'HOME': '/Users/cltbld', 04:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:19 INFO - 'LOGNAME': 'cltbld', 04:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:19 INFO - 'MOZ_NO_REMOTE': '1', 04:51:19 INFO - 'NO_EM_RESTART': '1', 04:51:19 INFO - 'PAGER': '/bin/cat', 04:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:19 INFO - 'PWD': '/builds/slave/test', 04:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:19 INFO - 'SHELL': '/bin/bash', 04:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:19 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:19 INFO - 'USER': 'cltbld', 04:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:19 INFO - 'XPC_FLAGS': '0x0', 04:51:19 INFO - 'XPC_SERVICE_NAME': '0', 04:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:51:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:51: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 04:51: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 04:51: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 04:51: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 04:51: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 04:51: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 04:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:51:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:51:23 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 04:51:23 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 04:51:23 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 04:51:23 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 04:51:23 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 04:51:23 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 04:51:23 INFO - Downloading docopt-0.6.1.tar.gz 04:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:51:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:51:23 INFO - Running setup.py install for blobuploader 04:51:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:51:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:51:23 INFO - Running setup.py install for requests 04:51:24 INFO - Running setup.py install for docopt 04:51:24 INFO - Successfully installed blobuploader requests docopt 04:51:24 INFO - Cleaning up... 04:51:24 INFO - Return code: 0 04:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:24 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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:24 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 04:51:24 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 04:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:24 INFO - 'HOME': '/Users/cltbld', 04:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:24 INFO - 'LOGNAME': 'cltbld', 04:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:24 INFO - 'MOZ_NO_REMOTE': '1', 04:51:24 INFO - 'NO_EM_RESTART': '1', 04:51:24 INFO - 'PAGER': '/bin/cat', 04:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:24 INFO - 'PWD': '/builds/slave/test', 04:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:24 INFO - 'SHELL': '/bin/bash', 04:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:24 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:24 INFO - 'USER': 'cltbld', 04:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:24 INFO - 'XPC_FLAGS': '0x0', 04:51:24 INFO - 'XPC_SERVICE_NAME': '0', 04:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:24 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jGpome-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-oVB183-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-MiTQJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-I6eehW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-MjEeMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-JzcwEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Oqg32Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-RKsAmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-rRaHgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-c9qpKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:25 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-4lCPbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:26 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-6LgGD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:26 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-7Nerwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:26 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-1xvAbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:26 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-xbPCK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:26 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-g_S7cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:26 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-icsYAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:51:26 INFO - Running setup.py install for manifestparser 04:51:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:51:26 INFO - Running setup.py install for mozcrash 04:51:26 INFO - Running setup.py install for mozdebug 04:51:27 INFO - Running setup.py install for mozdevice 04:51:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Running setup.py install for mozfile 04:51:27 INFO - Running setup.py install for mozhttpd 04:51:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Running setup.py install for mozinfo 04:51:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Running setup.py install for mozInstall 04:51:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:51:27 INFO - Running setup.py install for mozleak 04:51:27 INFO - Running setup.py install for mozlog 04:51:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:51:28 INFO - Running setup.py install for moznetwork 04:51:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:51:28 INFO - Running setup.py install for mozprocess 04:51:28 INFO - Running setup.py install for mozprofile 04:51:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:51:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:51:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:51:28 INFO - Running setup.py install for mozrunner 04:51:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:51:28 INFO - Running setup.py install for mozscreenshot 04:51:28 INFO - Running setup.py install for moztest 04:51:29 INFO - Running setup.py install for mozversion 04:51:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:51:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:51:29 INFO - Cleaning up... 04:51:29 INFO - Return code: 0 04:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:29 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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:29 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 04:51:29 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 04:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:29 INFO - 'HOME': '/Users/cltbld', 04:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:29 INFO - 'LOGNAME': 'cltbld', 04:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:29 INFO - 'MOZ_NO_REMOTE': '1', 04:51:29 INFO - 'NO_EM_RESTART': '1', 04:51:29 INFO - 'PAGER': '/bin/cat', 04:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:29 INFO - 'PWD': '/builds/slave/test', 04:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:29 INFO - 'SHELL': '/bin/bash', 04:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:29 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:29 INFO - 'USER': 'cltbld', 04:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:29 INFO - 'XPC_FLAGS': '0x0', 04:51:29 INFO - 'XPC_SERVICE_NAME': '0', 04:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:29 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-SnlTzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:29 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)) 04:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:29 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-_NwnBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:29 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-UHBi0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:29 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)) 04:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:29 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-QIv47d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:29 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-oa7Tw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:30 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-B_SX4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:30 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-CvGiDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:30 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Q0_WRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:30 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-zuGGW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:30 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-lFN68X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ZxGOLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:30 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-MgKrkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-LHUQZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:30 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)) 04:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:30 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-a_4o_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:31 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-yunckx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:31 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)) 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:31 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-S9yHG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:31 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-kT6Ohv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:31 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)) 04:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:51:31 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)) 04:51:31 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:31 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:51:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:51:31 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 04:51:31 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 04:51:31 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 04:51:31 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 04:51:31 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 04:51:31 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 04:51:33 INFO - Downloading blessings-1.6.tar.gz 04:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:51:33 INFO - Installing collected packages: blessings 04:51:33 INFO - Running setup.py install for blessings 04:51:34 INFO - Successfully installed blessings 04:51:34 INFO - Cleaning up... 04:51:34 INFO - Return code: 0 04:51:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:34 INFO - Reading from file tmpfile_stdout 04:51:34 INFO - Current package versions: 04:51:34 INFO - blessings == 1.6 04:51:34 INFO - blobuploader == 1.2.4 04:51:34 INFO - docopt == 0.6.1 04:51:34 INFO - functools32 == 3.2.3-2 04:51:34 INFO - jsonschema == 2.5.1 04:51:34 INFO - manifestparser == 1.1 04:51:34 INFO - mozInstall == 1.12 04:51:34 INFO - mozcrash == 0.17 04:51:34 INFO - mozdebug == 0.1 04:51:34 INFO - mozdevice == 0.48 04:51:34 INFO - mozfile == 1.2 04:51:34 INFO - mozhttpd == 0.7 04:51:34 INFO - mozinfo == 0.9 04:51:34 INFO - mozleak == 0.1 04:51:34 INFO - mozlog == 3.3 04:51:34 INFO - moznetwork == 0.27 04:51:34 INFO - mozprocess == 0.23 04:51:34 INFO - mozprofile == 0.28 04:51:34 INFO - mozrunner == 6.12 04:51:34 INFO - mozscreenshot == 0.1 04:51:34 INFO - mozsystemmonitor == 0.3 04:51:34 INFO - moztest == 0.7 04:51:34 INFO - mozversion == 1.4 04:51:34 INFO - psutil == 3.1.1 04:51:34 INFO - requests == 1.2.3 04:51:34 INFO - wsgiref == 0.1.2 04:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:34 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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:34 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 04:51:34 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 04:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:34 INFO - 'HOME': '/Users/cltbld', 04:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:34 INFO - 'LOGNAME': 'cltbld', 04:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:34 INFO - 'MOZ_NO_REMOTE': '1', 04:51:34 INFO - 'NO_EM_RESTART': '1', 04:51:34 INFO - 'PAGER': '/bin/cat', 04:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:34 INFO - 'PWD': '/builds/slave/test', 04:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:34 INFO - 'SHELL': '/bin/bash', 04:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:34 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:34 INFO - 'USER': 'cltbld', 04:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:34 INFO - 'XPC_FLAGS': '0x0', 04:51:34 INFO - 'XPC_SERVICE_NAME': '0', 04:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 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)) 04:51:34 INFO - Cleaning up... 04:51:34 INFO - Return code: 0 04:51:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:35 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 0x1020b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102149618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6915a2090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, '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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:51:35 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 04:51:35 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 04:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:35 INFO - 'HOME': '/Users/cltbld', 04:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:35 INFO - 'LOGNAME': 'cltbld', 04:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:35 INFO - 'MOZ_NO_REMOTE': '1', 04:51:35 INFO - 'NO_EM_RESTART': '1', 04:51:35 INFO - 'PAGER': '/bin/cat', 04:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:35 INFO - 'PWD': '/builds/slave/test', 04:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:35 INFO - 'SHELL': '/bin/bash', 04:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:51:35 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:35 INFO - 'USER': 'cltbld', 04:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:35 INFO - 'XPC_FLAGS': '0x0', 04:51:35 INFO - 'XPC_SERVICE_NAME': '0', 04:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:51:35 INFO - Cleaning up... 04:51:35 INFO - Return code: 0 04:51:35 INFO - Running post-action listener: _resource_record_post_action 04:51:35 INFO - Running post-action listener: _start_resource_monitoring 04:51:35 INFO - Starting resource monitoring. 04:51:35 INFO - [mozharness: 2016-08-24 11:51:35.368848Z] Finished create-virtualenv step (success) 04:51:35 INFO - [mozharness: 2016-08-24 11:51:35.369785Z] Running install step. 04:51:35 INFO - Running pre-action listener: _resource_record_pre_action 04:51:35 INFO - Running main action method: install 04:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:35 INFO - Reading from file tmpfile_stdout 04:51:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:51:35 INFO - Reading from file tmpfile_stdout 04:51:35 INFO - Output received: 04:51:35 INFO - Usage: mozinstall [options] installer 04:51:35 INFO - Options: 04:51:35 INFO - -h, --help show this help message and exit 04:51:35 INFO - -d DEST, --destination=DEST 04:51:35 INFO - Directory to install application into. [default: 04:51:35 INFO - "/builds/slave/test"] 04:51:35 INFO - --app=APP Application being installed. [default: firefox] 04:51:35 INFO - mkdir: /builds/slave/test/build/application 04:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:52:10 INFO - Reading from file tmpfile_stdout 04:52:10 INFO - Output received: 04:52:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:52:10 INFO - Running post-action listener: _resource_record_post_action 04:52:10 INFO - [mozharness: 2016-08-24 11:52:10.324072Z] Finished install step (success) 04:52:10 INFO - [mozharness: 2016-08-24 11:52:10.324221Z] Running run-tests step. 04:52:10 INFO - Running pre-action listener: _resource_record_pre_action 04:52:10 INFO - Running main action method: run_tests 04:52:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:10 INFO - 2016-08-24 04:52:10.338 screenresolution[1632:7390] starting screenresolution argv=screenresolution get 04:52:10 INFO - 2016-08-24 04:52:10.341 screenresolution[1632:7390] Display 0: 1600x1200x32@60 04:52:10 INFO - 2016-08-24 04:52:10.347 screenresolution[1633:7392] starting screenresolution argv=screenresolution list 04:52:10 INFO - Available Modes on Display 0 04:52:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:10 INFO - Intel Iris: 04:52:10 INFO - Chipset Model: Intel Iris 04:52:10 INFO - Type: GPU 04:52:10 INFO - Bus: Built-In 04:52:10 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:10 INFO - Vendor: Intel (0x8086) 04:52:10 INFO - Device ID: 0x0a2e 04:52:10 INFO - Revision ID: 0x0009 04:52:10 INFO - Displays: 04:52:10 INFO - Display: 04:52:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:10 INFO - Display Serial Number: 1600x1200 60 04:52:10 INFO - Main Display: Yes 04:52:10 INFO - Mirror: Off 04:52:10 INFO - Online: Yes 04:52:10 INFO - Rotation: Supported 04:52:10 INFO - Return code: 0 04:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:10 INFO - Python 2.7.3 04:52:10 INFO - Return code: 0 04:52:10 INFO - grabbing minidump binary from tooltool 04:52: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')]} 04:52:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102018d30>, '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 0x101d7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102010b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:52:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:52:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:52:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:10 INFO - Return code: 0 04:52:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:52:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:52:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 04:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --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 04:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ynbyPT5hj2/Render', 04:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:10 INFO - 'HOME': '/Users/cltbld', 04:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:10 INFO - 'LOGNAME': 'cltbld', 04:52:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:10 INFO - 'MOZ_NO_REMOTE': '1', 04:52:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:10 INFO - 'NO_EM_RESTART': '1', 04:52:10 INFO - 'PAGER': '/bin/cat', 04:52:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:10 INFO - 'PWD': '/builds/slave/test', 04:52:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:10 INFO - 'SHELL': '/bin/bash', 04:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cTZ1knpmJ3/Listeners', 04:52:10 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:10 INFO - 'USER': 'cltbld', 04:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:10 INFO - 'XPC_FLAGS': '0x0', 04:52:10 INFO - 'XPC_SERVICE_NAME': '0', 04:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 04:52:10 INFO - mozversion application_buildid: 20160823230014 04:52:10 INFO - mozversion application_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 04:52:10 INFO - mozversion application_display_name: Nightly 04:52:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:10 INFO - mozversion application_name: Firefox 04:52:10 INFO - mozversion application_remotingname: firefox 04:52:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:52:10 INFO - mozversion application_vendor: Mozilla 04:52:10 INFO - mozversion application_version: 51.0a1 04:52:10 INFO - mozversion platform_buildid: 20160823230014 04:52:10 INFO - mozversion platform_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 04:52:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:52:10 INFO - mozversion platform_version: 51.0a1 04:52:10 INFO - using testdate: 1472039530 04:52:10 INFO - actual date: 1472039530 04:52:10 INFO - starting webserver on 'localhost:49275' 04:52:10 INFO - SUITE-START | Running 2 tests 04:52:10 INFO - TEST-START | dromaeo_css 04:52:10 INFO - operating with platform_type : mac_ 04:52:10 INFO - Initialising browser for dromaeo_css test... 04:52:10 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpY0mWGl/profile http://localhost:49275/getInfo.html) 04:52:13 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 04:52:13 INFO - PROCESS | 1643 | colorDepth:24 04:52:13 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 04:52:13 INFO - PROCESS | 1643 | __metrics 04:52:13 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 04:52:14 INFO - TEST-INFO | 1643: exit 0 04:52:14 INFO - Browser initialized. 04:52:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:14 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpY0mWGl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:26 INFO - PROCESS | 1646 | RSS: Main: 244531200 04:52:26 INFO - PROCESS | 1646 | 04:53:16 INFO - PROCESS | 1646 | 1472039596125 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:55:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:55:29 INFO - PROCESS | 1646 | RSS: Main: 263372800 04:55:29 INFO - PROCESS | 1646 | 04:58:32 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 04:58:33 INFO - PROCESS | 1646 | RSS: Main: 270565376 04:58:33 INFO - PROCESS | 1646 | 05:01:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:01:35 INFO - PROCESS | 1646 | RSS: Main: 274280448 05:01:35 INFO - PROCESS | 1646 | 05:04:37 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:04:38 INFO - PROCESS | 1646 | RSS: Main: 268931072 05:04:38 INFO - PROCESS | 1646 | 05:07:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:07:41 INFO - PROCESS | 1646 | RSS: Main: 274284544 05:07:41 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:10:44 INFO - PROCESS | 1646 | RSS: Main: 278732800 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | __start_tp_report 05:10:44 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 05:10:44 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 05:10:44 INFO - PROCESS | 1646 | |i|pagename|runs| 05:10:44 INFO - PROCESS | 1646 | |0;dojo.html;3428.2457859270958;3433.570803649544;3459.65403459654;3459.9999999999986;3462.411390063689;5716.942830571693;5789.39211382805;5816.447437493442;5877.353491115974;5899.52803775698;5781.62419442736;5819.941800582003;5852.4440178183;5915.792947246837;5927.110933359998;5163.251328557357;5244.580433565325;5258.579313654898;5329.840104796862;5377.569794416457;5365;5366.517013468787;5401;5416.079266524681;5448.155535891943;4314.80583373749;4314.913701725979;5200.219967004941;5245.449227831099;5367;3922.7254092213557;5249.1338929076655;5256.421793602701;5256.92114618281;5350.678959262456;5246.449122842123;5267.631265811395;5277.8416647500635;5281.947180528184;5352.518273355417;5317.441668624778;5645.971770141164;5771.336296325934;5774.335951365562;5867.589268751189;6259.280182778994;6259.71831267594;6292.811215663537;6299.244090709099;6303.55875088744;6291.339409361997;6311.810645680637;6319.905201421982;6320.841978950563;6320.873582528369;5826.679532625704;5897.52819774417;5942.10868369748;5963.73163207648;5970.820875373745;6374.362563743682;6382.20222472191;6382.553221274559;6393.1688880445245;6415.069814876817;6274.058891166362;6275.623462592259;6284.12022316876;6289.150964619809;6291.433770960635;6188.628682279078;6225.159603453476;6248;6273.404026617464;6320.873582528324;6248.156498872685;6305.842353941096;6311.652859092794;6339.524535659844;6341.841453963688;6252.874942501125;6285.308616052231;6297.4647154992335;6318.494520438354;6322.33615470369;4909.288153217834;4952.207646776498;4991.80032798684;5000.89998200034;5010.574101201366;4481.148581769454;4484.775761211927;4496.617787488035;4502.122086193226;4535.092981403733;5826.82519524415;5928.911066334009;5940.762369505172;5943.138244954457;5953.315368732565;6199.318075011835;6214.906776398358;6246.46905013079;6277.2153480814895;6313.526485513605;5947.078202878561;5953.880922381528;5969.910451343233;5982;6028.819135425856;5454.154606036071;5506.476884695948;5508.3114610673665;5511.035568775448;5533.557315414757;6227.221597300338;6291.528135389773;6306.211723534559;6335.683215839282;6417.582857114273;6287.874242515032;6299.464545513682;6311.211098612674;6325.399087086719;6337.588056776295;5985.700714964321;6121.265448146251;6326.55714100027;6398.616083035033;6418.614883107029;5237.397699264633;6137.499563105042;6201.565890387629;6207.224096987877;6237.033259844731;4792.2332426811545;4830.2513110467935;6028.819135425944;6208.4722798562625;6302.432781049728;5416;6233.532485063729;6254.718537665725;6259.217597800275;6269.4984401246875;6087;6139.5228034422325;6151.50787936955;6183.938160618516;6186.907196391968;4895.559399654048;5009.574186194214;6157.907631385443;6160.16837726919;6164.784232552019;5077.543021127968;5111.284420181103;6234.75060997555;6252.280987686474;6269.62382257066;5989.700514974146;6051.939480605138;6060.151578778887;6114.633122012693;6149.385061493815 05:10:44 INFO - PROCESS | 1646 | |1;ext.html;493.4251596889625;493.75805855130983;537.6747068023845;538.5341679447276;554.3984776517478;37744.62255377449;40038.79980600096;40132.99667508314;40221.3966790498;40316.79841600795;41187.382189267184;41402.37896431548;41755.37366939498;41792.95517612061;41900.95247618811;8941.284697224239;9622.711318660451;9664.903350966488;9864.556094975707;9870.407775533455;8163.469374490669;9719.708408747714;9774.462404567746;9835.508224588777;9842.507874606277;9805.509724513782;9837.65568205113;9847.310688251826;9863.506824658774;9886.752831179207;9810.509474526316;9824.410535367864;9881.357711748713;9886.159676427513;9904.801903961952;9700.660476883346;9721.756956076155;9769;9780.804383912282;9821.705348839547;39448.01379965495;39463.21073578512;39734;39761.40357894634;39953.60046399557;3304.7802709800335;3553.076200187944;3816.0078379621223;3850.4801851750217;4132.235536425771;31294.53058204106;31860;32016.879409220797;32096.679033209835;32892.6710732892;3349.9832500837583;3363.478660807554;3409.3863104641155;3434.8969530914114;3480.8781692640637;439791;452761;453636;454270;454580;33273;56964;57305;57389.42610573924;57431.712841435525;28809.56785648217;33836.78550537744;34789.82605087009;35050.12374690653;35054;14493;14623.85376146225;14628.853711462962;14647.633809154857;14654.633634159018;12687.619371418872;12800.423980920881;12860.742785144244;12862.292573908338;12872.16330938486;6470.352964703586;7680.155182929873;7720;7751.496152750054;7775.222477752292;2925.692802255775;2967.5993740845142;2972.7324540791433;2975.3900450407614;3003.849807509616;916.3585490156917;968.7335982604699;987.6197663899451;1116.625930313354;1159.837622732818;30674.693253067184;30707.232319191753;30970.690293097232;31262.7494900206;31332;831.4720152702956;1053.7828807727087;1134.1493879590307;1202.500962100736;1244;14620.634484137769;14990.550283491513;15604.375824967101;17651.38220162288;18679.439616811247;677099;777213;793299;799321;1023729;64452.35547644558;64844.67577662082;65170.67414662991;65310;65395.673021635535;1412.6468382904275;1416.3414012484038;1449.1884544655027;1450.4053338131316;1452.6077958951023;31499.11005339687;32493.35013299768;32568.51147232841;32896.927160660576;32998.83500582482;54478.72760636172;54832.72583637056;55030;55084.72457637686;55170;635139;639510;640426;641116;642145;38150.427743583314;43027.784861075495;45047.09905801931;45445;45670.771646141555;49733.50266497434;50501;50550.241746373096;50609.746951265006;50640.49359506358;40118;40435.7978210107;40674.593254067084;40998.38502422526;41876.581234187266;38270.234595308495;40297.59702402938;40560.98597534967;41405;41577.96055098647;33553.32893342168;39566.802165988986;39650.40524392194;40035.59964400319;41282.9679258021;34691;35362.46956295709;36298.8185059073;36530.26939461143;36645.63354366422;20975.370738877857;25775.484490310464;25930.870345648153;26062.34844128912;26635.86682066577 05:10:44 INFO - PROCESS | 1646 | |2;jquery.html;336.83663423239733;364.52065533823003;374.50939269556875;382.82198777568425;396.9639241579477;20396.898015509938;20674.27640032599;21289.04199311031;21520.677189842147;21705.782942170572;11945.880541194607;12304.5693400731;12322.876771232284;12336.19814712043;18087.63824723505;5338.492843179911;5656.745446454919;5661.207430959648;5671.291088613923;5681.261436013312;3954;5517.475839795213;6514.57655252407;6837.3162683731725;6864.313568643146;5789.2763404574425;6831.282715314895;6833.726650933957;6844.38400543951;6874.518783685144;6045.063015232624;6184.814455566295;6191.2570491540855;6194.163787888645;6202.472789812871;5874.426033140373;5912;5965.910511342333;5984.072468767348;6032.672811981357;10389.27275090744;11712.88287117135;13576.913846892225;13581.456741730319;13811.51659691916;2020.828229600471;2094.1204694028393;2150.860194087395;2163.3185546552786;3000.9249768755735;10172.643957461527;10248.436336001518;10334;10470.842937355947;10624.150067994618;1573.9763903541457;1621.4243943400159;1656.8011838579328;1939.4181745476442;1977.1399441243104;126694;133445;133793.6620633791;135175;137134;11374.658760237206;11467.885321146849;11517.25137866036;11688.123390745728;11772.587959421378;14502.564923052325;14515.346809393603;14527.709445811235;14532.418703251962;14536.491222807152;8511.489310641382;8599;8642.524661143572;8674.219320261207;8803.16369944867;8426.567483527815;8619.525926074;8670.653173872974;8763.737087887373;8764;3846.8653597123966;3966.8944087006844;4313.590208930146;4546.909061818745;4629.560191781776;1777.2713187593024;1824.7289405774409;1930.3340347580063;1954.8924809135633;1973.5263536751077;810.5501446697021;888.1074520107251;915.734437013272;969.9515024248759;994.7314225159166;18256.9045857249;19449.513762155777;20289.89855050745;21771.891140544198;21944.670829937564;876.6624849432886;910.9635614575343;922.9215516681157;974.3131092579714;1006.225206590921;9250.306227033;11147.16071848136;11505.367204803817;11537.653870383901;11552.96023357885;501374;583770;609947;640747;647719;74053.88919166217;74426;74953.25046749462;125521.37239313746;131265;979.4368238262884;1003.7691330993912;1026.1944373666636;1027.609508386823;1031.1493018259966;18506;18962.146703398656;19855.702164467257;19898.70151947751;20656.690149648068;56904.71547642235;57255.42744572501;57340.426595735174;57393.42606573881;57534.7123264381;58176.4182358171;74462.62768686122;76518;76749;77403.2259677396;6942.680890630764;7251.891221631574;7673.8465230693955;7964.761057168294;8286.83426331482;9363.625454981724;11633.825492617449;12166.635000949631;12210.450529726006;12921.35393230316;10831.620893268699;10843;11128.944355278172;11158.776824463628;11324.433778310886;10370.533326000197;10506.579736810441;10601.734956626146;10995.285306455055;11001.61494347694;10009.749756256151;10425.426601536989;10462.267641265344;11154.553817847196;11385;6947.270536593584;7224.422046236184;7272.781816545512;7481.401487881065;8117.025956885212;9708.17480514136;10175.689641465864;10917.181211409335;11049.834252486058;11263 05:10:44 INFO - PROCESS | 1646 | |3;mootools.html;1301.6875949772054;1403.936822842972;1635.869130469562;1830.112395488189;1847.6581832361014;7913;8459.577021148942;8558;8968.596413161407;9008.684696035632;8601.655933762642;8798;8802.471851688888;8803.559822008907;8810.118988101187;2324.2910912171824;2365.8343915925893;2370.5021945391404;2371.2530552875874;2402.1712509184304;1843.3271855772614;2328.2433209207074;2363.775441333079;2374.0859768988976;2382.702162229721;2332.825038122148;2352.9176478823247;2355.128602417108;2367.5975084235633;2379.2029670060465;2106.7893210678885;2333.288347054148;2362.385779697274;2362.83460157789;2375.6317770745477;2044.6932960055963;2263.5739484124897;2318.431984163874;2356.7761062699014;2358.481134150484;8914.242289405409;8978.820423591556;8979.595918183697;8989.55052247385;9020.77448063797;5199.2461093141665;5337.039332920072;5340;5352.2506849041165;5356;3412.334594754024;3466.0988143082727;3545.1137215696076;3555.715542756573;3597.226596281786;1009.3893194617298;1036.5905467340433;1048.224314007629;1052.752603138262;1068.9732756681067;11306;11611.767764644745;11620.59327923527;11627.767444651145;11630.825537616858;3795.3358162321483;4577.244754615518;4796.56830885222;4796.688215265996;4800.495947925488;9774.511274436392;9863.704088877344;9872.901270987199;9874.851877221847;9878.456684882256;5282.788688452419;5311.548518375904;5319.9202011969855;5323.254744335796;5343.973280133574;4401.6478681705385;4725.858224253209;4822.180229360947;4883.291922671193;4894.143524883202;3846.615338466187;3912.4522566840665;3985.780782056957;3992;4020.3165461871554;1284.531146131674;1285.2802430638872;1291.6125162451226;1298.0718786067819;1308.2935214983802;749.3592978003837;819.5041999590281;869.9173578510031;918.4443411735804;920.4615300049412;5640.746166422521;5695.202671625976;5785.681787501644;5926.851828704317;5928.021876390348;952.4808979106404;964.344245912786;979.9167070799062;996.5814357969525;1075.5482697267166;3299.290652509722;3850.2299540092095;3885.1841113365945;3972.900677483086;3996.820143093568;10545.578176872992;10795.730106747236;10818.080463160719;10851.51168197433;10860.837087443695;10705.571777128984;10807.513661885234;10817.350958942488;10823.621173258898;10849.67450976472;6317.842053948596;7643.885341719879;8170.428070035159;8289.751307460785;8306.501609903426;5462;5691.516221121251;5809.30288365382;5847.502962248086;6005.2793664758765;9708.5145742714;9828.459434731158;9850.014998500093;9938.304318697621;9947.303688741718;9990.200783937413;10024.097831195228;10115.393076415145;10118.342307749972;10262.230332725225;6910.585364878123;7293.124825021031;7490.625468726651;7503.399728021855;7615.352695020763;7197.244289349543;8356.707515236938;8455;8464.746057618282;8476.788080298042;7431.40548756109;7512.887306690294;7599.772006839804;7604.8479030420185;7732.226777322223;6220.937790622036;6364.77723279683;7348.265173482823;7437.219091995263;7568.243175682388;6957.826054348682;6973.721051157897;7013.158420989514;7087.22040575526;7096.8935465967015;4912.214045752662;4973.303737476684;5024.296598476143;5055.5955523557295;5058.873528161826;4911.926321105258;4967.105920934267;4978.900421991612;5054.924176137434;5204.557612602971 05:10:44 INFO - PROCESS | 1646 | |4;prototype.html;293.4702861335289;303.64776858843743;310.51869602116716;314.03747513869985;314.15648982482054;5082.9579936113105;5108.282608369996;5357.7589008494615;5481.424450432707;5487.91768123478;4726.936439301156;5564.387917329091;5616.297962754656;5624.521915637166;5634.0703783875715;3484.4947482615135;4229.069604686964;4232.354778263585;4257;4261.872143835682;3839.7120215983914;4018.8546264314678;4106.932197628608;4255.340422234559;4276.337167739005;4164.293209413875;4176.352665336878;4207.431996680455;4209.452771139748;4217.620414162725;3636.76350040986;4215.789210539491;4231.238377092122;4231.957680423187;4233.116263262849;3664.3770559005034;3665.9450108248398;3670.5595328560476;3678.558572971234;3678.8528458861615;5201.453847346012;5351.839444816662;5439.292891924064;5452.645578037414;5487.5609951203805;4615.307703844416;4893.290472881448;4913.508649135094;4914.729689867056;4921.458639549646;5221.190715439075;5651.208830763697;5729.885402291972;5938.228030356069;5945.513621594601;3342.3067510401142;3682.521272234619;4032.354823228269;4036.6568841648495;4046.6358027777346;5098.260752190911;5689.890471358087;6024.3975602439405;6346.428821406142;6369.4585960193435;3927.5286965564314;4081.5918408158946;4114.835406583703;4126.504819421689;4173.332266837291;3366.713829324535;3534.745165466274;4011.6389524942897;4056.127932494469;4068.3694027425795;4178.352355384859;4456.6211871991245;4564.566366195206;4716.339712440261;4803.4061606731975;5168.069747445421;5725.885482290331;5739.339975902824;5789.681567513743;5983.341832398432;1250.8402838292045;1333.3266700316472;1367.8495365509787;1370.8766211040854;1386.750384930702;721.989170162448;804.4610111225493;848.4018766769412;853.5177624642057;854.1927878155208;4042.5755295694116;4047.777372244555;4469.9776501117285;4540.659450541222;4683.227267500893;4395.670324725658;4663.965669695756;4667.953320466752;4821.686590371614;5200.541639809484;4054.878353649395;4500.212462818994;4567.566081222279;4709.81160753566;4754.003318606194;2234.832387570939;2617.973820261811;2668.490251475001;2680.316519287569;2684.7986401020003;4300.7634580097765;4533.886652833639;5321.707306098202;5356.812511562077;5394.109971854678;4266.765327906933;4297.419848320499;4316.719413238192;4456.301269945937;5273.789048438096;4726.574608285271;4946.406431228275;4997.775100120503;5087.2623469595965;5342.5993050521365;4039.8990025249605;4686.625069994324;4720.961388494526;4822.300766388924;5208.8437346879655;4517.75152366623;4528.750918699503;4556.908861822812;5106.068327387965;5197.818076367309;4088.0393107619093;4766.61867050642;5100.593371026724;5221.399539053057;5305.442928492453;3401.9319613608086;3519.3665140274998;3519.9472007920413;3532.611412744545;3542.600672734307;4217.789110544399;4382.7209850878;4443.00064970758;5122.925215287814;5865.530757539302;5753.971230143822;5925.674087925033;5959.553033522589;5961.7615295387695;6008.699565021644;5581.386047534686;5627.915581266202;5681.7500149966945;5944.286685597756;5945.821625351246;5013.523715247045;5465.754041068082;5769.778635225384;5796.42035796417;5868.853278668067;5423.806762512241;5641.83074507749;5956.583039187389;5981.222441082631;6014.849628759316;5257.764425360114;5408.403411731155;5420.7289635518855;5548.667079975215;5846.655269288002 05:10:44 INFO - PROCESS | 1646 | |5;yui.html;694.4513834071083;718.6299055986168;725.771382014665;766.0347961568425;820.8891799607052;14201.644958876033;15166.545003649895;16365.345386184554;16377.18114094295;16388.67222655546;13979.161250324987;14723.631909202275;14759;14911.32899019544;14928.626784330398;832.2260297922944;850.1710831938872;852.0627309959058;852.9872051919226;853.9615717292705;675.9898601520981;831.6091437024588;850.4812064640564;858.0132847225678;865.7013330401033;897.7620930453403;897.995510022449;902.6660135749748;902.9593668284942;904.0688091266006;894.1014280647908;899.2131884600974;900.5857305639414;902.616388035089;903.5075883643398;651.993480065198;663.2737152817657;669.4410167510135;670.8859493886051;671.6306031682603;14876.404943802236;14887;14907.850921490755;14908.925455372762;14943.551693449213;14487.637809054753;14544.418223271057;14642.780358294634;14861.479848205261;14879.851201488063;11846.703832404173;12021.879781202164;12052.879471205264;12104.878951210463;12132.696682582919;3761.0221342450886;3809.447630093621;3836.5396152461603;3857.537095548524;3988.102676897704;110168.4491577537;116379;116988;117418;122371;10885.727856803485;10909.290896091728;11021.83467247992;11074.169437292236;11086.667399978014;19098.904505477385;23252.534949301258;23254;23256.95343709537;23304.53390932172;6884.931150688529;7717.691292348243;8164.183581641788;8176.754697359089;8402.327813774884;3737.289914916157;3762.8682996095004;4062.9639441942118;4331.938675024639;4476.328550717419;3384.627690953993;3489.5289135966827;3536.045267777737;3536.8938931832085;3551.662592053751;604.6100265328838;607.781198768443;622.7228883147046;628.4438272129198;638.8339031851659;576.2796504369538;617.290106405255;642.9935700642934;654.2998991079594;681.3833480699974;9107.908920910839;9214.861777073349;9413.48225847585;9526.285528585246;9860.556274967643;527.4435470578577;608.7930103764742;624.7376102037156;624.9843753906189;693.809202469325;4405.7797110144365;4475.776211189427;4718.905621887543;4754.524547545287;4837.733924634179;142789.28605357115;142946;144868;146230;147301;76408.61795691097;111392.4430377843;123893.76106239003;125798;128379.43241135312;100537.49731251443;104353.12998395221;107455;107810.67987861318;110692.4465377668;7243.782686519413;9468.47923364194;9554.235661146953;9885.55515001841;10069.647562335284;42795.78602107094;44522.3321650169;57543;59642.70178649253;60284.397156029634;59877.10184347151;65252.34747652463;79703.60148199454;79920;80306.59846700962;13194.538191163263;13273.66815829612;13323.267220302976;13409.396577154246;13657.521986730417;13263.005274604637;14869.47956821506;14882.776758348416;15102.773458397913;15621.297041633381;14017.579472615838;14034.508792192224;14077.929610351883;14093.788593171315;14436.696882159244;14033.087849289763;14120.50578229757;14164.220967846455;14196.645083872985;14275;13794.825941225905;14023.789643155565;14028.649283767987;14067.366968486238;14203.786943196066;10930.453477325942;11143.944280278547;11374.94312528432;11456.541738330374;11626.593069242535;11030.669079927615;11387.316760994367;11550.854094996235;11577.826332605186;11717.296962182296 05:10:44 INFO - PROCESS | 1646 | __end_tp_report 05:10:44 INFO - PROCESS | 1646 | __start_cc_report 05:10:44 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,410 05:10:44 INFO - PROCESS | 1646 | __end_cc_report 05:10:44 INFO - PROCESS | 1646 | __startTimestamp1472040644464__endTimestamp 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | ------- Summary: start ------- 05:10:44 INFO - PROCESS | 1646 | Number of tests: 6 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5761.05 Median:5985.70 stddev:682.47 (11.4%) stddev-sans-first:659.57 05:10:44 INFO - PROCESS | 1646 | Values: 3428.2 3433.6 3459.7 3460.0 3462.4 5716.9 5789.4 5816.4 5877.4 5899.5 5781.6 5819.9 5852.4 5915.8 5927.1 5163.3 5244.6 5258.6 5329.8 5377.6 5365.0 5366.5 5401.0 5416.1 5448.2 4314.8 4314.9 5200.2 5245.4 5367.0 3922.7 5249.1 5256.4 5256.9 5350.7 5246.4 5267.6 5277.8 5281.9 5352.5 5317.4 5646.0 5771.3 5774.3 5867.6 6259.3 6259.7 6292.8 6299.2 6303.6 6291.3 6311.8 6319.9 6320.8 6320.9 5826.7 5897.5 5942.1 5963.7 5970.8 6374.4 6382.2 6382.6 6393.2 6415.1 6274.1 6275.6 6284.1 6289.2 6291.4 6188.6 6225.2 6248.0 6273.4 6320.9 6248.2 6305.8 6311.7 6339.5 6341.8 6252.9 6285.3 6297.5 6318.5 6322.3 4909.3 4952.2 4991.8 5000.9 5010.6 4481.1 4484.8 4496.6 4502.1 4535.1 5826.8 5928.9 5940.8 5943.1 5953.3 6199.3 6214.9 6246.5 6277.2 6313.5 5947.1 5953.9 5969.9 5982.0 6028.8 5454.2 5506.5 5508.3 5511.0 5533.6 6227.2 6291.5 6306.2 6335.7 6417.6 6287.9 6299.5 6311.2 6325.4 6337.6 5985.7 6121.3 6326.6 6398.6 6418.6 5237.4 6137.5 6201.6 6207.2 6237.0 4792.2 4830.3 6028.8 6208.5 6302.4 5416.0 6233.5 6254.7 6259.2 6269.5 6087.0 6139.5 6151.5 6183.9 6186.9 4895.6 5009.6 6157.9 6160.2 6164.8 5077.5 5111.3 6234.8 6252.3 6269.6 5989.7 6051.9 6060.2 6114.6 6149.4 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:75446.59 Median:40498.39 stddev:176479.54 (435.8%) stddev-sans-first:176884.88 05:10:44 INFO - PROCESS | 1646 | Values: 493.4 493.8 537.7 538.5 554.4 37744.6 40038.8 40133.0 40221.4 40316.8 41187.4 41402.4 41755.4 41793.0 41901.0 8941.3 9622.7 9664.9 9864.6 9870.4 8163.5 9719.7 9774.5 9835.5 9842.5 9805.5 9837.7 9847.3 9863.5 9886.8 9810.5 9824.4 9881.4 9886.2 9904.8 9700.7 9721.8 9769.0 9780.8 9821.7 39448.0 39463.2 39734.0 39761.4 39953.6 3304.8 3553.1 3816.0 3850.5 4132.2 31294.5 31860.0 32016.9 32096.7 32892.7 3350.0 3363.5 3409.4 3434.9 3480.9 439791.0 452761.0 453636.0 454270.0 454580.0 33273.0 56964.0 57305.0 57389.4 57431.7 28809.6 33836.8 34789.8 35050.1 35054.0 14493.0 14623.9 14628.9 14647.6 14654.6 12687.6 12800.4 12860.7 12862.3 12872.2 6470.4 7680.2 7720.0 7751.5 7775.2 2925.7 2967.6 2972.7 2975.4 3003.8 916.4 968.7 987.6 1116.6 1159.8 30674.7 30707.2 30970.7 31262.7 31332.0 831.5 1053.8 1134.1 1202.5 1244.0 14620.6 14990.6 15604.4 17651.4 18679.4 677099.0 777213.0 793299.0 799321.0 1023729.0 64452.4 64844.7 65170.7 65310.0 65395.7 1412.6 1416.3 1449.2 1450.4 1452.6 31499.1 32493.4 32568.5 32896.9 32998.8 54478.7 54832.7 55030.0 55084.7 55170.0 635139.0 639510.0 640426.0 641116.0 642145.0 38150.4 43027.8 45047.1 45445.0 45670.8 49733.5 50501.0 50550.2 50609.7 50640.5 40118.0 40435.8 40674.6 40998.4 41876.6 38270.2 40297.6 40561.0 41405.0 41578.0 33553.3 39566.8 39650.4 40035.6 41283.0 34691.0 35362.5 36298.8 36530.3 36645.6 20975.4 25775.5 25930.9 26062.3 26635.9 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:33923.02 Median:21738.84 stddev:99858.62 (459.4%) stddev-sans-first:100106.90 05:10:44 INFO - PROCESS | 1646 | Values: 336.8 364.5 374.5 382.8 397.0 20396.9 20674.3 21289.0 21520.7 21705.8 11945.9 12304.6 12322.9 12336.2 18087.6 5338.5 5656.7 5661.2 5671.3 5681.3 3954.0 5517.5 6514.6 6837.3 6864.3 5789.3 6831.3 6833.7 6844.4 6874.5 6045.1 6184.8 6191.3 6194.2 6202.5 5874.4 5912.0 5965.9 5984.1 6032.7 10389.3 11712.9 13576.9 13581.5 13811.5 2020.8 2094.1 2150.9 2163.3 3000.9 10172.6 10248.4 10334.0 10470.8 10624.2 1574.0 1621.4 1656.8 1939.4 1977.1 126694.0 133445.0 133793.7 135175.0 137134.0 11374.7 11467.9 11517.3 11688.1 11772.6 14502.6 14515.3 14527.7 14532.4 14536.5 8511.5 8599.0 8642.5 8674.2 8803.2 8426.6 8619.5 8670.7 8763.7 8764.0 3846.9 3966.9 4313.6 4546.9 4629.6 1777.3 1824.7 1930.3 1954.9 1973.5 810.6 888.1 915.7 970.0 994.7 18256.9 19449.5 20289.9 21771.9 21944.7 876.7 911.0 922.9 974.3 1006.2 9250.3 11147.2 11505.4 11537.7 11553.0 501374.0 583770.0 609947.0 640747.0 647719.0 74053.9 74426.0 74953.3 125521.4 131265.0 979.4 1003.8 1026.2 1027.6 1031.1 18506.0 18962.1 19855.7 19898.7 20656.7 56904.7 57255.4 57340.4 57393.4 57534.7 58176.4 74462.6 76518.0 76749.0 77403.2 6942.7 7251.9 7673.8 7964.8 8286.8 9363.6 11633.8 12166.6 12210.5 12921.4 10831.6 10843.0 11128.9 11158.8 11324.4 10370.5 10506.6 10601.7 10995.3 11001.6 10009.7 10425.4 10462.3 11154.6 11385.0 6947.3 7224.4 7272.8 7481.4 8117.0 9708.2 10175.7 10917.2 11049.8 11263.0 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5674.70 Median:5039.61 stddev:3198.15 (63.5%) stddev-sans-first:3190.24 05:10:44 INFO - PROCESS | 1646 | Values: 1301.7 1403.9 1635.9 1830.1 1847.7 7913.0 8459.6 8558.0 8968.6 9008.7 8601.7 8798.0 8802.5 8803.6 8810.1 2324.3 2365.8 2370.5 2371.3 2402.2 1843.3 2328.2 2363.8 2374.1 2382.7 2332.8 2352.9 2355.1 2367.6 2379.2 2106.8 2333.3 2362.4 2362.8 2375.6 2044.7 2263.6 2318.4 2356.8 2358.5 8914.2 8978.8 8979.6 8989.6 9020.8 5199.2 5337.0 5340.0 5352.3 5356.0 3412.3 3466.1 3545.1 3555.7 3597.2 1009.4 1036.6 1048.2 1052.8 1069.0 11306.0 11611.8 11620.6 11627.8 11630.8 3795.3 4577.2 4796.6 4796.7 4800.5 9774.5 9863.7 9872.9 9874.9 9878.5 5282.8 5311.5 5319.9 5323.3 5344.0 4401.6 4725.9 4822.2 4883.3 4894.1 3846.6 3912.5 3985.8 3992.0 4020.3 1284.5 1285.3 1291.6 1298.1 1308.3 749.4 819.5 869.9 918.4 920.5 5640.7 5695.2 5785.7 5926.9 5928.0 952.5 964.3 979.9 996.6 1075.5 3299.3 3850.2 3885.2 3972.9 3996.8 10545.6 10795.7 10818.1 10851.5 10860.8 10705.6 10807.5 10817.4 10823.6 10849.7 6317.8 7643.9 8170.4 8289.8 8306.5 5462.0 5691.5 5809.3 5847.5 6005.3 9708.5 9828.5 9850.0 9938.3 9947.3 9990.2 10024.1 10115.4 10118.3 10262.2 6910.6 7293.1 7490.6 7503.4 7615.4 7197.2 8356.7 8455.0 8464.7 8476.8 7431.4 7512.9 7599.8 7604.8 7732.2 6220.9 6364.8 7348.3 7437.2 7568.2 6957.8 6973.7 7013.2 7087.2 7096.9 4912.2 4973.3 5024.3 5055.6 5058.9 4911.9 4967.1 4978.9 5054.9 5204.6 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4420.21 Median:4713.08 stddev:1360.02 (28.9%) stddev-sans-first:1328.09 05:10:44 INFO - PROCESS | 1646 | Values: 293.5 303.6 310.5 314.0 314.2 5083.0 5108.3 5357.8 5481.4 5487.9 4726.9 5564.4 5616.3 5624.5 5634.1 3484.5 4229.1 4232.4 4257.0 4261.9 3839.7 4018.9 4106.9 4255.3 4276.3 4164.3 4176.4 4207.4 4209.5 4217.6 3636.8 4215.8 4231.2 4232.0 4233.1 3664.4 3665.9 3670.6 3678.6 3678.9 5201.5 5351.8 5439.3 5452.6 5487.6 4615.3 4893.3 4913.5 4914.7 4921.5 5221.2 5651.2 5729.9 5938.2 5945.5 3342.3 3682.5 4032.4 4036.7 4046.6 5098.3 5689.9 6024.4 6346.4 6369.5 3927.5 4081.6 4114.8 4126.5 4173.3 3366.7 3534.7 4011.6 4056.1 4068.4 4178.4 4456.6 4564.6 4716.3 4803.4 5168.1 5725.9 5739.3 5789.7 5983.3 1250.8 1333.3 1367.8 1370.9 1386.8 722.0 804.5 848.4 853.5 854.2 4042.6 4047.8 4470.0 4540.7 4683.2 4395.7 4664.0 4668.0 4821.7 5200.5 4054.9 4500.2 4567.6 4709.8 4754.0 2234.8 2618.0 2668.5 2680.3 2684.8 4300.8 4533.9 5321.7 5356.8 5394.1 4266.8 4297.4 4316.7 4456.3 5273.8 4726.6 4946.4 4997.8 5087.3 5342.6 4039.9 4686.6 4721.0 4822.3 5208.8 4517.8 4528.8 4556.9 5106.1 5197.8 4088.0 4766.6 5100.6 5221.4 5305.4 3401.9 3519.4 3519.9 3532.6 3542.6 4217.8 4382.7 4443.0 5122.9 5865.5 5754.0 5925.7 5959.6 5961.8 6008.7 5581.4 5627.9 5681.8 5944.3 5945.8 5013.5 5465.8 5769.8 5796.4 5868.9 5423.8 5641.8 5956.6 5981.2 6014.8 5257.8 5408.4 5420.7 5548.7 5846.7 05:10:44 INFO - PROCESS | 1646 | 05:10:44 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:23743.21 Median:3437.08 stddev:37474.84 (1090.3%) stddev-sans-first:37540.01 05:10:44 INFO - PROCESS | 1646 | Values: 694.5 718.6 725.8 766.0 820.9 14201.6 15166.5 16365.3 16377.2 16388.7 13979.2 14723.6 14759.0 14911.3 14928.6 832.2 850.2 852.1 853.0 854.0 676.0 831.6 850.5 858.0 865.7 897.8 898.0 902.7 903.0 904.1 894.1 899.2 900.6 902.6 903.5 652.0 663.3 669.4 670.9 671.6 14876.4 14887.0 14907.9 14908.9 14943.6 14487.6 14544.4 14642.8 14861.5 14879.9 11846.7 12021.9 12052.9 12104.9 12132.7 3761.0 3809.4 3836.5 3857.5 3988.1 110168.4 116379.0 116988.0 117418.0 122371.0 10885.7 10909.3 11021.8 11074.2 11086.7 19098.9 23252.5 23254.0 23257.0 23304.5 6884.9 7717.7 8164.2 8176.8 8402.3 3737.3 3762.9 4063.0 4331.9 4476.3 3384.6 3489.5 3536.0 3536.9 3551.7 604.6 607.8 622.7 628.4 638.8 576.3 617.3 643.0 654.3 681.4 9107.9 9214.9 9413.5 9526.3 9860.6 527.4 608.8 624.7 625.0 693.8 4405.8 4475.8 4718.9 4754.5 4837.7 142789.3 142946.0 144868.0 146230.0 147301.0 76408.6 111392.4 123893.8 125798.0 128379.4 100537.5 104353.1 107455.0 107810.7 110692.4 7243.8 9468.5 9554.2 9885.6 10069.6 42795.8 44522.3 57543.0 59642.7 60284.4 59877.1 65252.3 79703.6 79920.0 80306.6 13194.5 13273.7 13323.3 13409.4 13657.5 13263.0 14869.5 14882.8 15102.8 15621.3 14017.6 14034.5 14077.9 14093.8 14436.7 14033.1 14120.5 14164.2 14196.6 14275.0 13794.8 14023.8 14028.6 14067.4 14203.8 10930.5 11143.9 11374.9 11456.5 11626.6 11030.7 11387.3 11550.9 11577.8 11717.3 05:10:44 INFO - PROCESS | 1646 | -------- Summary: end -------- 05:10:44 INFO - PROCESS | 1646 | 05:10:45 INFO - TEST-INFO | 1646: exit 0 05:10:45 INFO - TEST-OK | dromaeo_css | took 1114153ms 05:10:45 INFO - TEST-START | kraken 05:10:45 INFO - operating with platform_type : mac_ 05:10:45 INFO - Initialising browser for kraken test... 05:10:45 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmp3q5zQ4/profile http://localhost:49275/getInfo.html) 05:10:47 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:10:47 INFO - PROCESS | 1657 | colorDepth:24 05:10:47 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:10:47 INFO - PROCESS | 1657 | __metrics 05:10:47 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:10:48 INFO - TEST-INFO | 1657: exit 0 05:10:48 INFO - Browser initialized. 05:10:48 INFO - Running cycle 1/1 for kraken test... 05:10:48 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmp3q5zQ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:00 INFO - PROCESS | 1659 | RSS: Main: 244813824 05:11:00 INFO - PROCESS | 1659 | 05:11:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:04 INFO - PROCESS | 1659 | RSS: Main: 257449984 05:11:04 INFO - PROCESS | 1659 | 05:11:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:11:07 INFO - PROCESS | 1659 | RSS: Main: 266141696 05:11:07 INFO - PROCESS | 1659 | 05:11:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:11:11 INFO - PROCESS | 1659 | RSS: Main: 262922240 05:11:11 INFO - PROCESS | 1659 | 05:11:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:11:14 INFO - PROCESS | 1659 | RSS: Main: 265809920 05:11:14 INFO - PROCESS | 1659 | 05:11:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:17 INFO - PROCESS | 1659 | RSS: Main: 265658368 05:11:17 INFO - PROCESS | 1659 | 05:11:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:20 INFO - PROCESS | 1659 | RSS: Main: 265920512 05:11:20 INFO - PROCESS | 1659 | 05:11:23 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:24 INFO - PROCESS | 1659 | RSS: Main: 266158080 05:11:24 INFO - PROCESS | 1659 | 05:11:27 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:11:28 INFO - PROCESS | 1659 | RSS: Main: 267796480 05:11:28 INFO - PROCESS | 1659 | 05:11:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:30 INFO - PROCESS | 1659 | RSS: Main: 267239424 05:11:30 INFO - PROCESS | 1659 | 05:11:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:11:32 INFO - PROCESS | 1659 | RSS: Main: 267247616 05:11:32 INFO - PROCESS | 1659 | 05:11:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:11:35 INFO - PROCESS | 1659 | RSS: Main: 267612160 05:11:35 INFO - PROCESS | 1659 | 05:11:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:11:39 INFO - PROCESS | 1659 | RSS: Main: 268054528 05:11:39 INFO - PROCESS | 1659 | 05:11:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:11:42 INFO - PROCESS | 1659 | RSS: Main: 268054528 05:11:42 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:11:44 INFO - PROCESS | 1659 | RSS: Main: 269860864 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | __start_tp_report 05:11:44 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 05:11:44 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 05:11:44 INFO - PROCESS | 1659 | |i|pagename|runs| 05:11:44 INFO - PROCESS | 1659 | |0;ai-astar;137;159;94;161;172;123;119;116;119;119 05:11:44 INFO - PROCESS | 1659 | |1;audio-beat-detection;142;112;160;166;113;134;132;110;158;108 05:11:44 INFO - PROCESS | 1659 | |2;audio-dft;195;199;213;214;201;229;227;201;243;278 05:11:44 INFO - PROCESS | 1659 | |3;audio-fft;67;82;75;147;59;60;60;62;137;61 05:11:44 INFO - PROCESS | 1659 | |4;audio-oscillator;73;72;123;70;76;119;140;80;74;113 05:11:44 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;93;90;92;91;93;88;93;91;117;108 05:11:44 INFO - PROCESS | 1659 | |6;imaging-darkroom;98;99;99;96;98;96;97;99;152;97 05:11:44 INFO - PROCESS | 1659 | |7;imaging-desaturate;91;104;150;106;146;147;140;92;92;91 05:11:44 INFO - PROCESS | 1659 | |8;json-parse-financial;57;58;58;58;58;57;57;58;59;58 05:11:44 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;82;72;70;73;79;82;75;69;72;70 05:11:44 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;91;90;86;88;89;107;90;87;93;91 05:11:44 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;157;158;137;137;158;153;141;142;154;141 05:11:44 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;171;174;169;193;190;172;172;172;170;175 05:11:44 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;70;69;91;87;93;74;68;69;67;70 05:11:44 INFO - PROCESS | 1659 | __end_tp_report 05:11:44 INFO - PROCESS | 1659 | __start_cc_report 05:11:44 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1032 05:11:44 INFO - PROCESS | 1659 | __end_cc_report 05:11:44 INFO - PROCESS | 1659 | __startTimestamp1472040704923__endTimestamp 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | ------- Summary: start ------- 05:11:44 INFO - PROCESS | 1659 | Number of tests: 14 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:131.90 Median:148.00 stddev:24.68 (16.7%) stddev-sans-first:26.11 05:11:44 INFO - PROCESS | 1659 | Values: 137.0 159.0 94.0 161.0 172.0 123.0 119.0 116.0 119.0 119.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:138.00 stddev:22.41 (16.2%) stddev-sans-first:23.55 05:11:44 INFO - PROCESS | 1659 | Values: 142.0 112.0 160.0 166.0 113.0 134.0 132.0 110.0 158.0 108.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:220.00 Median:220.50 stddev:25.60 (11.6%) stddev-sans-first:25.50 05:11:44 INFO - PROCESS | 1659 | Values: 195.0 199.0 213.0 214.0 201.0 229.0 227.0 201.0 243.0 278.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:81.00 Median:61.50 stddev:33.09 (53.8%) stddev-sans-first:34.70 05:11:44 INFO - PROCESS | 1659 | Values: 67.0 82.0 75.0 147.0 59.0 60.0 60.0 62.0 137.0 61.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:72.50 stddev:26.59 (36.7%) stddev-sans-first:27.10 05:11:44 INFO - PROCESS | 1659 | Values: 73.0 72.0 123.0 70.0 76.0 119.0 140.0 80.0 74.0 113.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:91.50 stddev:9.29 (10.2%) stddev-sans-first:9.80 05:11:44 INFO - PROCESS | 1659 | Values: 93.0 90.0 92.0 91.0 93.0 88.0 93.0 91.0 117.0 108.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:98.00 stddev:17.22 (17.6%) stddev-sans-first:18.17 05:11:44 INFO - PROCESS | 1659 | Values: 98.0 99.0 99.0 96.0 98.0 96.0 97.0 99.0 152.0 97.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:115.90 Median:120.50 stddev:26.33 (21.8%) stddev-sans-first:26.34 05:11:44 INFO - PROCESS | 1659 | Values: 91.0 104.0 150.0 106.0 146.0 147.0 140.0 92.0 92.0 91.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 05:11:44 INFO - PROCESS | 1659 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 57.0 58.0 59.0 58.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:74.00 stddev:4.93 (6.7%) stddev-sans-first:4.39 05:11:44 INFO - PROCESS | 1659 | Values: 82.0 72.0 70.0 73.0 79.0 82.0 75.0 69.0 72.0 70.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:90.00 stddev:5.92 (6.6%) stddev-sans-first:6.28 05:11:44 INFO - PROCESS | 1659 | Values: 91.0 90.0 86.0 88.0 89.0 107.0 90.0 87.0 93.0 91.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:153.50 stddev:8.93 (5.8%) stddev-sans-first:8.83 05:11:44 INFO - PROCESS | 1659 | Values: 157.0 158.0 137.0 137.0 158.0 153.0 141.0 142.0 154.0 141.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:173.00 stddev:8.48 (4.9%) stddev-sans-first:8.82 05:11:44 INFO - PROCESS | 1659 | Values: 171.0 174.0 169.0 193.0 190.0 172.0 172.0 172.0 170.0 175.0 05:11:44 INFO - PROCESS | 1659 | 05:11:44 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:72.00 stddev:10.29 (14.3%) stddev-sans-first:10.70 05:11:44 INFO - PROCESS | 1659 | Values: 70.0 69.0 91.0 87.0 93.0 74.0 68.0 69.0 67.0 70.0 05:11:44 INFO - PROCESS | 1659 | -------- Summary: end -------- 05:11:44 INFO - PROCESS | 1659 | 05:11:45 INFO - TEST-INFO | 1659: exit 0 05:11:45 INFO - TEST-OK | kraken | took 60636ms 05:11:45 INFO - SUITE-END | took 1174s 05:11:46 INFO - Completed test suite (00:19:35) 05:11:46 INFO - javascript benchmark 05:11:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.007678811267, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3428.2457859270958, 3433.570803649544, 3459.65403459654, 3459.9999999999986, 3462.411390063689, 5716.942830571693, 5789.39211382805, 5816.447437493442, 5877.353491115974, 5899.52803775698, 5781.62419442736, 5819.941800582003, 5852.4440178183, 5915.792947246837, 5927.110933359998, 5163.251328557357, 5244.580433565325, 5258.579313654898, 5329.840104796862, 5377.569794416457, 5365.0, 5366.517013468787, 5401.0, 5416.079266524681, 5448.155535891943, 4314.80583373749, 4314.913701725979, 5200.219967004941, 5245.449227831099, 5367.0, 3922.7254092213557, 5249.1338929076655, 5256.421793602701, 5256.92114618281, 5350.678959262456, 5246.449122842123, 5267.631265811395, 5277.8416647500635, 5281.947180528184, 5352.518273355417, 5317.441668624778, 5645.971770141164, 5771.336296325934, 5774.335951365562, 5867.589268751189, 6259.280182778994, 6259.71831267594, 6292.811215663537, 6299.244090709099, 6303.55875088744, 6291.339409361997, 6311.810645680637, 6319.905201421982, 6320.841978950563, 6320.873582528369, 5826.679532625704, 5897.52819774417, 5942.10868369748, 5963.73163207648, 5970.820875373745, 6374.362563743682, 6382.20222472191, 6382.553221274559, 6393.1688880445245, 6415.069814876817, 6274.058891166362, 6275.623462592259, 6284.12022316876, 6289.150964619809, 6291.433770960635, 6188.628682279078, 6225.159603453476, 6248.0, 6273.404026617464, 6320.873582528324, 6248.156498872685, 6305.842353941096, 6311.652859092794, 6339.524535659844, 6341.841453963688, 6252.874942501125, 6285.308616052231, 6297.4647154992335, 6318.494520438354, 6322.33615470369, 4909.288153217834, 4952.207646776498, 4991.80032798684, 5000.89998200034, 5010.574101201366, 4481.148581769454, 4484.775761211927, 4496.617787488035, 4502.122086193226, 4535.092981403733, 5826.82519524415, 5928.911066334009, 5940.762369505172, 5943.138244954457, 5953.315368732565, 6199.318075011835, 6214.906776398358, 6246.46905013079, 6277.2153480814895, 6313.526485513605, 5947.078202878561, 5953.880922381528, 5969.910451343233, 5982.0, 6028.819135425856, 5454.154606036071, 5506.476884695948, 5508.3114610673665, 5511.035568775448, 5533.557315414757, 6227.221597300338, 6291.528135389773, 6306.211723534559, 6335.683215839282, 6417.582857114273, 6287.874242515032, 6299.464545513682, 6311.211098612674, 6325.399087086719, 6337.588056776295, 5985.700714964321, 6121.265448146251, 6326.55714100027, 6398.616083035033, 6418.614883107029, 5237.397699264633, 6137.499563105042, 6201.565890387629, 6207.224096987877, 6237.033259844731, 4792.2332426811545, 4830.2513110467935, 6028.819135425944, 6208.4722798562625, 6302.432781049728, 5416.0, 6233.532485063729, 6254.718537665725, 6259.217597800275, 6269.4984401246875, 6087.0, 6139.5228034422325, 6151.50787936955, 6183.938160618516, 6186.907196391968, 4895.559399654048, 5009.574186194214, 6157.907631385443, 6160.16837726919, 6164.784232552019, 5077.543021127968, 5111.284420181103, 6234.75060997555, 6252.280987686474, 6269.62382257066, 5989.700514974146, 6051.939480605138, 6060.151578778887, 6114.633122012693, 6149.385061493815], "value": 5720.039568041654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.4251596889625, 493.75805855130983, 537.6747068023845, 538.5341679447276, 554.3984776517478, 37744.62255377449, 40038.79980600096, 40132.99667508314, 40221.3966790498, 40316.79841600795, 41187.382189267184, 41402.37896431548, 41755.37366939498, 41792.95517612061, 41900.95247618811, 8941.284697224239, 9622.711318660451, 9664.903350966488, 9864.556094975707, 9870.407775533455, 8163.469374490669, 9719.708408747714, 9774.462404567746, 9835.508224588777, 9842.507874606277, 9805.509724513782, 9837.65568205113, 9847.310688251826, 9863.506824658774, 9886.752831179207, 9810.509474526316, 9824.410535367864, 9881.357711748713, 9886.159676427513, 9904.801903961952, 9700.660476883346, 9721.756956076155, 9769.0, 9780.804383912282, 9821.705348839547, 39448.01379965495, 39463.21073578512, 39734.0, 39761.40357894634, 39953.60046399557, 3304.7802709800335, 3553.076200187944, 3816.0078379621223, 3850.4801851750217, 4132.235536425771, 31294.53058204106, 31860.0, 32016.879409220797, 32096.679033209835, 32892.6710732892, 3349.9832500837583, 3363.478660807554, 3409.3863104641155, 3434.8969530914114, 3480.8781692640637, 439791.0, 452761.0, 453636.0, 454270.0, 454580.0, 33273.0, 56964.0, 57305.0, 57389.42610573924, 57431.712841435525, 28809.56785648217, 33836.78550537744, 34789.82605087009, 35050.12374690653, 35054.0, 14493.0, 14623.85376146225, 14628.853711462962, 14647.633809154857, 14654.633634159018, 12687.619371418872, 12800.423980920881, 12860.742785144244, 12862.292573908338, 12872.16330938486, 6470.352964703586, 7680.155182929873, 7720.0, 7751.496152750054, 7775.222477752292, 2925.692802255775, 2967.5993740845142, 2972.7324540791433, 2975.3900450407614, 3003.849807509616, 916.3585490156917, 968.7335982604699, 987.6197663899451, 1116.625930313354, 1159.837622732818, 30674.693253067184, 30707.232319191753, 30970.690293097232, 31262.7494900206, 31332.0, 831.4720152702956, 1053.7828807727087, 1134.1493879590307, 1202.500962100736, 1244.0, 14620.634484137769, 14990.550283491513, 15604.375824967101, 17651.38220162288, 18679.439616811247, 677099.0, 777213.0, 793299.0, 799321.0, 1023729.0, 64452.35547644558, 64844.67577662082, 65170.67414662991, 65310.0, 65395.673021635535, 1412.6468382904275, 1416.3414012484038, 1449.1884544655027, 1450.4053338131316, 1452.6077958951023, 31499.11005339687, 32493.35013299768, 32568.51147232841, 32896.927160660576, 32998.83500582482, 54478.72760636172, 54832.72583637056, 55030.0, 55084.72457637686, 55170.0, 635139.0, 639510.0, 640426.0, 641116.0, 642145.0, 38150.427743583314, 43027.784861075495, 45047.09905801931, 45445.0, 45670.771646141555, 49733.50266497434, 50501.0, 50550.241746373096, 50609.746951265006, 50640.49359506358, 40118.0, 40435.7978210107, 40674.593254067084, 40998.38502422526, 41876.581234187266, 38270.234595308495, 40297.59702402938, 40560.98597534967, 41405.0, 41577.96055098647, 33553.32893342168, 39566.802165988986, 39650.40524392194, 40035.59964400319, 41282.9679258021, 34691.0, 35362.46956295709, 36298.8185059073, 36530.26939461143, 36645.63354366422, 20975.370738877857, 25775.484490310464, 25930.870345648153, 26062.34844128912, 26635.86682066577], "value": 19443.13270665331, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.83663423239733, 364.52065533823003, 374.50939269556875, 382.82198777568425, 396.9639241579477, 20396.898015509938, 20674.27640032599, 21289.04199311031, 21520.677189842147, 21705.782942170572, 11945.880541194607, 12304.5693400731, 12322.876771232284, 12336.19814712043, 18087.63824723505, 5338.492843179911, 5656.745446454919, 5661.207430959648, 5671.291088613923, 5681.261436013312, 3954.0, 5517.475839795213, 6514.57655252407, 6837.3162683731725, 6864.313568643146, 5789.2763404574425, 6831.282715314895, 6833.726650933957, 6844.38400543951, 6874.518783685144, 6045.063015232624, 6184.814455566295, 6191.2570491540855, 6194.163787888645, 6202.472789812871, 5874.426033140373, 5912.0, 5965.910511342333, 5984.072468767348, 6032.672811981357, 10389.27275090744, 11712.88287117135, 13576.913846892225, 13581.456741730319, 13811.51659691916, 2020.828229600471, 2094.1204694028393, 2150.860194087395, 2163.3185546552786, 3000.9249768755735, 10172.643957461527, 10248.436336001518, 10334.0, 10470.842937355947, 10624.150067994618, 1573.9763903541457, 1621.4243943400159, 1656.8011838579328, 1939.4181745476442, 1977.1399441243104, 126694.0, 133445.0, 133793.6620633791, 135175.0, 137134.0, 11374.658760237206, 11467.885321146849, 11517.25137866036, 11688.123390745728, 11772.587959421378, 14502.564923052325, 14515.346809393603, 14527.709445811235, 14532.418703251962, 14536.491222807152, 8511.489310641382, 8599.0, 8642.524661143572, 8674.219320261207, 8803.16369944867, 8426.567483527815, 8619.525926074, 8670.653173872974, 8763.737087887373, 8764.0, 3846.8653597123966, 3966.8944087006844, 4313.590208930146, 4546.909061818745, 4629.560191781776, 1777.2713187593024, 1824.7289405774409, 1930.3340347580063, 1954.8924809135633, 1973.5263536751077, 810.5501446697021, 888.1074520107251, 915.734437013272, 969.9515024248759, 994.7314225159166, 18256.9045857249, 19449.513762155777, 20289.89855050745, 21771.891140544198, 21944.670829937564, 876.6624849432886, 910.9635614575343, 922.9215516681157, 974.3131092579714, 1006.225206590921, 9250.306227033, 11147.16071848136, 11505.367204803817, 11537.653870383901, 11552.96023357885, 501374.0, 583770.0, 609947.0, 640747.0, 647719.0, 74053.88919166217, 74426.0, 74953.25046749462, 125521.37239313746, 131265.0, 979.4368238262884, 1003.7691330993912, 1026.1944373666636, 1027.609508386823, 1031.1493018259966, 18506.0, 18962.146703398656, 19855.702164467257, 19898.70151947751, 20656.690149648068, 56904.71547642235, 57255.42744572501, 57340.426595735174, 57393.42606573881, 57534.7123264381, 58176.4182358171, 74462.62768686122, 76518.0, 76749.0, 77403.2259677396, 6942.680890630764, 7251.891221631574, 7673.8465230693955, 7964.761057168294, 8286.83426331482, 9363.625454981724, 11633.825492617449, 12166.635000949631, 12210.450529726006, 12921.35393230316, 10831.620893268699, 10843.0, 11128.944355278172, 11158.776824463628, 11324.433778310886, 10370.533326000197, 10506.579736810441, 10601.734956626146, 10995.285306455055, 11001.61494347694, 10009.749756256151, 10425.426601536989, 10462.267641265344, 11154.553817847196, 11385.0, 6947.270536593584, 7224.422046236184, 7272.781816545512, 7481.401487881065, 8117.025956885212, 9708.17480514136, 10175.689641465864, 10917.181211409335, 11049.834252486058, 11263.0], "value": 9194.863985256217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.6875949772054, 1403.936822842972, 1635.869130469562, 1830.112395488189, 1847.6581832361014, 7913.0, 8459.577021148942, 8558.0, 8968.596413161407, 9008.684696035632, 8601.655933762642, 8798.0, 8802.471851688888, 8803.559822008907, 8810.118988101187, 2324.2910912171824, 2365.8343915925893, 2370.5021945391404, 2371.2530552875874, 2402.1712509184304, 1843.3271855772614, 2328.2433209207074, 2363.775441333079, 2374.0859768988976, 2382.702162229721, 2332.825038122148, 2352.9176478823247, 2355.128602417108, 2367.5975084235633, 2379.2029670060465, 2106.7893210678885, 2333.288347054148, 2362.385779697274, 2362.83460157789, 2375.6317770745477, 2044.6932960055963, 2263.5739484124897, 2318.431984163874, 2356.7761062699014, 2358.481134150484, 8914.242289405409, 8978.820423591556, 8979.595918183697, 8989.55052247385, 9020.77448063797, 5199.2461093141665, 5337.039332920072, 5340.0, 5352.2506849041165, 5356.0, 3412.334594754024, 3466.0988143082727, 3545.1137215696076, 3555.715542756573, 3597.226596281786, 1009.3893194617298, 1036.5905467340433, 1048.224314007629, 1052.752603138262, 1068.9732756681067, 11306.0, 11611.767764644745, 11620.59327923527, 11627.767444651145, 11630.825537616858, 3795.3358162321483, 4577.244754615518, 4796.56830885222, 4796.688215265996, 4800.495947925488, 9774.511274436392, 9863.704088877344, 9872.901270987199, 9874.851877221847, 9878.456684882256, 5282.788688452419, 5311.548518375904, 5319.9202011969855, 5323.254744335796, 5343.973280133574, 4401.6478681705385, 4725.858224253209, 4822.180229360947, 4883.291922671193, 4894.143524883202, 3846.615338466187, 3912.4522566840665, 3985.780782056957, 3992.0, 4020.3165461871554, 1284.531146131674, 1285.2802430638872, 1291.6125162451226, 1298.0718786067819, 1308.2935214983802, 749.3592978003837, 819.5041999590281, 869.9173578510031, 918.4443411735804, 920.4615300049412, 5640.746166422521, 5695.202671625976, 5785.681787501644, 5926.851828704317, 5928.021876390348, 952.4808979106404, 964.344245912786, 979.9167070799062, 996.5814357969525, 1075.5482697267166, 3299.290652509722, 3850.2299540092095, 3885.1841113365945, 3972.900677483086, 3996.820143093568, 10545.578176872992, 10795.730106747236, 10818.080463160719, 10851.51168197433, 10860.837087443695, 10705.571777128984, 10807.513661885234, 10817.350958942488, 10823.621173258898, 10849.67450976472, 6317.842053948596, 7643.885341719879, 8170.428070035159, 8289.751307460785, 8306.501609903426, 5462.0, 5691.516221121251, 5809.30288365382, 5847.502962248086, 6005.2793664758765, 9708.5145742714, 9828.459434731158, 9850.014998500093, 9938.304318697621, 9947.303688741718, 9990.200783937413, 10024.097831195228, 10115.393076415145, 10118.342307749972, 10262.230332725225, 6910.585364878123, 7293.124825021031, 7490.625468726651, 7503.399728021855, 7615.352695020763, 7197.244289349543, 8356.707515236938, 8455.0, 8464.746057618282, 8476.788080298042, 7431.40548756109, 7512.887306690294, 7599.772006839804, 7604.8479030420185, 7732.226777322223, 6220.937790622036, 6364.77723279683, 7348.265173482823, 7437.219091995263, 7568.243175682388, 6957.826054348682, 6973.721051157897, 7013.158420989514, 7087.22040575526, 7096.8935465967015, 4912.214045752662, 4973.303737476684, 5024.296598476143, 5055.5955523557295, 5058.873528161826, 4911.926321105258, 4967.105920934267, 4978.900421991612, 5054.924176137434, 5204.557612602971], "value": 4555.616392415829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.4702861335289, 303.64776858843743, 310.51869602116716, 314.03747513869985, 314.15648982482054, 5082.9579936113105, 5108.282608369996, 5357.7589008494615, 5481.424450432707, 5487.91768123478, 4726.936439301156, 5564.387917329091, 5616.297962754656, 5624.521915637166, 5634.0703783875715, 3484.4947482615135, 4229.069604686964, 4232.354778263585, 4257.0, 4261.872143835682, 3839.7120215983914, 4018.8546264314678, 4106.932197628608, 4255.340422234559, 4276.337167739005, 4164.293209413875, 4176.352665336878, 4207.431996680455, 4209.452771139748, 4217.620414162725, 3636.76350040986, 4215.789210539491, 4231.238377092122, 4231.957680423187, 4233.116263262849, 3664.3770559005034, 3665.9450108248398, 3670.5595328560476, 3678.558572971234, 3678.8528458861615, 5201.453847346012, 5351.839444816662, 5439.292891924064, 5452.645578037414, 5487.5609951203805, 4615.307703844416, 4893.290472881448, 4913.508649135094, 4914.729689867056, 4921.458639549646, 5221.190715439075, 5651.208830763697, 5729.885402291972, 5938.228030356069, 5945.513621594601, 3342.3067510401142, 3682.521272234619, 4032.354823228269, 4036.6568841648495, 4046.6358027777346, 5098.260752190911, 5689.890471358087, 6024.3975602439405, 6346.428821406142, 6369.4585960193435, 3927.5286965564314, 4081.5918408158946, 4114.835406583703, 4126.504819421689, 4173.332266837291, 3366.713829324535, 3534.745165466274, 4011.6389524942897, 4056.127932494469, 4068.3694027425795, 4178.352355384859, 4456.6211871991245, 4564.566366195206, 4716.339712440261, 4803.4061606731975, 5168.069747445421, 5725.885482290331, 5739.339975902824, 5789.681567513743, 5983.341832398432, 1250.8402838292045, 1333.3266700316472, 1367.8495365509787, 1370.8766211040854, 1386.750384930702, 721.989170162448, 804.4610111225493, 848.4018766769412, 853.5177624642057, 854.1927878155208, 4042.5755295694116, 4047.777372244555, 4469.9776501117285, 4540.659450541222, 4683.227267500893, 4395.670324725658, 4663.965669695756, 4667.953320466752, 4821.686590371614, 5200.541639809484, 4054.878353649395, 4500.212462818994, 4567.566081222279, 4709.81160753566, 4754.003318606194, 2234.832387570939, 2617.973820261811, 2668.490251475001, 2680.316519287569, 2684.7986401020003, 4300.7634580097765, 4533.886652833639, 5321.707306098202, 5356.812511562077, 5394.109971854678, 4266.765327906933, 4297.419848320499, 4316.719413238192, 4456.301269945937, 5273.789048438096, 4726.574608285271, 4946.406431228275, 4997.775100120503, 5087.2623469595965, 5342.5993050521365, 4039.8990025249605, 4686.625069994324, 4720.961388494526, 4822.300766388924, 5208.8437346879655, 4517.75152366623, 4528.750918699503, 4556.908861822812, 5106.068327387965, 5197.818076367309, 4088.0393107619093, 4766.61867050642, 5100.593371026724, 5221.399539053057, 5305.442928492453, 3401.9319613608086, 3519.3665140274998, 3519.9472007920413, 3532.611412744545, 3542.600672734307, 4217.789110544399, 4382.7209850878, 4443.00064970758, 5122.925215287814, 5865.530757539302, 5753.971230143822, 5925.674087925033, 5959.553033522589, 5961.7615295387695, 6008.699565021644, 5581.386047534686, 5627.915581266202, 5681.7500149966945, 5944.286685597756, 5945.821625351246, 5013.523715247045, 5465.754041068082, 5769.778635225384, 5796.42035796417, 5868.853278668067, 5423.806762512241, 5641.83074507749, 5956.583039187389, 5981.222441082631, 6014.849628759316, 5257.764425360114, 5408.403411731155, 5420.7289635518855, 5548.667079975215, 5846.655269288002], "value": 3989.009393050777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.4513834071083, 718.6299055986168, 725.771382014665, 766.0347961568425, 820.8891799607052, 14201.644958876033, 15166.545003649895, 16365.345386184554, 16377.18114094295, 16388.67222655546, 13979.161250324987, 14723.631909202275, 14759.0, 14911.32899019544, 14928.626784330398, 832.2260297922944, 850.1710831938872, 852.0627309959058, 852.9872051919226, 853.9615717292705, 675.9898601520981, 831.6091437024588, 850.4812064640564, 858.0132847225678, 865.7013330401033, 897.7620930453403, 897.995510022449, 902.6660135749748, 902.9593668284942, 904.0688091266006, 894.1014280647908, 899.2131884600974, 900.5857305639414, 902.616388035089, 903.5075883643398, 651.993480065198, 663.2737152817657, 669.4410167510135, 670.8859493886051, 671.6306031682603, 14876.404943802236, 14887.0, 14907.850921490755, 14908.925455372762, 14943.551693449213, 14487.637809054753, 14544.418223271057, 14642.780358294634, 14861.479848205261, 14879.851201488063, 11846.703832404173, 12021.879781202164, 12052.879471205264, 12104.878951210463, 12132.696682582919, 3761.0221342450886, 3809.447630093621, 3836.5396152461603, 3857.537095548524, 3988.102676897704, 110168.4491577537, 116379.0, 116988.0, 117418.0, 122371.0, 10885.727856803485, 10909.290896091728, 11021.83467247992, 11074.169437292236, 11086.667399978014, 19098.904505477385, 23252.534949301258, 23254.0, 23256.95343709537, 23304.53390932172, 6884.931150688529, 7717.691292348243, 8164.183581641788, 8176.754697359089, 8402.327813774884, 3737.289914916157, 3762.8682996095004, 4062.9639441942118, 4331.938675024639, 4476.328550717419, 3384.627690953993, 3489.5289135966827, 3536.045267777737, 3536.8938931832085, 3551.662592053751, 604.6100265328838, 607.781198768443, 622.7228883147046, 628.4438272129198, 638.8339031851659, 576.2796504369538, 617.290106405255, 642.9935700642934, 654.2998991079594, 681.3833480699974, 9107.908920910839, 9214.861777073349, 9413.48225847585, 9526.285528585246, 9860.556274967643, 527.4435470578577, 608.7930103764742, 624.7376102037156, 624.9843753906189, 693.809202469325, 4405.7797110144365, 4475.776211189427, 4718.905621887543, 4754.524547545287, 4837.733924634179, 142789.28605357115, 142946.0, 144868.0, 146230.0, 147301.0, 76408.61795691097, 111392.4430377843, 123893.76106239003, 125798.0, 128379.43241135312, 100537.49731251443, 104353.12998395221, 107455.0, 107810.67987861318, 110692.4465377668, 7243.782686519413, 9468.47923364194, 9554.235661146953, 9885.55515001841, 10069.647562335284, 42795.78602107094, 44522.3321650169, 57543.0, 59642.70178649253, 60284.397156029634, 59877.10184347151, 65252.34747652463, 79703.60148199454, 79920.0, 80306.59846700962, 13194.538191163263, 13273.66815829612, 13323.267220302976, 13409.396577154246, 13657.521986730417, 13263.005274604637, 14869.47956821506, 14882.776758348416, 15102.773458397913, 15621.297041633381, 14017.579472615838, 14034.508792192224, 14077.929610351883, 14093.788593171315, 14436.696882159244, 14033.087849289763, 14120.50578229757, 14164.220967846455, 14196.645083872985, 14275.0, 13794.825941225905, 14023.789643155565, 14028.649283767987, 14067.366968486238, 14203.786943196066, 10930.453477325942, 11143.944280278547, 11374.94312528432, 11456.541738330374, 11626.593069242535, 11030.669079927615, 11387.316760994367, 11550.854094996235, 11577.826332605186, 11717.296962182296], "value": 7742.9351536250715, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 159.0, 94.0, 161.0, 172.0, 123.0, 119.0, 116.0, 119.0, 119.0], "value": 131.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 160.0, 166.0, 113.0, 134.0, 132.0, 110.0, 158.0, 108.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 213.0, 214.0, 201.0, 229.0, 227.0, 201.0, 243.0, 278.0], "value": 220.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 82.0, 75.0, 147.0, 59.0, 60.0, 60.0, 62.0, 137.0, 61.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 123.0, 70.0, 76.0, 119.0, 140.0, 80.0, 74.0, 113.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 92.0, 91.0, 93.0, 88.0, 93.0, 91.0, 117.0, 108.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 99.0, 96.0, 98.0, 96.0, 97.0, 99.0, 152.0, 97.0], "value": 103.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 104.0, 150.0, 106.0, 146.0, 147.0, 140.0, 92.0, 92.0, 91.0], "value": 115.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 59.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 70.0, 73.0, 79.0, 82.0, 75.0, 69.0, 72.0, 70.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 86.0, 88.0, 89.0, 107.0, 90.0, 87.0, 93.0, 91.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 137.0, 137.0, 158.0, 153.0, 141.0, 142.0, 154.0, 141.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 169.0, 193.0, 190.0, 172.0, 172.0, 172.0, 170.0, 175.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 91.0, 87.0, 93.0, 74.0, 68.0, 69.0, 67.0, 70.0], "value": 75.8, "unit": "score"}]}]} 05:11:46 INFO - Return code: 0 05:11:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:11:46 ERROR - # TBPL SUCCESS # 05:11:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:46 INFO - 2016-08-24 05:11:46.262 screenresolution[1664:10348] starting screenresolution argv=screenresolution get 05:11:46 INFO - 2016-08-24 05:11:46.265 screenresolution[1664:10348] Display 0: 1600x1200x32@60 05:11:46 INFO - 2016-08-24 05:11:46.271 screenresolution[1665:10351] starting screenresolution argv=screenresolution list 05:11:46 INFO - Available Modes on Display 0 05:11:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:46 INFO - Intel Iris: 05:11:46 INFO - Chipset Model: Intel Iris 05:11:46 INFO - Type: GPU 05:11:46 INFO - Bus: Built-In 05:11:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:11:46 INFO - Vendor: Intel (0x8086) 05:11:46 INFO - Device ID: 0x0a2e 05:11:46 INFO - Revision ID: 0x0009 05:11:46 INFO - Displays: 05:11:46 INFO - Display: 05:11:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:46 INFO - Display Serial Number: 1600x1200 60 05:11:46 INFO - Main Display: Yes 05:11:46 INFO - Mirror: Off 05:11:46 INFO - Online: Yes 05:11:46 INFO - Rotation: Supported 05:11:46 INFO - Return code: 0 05:11:46 INFO - Running post-action listener: _resource_record_post_action 05:11:46 INFO - [mozharness: 2016-08-24 12:11:46.511011Z] Finished run-tests step (success) 05:11:46 INFO - Running post-run listener: _resource_record_post_run 05:11:46 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 38372352; Write bytes: 705066496; Read time: 402; Write time: 1989 05:11:46 INFO - TinderboxPrint: CPU usage
54.7% 05:11:46 INFO - TinderboxPrint: I/O read bytes / time
38,372,352 / 402 05:11:46 INFO - TinderboxPrint: I/O write bytes / time
705,066,496 / 1,989 05:11:46 INFO - TinderboxPrint: CPU idle
2,195.0 (45.3%) 05:11:46 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 05:11:46 INFO - TinderboxPrint: CPU user
1,666.2 (34.4%) 05:11:46 INFO - TinderboxPrint: Swap in / out
443,621,376 / 0 05:11:46 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384330240; Write bytes: 378210304; Read time: 29153; Write time: 701 05:11:46 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 37417984; Write bytes: 297332224; Read time: 387; Write time: 1211 05:11:46 INFO - Running post-run listener: _upload_blobber_files 05:11:46 INFO - Blob upload gear active. 05:11:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:11:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:11:46 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:11:46 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:11:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:48 INFO - (blobuploader) - INFO - Done attempting. 05:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:49 INFO - (blobuploader) - INFO - Done attempting. 05:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:51 INFO - (blobuploader) - INFO - Done attempting. 05:11:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:11:51 INFO - Return code: 0 05:11:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:11:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:11:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2204a0c80729ccf9ca245d06f7e188ead2942ea646f7a85ffa3690f94b553ccbc403b2099d4bf13792f4d4575960797998a6b33785919a9a06dac96b781ca379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ebca0668f0fb65ff3492c48f237254df70d5f167259e3dd1dc49b0c3c0aee88e2c561fa64d0c4afa20d008ce6f7cd0671a9cc806cb28af5b15ca022a9d3d114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ef32c4e36b1a7720d4f50bf477ce3a3c3f88e326ba926b01edf619b3f580603bd92b0fbb485474123eb896d88907217f7790ea449259cd65b26c3d5199b4bc"} 05:11:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:11:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:11:51 INFO - Contents: 05:11:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2204a0c80729ccf9ca245d06f7e188ead2942ea646f7a85ffa3690f94b553ccbc403b2099d4bf13792f4d4575960797998a6b33785919a9a06dac96b781ca379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ebca0668f0fb65ff3492c48f237254df70d5f167259e3dd1dc49b0c3c0aee88e2c561fa64d0c4afa20d008ce6f7cd0671a9cc806cb28af5b15ca022a9d3d114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ef32c4e36b1a7720d4f50bf477ce3a3c3f88e326ba926b01edf619b3f580603bd92b0fbb485474123eb896d88907217f7790ea449259cd65b26c3d5199b4bc"} 05:11:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:11:51 INFO - Copying logs to upload dir... 05:11:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:11:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.885305 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-24 05:11:51.379666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 05:11:51.383051) ========= 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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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/Fx-Team/sha512/2204a0c80729ccf9ca245d06f7e188ead2942ea646f7a85ffa3690f94b553ccbc403b2099d4bf13792f4d4575960797998a6b33785919a9a06dac96b781ca379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ebca0668f0fb65ff3492c48f237254df70d5f167259e3dd1dc49b0c3c0aee88e2c561fa64d0c4afa20d008ce6f7cd0671a9cc806cb28af5b15ca022a9d3d114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ef32c4e36b1a7720d4f50bf477ce3a3c3f88e326ba926b01edf619b3f580603bd92b0fbb485474123eb896d88907217f7790ea449259cd65b26c3d5199b4bc"} build_url:https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/S4CkCS6JRLOtpaQWBl_q-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2204a0c80729ccf9ca245d06f7e188ead2942ea646f7a85ffa3690f94b553ccbc403b2099d4bf13792f4d4575960797998a6b33785919a9a06dac96b781ca379", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ebca0668f0fb65ff3492c48f237254df70d5f167259e3dd1dc49b0c3c0aee88e2c561fa64d0c4afa20d008ce6f7cd0671a9cc806cb28af5b15ca022a9d3d114", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ef32c4e36b1a7720d4f50bf477ce3a3c3f88e326ba926b01edf619b3f580603bd92b0fbb485474123eb896d88907217f7790ea449259cd65b26c3d5199b4bc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 05:11:51.420921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:11:51.421660) ========= 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.ynbyPT5hj2/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.cTZ1knpmJ3/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005311 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:11:51.476601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 05:11:51.477308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 05:11:51.478110) ========= ========= Total master_lag: 0.19 =========