builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0109 starttime: 1467294843.89 results: success (0) buildid: 20160630050028 builduid: f3200c2a868646cbbc175544f57737c2 revision: 15bd559b68aa58d884ce155bba5f754ded2daec8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:03.890623) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:03.891084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:03.891366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:03.961431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 06:54:03.961817) ========= 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.r2eHyYMieu/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.0LNd81Kar9/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-06-30 06:54:03-- 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% 140M=0s 2016-06-30 06:54:04 (140 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103526 ========= master_lag: 1.74 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 06:54:05.801162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:05.801500) ========= 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.r2eHyYMieu/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.0LNd81Kar9/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.020881 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:05.843765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 06:54:05.844350) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 15bd559b68aa58d884ce155bba5f754ded2daec8 --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 15bd559b68aa58d884ce155bba5f754ded2daec8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r2eHyYMieu/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.0LNd81Kar9/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-06-30 06:54:05,922 truncating revision to first 12 chars 2016-06-30 06:54:05,922 Setting DEBUG logging. 2016-06-30 06:54:05,922 attempt 1/10 2016-06-30 06:54:05,922 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/15bd559b68aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 06:54:06,666 unpacking tar archive at: fx-team-15bd559b68aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 06:54:06.863790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:06.864127) ========= script_repo_revision: 15bd559b68aa58d884ce155bba5f754ded2daec8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:06.864559) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:06.864838) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 06:54:06.882668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-30 06:54:06.882993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.r2eHyYMieu/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.0LNd81Kar9/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:07 INFO - MultiFileLogger online at 20160630 06:54:07 in /builds/slave/test 06:54:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:54:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:07 INFO - {'append_to_log': False, 06:54:07 INFO - 'base_work_dir': '/builds/slave/test', 06:54:07 INFO - 'blob_upload_branch': 'Fx-Team', 06:54:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:07 INFO - 'branch': 'Fx-Team', 06:54:07 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:07 INFO - 'config_files': ('talos/mac_config.py',), 06:54:07 INFO - 'default_actions': ('clobber', 06:54:07 INFO - 'read-buildbot-config', 06:54:07 INFO - 'download-and-extract', 06:54:07 INFO - 'populate-webroot', 06:54:07 INFO - 'create-virtualenv', 06:54:07 INFO - 'install', 06:54:07 INFO - 'run-tests'), 06:54:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:07 INFO - 'download_minidump_stackwalk': True, 06:54:07 INFO - 'download_symbols': 'ondemand', 06:54:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:07 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:07 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:07 INFO - 'installer_path': 'installer.exe', 06:54:07 INFO - 'log_level': 'info', 06:54:07 INFO - 'log_name': 'talos', 06:54:07 INFO - 'log_to_console': True, 06:54:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:54:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:54:07 INFO - 'opt_config_files': (), 06:54:07 INFO - 'pip_index': False, 06:54:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:07 INFO - 'cmd': ('bash', 06:54:07 INFO - '-c', 06:54:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:07 INFO - 'enabled': True, 06:54:07 INFO - 'halt_on_failure': False, 06:54:07 INFO - 'name': 'check_screen_resolution'},), 06:54:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:07 INFO - 'cmd': ('bash', 06:54:07 INFO - '-c', 06:54:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:07 INFO - 'enabled': True, 06:54:07 INFO - 'halt_on_failure': False, 06:54:07 INFO - 'name': 'check_screen_resolution'},), 06:54:07 INFO - 'run_cmd_checks_enabled': True, 06:54:07 INFO - 'sps_profile': False, 06:54:07 INFO - 'sps_profile_interval': 0, 06:54:07 INFO - 'suite': 'dromaeojs', 06:54:07 INFO - 'system_bits': '32', 06:54:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:07 INFO - 'title': 't-yosemite-r7-0109', 06:54:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:07 INFO - 'use_talos_json': True, 06:54:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:07 INFO - 'work_dir': 'build'} 06:54:07 INFO - ##### 06:54:07 INFO - ##### Running clobber step. 06:54:07 INFO - ##### 06:54:07 INFO - Running pre-action listener: _resource_record_pre_action 06:54:07 INFO - Running main action method: clobber 06:54:07 INFO - rmtree: /builds/slave/test/build 06:54:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:08 INFO - Running post-action listener: _resource_record_post_action 06:54:08 INFO - ##### 06:54:08 INFO - ##### Finished clobber step (success) 06:54:08 INFO - ##### 06:54:08 INFO - ##### 06:54:08 INFO - ##### Running read-buildbot-config step. 06:54:08 INFO - ##### 06:54:08 INFO - Running pre-action listener: _resource_record_pre_action 06:54:08 INFO - Running main action method: read_buildbot_config 06:54:08 INFO - Using buildbot properties: 06:54:08 INFO - { 06:54:08 INFO - "project": "", 06:54:08 INFO - "product": "firefox", 06:54:08 INFO - "script_repo_revision": "production", 06:54:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:54:08 INFO - "repository": "", 06:54:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:54:08 INFO - "buildid": "20160630050028", 06:54:08 INFO - "pgo_build": "False", 06:54:08 INFO - "basedir": "/builds/slave/test", 06:54:08 INFO - "buildnumber": 831, 06:54:08 INFO - "slavename": "t-yosemite-r7-0109", 06:54:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:54:08 INFO - "platform": "yosemite_r7", 06:54:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:54:08 INFO - "branch": "fx-team", 06:54:08 INFO - "repo_path": "integration/fx-team", 06:54:08 INFO - "revision": "15bd559b68aa58d884ce155bba5f754ded2daec8", 06:54:08 INFO - "stage_platform": "macosx64", 06:54:08 INFO - "builduid": "f3200c2a868646cbbc175544f57737c2", 06:54:08 INFO - "slavebuilddir": "test" 06:54:08 INFO - } 06:54:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 06:54:08 INFO - Running post-action listener: _resource_record_post_action 06:54:08 INFO - ##### 06:54:08 INFO - ##### Finished read-buildbot-config step (success) 06:54:08 INFO - ##### 06:54:08 INFO - ##### 06:54:08 INFO - ##### Running download-and-extract step. 06:54:08 INFO - ##### 06:54:08 INFO - Running pre-action listener: _resource_record_pre_action 06:54:08 INFO - Running main action method: download_and_extract 06:54:08 INFO - mkdir: /builds/slave/test/build/tests 06:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:08 INFO - https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:54:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:54:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 06:54:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 06:54:09 INFO - Downloaded 1199 bytes. 06:54:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 06:54:09 INFO - Using the following test package requirements: 06:54:09 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:54:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 06:54:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 06:54:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'jsshell-mac.zip'], 06:54:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 06:54:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 06:54:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 06:54:09 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 06:54:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 06:54:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 06:54:09 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 06:54:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:54:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:09 INFO - https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:54:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:54:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:54:11 INFO - Downloaded 18788490 bytes. 06:54:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:54:14 INFO - Return code: 0 06:54:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:14 INFO - https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:54:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:54:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 06:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:54:15 INFO - Downloaded 18788490 bytes. 06:54:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:54:19 INFO - Return code: 0 06:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:19 INFO - https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 06:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:54:20 INFO - Downloaded 14405242 bytes. 06:54:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:54:20 INFO - Return code: 0 06:54:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:20 INFO - https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 06:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 06:54:25 INFO - Downloaded 112410529 bytes. 06:54:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:54:25 INFO - mkdir: /builds/slave/test/properties 06:54:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:25 INFO - Contents: 06:54:25 INFO - build_url:https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 06:54:27 INFO - Running post-action listener: _resource_record_post_action 06:54:27 INFO - Running post-action listener: set_extra_try_arguments 06:54:27 INFO - ##### 06:54:27 INFO - ##### Finished download-and-extract step (success) 06:54:27 INFO - ##### 06:54:27 INFO - ##### 06:54:27 INFO - ##### Running populate-webroot step. 06:54:27 INFO - ##### 06:54:27 INFO - Running pre-action listener: _resource_record_pre_action 06:54:27 INFO - Running main action method: populate_webroot 06:54:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:27 INFO - '--tppagecycles', 06:54:27 INFO - '7'], 06:54:27 INFO - 'tests': ['tsvgm']}}, 06:54:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:54:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:54:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['damp', 'tps']}, 06:54:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'tests': ['damp', 'tps']}, 06:54:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['dromaeo_dom']}, 06:54:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['basic_compositor_video']}, 06:54:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:54:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['a11yr', 06:54:27 INFO - 'ts_paint', 06:54:27 INFO - 'tpaint', 06:54:27 INFO - 'sessionrestore', 06:54:27 INFO - 'sessionrestore_no_auto_restore', 06:54:27 INFO - 'tabpaint']}, 06:54:27 INFO - 'other-e10s': {'tests': ['a11yr', 06:54:27 INFO - 'ts_paint', 06:54:27 INFO - 'tpaint', 06:54:27 INFO - 'sessionrestore', 06:54:27 INFO - 'sessionrestore_no_auto_restore', 06:54:27 INFO - 'tabpaint']}, 06:54:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:54:27 INFO - 'ts_paint', 06:54:27 INFO - 'tpaint', 06:54:27 INFO - 'sessionrestore', 06:54:27 INFO - 'sessionrestore_no_auto_restore', 06:54:27 INFO - 'tabpaint']}, 06:54:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:54:27 INFO - 'ts_paint', 06:54:27 INFO - 'tpaint', 06:54:27 INFO - 'sessionrestore', 06:54:27 INFO - 'sessionrestore_no_auto_restore', 06:54:27 INFO - 'tabpaint']}, 06:54:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['a11yr', 06:54:27 INFO - 'ts_paint', 06:54:27 INFO - 'tpaint', 06:54:27 INFO - 'sessionrestore', 06:54:27 INFO - 'sessionrestore_no_auto_restore', 06:54:27 INFO - 'tabpaint']}, 06:54:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['a11yr', 06:54:27 INFO - 'ts_paint', 06:54:27 INFO - 'tpaint', 06:54:27 INFO - 'sessionrestore', 06:54:27 INFO - 'sessionrestore_no_auto_restore', 06:54:27 INFO - 'tabpaint']}, 06:54:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['tsvgx', 06:54:27 INFO - 'tsvgr_opacity', 06:54:27 INFO - 'tart', 06:54:27 INFO - 'tscrollx', 06:54:27 INFO - 'cart']}, 06:54:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:54:27 INFO - 'tsvgr_opacity', 06:54:27 INFO - 'tart', 06:54:27 INFO - 'tscrollx', 06:54:27 INFO - 'cart']}, 06:54:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'talos_options': ['--disable-e10s'], 06:54:27 INFO - 'tests': ['tp5o']}, 06:54:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'tests': ['tp5o']}, 06:54:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'talos_options': ['--disable-e10s', 06:54:27 INFO - '--xperf_path', 06:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:27 INFO - 'tests': ['tp5n']}, 06:54:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:27 INFO - 'talos_options': ['--xperf_path', 06:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:27 INFO - 'tests': ['tp5n']}}, 06:54:27 INFO - 'talos.zip': {'path': '', 06:54:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:27 INFO - Running post-action listener: _resource_record_post_action 06:54:27 INFO - ##### 06:54:27 INFO - ##### Finished populate-webroot step (success) 06:54:27 INFO - ##### 06:54:27 INFO - ##### 06:54:27 INFO - ##### Running create-virtualenv step. 06:54:27 INFO - ##### 06:54:27 INFO - Running pre-action listener: _resource_record_pre_action 06:54:27 INFO - Running main action method: create_virtualenv 06:54:27 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:27 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 06:54:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:27 INFO - Using real prefix '/tools/python27' 06:54:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:28 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:30 INFO - Installing pip.................done. 06:54:30 INFO - Return code: 0 06:54:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:30 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:30 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 06:54:30 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 06:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:30 INFO - 'HOME': '/Users/cltbld', 06:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:30 INFO - 'LOGNAME': 'cltbld', 06:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:30 INFO - 'MOZ_NO_REMOTE': '1', 06:54:30 INFO - 'NO_EM_RESTART': '1', 06:54:30 INFO - 'PAGER': '/bin/cat', 06:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:30 INFO - 'PWD': '/builds/slave/test', 06:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:30 INFO - 'SHELL': '/bin/bash', 06:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:30 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:30 INFO - 'USER': 'cltbld', 06:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:30 INFO - 'XPC_FLAGS': '0x0', 06:54:30 INFO - 'XPC_SERVICE_NAME': '0', 06:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:31 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 06:54:31 INFO - Cleaning up... 06:54:31 INFO - Return code: 0 06:54:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:31 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:31 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 06:54:31 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 06:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:31 INFO - 'HOME': '/Users/cltbld', 06:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:31 INFO - 'LOGNAME': 'cltbld', 06:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:31 INFO - 'MOZ_NO_REMOTE': '1', 06:54:31 INFO - 'NO_EM_RESTART': '1', 06:54:31 INFO - 'PAGER': '/bin/cat', 06:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:31 INFO - 'PWD': '/builds/slave/test', 06:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:31 INFO - 'SHELL': '/bin/bash', 06:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:31 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:31 INFO - 'USER': 'cltbld', 06:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:31 INFO - 'XPC_FLAGS': '0x0', 06:54:31 INFO - 'XPC_SERVICE_NAME': '0', 06:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:31 INFO - Downloading/unpacking psutil>=3.1.1 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:33 INFO - Installing collected packages: psutil 06:54:33 INFO - Running setup.py install for psutil 06:54:34 INFO - building 'psutil._psutil_osx' extension 06:54:34 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 06:54:34 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 06:54:34 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 06:54:34 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 06:54:34 INFO - building 'psutil._psutil_posix' extension 06:54:34 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 06:54:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:54:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:54:34 INFO - ^ 06:54:34 INFO - 1 warning generated. 06:54:34 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 06:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:34 INFO - Successfully installed psutil 06:54:34 INFO - Cleaning up... 06:54:34 INFO - Return code: 0 06:54:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:34 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:34 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 06:54:34 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 06:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:34 INFO - 'HOME': '/Users/cltbld', 06:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:34 INFO - 'LOGNAME': 'cltbld', 06:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:34 INFO - 'MOZ_NO_REMOTE': '1', 06:54:34 INFO - 'NO_EM_RESTART': '1', 06:54:34 INFO - 'PAGER': '/bin/cat', 06:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:34 INFO - 'PWD': '/builds/slave/test', 06:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:34 INFO - 'SHELL': '/bin/bash', 06:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:34 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:34 INFO - 'USER': 'cltbld', 06:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:34 INFO - 'XPC_FLAGS': '0x0', 06:54:34 INFO - 'XPC_SERVICE_NAME': '0', 06:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:54:35 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 06:54:35 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 06:54:35 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 06:54:35 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 06:54:35 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 06:54:35 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 06:54:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:54:37 INFO - Installing collected packages: mozsystemmonitor 06:54:37 INFO - Running setup.py install for mozsystemmonitor 06:54:37 INFO - Successfully installed mozsystemmonitor 06:54:37 INFO - Cleaning up... 06:54:37 INFO - Return code: 0 06:54:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:54:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:37 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:37 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 06:54:37 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 06:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:37 INFO - 'HOME': '/Users/cltbld', 06:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:37 INFO - 'LOGNAME': 'cltbld', 06:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:37 INFO - 'MOZ_NO_REMOTE': '1', 06:54:37 INFO - 'NO_EM_RESTART': '1', 06:54:37 INFO - 'PAGER': '/bin/cat', 06:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:37 INFO - 'PWD': '/builds/slave/test', 06:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:37 INFO - 'SHELL': '/bin/bash', 06:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:37 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:37 INFO - 'USER': 'cltbld', 06:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:37 INFO - 'XPC_FLAGS': '0x0', 06:54:37 INFO - 'XPC_SERVICE_NAME': '0', 06:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:38 INFO - Downloading/unpacking jsonschema==2.5.1 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:38 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 06:54:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:54:40 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 06:54:40 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 06:54:40 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 06:54:40 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 06:54:40 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 06:54:40 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 06:54:40 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:40 INFO - warning: no files found matching '*.txt' 06:54:40 INFO - no previously-included directories found matching 'build' 06:54:40 INFO - no previously-included directories found matching 'dist' 06:54:40 INFO - no previously-included directories found matching '.git*' 06:54:40 INFO - Installing collected packages: jsonschema, functools32 06:54:41 INFO - Running setup.py install for functools32 06:54:41 INFO - warning: no files found matching '*.txt' 06:54:41 INFO - no previously-included directories found matching 'build' 06:54:41 INFO - no previously-included directories found matching 'dist' 06:54:41 INFO - no previously-included directories found matching '.git*' 06:54:41 INFO - Successfully installed jsonschema functools32 06:54:41 INFO - Cleaning up... 06:54:41 INFO - Return code: 0 06:54:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:41 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:41 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 06:54:41 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 06:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:41 INFO - 'HOME': '/Users/cltbld', 06:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:41 INFO - 'LOGNAME': 'cltbld', 06:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:41 INFO - 'MOZ_NO_REMOTE': '1', 06:54:41 INFO - 'NO_EM_RESTART': '1', 06:54:41 INFO - 'PAGER': '/bin/cat', 06:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:41 INFO - 'PWD': '/builds/slave/test', 06:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:41 INFO - 'SHELL': '/bin/bash', 06:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:41 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:41 INFO - 'USER': 'cltbld', 06:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:41 INFO - 'XPC_FLAGS': '0x0', 06:54:41 INFO - 'XPC_SERVICE_NAME': '0', 06:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:43 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:44 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 06:54:44 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 06:54:44 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 06:54:44 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 06:54:44 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 06:54:44 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 06:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:44 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 06:54:44 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 06:54:44 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 06:54:44 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 06:54:44 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 06:54:44 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 06:54:45 INFO - Downloading docopt-0.6.1.tar.gz 06:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:45 INFO - Running setup.py install for blobuploader 06:54:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:45 INFO - Running setup.py install for requests 06:54:45 INFO - Running setup.py install for docopt 06:54:46 INFO - Successfully installed blobuploader requests docopt 06:54:46 INFO - Cleaning up... 06:54:46 INFO - Return code: 0 06:54:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:46 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:46 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 06:54:46 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 06:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:46 INFO - 'HOME': '/Users/cltbld', 06:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:46 INFO - 'LOGNAME': 'cltbld', 06:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:46 INFO - 'MOZ_NO_REMOTE': '1', 06:54:46 INFO - 'NO_EM_RESTART': '1', 06:54:46 INFO - 'PAGER': '/bin/cat', 06:54:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:46 INFO - 'PWD': '/builds/slave/test', 06:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:46 INFO - 'SHELL': '/bin/bash', 06:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:46 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:46 INFO - 'USER': 'cltbld', 06:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:46 INFO - 'XPC_FLAGS': '0x0', 06:54:46 INFO - 'XPC_SERVICE_NAME': '0', 06:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Er8pXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Vwh9jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-iNSMVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-OqDAYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-gMmc2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-wxXbrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ywCcA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-NWqPXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-A3WfeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-rBzc_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-oGrQhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-cjtT1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-WLGxrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-nvmRYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-wZghFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-neWAW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-UK0wWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:48 INFO - Running setup.py install for manifestparser 06:54:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:54:48 INFO - Running setup.py install for mozcrash 06:54:48 INFO - Running setup.py install for mozdebug 06:54:48 INFO - Running setup.py install for mozdevice 06:54:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:54:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:54:48 INFO - Running setup.py install for mozfile 06:54:48 INFO - Running setup.py install for mozhttpd 06:54:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Running setup.py install for mozinfo 06:54:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Running setup.py install for mozInstall 06:54:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Running setup.py install for mozleak 06:54:49 INFO - Running setup.py install for mozlog 06:54:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Running setup.py install for moznetwork 06:54:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:54:49 INFO - Running setup.py install for mozprocess 06:54:49 INFO - Running setup.py install for mozprofile 06:54:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:54:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:54:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:54:50 INFO - Running setup.py install for mozrunner 06:54:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:54:50 INFO - Running setup.py install for mozscreenshot 06:54:50 INFO - Running setup.py install for moztest 06:54:50 INFO - Running setup.py install for mozversion 06:54:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:54:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:50 INFO - Cleaning up... 06:54:50 INFO - Return code: 0 06:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:50 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:50 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 06:54:50 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 06:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:50 INFO - 'HOME': '/Users/cltbld', 06:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:50 INFO - 'LOGNAME': 'cltbld', 06:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:50 INFO - 'MOZ_NO_REMOTE': '1', 06:54:50 INFO - 'NO_EM_RESTART': '1', 06:54:50 INFO - 'PAGER': '/bin/cat', 06:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:50 INFO - 'PWD': '/builds/slave/test', 06:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:50 INFO - 'SHELL': '/bin/bash', 06:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:50 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:50 INFO - 'USER': 'cltbld', 06:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:50 INFO - 'XPC_FLAGS': '0x0', 06:54:50 INFO - 'XPC_SERVICE_NAME': '0', 06:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-nDq9Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ncyH1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-TM8uED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-cAucMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-xdnHjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-DMOzlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-HCzZRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-rKuAku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-wHTv0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:51 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)) 06:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-RMsvQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-EDSBzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:52 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)) 06:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-c5hvWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Eh_UUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:52 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)) 06:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-VTAVpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Fwkbzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:52 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)) 06:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-j2ufO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:52 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)) 06:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-HviV80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:52 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)) 06:54:52 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)) 06:54:52 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)) 06:54:52 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)) 06:54:52 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)) 06:54:52 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)) 06:54:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:52 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 06:54:52 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 06:54:52 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 06:54:52 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 06:54:52 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 06:54:52 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 06:54:55 INFO - Downloading blessings-1.6.tar.gz 06:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:55 INFO - Installing collected packages: blessings 06:54:55 INFO - Running setup.py install for blessings 06:54:55 INFO - Successfully installed blessings 06:54:55 INFO - Cleaning up... 06:54:55 INFO - Return code: 0 06:54:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:55 INFO - Reading from file tmpfile_stdout 06:54:55 INFO - Current package versions: 06:54:55 INFO - blessings == 1.6 06:54:55 INFO - blobuploader == 1.2.4 06:54:55 INFO - docopt == 0.6.1 06:54:55 INFO - functools32 == 3.2.3-2 06:54:55 INFO - jsonschema == 2.5.1 06:54:55 INFO - manifestparser == 1.1 06:54:55 INFO - mozInstall == 1.12 06:54:55 INFO - mozcrash == 0.17 06:54:55 INFO - mozdebug == 0.1 06:54:55 INFO - mozdevice == 0.48 06:54:55 INFO - mozfile == 1.2 06:54:55 INFO - mozhttpd == 0.7 06:54:55 INFO - mozinfo == 0.9 06:54:55 INFO - mozleak == 0.1 06:54:55 INFO - mozlog == 3.2 06:54:55 INFO - moznetwork == 0.27 06:54:55 INFO - mozprocess == 0.22 06:54:55 INFO - mozprofile == 0.28 06:54:55 INFO - mozrunner == 6.11 06:54:55 INFO - mozscreenshot == 0.1 06:54:55 INFO - mozsystemmonitor == 0.3 06:54:55 INFO - moztest == 0.7 06:54:55 INFO - mozversion == 1.4 06:54:55 INFO - psutil == 3.1.1 06:54:55 INFO - requests == 1.2.3 06:54:55 INFO - wsgiref == 0.1.2 06:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:55 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 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:55 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 06:54:55 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 06:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:55 INFO - 'HOME': '/Users/cltbld', 06:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:55 INFO - 'LOGNAME': 'cltbld', 06:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:55 INFO - 'MOZ_NO_REMOTE': '1', 06:54:55 INFO - 'NO_EM_RESTART': '1', 06:54:55 INFO - 'PAGER': '/bin/cat', 06:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:55 INFO - 'PWD': '/builds/slave/test', 06:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:55 INFO - 'SHELL': '/bin/bash', 06:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:55 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:55 INFO - 'USER': 'cltbld', 06:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:55 INFO - 'XPC_FLAGS': '0x0', 06:54:55 INFO - 'XPC_SERVICE_NAME': '0', 06:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 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)) 06:54:56 INFO - Cleaning up... 06:54:56 INFO - Return code: 0 06:54:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107dd2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2b2ceef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, '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.r2eHyYMieu/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.0LNd81Kar9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 06:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:56 INFO - 'HOME': '/Users/cltbld', 06:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:56 INFO - 'LOGNAME': 'cltbld', 06:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:56 INFO - 'MOZ_NO_REMOTE': '1', 06:54:56 INFO - 'NO_EM_RESTART': '1', 06:54:56 INFO - 'PAGER': '/bin/cat', 06:54:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:56 INFO - 'PWD': '/builds/slave/test', 06:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:56 INFO - 'SHELL': '/bin/bash', 06:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:54:56 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:56 INFO - 'USER': 'cltbld', 06:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:56 INFO - 'XPC_FLAGS': '0x0', 06:54:56 INFO - 'XPC_SERVICE_NAME': '0', 06:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:54:56 INFO - Cleaning up... 06:54:56 INFO - Return code: 0 06:54:56 INFO - Running post-action listener: _resource_record_post_action 06:54:56 INFO - Running post-action listener: _start_resource_monitoring 06:54:56 INFO - Starting resource monitoring. 06:54:56 INFO - ##### 06:54:56 INFO - ##### Finished create-virtualenv step (success) 06:54:56 INFO - ##### 06:54:56 INFO - ##### 06:54:56 INFO - ##### Running install step. 06:54:56 INFO - ##### 06:54:56 INFO - Running pre-action listener: _resource_record_pre_action 06:54:56 INFO - Running main action method: install 06:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:56 INFO - Reading from file tmpfile_stdout 06:54:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:54:56 INFO - Reading from file tmpfile_stdout 06:54:56 INFO - Output received: 06:54:56 INFO - Usage: mozinstall [options] installer 06:54:56 INFO - Options: 06:54:56 INFO - -h, --help show this help message and exit 06:54:56 INFO - -d DEST, --destination=DEST 06:54:56 INFO - Directory to install application into. [default: 06:54:56 INFO - "/builds/slave/test"] 06:54:56 INFO - --app=APP Application being installed. [default: firefox] 06:54:56 INFO - mkdir: /builds/slave/test/build/application 06:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:55:31 INFO - Reading from file tmpfile_stdout 06:55:31 INFO - Output received: 06:55:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:55:31 INFO - Running post-action listener: _resource_record_post_action 06:55:31 INFO - ##### 06:55:31 INFO - ##### Finished install step (success) 06:55:31 INFO - ##### 06:55:31 INFO - ##### 06:55:31 INFO - ##### Running run-tests step. 06:55:31 INFO - ##### 06:55:31 INFO - Running pre-action listener: _resource_record_pre_action 06:55:31 INFO - Running main action method: run_tests 06:55:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:55:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:55:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:55:31 INFO - 2016-06-30 06:55:31.399 screenresolution[1919:13271] starting screenresolution argv=screenresolution get 06:55:31 INFO - 2016-06-30 06:55:31.402 screenresolution[1919:13271] Display 0: 1600x1200x32@60 06:55:31 INFO - 2016-06-30 06:55:31.408 screenresolution[1920:13273] starting screenresolution argv=screenresolution list 06:55:31 INFO - Available Modes on Display 0 06:55:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:55:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:55:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:55:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:55:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:55:31 INFO - Intel Iris: 06:55:31 INFO - Chipset Model: Intel Iris 06:55:31 INFO - Type: GPU 06:55:31 INFO - Bus: Built-In 06:55:31 INFO - VRAM (Dynamic, Max): 1536 MB 06:55:31 INFO - Vendor: Intel (0x8086) 06:55:31 INFO - Device ID: 0x0a2e 06:55:31 INFO - Revision ID: 0x0009 06:55:31 INFO - Displays: 06:55:31 INFO - Display: 06:55:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:55:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:55:31 INFO - Display Serial Number: 1600x1200 60 06:55:31 INFO - Main Display: Yes 06:55:31 INFO - Mirror: Off 06:55:31 INFO - Online: Yes 06:55:31 INFO - Rotation: Supported 06:55:31 INFO - Return code: 0 06:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:55:31 INFO - Python 2.7.3 06:55:31 INFO - Return code: 0 06:55:31 INFO - grabbing minidump binary from tooltool 06:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:31 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 0x107d36d30>, '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 0x107a9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d2eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:55:31 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 06:55:31 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 06:55:31 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 06:55:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:31 INFO - Return code: 0 06:55:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:55:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:55:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:55:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:55:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:55:31 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:55:31 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0109 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r2eHyYMieu/Render', 06:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:31 INFO - 'HOME': '/Users/cltbld', 06:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:31 INFO - 'LOGNAME': 'cltbld', 06:55:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:31 INFO - 'MOZ_NO_REMOTE': '1', 06:55:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:31 INFO - 'NO_EM_RESTART': '1', 06:55:31 INFO - 'PAGER': '/bin/cat', 06:55:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:31 INFO - 'PWD': '/builds/slave/test', 06:55:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:31 INFO - 'SHELL': '/bin/bash', 06:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0LNd81Kar9/Listeners', 06:55:31 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 06:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:31 INFO - 'USER': 'cltbld', 06:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:31 INFO - 'XPC_FLAGS': '0x0', 06:55:31 INFO - 'XPC_SERVICE_NAME': '0', 06:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:55:31 INFO - mozversion application_buildid: 20160630050028 06:55:31 INFO - mozversion application_changeset: 15bd559b68aa58d884ce155bba5f754ded2daec8 06:55:31 INFO - mozversion application_display_name: Nightly 06:55:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:31 INFO - mozversion application_name: Firefox 06:55:31 INFO - mozversion application_remotingname: firefox 06:55:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:55:31 INFO - mozversion application_vendor: Mozilla 06:55:31 INFO - mozversion application_version: 50.0a1 06:55:31 INFO - mozversion platform_buildid: 20160630050028 06:55:31 INFO - mozversion platform_changeset: 15bd559b68aa58d884ce155bba5f754ded2daec8 06:55:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:55:31 INFO - mozversion platform_version: 50.0a1 06:55:31 INFO - using testdate: 1467294931 06:55:31 INFO - actual date: 1467294931 06:55:31 INFO - starting webserver on 'localhost:50904' 06:55:31 INFO - SUITE-START | Running 2 tests 06:55:31 INFO - TEST-START | dromaeo_css 06:55:31 INFO - operating with platform_type : mac_ 06:55:31 INFO - Initialising browser for dromaeo_css test... 06:55:32 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmp6l22cY/profile http://localhost:50904/getInfo.html) 06:55:34 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 06:55:34 INFO - PROCESS | 1930 | colorDepth:24 06:55:34 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 06:55:34 INFO - PROCESS | 1930 | __metrics 06:55:34 INFO - PROCESS | 1930 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:55:34 INFO - PROCESS | 1930 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:35 INFO - TEST-INFO | 1930: exit 0 06:55:35 INFO - Browser initialized. 06:55:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:35 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmp6l22cY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:46 INFO - PROCESS | 1932 | RSS: Main: 243752960 06:55:46 INFO - PROCESS | 1932 | 06:56:38 INFO - PROCESS | 1932 | 1467294998375 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] 06:58:48 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:50904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50904/tests/dromaeo/cssquery-ext.html) 06:58:49 INFO - PROCESS | 1932 | RSS: Main: 339673088 06:58:49 INFO - PROCESS | 1932 | 07:01:52 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:50904/tests/dromaeo/cssquery-ext.html (next: http://localhost:50904/tests/dromaeo/cssquery-jquery.html) 07:01:53 INFO - PROCESS | 1932 | RSS: Main: 380399616 07:01:53 INFO - PROCESS | 1932 | 07:04:55 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:50904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50904/tests/dromaeo/cssquery-mootools.html) 07:04:56 INFO - PROCESS | 1932 | RSS: Main: 371298304 07:04:56 INFO - PROCESS | 1932 | 07:07:58 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:50904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50904/tests/dromaeo/cssquery-prototype.html) 07:07:59 INFO - PROCESS | 1932 | RSS: Main: 372133888 07:07:59 INFO - PROCESS | 1932 | 07:11:02 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:50904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50904/tests/dromaeo/cssquery-yui.html) 07:11:03 INFO - PROCESS | 1932 | RSS: Main: 343015424 07:11:03 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:50904/tests/dromaeo/cssquery-yui.html (next: http://localhost:50904/tests/dromaeo/cssquery-dojo.html) 07:14:06 INFO - PROCESS | 1932 | RSS: Main: 458256384 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | __start_tp_report 07:14:06 INFO - PROCESS | 1932 | _x_x_mozilla_page_load 07:14:06 INFO - PROCESS | 1932 | _x_x_mozilla_page_load_details 07:14:06 INFO - PROCESS | 1932 | |i|pagename|runs| 07:14:06 INFO - PROCESS | 1932 | |0;dojo.html;3236.70869621734;3284.950725739114;3296.0276718368086;3308;3316.4693649016162;5487.972560137204;5568.916466252999;5574.581906357019;5592.217089607453;5614.915776263354;5564.527015203703;5584.329880414346;5669;5702.572307076975;5714.114312281593;5056.19100943849;5063.367079115111;5124.692518448905;5133.948660513403;5291.259223708684;5200.635955483118;5230.1108811501945;5248.5276325130735;5257.789688412459;5263.578913686915;5040.1179793535985;5101.413337466165;5112.974435127838;5122.513361230677;5182.015417070764;5107.438181800037;5110.233464980245;5120;5126.410462796752;5149.124648809711;5131.999260144274;5135.717535535544;5142.1772516397195;5169.819056333048;5217.765200565984;5468.589855760833;5538.307711536058;5638;5696.3449203341315;5744.195812586241;6096.927044804744;6166.506679465677;6180.3201647818705;6191.349908259658;6205.317415084337;5148.279240906276;6246.6252024878195;6250.281217659982;6251.593646412968;6254.030625253047;5560.304961879765;5650.971745141248;5718.999175144333;5747.741351639186;5792.8841423171725;6299.716512756937;6322.209723784527;6322.462590679752;6322.988321868479;6327.4938004959495;6065.559880582722;6066.98736501729;6068.162513101474;6079.211861876839;6085.0428907197565;6028.57799953999;6063.999440092423;6130.754769809158;6152.230971128609;6212.627242365473;6103.974138059404;6120.355709576858;6123.4351415035735;6127.097902969301;6135.416406698409;6147.754089836357;6150.200473938359;6161.969190154021;6190.0405437157315;6191.318954914956;4317.762523061199;4874.171390863562;4888.926666100011;4916.852494425173;4978.477259887732;3822.3884178531857;4314.69797114199;4462.062966777014;4464.241079016575;4464.352668862996;4696.459907110658;5539.667619942817;5572.136318870582;5581.386047534768;5590.692511911802;6239.313675495692;6254.499640028786;6255.218097737783;6256.374362563798;6278.497720182374;5577.944220557823;5592.412796656293;5608.579356548194;5624.578156638268;5629.549636029108;4455.866324010285;5236.371635403776;5299.867503312371;5338.332708411449;5360.437154098841;5289.550388217045;6251.3123556408755;6262.2172228471445;6262.68686565679;6302.401271879165;6167.198264225622;6183.598066125687;6185.195924529782;6206.689665516616;6206.906896396648;6169.876602468015;6189;6250.718717657625;6268.529860260407;6288.905666414916;6097.939020609737;6103.298120716175;6121.84695382619;6122.051082082285;6152.600080994721;6157.0456579230295;6211.844703882439;6215.9378406217165;6216.564840461125;6241.407066328873;5622.690752008515;5952.404759524186;6010.7295171716505;6052.364501727431;6055.697215139137;5984.730687119177;6022.156898034191;6026.879462410815;6036.426539478743;6046.395360464095;5578.386377498391;5873.4126587342635;5908;5918.17145599625;5951.970240148771;5926.111083337534;5986.850328741816;6002.879942401215;6033.849153771191;6040.728167232397;5856.707164641836;5867.6772777497645;5883.2057672213705;5890.175375447355;5899.46904778572 07:14:06 INFO - PROCESS | 1932 | |1;ext.html;460.1693942433906;466.63136122463254;523.471293993067;524.5488879563577;524.6878107526023;39254.803725981365;40173.39739903904;40275.993100172476;40421.38314467421;43099.35350969738;40336.59663403365;40785.38821917666;40836.79581602095;40901.18197636046;40916.181676366454;9597.280203984712;9759.853602195974;9768.609255629766;9794.90205097947;9801.607935682565;9617.37487063342;9718.125368716814;9726.854097188549;9730.172935300472;9731.95134024329;9713.562889669947;9726.805463890752;9728.75678108046;9751.707448776548;9753.414795112316;9671.5647795849;9715.417074975525;9728.319017668766;9728.75678108046;9734.977827328099;9536.952315238379;9610.615575376976;9615.086566776145;9630.855537166948;9639.3734407264;39089;39159.804200979095;39205.80397098025;39262.411063834064;39547.406788897904;3397.6432474590306;3429.794212347242;3449.2411669432936;3506.211102501942;3665.1753355495066;30024.399512009855;31259.531107033414;31516.896908608087;31544.684553154406;31727.841360793278;3297.4229509835923;3345.080102971678;3354.865805367807;3407.505911642823;3435.124043368925;398007;437907;439010;439705;441137.7943110264;49407.50592494101;49809;54486.45513544814;54742.452575474534;56822.71588642113;57660.42339576551;60852.087218691755;61073.08390374148;61136.69431652902;61217.38782612117;15729.134897580743;15881.841181588035;15905.363785448684;15931.601709957344;15940.68118637644;11008.174386920853;12106.878931210575;12277.69305767363;12350.505979760888;12395.132340736061;15513.224338783015;15570.455034073753;15572.92213538925;15655.530334089995;15785.921070394805;5383.973080134652;5491.945080549143;6296.622202667763;6377.565047864194;6410.262819775786;866.7789713622985;937.2782957122977;984.7341217871278;994.9751256218652;1079.5142186016324;26508.46983060328;27932.58101128444;30122.849385752932;30791.30647814347;30972.845135774176;932.9720108396759;1040.490159821697;1045.7908418316367;1136.193302755053;1146.4611632532697;15796.447124350823;15899;15902.602434938988;16067.955582887074;16079.437219697254;612955;617267;623656;624216;625362;58357.8328433429;58431.70784146052;58453;58504.41495585075;58536;1248.2572869142846;1369.4795977528474;1396.190209678384;1404.0242031788014;1416.7662335714904;29875.253118672208;30861.537076944314;31202.531962020134;32243.677563224068;32297.838510807294;52260.34177607531;53595.732021339645;56846.43153568411;56859.14711279417;57509.712451437474;527139;529241.3537932286;529365;529519;529802;18374.540636484195;22878.656820148044;23394.415139621644;25861.353466162745;26373.07694230693;47493.76253118712;48063;48616.75691621519;49081.50918490769;49179;34795.65204347924;38379;39558.604413956644;39745.40381894332;40858.591414086666;38889.22221555497;39823;40158;40522.59477405306;40551.59448405478;38143.61856381401;38207;38775.61224387833;38924.6107538921;38931.61068389393;32528.674713252563;34513.48229776606;35152.82423587866;35233.647663523036;35356.11609709778;21010.789892100882;25319.113831016562;25350.619740704275;25621.01910828055;26005.739942600332 07:14:06 INFO - PROCESS | 1932 | |2;jquery.html;313.62051917180213;336.3395541268565;388.3785942492013;396.04750574867455;397.8567715622377;20419.979001049946;20432.387028389152;20763.584728305425;21760.673589896163;21785;20520.692189617166;21052.89473552634;21335.786642133575;21348.8932555337;21462.678059829115;5165.586753059746;5497.230387745719;6038.215032045828;6041.365656606059;6046.516278697715;5927.466528012478;5967.343592204854;6009.699515024253;6018.428249316308;6042.063480160582;5708.373113662607;5931.970340148293;5932.851678708023;5938.0499120140785;5971.731272092745;5615.6630602164005;5876.0598304271325;5967.671778052206;5970.1940238067955;5980.671063091529;5105.310783044279;5126.794928202868;5141.0232055909255;5141.408737995141;5145.9485405146215;26295.605565916525;26467.205983820517;26500.07249746269;26874.86562567194;26919.654017299254;2418.8548687078833;2440.9389765255833;2553.8084643651614;2819.943601127966;3127.8279694616785;13109.737805243842;15691.980021298694;15889.126098064602;15917.52247432579;16638.417655382123;1862.3947217154343;1898.686716691758;1910.570121722615;1931.7005864091088;1996.391100714296;86616;94721.52639236828;110803.78392432186;118532;124521;9447.196988255937;10614.150867930546;11106.056440122946;11114.388708620942;11263.26788758728;12214.938925305494;12706;12778;13801.516946907012;13830.515931942535;8434.409591328671;8541.103184165697;8555.058943516333;8624.741257762276;8627.352948528885;8517.44636598619;8521.914780852112;8529.061803201643;8633;8651;6609.339066093352;6684.364985326386;6698.39714425704;6726.159230096238;6736.292689267654;1643.5808868738634;1853.2031226572703;1861.6276744650854;1899.9620007599772;1909.2458478900755;822.2928281677753;922.686286662538;953.4422362917771;1003.7239759066169;1006.7986402719486;21873.12507499682;22778.31665050051;22858.314250572177;22937.426564336027;22975.42561435944;825.781167990483;984.1339621133357;1054.9789004219872;1098.368438148068;1098.555085190499;9222.354435189607;11044.723881902855;11683.591074312359;11698.766024679458;11789.705257368463;589149;594475;598397;608186;608550;83838;97650.5117474408;118668.40665796789;119764.4011779953;121158;867.9956600216958;982.6511588386163;998.2263745597076;1000.5397517142051;1021.2289721260549;18543.536411589277;19387.12757925925;19442.513937151685;19789.901050494656;19844.603107937473;35653.64346356607;44147.77926110349;52845.150419735124;57020.429795701515;59619.70190149022;81066.5946670263;84347;84862.57568712116;85125.57437212774;85814;6728.629925354153;8245.340372770044;8380.664773408995;8461.32309415233;8563.186497282748;12623.747525049264;13504.527341542998;13682.179069255877;13702.794458082937;13816.309184540532;10621.884702106168;11353.54585816558;11680.70798230051;11771.470283837076;11829.940850295694;9488.667896623585;11442.599509017144;11525.942370288094;11737.35444550558;11754.941225293818;11618.360990145624;11734.530618775494;11740.941295293469;11972.221805582609;12015.639530814089;7173.820654483679;7486.176520582841;7538.246175382418;7799.805004874924;8581.2705919995;10335;11565.710857228636;11772.705682357668;11827.172097953406;11843.407829608657 07:14:06 INFO - PROCESS | 1932 | |3;mootools.html;1503.1882783297017;1532.923353832308;1728.3259528783776;1882.8305452509271;1909.4939840942152;8482.575871206438;8742.694005709802;8922.42004269722;8954.955225223865;8961.417507861992;7816.648250828712;8112.553809540473;8512.574371281442;8761.123887611237;8780.824383512327;2377.976220237793;2407.5425669122897;2408.8313818032743;2413.1433341163897;2421.249412682065;2386.606209975361;2392.3301475586863;2418.141559746291;2420.4674971506242;2427;2113.9154433822628;2196.077647388101;2319.9884000579973;2398.724146723123;2401.495685905953;2380.190735150057;2384.415818124562;2406.4224586099385;2406.6871306730186;2410.349205714465;2392.676988606533;2400.4838959623767;2402.639604059405;2403.3871362802547;2405.9759402405925;8845.071267516882;8895.555222238927;8906.51014194219;8908.331875109328;8910.55447227636;5253.52718255355;5334.653247538937;5400.162974738922;5401.108817045183;5407.945920540784;3445.207602251471;3477.51314815926;3603.585587657427;3606;3606.6032736398975;1037.1547189040907;1055.773008803111;1063.0910571461366;1075.2634445404922;1079.373963101407;11615.419229038514;11631.360275184861;11631.418429078596;11650.533978640844;11674;3810.7904065276675;4620.815167393266;4825.806967721322;4831.106245344622;4848.515148485194;9941.751456213507;9949.701508954742;9958.253131015203;9960.302778805559;9969.35199212049;5377.220303056113;5384.111621582473;5391.406945236021;5391.865203369947;5395.05586522357;4753.239481682983;4929.482404347564;4948.455669876311;4952.455229924705;4967.05625931072;3805.1058001369656;3806.6193380662266;3843.5195600549932;3873.845046198177;3890.280298144852;1096.2052511928787;1159.368144361325;1164.0978241862456;1170.5076028064286;1172.8123500239922;717.5981450387695;808.3129340060901;901.1259078693656;918.0727465260136;922.3128769066954;5884.499817515559;5953.047512397996;6007.969960150259;6022.638641681426;6172.259328880563;876.7106854737921;897.4077109107957;901.4906577783531;968.9031096890254;1003.1673710820002;3522.5068440552463;3902.2195560887935;4048.8785336439955;4051.355489596606;4056.716029877939;10745.623903163509;11068.723281918017;11084;11098.001179893849;11110.555577776799;8888.666699994923;9600.855987160197;9968.651097211708;10383.740406489747;10700.143988480902;8011.759647210476;8244.8351032979;8289.875651865348;8333.16668333174;8339.457935234312;5984.19213406202;6035.426634469718;6190.50475961931;6205.379462053758;6361.968190159205;9623.5669394876;9806;10128.189744820544;10129.696109116738;10198.847017294895;9916.603335866484;10098.444585547866;10236.744081397726;10265.384076955406;10450.372977621368;8096.51420914747;8412.495250285003;8449.197326253996;8530.232279094911;8559.61481733336;6700.698468569024;8381.371397145116;8527.062023177321;8576.313894888519;8578.056413794602;7551.207123252199;7634.847303054019;7644.235576442311;7658.770236892902;7681.078270607562;7417.962910185414;7498.887516687363;7499.137599175946;7532.962335188289;7594.6202689866395;6934.16789985205;7095.8935615964765;7155.3202445767565;7158.570485770871;7158.785236442915;4829.7585120743115;4833.299171620025;4835.492273311393;4908.779104940215;4929.926051109164;4988.700677959334;5003.999200159909;5031.572316353151;5103.617228707788;5108.412532558803 07:14:06 INFO - PROCESS | 1932 | |4;prototype.html;298.741588525925;306.4086313415108;309.7583884570036;315.2434158020748;315.2685769015881;5108.948910510894;5466.753996070176;5473.2063850741615;5483.835484935454;5503.3395992480855;4940.6047516198705;5369.355677318717;5386.622936394454;5431.511163995239;5470.097433923398;3888.5139357580374;3945.3884647879627;4059.269331520325;4125.7524548527035;4140.654287356621;4043.514778226602;4094.1811637672436;4119.958800411988;4121.464209652741;4169.894977830877;3667.9826095647422;3903.4144878268344;4073.816678249486;4117;4149.3775933609895;3351.413502637041;3455.8272086395577;3892.727509074366;4009.558948515661;4140.710150289481;3092.70619291167;3409.028426898322;3505.526753888218;3523.9295214095832;3551.7158627309755;5166.5458907018865;5187.3775146982225;5194.220866869962;5229.660072095339;5280.072773437668;4493.9101217975785;4662.111844702901;4696.013837094214;4701.459332176809;4710.24636058229;5075.619328550337;5520.8406234690765;5678.261825962599;5712.542996560265;5725.713714314267;3619.511365965587;3930.0567863712504;3941.8029098545244;3943.881683549498;3949.447077409165;5060.620453466005;5700.515456186229;5718.59969802114;5955.106733989936;6044.607100538451;3331.9504356128227;3507.1582820122985;3883.9026925459934;4006.5560008394855;4052.4731784867777;3577.624349443323;3997.700172487075;4072.144849581621;4102;4113.609207125318;3907.6092390761264;4309.892252693708;4728.432588089451;4747.95252047482;4759.6430267729365;5484.8354549363585;5713.428657134254;5734.419511219968;5747.425257474303;5766.327764948118;1154.8509233312739;1178.3460179600404;1303.2571434282368;1402.6212922510865;1403.4596680278166;804.937482523064;811.8376324735077;851.7742798158492;863.7840539865034;868.9398933301362;4373.846915357947;4850.563449289581;5203.297554830049;5215.530602245816;5225.712585807741;4557.814968108316;5138.6659867109265;5657.971710141505;5724.79963201286;5821.79623713168;4455.777211139495;5060.696358218519;5340.465953404629;5352.652077614943;5390.568754499709;3027.2129246396094;3035;3052.679468655759;3053.5495639571027;3099.9845000775304;5100.923486147711;5305.628605997543;5848.800995795852;5945.918928375034;6065.75736970525;5282.418933917266;5657;5968.731407086691;6025.427584379565;6085.57400981927;5959;5995.830812991512;5997.6401415914315;6043.909341359971;6077.878442431127;5616.494515493625;5623.537880151272;5643.971780141073;5849.853753656193;5853.531717462678;4934.925976110433;5080.49195080489;5275.551578115903;5715.714214289352;5726.856828579319;5055.545000949932;5413.70224637633;5928.555358348055;6018.21763170785;6067;3672.6510981456718;3704.8888533344043;3922.3528117860233;3938.783366914847;3974.2250261198787;5677.801276955287;5736.483716465538;5748.464694212946;5767.596268261349;5779.624324418899;5626.2685850839125;5709.885802284014;5720.799772007959;5741.569382296261;5742.655440673573;4622.867397487637;4847.739587707151;5024.246363045572;5254.605904557097;5675.687837168995;5125.231795030709;5293.338332708411;5515.393306736176;5676.290463692038;5684.9301377255815;5271.68369897792;5552.750126244248;5604.971975140098;5742.253507044057;5764.654120752768;5153.819616313411;5658.20785090096;5670;5687.919295333873;5697.715114244188 07:14:06 INFO - PROCESS | 1932 | |5;yui.html;707.19026714412;717.2827172827173;734.3354264390725;779.6920216514475;794.8807678848168;15065.472708455207;15535;15944.282507287156;15945.920270398647;16605.252763625635;14858.55424337269;15040.924795376035;15068.246587670628;15074.246287685626;15076;686.9381755641991;710.4671496377716;810.7284059839945;819.4796304346753;853.7609469348562;852.8592782190931;854.8247609240121;857.2584714222185;857.6655104509247;857.6826574167567;909.7134402663173;911.239115338693;912.2018234045211;913.9900410046902;914.5427286356821;703.4829400390709;738.3613174603929;740.4853626729425;740.7481456304882;907.7095329494564;641.3682522715122;675.4495086504533;678.6979793991676;682.1405029662661;682.2461180395641;15050;15059.698806023818;15067.773983390258;15132.470363537333;15152.242387880671;13867.098638588459;14060.578182654435;14089.436422543085;14117;14310;12613.621591352274;12756.170848894884;12781.488740450372;12833.736207555583;12885.484580616763;4455.754933478657;4528.909421811578;4536.954630453719;4576.588107070346;4740.241561350202;112520.9758616238;114507;114757.85242147555;114860.27709584363;116654;11044.723881902855;11155.442227888572;11200.159988000933;11240.269382490113;11687.123465740104;22093.779062209494;22104.557908841733;22134.88932555359;22143.778562214495;22176;7586.764324345904;7860.096088949729;7900.367970562341;7949.920500795034;8183.549904755296;4412.84555040572;4466.821327146878;4470.6423486121685;4479.708818926824;4508.07584445188;3473.426884564069;3585.229175727179;3589.2283159120916;3590.0665826885197;3591.892243232707;639.7568923809016;646.6088016749893;647.9578827376206;663.2273401487213;671.4997326991422;601.4286427893519;605.3704147686357;623.6164758673383;631.4979591224987;643.2217017408894;7808.492447990862;8600.225979661735;8670.566471676391;8898.4660920345;9189.805325307667;564.7261078376984;570.164708701754;624.8545554471821;634.8317695810522;639.4181295021508;4159.230542349675;4241.34259189826;4372.3878656988045;4413.029133590605;4454;91963.54018229866;124632;128338.35830820785;129327.35336323259;148627.51372486353;119965;122098;128720.35639821741;129297.70702292856;135080;109204.4539777296;112017;116121.41939290249;116897.41551292359;117553.5515209429;8508.659653613786;8554.230119289294;8559.828803423772;8574.208859188384;8847.071057539124;61820.69089654703;63924;64171.35828641654;65688;66495.66752166208;94695.5265223697;97939.51030244803;98230;99183;101809;11637.709057273636;11675.649730508097;11677.649670509898;11803.350815704875;12286.447109880255;12224;12778;12797.680057998252;12840.101192916407;12914.612561623166;11784;11859.34773587461;11877.703057423634;12010.219335743148;12274.631761047183;11486.425678716198;12019.879801202225;12043.81934270969;12138.271703697807;12157.966572841407;11611.303321800719;11640.243384180001;12042.518299267931;12152.453139608562;12250.693732656398;8406.537640429591;9329.486878221764;9360.672376466791;9923.65267215644;9977.501124943868;9086.141012512748;9308.860367094634;9370.812583748424;9408.529573521433;9989.500524973577 07:14:06 INFO - PROCESS | 1932 | __end_tp_report 07:14:06 INFO - PROCESS | 1932 | __start_cc_report 07:14:06 INFO - PROCESS | 1932 | _x_x_mozilla_cycle_collect,1202 07:14:06 INFO - PROCESS | 1932 | __end_cc_report 07:14:06 INFO - PROCESS | 1932 | __startTimestamp1467296046920__endTimestamp 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | ------- Summary: start ------- 07:14:06 INFO - PROCESS | 1932 | Number of tests: 6 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | [#0] dojo.html Cycles:165 Average:5654.23 Median:5883.21 stddev:662.43 (11.3%) stddev-sans-first:636.73 07:14:06 INFO - PROCESS | 1932 | Values: 3236.7 3285.0 3296.0 3308.0 3316.5 5488.0 5568.9 5574.6 5592.2 5614.9 5564.5 5584.3 5669.0 5702.6 5714.1 5056.2 5063.4 5124.7 5133.9 5291.3 5200.6 5230.1 5248.5 5257.8 5263.6 5040.1 5101.4 5113.0 5122.5 5182.0 5107.4 5110.2 5120.0 5126.4 5149.1 5132.0 5135.7 5142.2 5169.8 5217.8 5468.6 5538.3 5638.0 5696.3 5744.2 6096.9 6166.5 6180.3 6191.3 6205.3 5148.3 6246.6 6250.3 6251.6 6254.0 5560.3 5651.0 5719.0 5747.7 5792.9 6299.7 6322.2 6322.5 6323.0 6327.5 6065.6 6067.0 6068.2 6079.2 6085.0 6028.6 6064.0 6130.8 6152.2 6212.6 6104.0 6120.4 6123.4 6127.1 6135.4 6147.8 6150.2 6162.0 6190.0 6191.3 4317.8 4874.2 4888.9 4916.9 4978.5 3822.4 4314.7 4462.1 4464.2 4464.4 4696.5 5539.7 5572.1 5581.4 5590.7 6239.3 6254.5 6255.2 6256.4 6278.5 5577.9 5592.4 5608.6 5624.6 5629.5 4455.9 5236.4 5299.9 5338.3 5360.4 5289.6 6251.3 6262.2 6262.7 6302.4 6167.2 6183.6 6185.2 6206.7 6206.9 6169.9 6189.0 6250.7 6268.5 6288.9 6097.9 6103.3 6121.8 6122.1 6152.6 6157.0 6211.8 6215.9 6216.6 6241.4 5622.7 5952.4 6010.7 6052.4 6055.7 5984.7 6022.2 6026.9 6036.4 6046.4 5578.4 5873.4 5908.0 5918.2 5952.0 5926.1 5986.9 6002.9 6033.8 6040.7 5856.7 5867.7 5883.2 5890.2 5899.5 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | [#1] ext.html Cycles:180 Average:66490.68 Median:40306.29 stddev:142161.56 (352.7%) stddev-sans-first:142473.91 07:14:06 INFO - PROCESS | 1932 | Values: 460.2 466.6 523.5 524.5 524.7 39254.8 40173.4 40276.0 40421.4 43099.4 40336.6 40785.4 40836.8 40901.2 40916.2 9597.3 9759.9 9768.6 9794.9 9801.6 9617.4 9718.1 9726.9 9730.2 9732.0 9713.6 9726.8 9728.8 9751.7 9753.4 9671.6 9715.4 9728.3 9728.8 9735.0 9537.0 9610.6 9615.1 9630.9 9639.4 39089.0 39159.8 39205.8 39262.4 39547.4 3397.6 3429.8 3449.2 3506.2 3665.2 30024.4 31259.5 31516.9 31544.7 31727.8 3297.4 3345.1 3354.9 3407.5 3435.1 398007.0 437907.0 439010.0 439705.0 441137.8 49407.5 49809.0 54486.5 54742.5 56822.7 57660.4 60852.1 61073.1 61136.7 61217.4 15729.1 15881.8 15905.4 15931.6 15940.7 11008.2 12106.9 12277.7 12350.5 12395.1 15513.2 15570.5 15572.9 15655.5 15785.9 5384.0 5491.9 6296.6 6377.6 6410.3 866.8 937.3 984.7 995.0 1079.5 26508.5 27932.6 30122.8 30791.3 30972.8 933.0 1040.5 1045.8 1136.2 1146.5 15796.4 15899.0 15902.6 16068.0 16079.4 612955.0 617267.0 623656.0 624216.0 625362.0 58357.8 58431.7 58453.0 58504.4 58536.0 1248.3 1369.5 1396.2 1404.0 1416.8 29875.3 30861.5 31202.5 32243.7 32297.8 52260.3 53595.7 56846.4 56859.1 57509.7 527139.0 529241.4 529365.0 529519.0 529802.0 18374.5 22878.7 23394.4 25861.4 26373.1 47493.8 48063.0 48616.8 49081.5 49179.0 34795.7 38379.0 39558.6 39745.4 40858.6 38889.2 39823.0 40158.0 40522.6 40551.6 38143.6 38207.0 38775.6 38924.6 38931.6 32528.7 34513.5 35152.8 35233.6 35356.1 21010.8 25319.1 25350.6 25621.0 26005.7 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | [#2] jquery.html Cycles:180 Average:34657.70 Median:26687.47 stddev:99457.50 (372.7%) stddev-sans-first:99703.08 07:14:06 INFO - PROCESS | 1932 | Values: 313.6 336.3 388.4 396.0 397.9 20420.0 20432.4 20763.6 21760.7 21785.0 20520.7 21052.9 21335.8 21348.9 21462.7 5165.6 5497.2 6038.2 6041.4 6046.5 5927.5 5967.3 6009.7 6018.4 6042.1 5708.4 5932.0 5932.9 5938.0 5971.7 5615.7 5876.1 5967.7 5970.2 5980.7 5105.3 5126.8 5141.0 5141.4 5145.9 26295.6 26467.2 26500.1 26874.9 26919.7 2418.9 2440.9 2553.8 2819.9 3127.8 13109.7 15692.0 15889.1 15917.5 16638.4 1862.4 1898.7 1910.6 1931.7 1996.4 86616.0 94721.5 110803.8 118532.0 124521.0 9447.2 10614.2 11106.1 11114.4 11263.3 12214.9 12706.0 12778.0 13801.5 13830.5 8434.4 8541.1 8555.1 8624.7 8627.4 8517.4 8521.9 8529.1 8633.0 8651.0 6609.3 6684.4 6698.4 6726.2 6736.3 1643.6 1853.2 1861.6 1900.0 1909.2 822.3 922.7 953.4 1003.7 1006.8 21873.1 22778.3 22858.3 22937.4 22975.4 825.8 984.1 1055.0 1098.4 1098.6 9222.4 11044.7 11683.6 11698.8 11789.7 589149.0 594475.0 598397.0 608186.0 608550.0 83838.0 97650.5 118668.4 119764.4 121158.0 868.0 982.7 998.2 1000.5 1021.2 18543.5 19387.1 19442.5 19789.9 19844.6 35653.6 44147.8 52845.2 57020.4 59619.7 81066.6 84347.0 84862.6 85125.6 85814.0 6728.6 8245.3 8380.7 8461.3 8563.2 12623.7 13504.5 13682.2 13702.8 13816.3 10621.9 11353.5 11680.7 11771.5 11829.9 9488.7 11442.6 11525.9 11737.4 11754.9 11618.4 11734.5 11740.9 11972.2 12015.6 7173.8 7486.2 7538.2 7799.8 8581.3 10335.0 11565.7 11772.7 11827.2 11843.4 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | [#3] mootools.html Cycles:180 Average:5752.47 Median:4996.35 stddev:3212.96 (64.3%) stddev-sans-first:3206.11 07:14:06 INFO - PROCESS | 1932 | Values: 1503.2 1532.9 1728.3 1882.8 1909.5 8482.6 8742.7 8922.4 8955.0 8961.4 7816.6 8112.6 8512.6 8761.1 8780.8 2378.0 2407.5 2408.8 2413.1 2421.2 2386.6 2392.3 2418.1 2420.5 2427.0 2113.9 2196.1 2320.0 2398.7 2401.5 2380.2 2384.4 2406.4 2406.7 2410.3 2392.7 2400.5 2402.6 2403.4 2406.0 8845.1 8895.6 8906.5 8908.3 8910.6 5253.5 5334.7 5400.2 5401.1 5407.9 3445.2 3477.5 3603.6 3606.0 3606.6 1037.2 1055.8 1063.1 1075.3 1079.4 11615.4 11631.4 11631.4 11650.5 11674.0 3810.8 4620.8 4825.8 4831.1 4848.5 9941.8 9949.7 9958.3 9960.3 9969.4 5377.2 5384.1 5391.4 5391.9 5395.1 4753.2 4929.5 4948.5 4952.5 4967.1 3805.1 3806.6 3843.5 3873.8 3890.3 1096.2 1159.4 1164.1 1170.5 1172.8 717.6 808.3 901.1 918.1 922.3 5884.5 5953.0 6008.0 6022.6 6172.3 876.7 897.4 901.5 968.9 1003.2 3522.5 3902.2 4048.9 4051.4 4056.7 10745.6 11068.7 11084.0 11098.0 11110.6 8888.7 9600.9 9968.7 10383.7 10700.1 8011.8 8244.8 8289.9 8333.2 8339.5 5984.2 6035.4 6190.5 6205.4 6362.0 9623.6 9806.0 10128.2 10129.7 10198.8 9916.6 10098.4 10236.7 10265.4 10450.4 8096.5 8412.5 8449.2 8530.2 8559.6 6700.7 8381.4 8527.1 8576.3 8578.1 7551.2 7634.8 7644.2 7658.8 7681.1 7418.0 7498.9 7499.1 7533.0 7594.6 6934.2 7095.9 7155.3 7158.6 7158.8 4829.8 4833.3 4835.5 4908.8 4929.9 4988.7 5004.0 5031.6 5103.6 5108.4 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | [#4] prototype.html Cycles:180 Average:4586.73 Median:5190.80 stddev:1417.35 (27.3%) stddev-sans-first:1384.30 07:14:06 INFO - PROCESS | 1932 | Values: 298.7 306.4 309.8 315.2 315.3 5108.9 5466.8 5473.2 5483.8 5503.3 4940.6 5369.4 5386.6 5431.5 5470.1 3888.5 3945.4 4059.3 4125.8 4140.7 4043.5 4094.2 4120.0 4121.5 4169.9 3668.0 3903.4 4073.8 4117.0 4149.4 3351.4 3455.8 3892.7 4009.6 4140.7 3092.7 3409.0 3505.5 3523.9 3551.7 5166.5 5187.4 5194.2 5229.7 5280.1 4493.9 4662.1 4696.0 4701.5 4710.2 5075.6 5520.8 5678.3 5712.5 5725.7 3619.5 3930.1 3941.8 3943.9 3949.4 5060.6 5700.5 5718.6 5955.1 6044.6 3332.0 3507.2 3883.9 4006.6 4052.5 3577.6 3997.7 4072.1 4102.0 4113.6 3907.6 4309.9 4728.4 4748.0 4759.6 5484.8 5713.4 5734.4 5747.4 5766.3 1154.9 1178.3 1303.3 1402.6 1403.5 804.9 811.8 851.8 863.8 868.9 4373.8 4850.6 5203.3 5215.5 5225.7 4557.8 5138.7 5658.0 5724.8 5821.8 4455.8 5060.7 5340.5 5352.7 5390.6 3027.2 3035.0 3052.7 3053.5 3100.0 5100.9 5305.6 5848.8 5945.9 6065.8 5282.4 5657.0 5968.7 6025.4 6085.6 5959.0 5995.8 5997.6 6043.9 6077.9 5616.5 5623.5 5644.0 5849.9 5853.5 4934.9 5080.5 5275.6 5715.7 5726.9 5055.5 5413.7 5928.6 6018.2 6067.0 3672.7 3704.9 3922.4 3938.8 3974.2 5677.8 5736.5 5748.5 5767.6 5779.6 5626.3 5709.9 5720.8 5741.6 5742.7 4622.9 4847.7 5024.2 5254.6 5675.7 5125.2 5293.3 5515.4 5676.3 5684.9 5271.7 5552.8 5605.0 5742.3 5764.7 5153.8 5658.2 5670.0 5687.9 5697.7 07:14:06 INFO - PROCESS | 1932 | 07:14:06 INFO - PROCESS | 1932 | [#5] yui.html Cycles:180 Average:24375.63 Median:4454.88 stddev:38687.43 (868.4%) stddev-sans-first:38755.14 07:14:06 INFO - PROCESS | 1932 | Values: 707.2 717.3 734.3 779.7 794.9 15065.5 15535.0 15944.3 15945.9 16605.3 14858.6 15040.9 15068.2 15074.2 15076.0 686.9 710.5 810.7 819.5 853.8 852.9 854.8 857.3 857.7 857.7 909.7 911.2 912.2 914.0 914.5 703.5 738.4 740.5 740.7 907.7 641.4 675.4 678.7 682.1 682.2 15050.0 15059.7 15067.8 15132.5 15152.2 13867.1 14060.6 14089.4 14117.0 14310.0 12613.6 12756.2 12781.5 12833.7 12885.5 4455.8 4528.9 4537.0 4576.6 4740.2 112521.0 114507.0 114757.9 114860.3 116654.0 11044.7 11155.4 11200.2 11240.3 11687.1 22093.8 22104.6 22134.9 22143.8 22176.0 7586.8 7860.1 7900.4 7949.9 8183.5 4412.8 4466.8 4470.6 4479.7 4508.1 3473.4 3585.2 3589.2 3590.1 3591.9 639.8 646.6 648.0 663.2 671.5 601.4 605.4 623.6 631.5 643.2 7808.5 8600.2 8670.6 8898.5 9189.8 564.7 570.2 624.9 634.8 639.4 4159.2 4241.3 4372.4 4413.0 4454.0 91963.5 124632.0 128338.4 129327.4 148627.5 119965.0 122098.0 128720.4 129297.7 135080.0 109204.5 112017.0 116121.4 116897.4 117553.6 8508.7 8554.2 8559.8 8574.2 8847.1 61820.7 63924.0 64171.4 65688.0 66495.7 94695.5 97939.5 98230.0 99183.0 101809.0 11637.7 11675.6 11677.6 11803.4 12286.4 12224.0 12778.0 12797.7 12840.1 12914.6 11784.0 11859.3 11877.7 12010.2 12274.6 11486.4 12019.9 12043.8 12138.3 12158.0 11611.3 11640.2 12042.5 12152.5 12250.7 8406.5 9329.5 9360.7 9923.7 9977.5 9086.1 9308.9 9370.8 9408.5 9989.5 07:14:06 INFO - PROCESS | 1932 | -------- Summary: end -------- 07:14:06 INFO - PROCESS | 1932 | 07:14:07 INFO - TEST-INFO | 1932: exit 0 07:14:07 INFO - TEST-OK | dromaeo_css | took 1115551ms 07:14:07 INFO - TEST-START | kraken 07:14:07 INFO - operating with platform_type : mac_ 07:14:07 INFO - Initialising browser for kraken test... 07:14:07 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpixZVff/profile http://localhost:50904/getInfo.html) 07:14:09 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 07:14:09 INFO - PROCESS | 1934 | colorDepth:24 07:14:09 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 07:14:09 INFO - PROCESS | 1934 | __metrics 07:14:10 INFO - PROCESS | 1934 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:14:10 INFO - PROCESS | 1934 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:10 INFO - TEST-INFO | 1934: exit 0 07:14:10 INFO - Browser initialized. 07:14:10 INFO - Running cycle 1/1 for kraken test... 07:14:10 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpixZVff/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:22 INFO - PROCESS | 1935 | RSS: Main: 243638272 07:14:22 INFO - PROCESS | 1935 | 07:14:25 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50904/tests/kraken/driver.html?testName=audio-beat-detection) 07:14:26 INFO - PROCESS | 1935 | RSS: Main: 294273024 07:14:26 INFO - PROCESS | 1935 | 07:14:29 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50904/tests/kraken/driver.html?testName=audio-dft) 07:14:29 INFO - PROCESS | 1935 | RSS: Main: 304971776 07:14:29 INFO - PROCESS | 1935 | 07:14:33 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50904/tests/kraken/driver.html?testName=audio-fft) 07:14:33 INFO - PROCESS | 1935 | RSS: Main: 388653056 07:14:33 INFO - PROCESS | 1935 | 07:14:35 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50904/tests/kraken/driver.html?testName=audio-oscillator) 07:14:36 INFO - PROCESS | 1935 | RSS: Main: 290873344 07:14:36 INFO - PROCESS | 1935 | 07:14:38 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:39 INFO - PROCESS | 1935 | RSS: Main: 294252544 07:14:39 INFO - PROCESS | 1935 | 07:14:42 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50904/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:42 INFO - PROCESS | 1935 | RSS: Main: 332046336 07:14:42 INFO - PROCESS | 1935 | 07:14:45 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50904/tests/kraken/driver.html?testName=imaging-desaturate) 07:14:46 INFO - PROCESS | 1935 | RSS: Main: 333283328 07:14:46 INFO - PROCESS | 1935 | 07:14:48 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50904/tests/kraken/driver.html?testName=json-parse-financial) 07:14:49 INFO - PROCESS | 1935 | RSS: Main: 330805248 07:14:49 INFO - PROCESS | 1935 | 07:14:51 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:51 INFO - PROCESS | 1935 | RSS: Main: 311889920 07:14:51 INFO - PROCESS | 1935 | 07:14:53 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:54 INFO - PROCESS | 1935 | RSS: Main: 318226432 07:14:54 INFO - PROCESS | 1935 | 07:14:56 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:57 INFO - PROCESS | 1935 | RSS: Main: 318164992 07:14:57 INFO - PROCESS | 1935 | 07:15:00 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:00 INFO - PROCESS | 1935 | RSS: Main: 331808768 07:15:00 INFO - PROCESS | 1935 | 07:15:03 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:04 INFO - PROCESS | 1935 | RSS: Main: 327897088 07:15:04 INFO - PROCESS | 1935 | 07:15:05 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:50904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50904/tests/kraken/driver.html?testName=ai-astar) 07:15:06 INFO - PROCESS | 1935 | RSS: Main: 371429376 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | __start_tp_report 07:15:06 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 07:15:06 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 07:15:06 INFO - PROCESS | 1935 | |i|pagename|runs| 07:15:06 INFO - PROCESS | 1935 | |0;ai-astar;100;110;110;108;110;109;116;143;112;111 07:15:06 INFO - PROCESS | 1935 | |1;audio-beat-detection;146;107;106;166;138;124;128;106;140;105 07:15:06 INFO - PROCESS | 1935 | |2;audio-dft;185;181;183;182;186;180;183;182;186;185 07:15:06 INFO - PROCESS | 1935 | |3;audio-fft;82;73;61;126;81;80;60;68;83;57 07:15:06 INFO - PROCESS | 1935 | |4;audio-oscillator;87;86;91;71;72;69;94;71;67;98 07:15:06 INFO - PROCESS | 1935 | |5;imaging-gaussian-blur;88;91;112;114;136;84;88;84;88;84 07:15:06 INFO - PROCESS | 1935 | |6;imaging-darkroom;93;93;93;103;93;92;135;94;94;93 07:15:06 INFO - PROCESS | 1935 | |7;imaging-desaturate;87;84;85;86;85;86;86;86;86;85 07:15:06 INFO - PROCESS | 1935 | |8;json-parse-financial;51;55;52;55;54;53;54;55;53;55 07:15:06 INFO - PROCESS | 1935 | |9;json-stringify-tinderbox;66;66;71;81;72;77;70;71;71;72 07:15:06 INFO - PROCESS | 1935 | |10;stanford-crypto-aes;86;83;85;93;98;101;79;85;85;87 07:15:06 INFO - PROCESS | 1935 | |11;stanford-crypto-ccm;137;148;156;150;144;130;145;144;168;145 07:15:06 INFO - PROCESS | 1935 | |12;stanford-crypto-pbkdf2;161;162;159;160;162;161;162;162;160;161 07:15:06 INFO - PROCESS | 1935 | |13;stanford-crypto-sha256-iterative;67;68;66;67;69;65;67;65;66;66 07:15:06 INFO - PROCESS | 1935 | __end_tp_report 07:15:06 INFO - PROCESS | 1935 | __start_cc_report 07:15:06 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,2034 07:15:06 INFO - PROCESS | 1935 | __end_cc_report 07:15:06 INFO - PROCESS | 1935 | __startTimestamp1467296106171__endTimestamp 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | ------- Summary: start ------- 07:15:06 INFO - PROCESS | 1935 | Number of tests: 14 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#0] ai-astar Cycles:10 Average:112.90 Median:110.50 stddev:11.31 (10.2%) stddev-sans-first:10.99 07:15:06 INFO - PROCESS | 1935 | Values: 100.0 110.0 110.0 108.0 110.0 109.0 116.0 143.0 112.0 111.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:133.00 stddev:20.94 (15.7%) stddev-sans-first:21.00 07:15:06 INFO - PROCESS | 1935 | Values: 146.0 107.0 106.0 166.0 138.0 124.0 128.0 106.0 140.0 105.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.11 (1.1%) stddev-sans-first:2.15 07:15:06 INFO - PROCESS | 1935 | Values: 185.0 181.0 183.0 182.0 186.0 180.0 183.0 182.0 186.0 185.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#3] audio-fft Cycles:10 Average:77.10 Median:76.50 stddev:19.80 (25.9%) stddev-sans-first:20.92 07:15:06 INFO - PROCESS | 1935 | Values: 82.0 73.0 61.0 126.0 81.0 80.0 60.0 68.0 83.0 57.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:86.50 stddev:11.73 (13.6%) stddev-sans-first:12.21 07:15:06 INFO - PROCESS | 1935 | Values: 87.0 86.0 91.0 71.0 72.0 69.0 94.0 71.0 67.0 98.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:86.00 stddev:17.70 (20.6%) stddev-sans-first:18.48 07:15:06 INFO - PROCESS | 1935 | Values: 88.0 91.0 112.0 114.0 136.0 84.0 88.0 84.0 88.0 84.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:93.00 stddev:13.28 (14.3%) stddev-sans-first:13.94 07:15:06 INFO - PROCESS | 1935 | Values: 93.0 93.0 93.0 103.0 93.0 92.0 135.0 94.0 94.0 93.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.84 (1.0%) stddev-sans-first:0.73 07:15:06 INFO - PROCESS | 1935 | Values: 87.0 84.0 85.0 86.0 85.0 86.0 86.0 86.0 86.0 85.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.50 stddev:1.42 (2.6%) stddev-sans-first:1.12 07:15:06 INFO - PROCESS | 1935 | Values: 51.0 55.0 52.0 55.0 54.0 53.0 54.0 55.0 53.0 55.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:4.52 (6.3%) stddev-sans-first:4.30 07:15:06 INFO - PROCESS | 1935 | Values: 66.0 66.0 71.0 81.0 72.0 77.0 70.0 71.0 71.0 72.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:85.50 stddev:6.92 (8.1%) stddev-sans-first:7.30 07:15:06 INFO - PROCESS | 1935 | Values: 86.0 83.0 85.0 93.0 98.0 101.0 79.0 85.0 85.0 87.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:146.50 stddev:10.25 (7.0%) stddev-sans-first:10.26 07:15:06 INFO - PROCESS | 1935 | Values: 137.0 148.0 156.0 150.0 144.0 130.0 145.0 144.0 168.0 145.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 07:15:06 INFO - PROCESS | 1935 | Values: 161.0 162.0 159.0 160.0 162.0 161.0 162.0 162.0 160.0 161.0 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - PROCESS | 1935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 07:15:06 INFO - PROCESS | 1935 | Values: 67.0 68.0 66.0 67.0 69.0 65.0 67.0 65.0 66.0 66.0 07:15:06 INFO - PROCESS | 1935 | -------- Summary: end -------- 07:15:06 INFO - PROCESS | 1935 | 07:15:06 INFO - TEST-INFO | 1935: exit 0 07:15:06 INFO - TEST-OK | kraken | took 59421ms 07:15:06 INFO - SUITE-END | took 1174s 07:15:07 INFO - Completed test suite (00:19:35) 07:15:07 INFO - javascript benchmark 07:15:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.70869621734, 3284.950725739114, 3296.0276718368086, 3308.0, 3316.4693649016162, 5487.972560137204, 5568.916466252999, 5574.581906357019, 5592.217089607453, 5614.915776263354, 5564.527015203703, 5584.329880414346, 5669.0, 5702.572307076975, 5714.114312281593, 5056.19100943849, 5063.367079115111, 5124.692518448905, 5133.948660513403, 5291.259223708684, 5200.635955483118, 5230.1108811501945, 5248.5276325130735, 5257.789688412459, 5263.578913686915, 5040.1179793535985, 5101.413337466165, 5112.974435127838, 5122.513361230677, 5182.015417070764, 5107.438181800037, 5110.233464980245, 5120.0, 5126.410462796752, 5149.124648809711, 5131.999260144274, 5135.717535535544, 5142.1772516397195, 5169.819056333048, 5217.765200565984, 5468.589855760833, 5538.307711536058, 5638.0, 5696.3449203341315, 5744.195812586241, 6096.927044804744, 6166.506679465677, 6180.3201647818705, 6191.349908259658, 6205.317415084337, 5148.279240906276, 6246.6252024878195, 6250.281217659982, 6251.593646412968, 6254.030625253047, 5560.304961879765, 5650.971745141248, 5718.999175144333, 5747.741351639186, 5792.8841423171725, 6299.716512756937, 6322.209723784527, 6322.462590679752, 6322.988321868479, 6327.4938004959495, 6065.559880582722, 6066.98736501729, 6068.162513101474, 6079.211861876839, 6085.0428907197565, 6028.57799953999, 6063.999440092423, 6130.754769809158, 6152.230971128609, 6212.627242365473, 6103.974138059404, 6120.355709576858, 6123.4351415035735, 6127.097902969301, 6135.416406698409, 6147.754089836357, 6150.200473938359, 6161.969190154021, 6190.0405437157315, 6191.318954914956, 4317.762523061199, 4874.171390863562, 4888.926666100011, 4916.852494425173, 4978.477259887732, 3822.3884178531857, 4314.69797114199, 4462.062966777014, 4464.241079016575, 4464.352668862996, 4696.459907110658, 5539.667619942817, 5572.136318870582, 5581.386047534768, 5590.692511911802, 6239.313675495692, 6254.499640028786, 6255.218097737783, 6256.374362563798, 6278.497720182374, 5577.944220557823, 5592.412796656293, 5608.579356548194, 5624.578156638268, 5629.549636029108, 4455.866324010285, 5236.371635403776, 5299.867503312371, 5338.332708411449, 5360.437154098841, 5289.550388217045, 6251.3123556408755, 6262.2172228471445, 6262.68686565679, 6302.401271879165, 6167.198264225622, 6183.598066125687, 6185.195924529782, 6206.689665516616, 6206.906896396648, 6169.876602468015, 6189.0, 6250.718717657625, 6268.529860260407, 6288.905666414916, 6097.939020609737, 6103.298120716175, 6121.84695382619, 6122.051082082285, 6152.600080994721, 6157.0456579230295, 6211.844703882439, 6215.9378406217165, 6216.564840461125, 6241.407066328873, 5622.690752008515, 5952.404759524186, 6010.7295171716505, 6052.364501727431, 6055.697215139137, 5984.730687119177, 6022.156898034191, 6026.879462410815, 6036.426539478743, 6046.395360464095, 5578.386377498391, 5873.4126587342635, 5908.0, 5918.17145599625, 5951.970240148771, 5926.111083337534, 5986.850328741816, 6002.879942401215, 6033.849153771191, 6040.728167232397, 5856.707164641836, 5867.6772777497645, 5883.2057672213705, 5890.175375447355, 5899.46904778572], "value": 5610.9359316096225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.1693942433906, 466.63136122463254, 523.471293993067, 524.5488879563577, 524.6878107526023, 39254.803725981365, 40173.39739903904, 40275.993100172476, 40421.38314467421, 43099.35350969738, 40336.59663403365, 40785.38821917666, 40836.79581602095, 40901.18197636046, 40916.181676366454, 9597.280203984712, 9759.853602195974, 9768.609255629766, 9794.90205097947, 9801.607935682565, 9617.37487063342, 9718.125368716814, 9726.854097188549, 9730.172935300472, 9731.95134024329, 9713.562889669947, 9726.805463890752, 9728.75678108046, 9751.707448776548, 9753.414795112316, 9671.5647795849, 9715.417074975525, 9728.319017668766, 9728.75678108046, 9734.977827328099, 9536.952315238379, 9610.615575376976, 9615.086566776145, 9630.855537166948, 9639.3734407264, 39089.0, 39159.804200979095, 39205.80397098025, 39262.411063834064, 39547.406788897904, 3397.6432474590306, 3429.794212347242, 3449.2411669432936, 3506.211102501942, 3665.1753355495066, 30024.399512009855, 31259.531107033414, 31516.896908608087, 31544.684553154406, 31727.841360793278, 3297.4229509835923, 3345.080102971678, 3354.865805367807, 3407.505911642823, 3435.124043368925, 398007.0, 437907.0, 439010.0, 439705.0, 441137.7943110264, 49407.50592494101, 49809.0, 54486.45513544814, 54742.452575474534, 56822.71588642113, 57660.42339576551, 60852.087218691755, 61073.08390374148, 61136.69431652902, 61217.38782612117, 15729.134897580743, 15881.841181588035, 15905.363785448684, 15931.601709957344, 15940.68118637644, 11008.174386920853, 12106.878931210575, 12277.69305767363, 12350.505979760888, 12395.132340736061, 15513.224338783015, 15570.455034073753, 15572.92213538925, 15655.530334089995, 15785.921070394805, 5383.973080134652, 5491.945080549143, 6296.622202667763, 6377.565047864194, 6410.262819775786, 866.7789713622985, 937.2782957122977, 984.7341217871278, 994.9751256218652, 1079.5142186016324, 26508.46983060328, 27932.58101128444, 30122.849385752932, 30791.30647814347, 30972.845135774176, 932.9720108396759, 1040.490159821697, 1045.7908418316367, 1136.193302755053, 1146.4611632532697, 15796.447124350823, 15899.0, 15902.602434938988, 16067.955582887074, 16079.437219697254, 612955.0, 617267.0, 623656.0, 624216.0, 625362.0, 58357.8328433429, 58431.70784146052, 58453.0, 58504.41495585075, 58536.0, 1248.2572869142846, 1369.4795977528474, 1396.190209678384, 1404.0242031788014, 1416.7662335714904, 29875.253118672208, 30861.537076944314, 31202.531962020134, 32243.677563224068, 32297.838510807294, 52260.34177607531, 53595.732021339645, 56846.43153568411, 56859.14711279417, 57509.712451437474, 527139.0, 529241.3537932286, 529365.0, 529519.0, 529802.0, 18374.540636484195, 22878.656820148044, 23394.415139621644, 25861.353466162745, 26373.07694230693, 47493.76253118712, 48063.0, 48616.75691621519, 49081.50918490769, 49179.0, 34795.65204347924, 38379.0, 39558.604413956644, 39745.40381894332, 40858.591414086666, 38889.22221555497, 39823.0, 40158.0, 40522.59477405306, 40551.59448405478, 38143.61856381401, 38207.0, 38775.61224387833, 38924.6107538921, 38931.61068389393, 32528.674713252563, 34513.48229776606, 35152.82423587866, 35233.647663523036, 35356.11609709778, 21010.789892100882, 25319.113831016562, 25350.619740704275, 25621.01910828055, 26005.739942600332], "value": 19581.6149147641, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.62051917180213, 336.3395541268565, 388.3785942492013, 396.04750574867455, 397.8567715622377, 20419.979001049946, 20432.387028389152, 20763.584728305425, 21760.673589896163, 21785.0, 20520.692189617166, 21052.89473552634, 21335.786642133575, 21348.8932555337, 21462.678059829115, 5165.586753059746, 5497.230387745719, 6038.215032045828, 6041.365656606059, 6046.516278697715, 5927.466528012478, 5967.343592204854, 6009.699515024253, 6018.428249316308, 6042.063480160582, 5708.373113662607, 5931.970340148293, 5932.851678708023, 5938.0499120140785, 5971.731272092745, 5615.6630602164005, 5876.0598304271325, 5967.671778052206, 5970.1940238067955, 5980.671063091529, 5105.310783044279, 5126.794928202868, 5141.0232055909255, 5141.408737995141, 5145.9485405146215, 26295.605565916525, 26467.205983820517, 26500.07249746269, 26874.86562567194, 26919.654017299254, 2418.8548687078833, 2440.9389765255833, 2553.8084643651614, 2819.943601127966, 3127.8279694616785, 13109.737805243842, 15691.980021298694, 15889.126098064602, 15917.52247432579, 16638.417655382123, 1862.3947217154343, 1898.686716691758, 1910.570121722615, 1931.7005864091088, 1996.391100714296, 86616.0, 94721.52639236828, 110803.78392432186, 118532.0, 124521.0, 9447.196988255937, 10614.150867930546, 11106.056440122946, 11114.388708620942, 11263.26788758728, 12214.938925305494, 12706.0, 12778.0, 13801.516946907012, 13830.515931942535, 8434.409591328671, 8541.103184165697, 8555.058943516333, 8624.741257762276, 8627.352948528885, 8517.44636598619, 8521.914780852112, 8529.061803201643, 8633.0, 8651.0, 6609.339066093352, 6684.364985326386, 6698.39714425704, 6726.159230096238, 6736.292689267654, 1643.5808868738634, 1853.2031226572703, 1861.6276744650854, 1899.9620007599772, 1909.2458478900755, 822.2928281677753, 922.686286662538, 953.4422362917771, 1003.7239759066169, 1006.7986402719486, 21873.12507499682, 22778.31665050051, 22858.314250572177, 22937.426564336027, 22975.42561435944, 825.781167990483, 984.1339621133357, 1054.9789004219872, 1098.368438148068, 1098.555085190499, 9222.354435189607, 11044.723881902855, 11683.591074312359, 11698.766024679458, 11789.705257368463, 589149.0, 594475.0, 598397.0, 608186.0, 608550.0, 83838.0, 97650.5117474408, 118668.40665796789, 119764.4011779953, 121158.0, 867.9956600216958, 982.6511588386163, 998.2263745597076, 1000.5397517142051, 1021.2289721260549, 18543.536411589277, 19387.12757925925, 19442.513937151685, 19789.901050494656, 19844.603107937473, 35653.64346356607, 44147.77926110349, 52845.150419735124, 57020.429795701515, 59619.70190149022, 81066.5946670263, 84347.0, 84862.57568712116, 85125.57437212774, 85814.0, 6728.629925354153, 8245.340372770044, 8380.664773408995, 8461.32309415233, 8563.186497282748, 12623.747525049264, 13504.527341542998, 13682.179069255877, 13702.794458082937, 13816.309184540532, 10621.884702106168, 11353.54585816558, 11680.70798230051, 11771.470283837076, 11829.940850295694, 9488.667896623585, 11442.599509017144, 11525.942370288094, 11737.35444550558, 11754.941225293818, 11618.360990145624, 11734.530618775494, 11740.941295293469, 11972.221805582609, 12015.639530814089, 7173.820654483679, 7486.176520582841, 7538.246175382418, 7799.805004874924, 8581.2705919995, 10335.0, 11565.710857228636, 11772.705682357668, 11827.172097953406, 11843.407829608657], "value": 9817.528005153494, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.1882783297017, 1532.923353832308, 1728.3259528783776, 1882.8305452509271, 1909.4939840942152, 8482.575871206438, 8742.694005709802, 8922.42004269722, 8954.955225223865, 8961.417507861992, 7816.648250828712, 8112.553809540473, 8512.574371281442, 8761.123887611237, 8780.824383512327, 2377.976220237793, 2407.5425669122897, 2408.8313818032743, 2413.1433341163897, 2421.249412682065, 2386.606209975361, 2392.3301475586863, 2418.141559746291, 2420.4674971506242, 2427.0, 2113.9154433822628, 2196.077647388101, 2319.9884000579973, 2398.724146723123, 2401.495685905953, 2380.190735150057, 2384.415818124562, 2406.4224586099385, 2406.6871306730186, 2410.349205714465, 2392.676988606533, 2400.4838959623767, 2402.639604059405, 2403.3871362802547, 2405.9759402405925, 8845.071267516882, 8895.555222238927, 8906.51014194219, 8908.331875109328, 8910.55447227636, 5253.52718255355, 5334.653247538937, 5400.162974738922, 5401.108817045183, 5407.945920540784, 3445.207602251471, 3477.51314815926, 3603.585587657427, 3606.0, 3606.6032736398975, 1037.1547189040907, 1055.773008803111, 1063.0910571461366, 1075.2634445404922, 1079.373963101407, 11615.419229038514, 11631.360275184861, 11631.418429078596, 11650.533978640844, 11674.0, 3810.7904065276675, 4620.815167393266, 4825.806967721322, 4831.106245344622, 4848.515148485194, 9941.751456213507, 9949.701508954742, 9958.253131015203, 9960.302778805559, 9969.35199212049, 5377.220303056113, 5384.111621582473, 5391.406945236021, 5391.865203369947, 5395.05586522357, 4753.239481682983, 4929.482404347564, 4948.455669876311, 4952.455229924705, 4967.05625931072, 3805.1058001369656, 3806.6193380662266, 3843.5195600549932, 3873.845046198177, 3890.280298144852, 1096.2052511928787, 1159.368144361325, 1164.0978241862456, 1170.5076028064286, 1172.8123500239922, 717.5981450387695, 808.3129340060901, 901.1259078693656, 918.0727465260136, 922.3128769066954, 5884.499817515559, 5953.047512397996, 6007.969960150259, 6022.638641681426, 6172.259328880563, 876.7106854737921, 897.4077109107957, 901.4906577783531, 968.9031096890254, 1003.1673710820002, 3522.5068440552463, 3902.2195560887935, 4048.8785336439955, 4051.355489596606, 4056.716029877939, 10745.623903163509, 11068.723281918017, 11084.0, 11098.001179893849, 11110.555577776799, 8888.666699994923, 9600.855987160197, 9968.651097211708, 10383.740406489747, 10700.143988480902, 8011.759647210476, 8244.8351032979, 8289.875651865348, 8333.16668333174, 8339.457935234312, 5984.19213406202, 6035.426634469718, 6190.50475961931, 6205.379462053758, 6361.968190159205, 9623.5669394876, 9806.0, 10128.189744820544, 10129.696109116738, 10198.847017294895, 9916.603335866484, 10098.444585547866, 10236.744081397726, 10265.384076955406, 10450.372977621368, 8096.51420914747, 8412.495250285003, 8449.197326253996, 8530.232279094911, 8559.61481733336, 6700.698468569024, 8381.371397145116, 8527.062023177321, 8576.313894888519, 8578.056413794602, 7551.207123252199, 7634.847303054019, 7644.235576442311, 7658.770236892902, 7681.078270607562, 7417.962910185414, 7498.887516687363, 7499.137599175946, 7532.962335188289, 7594.6202689866395, 6934.16789985205, 7095.8935615964765, 7155.3202445767565, 7158.570485770871, 7158.785236442915, 4829.7585120743115, 4833.299171620025, 4835.492273311393, 4908.779104940215, 4929.926051109164, 4988.700677959334, 5003.999200159909, 5031.572316353151, 5103.617228707788, 5108.412532558803], "value": 4609.979572077984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.741588525925, 306.4086313415108, 309.7583884570036, 315.2434158020748, 315.2685769015881, 5108.948910510894, 5466.753996070176, 5473.2063850741615, 5483.835484935454, 5503.3395992480855, 4940.6047516198705, 5369.355677318717, 5386.622936394454, 5431.511163995239, 5470.097433923398, 3888.5139357580374, 3945.3884647879627, 4059.269331520325, 4125.7524548527035, 4140.654287356621, 4043.514778226602, 4094.1811637672436, 4119.958800411988, 4121.464209652741, 4169.894977830877, 3667.9826095647422, 3903.4144878268344, 4073.816678249486, 4117.0, 4149.3775933609895, 3351.413502637041, 3455.8272086395577, 3892.727509074366, 4009.558948515661, 4140.710150289481, 3092.70619291167, 3409.028426898322, 3505.526753888218, 3523.9295214095832, 3551.7158627309755, 5166.5458907018865, 5187.3775146982225, 5194.220866869962, 5229.660072095339, 5280.072773437668, 4493.9101217975785, 4662.111844702901, 4696.013837094214, 4701.459332176809, 4710.24636058229, 5075.619328550337, 5520.8406234690765, 5678.261825962599, 5712.542996560265, 5725.713714314267, 3619.511365965587, 3930.0567863712504, 3941.8029098545244, 3943.881683549498, 3949.447077409165, 5060.620453466005, 5700.515456186229, 5718.59969802114, 5955.106733989936, 6044.607100538451, 3331.9504356128227, 3507.1582820122985, 3883.9026925459934, 4006.5560008394855, 4052.4731784867777, 3577.624349443323, 3997.700172487075, 4072.144849581621, 4102.0, 4113.609207125318, 3907.6092390761264, 4309.892252693708, 4728.432588089451, 4747.95252047482, 4759.6430267729365, 5484.8354549363585, 5713.428657134254, 5734.419511219968, 5747.425257474303, 5766.327764948118, 1154.8509233312739, 1178.3460179600404, 1303.2571434282368, 1402.6212922510865, 1403.4596680278166, 804.937482523064, 811.8376324735077, 851.7742798158492, 863.7840539865034, 868.9398933301362, 4373.846915357947, 4850.563449289581, 5203.297554830049, 5215.530602245816, 5225.712585807741, 4557.814968108316, 5138.6659867109265, 5657.971710141505, 5724.79963201286, 5821.79623713168, 4455.777211139495, 5060.696358218519, 5340.465953404629, 5352.652077614943, 5390.568754499709, 3027.2129246396094, 3035.0, 3052.679468655759, 3053.5495639571027, 3099.9845000775304, 5100.923486147711, 5305.628605997543, 5848.800995795852, 5945.918928375034, 6065.75736970525, 5282.418933917266, 5657.0, 5968.731407086691, 6025.427584379565, 6085.57400981927, 5959.0, 5995.830812991512, 5997.6401415914315, 6043.909341359971, 6077.878442431127, 5616.494515493625, 5623.537880151272, 5643.971780141073, 5849.853753656193, 5853.531717462678, 4934.925976110433, 5080.49195080489, 5275.551578115903, 5715.714214289352, 5726.856828579319, 5055.545000949932, 5413.70224637633, 5928.555358348055, 6018.21763170785, 6067.0, 3672.6510981456718, 3704.8888533344043, 3922.3528117860233, 3938.783366914847, 3974.2250261198787, 5677.801276955287, 5736.483716465538, 5748.464694212946, 5767.596268261349, 5779.624324418899, 5626.2685850839125, 5709.885802284014, 5720.799772007959, 5741.569382296261, 5742.655440673573, 4622.867397487637, 4847.739587707151, 5024.246363045572, 5254.605904557097, 5675.687837168995, 5125.231795030709, 5293.338332708411, 5515.393306736176, 5676.290463692038, 5684.9301377255815, 5271.68369897792, 5552.750126244248, 5604.971975140098, 5742.253507044057, 5764.654120752768, 5153.819616313411, 5658.20785090096, 5670.0, 5687.919295333873, 5697.715114244188], "value": 4126.94760826778, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.19026714412, 717.2827172827173, 734.3354264390725, 779.6920216514475, 794.8807678848168, 15065.472708455207, 15535.0, 15944.282507287156, 15945.920270398647, 16605.252763625635, 14858.55424337269, 15040.924795376035, 15068.246587670628, 15074.246287685626, 15076.0, 686.9381755641991, 710.4671496377716, 810.7284059839945, 819.4796304346753, 853.7609469348562, 852.8592782190931, 854.8247609240121, 857.2584714222185, 857.6655104509247, 857.6826574167567, 909.7134402663173, 911.239115338693, 912.2018234045211, 913.9900410046902, 914.5427286356821, 703.4829400390709, 738.3613174603929, 740.4853626729425, 740.7481456304882, 907.7095329494564, 641.3682522715122, 675.4495086504533, 678.6979793991676, 682.1405029662661, 682.2461180395641, 15050.0, 15059.698806023818, 15067.773983390258, 15132.470363537333, 15152.242387880671, 13867.098638588459, 14060.578182654435, 14089.436422543085, 14117.0, 14310.0, 12613.621591352274, 12756.170848894884, 12781.488740450372, 12833.736207555583, 12885.484580616763, 4455.754933478657, 4528.909421811578, 4536.954630453719, 4576.588107070346, 4740.241561350202, 112520.9758616238, 114507.0, 114757.85242147555, 114860.27709584363, 116654.0, 11044.723881902855, 11155.442227888572, 11200.159988000933, 11240.269382490113, 11687.123465740104, 22093.779062209494, 22104.557908841733, 22134.88932555359, 22143.778562214495, 22176.0, 7586.764324345904, 7860.096088949729, 7900.367970562341, 7949.920500795034, 8183.549904755296, 4412.84555040572, 4466.821327146878, 4470.6423486121685, 4479.708818926824, 4508.07584445188, 3473.426884564069, 3585.229175727179, 3589.2283159120916, 3590.0665826885197, 3591.892243232707, 639.7568923809016, 646.6088016749893, 647.9578827376206, 663.2273401487213, 671.4997326991422, 601.4286427893519, 605.3704147686357, 623.6164758673383, 631.4979591224987, 643.2217017408894, 7808.492447990862, 8600.225979661735, 8670.566471676391, 8898.4660920345, 9189.805325307667, 564.7261078376984, 570.164708701754, 624.8545554471821, 634.8317695810522, 639.4181295021508, 4159.230542349675, 4241.34259189826, 4372.3878656988045, 4413.029133590605, 4454.0, 91963.54018229866, 124632.0, 128338.35830820785, 129327.35336323259, 148627.51372486353, 119965.0, 122098.0, 128720.35639821741, 129297.70702292856, 135080.0, 109204.4539777296, 112017.0, 116121.41939290249, 116897.41551292359, 117553.5515209429, 8508.659653613786, 8554.230119289294, 8559.828803423772, 8574.208859188384, 8847.071057539124, 61820.69089654703, 63924.0, 64171.35828641654, 65688.0, 66495.66752166208, 94695.5265223697, 97939.51030244803, 98230.0, 99183.0, 101809.0, 11637.709057273636, 11675.649730508097, 11677.649670509898, 11803.350815704875, 12286.447109880255, 12224.0, 12778.0, 12797.680057998252, 12840.101192916407, 12914.612561623166, 11784.0, 11859.34773587461, 11877.703057423634, 12010.219335743148, 12274.631761047183, 11486.425678716198, 12019.879801202225, 12043.81934270969, 12138.271703697807, 12157.966572841407, 11611.303321800719, 11640.243384180001, 12042.518299267931, 12152.453139608562, 12250.693732656398, 8406.537640429591, 9329.486878221764, 9360.672376466791, 9923.65267215644, 9977.501124943868, 9086.141012512748, 9308.860367094634, 9370.812583748424, 9408.529573521433, 9989.500524973577], "value": 7601.862734211746, "unit": "score"}], "name": "dromaeo_css", "value": 7337.191638537351, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 110.0, 108.0, 110.0, 109.0, 116.0, 143.0, 112.0, 111.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 107.0, 106.0, 166.0, 138.0, 124.0, 128.0, 106.0, 140.0, 105.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 183.0, 182.0, 186.0, 180.0, 183.0, 182.0, 186.0, 185.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 61.0, 126.0, 81.0, 80.0, 60.0, 68.0, 83.0, 57.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 91.0, 71.0, 72.0, 69.0, 94.0, 71.0, 67.0, 98.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 112.0, 114.0, 136.0, 84.0, 88.0, 84.0, 88.0, 84.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 103.0, 93.0, 92.0, 135.0, 94.0, 94.0, 93.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 52.0, 55.0, 54.0, 53.0, 54.0, 55.0, 53.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 71.0, 81.0, 72.0, 77.0, 70.0, 71.0, 71.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 93.0, 98.0, 101.0, 79.0, 85.0, 85.0, 87.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 148.0, 156.0, 150.0, 144.0, 130.0, 145.0, 144.0, 168.0, 145.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 160.0, 162.0, 161.0, 162.0, 162.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 67.0, 69.0, 65.0, 67.0, 65.0, 66.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1449.2, "alertThreshold": 2.0}]} 07:15:07 INFO - Return code: 0 07:15:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:15:07 INFO - # TBPL SUCCESS # 07:15:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:07 INFO - 2016-06-30 07:15:07.498 screenresolution[1939:15141] starting screenresolution argv=screenresolution get 07:15:07 INFO - 2016-06-30 07:15:07.500 screenresolution[1939:15141] Display 0: 1600x1200x32@60 07:15:07 INFO - 2016-06-30 07:15:07.506 screenresolution[1940:15144] starting screenresolution argv=screenresolution list 07:15:07 INFO - Available Modes on Display 0 07:15:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:07 INFO - Intel Iris: 07:15:07 INFO - Chipset Model: Intel Iris 07:15:07 INFO - Type: GPU 07:15:07 INFO - Bus: Built-In 07:15:07 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:07 INFO - Vendor: Intel (0x8086) 07:15:07 INFO - Device ID: 0x0a2e 07:15:07 INFO - Revision ID: 0x0009 07:15:07 INFO - Displays: 07:15:07 INFO - Display: 07:15:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:07 INFO - Display Serial Number: 1600x1200 60 07:15:07 INFO - Main Display: Yes 07:15:07 INFO - Mirror: Off 07:15:07 INFO - Online: Yes 07:15:07 INFO - Rotation: Supported 07:15:07 INFO - Return code: 0 07:15:07 INFO - Running post-action listener: _resource_record_post_action 07:15:07 INFO - ##### 07:15:07 INFO - ##### Finished run-tests step (success) 07:15:07 INFO - ##### 07:15:07 INFO - Running post-run listener: _resource_record_post_run 07:15:07 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 430080; Write bytes: 703904256; Read time: 4; Write time: 1906 07:15:07 INFO - TinderboxPrint: CPU usage
53.5% 07:15:07 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 4 07:15:07 INFO - TinderboxPrint: I/O write bytes / time
703,904,256 / 1,906 07:15:07 INFO - TinderboxPrint: CPU idle
2,253.2 (46.5%) 07:15:07 INFO - TinderboxPrint: CPU system
967.9 (20.0%) 07:15:07 INFO - TinderboxPrint: CPU user
1,620.7 (33.5%) 07:15:07 INFO - TinderboxPrint: Swap in / out
406,724,608 / 0 07:15:07 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385546752; Write bytes: 380589568; Read time: 28658; Write time: 681 07:15:07 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 430080; Write bytes: 293819392; Read time: 4; Write time: 1170 07:15:08 INFO - Running post-run listener: _upload_blobber_files 07:15:08 INFO - Blob upload gear active. 07:15:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:08 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 07:15:08 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'] 07:15:08 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 07:15:08 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:09 INFO - (blobuploader) - INFO - Done attempting. 07:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:10 INFO - (blobuploader) - INFO - Done attempting. 07:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:12 INFO - (blobuploader) - INFO - Done attempting. 07:15:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:12 INFO - Return code: 0 07:15:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612ee642a246bf3bc8401586841b7387e0a221bc940c7a17a5f57060438c04b5845a46d49ba7e10db7f5daa352b1bd53380e27424c65f06d61a50d2fba9fd54d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ea296c97ead0a0b3da09c64e4225dcc419bfe6f3f45d2a0ab8a2d26339a0908bc3c4b6d729beb76ecf1b4691897b10fa5ec344b8440b9eab81eef4b810f6e65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598a010f858243d661520dcc8d13e8d8d4502290094970f9578722b460cdc8d34d87ebe93f3b3883354e537f5b7e37a264c4a0d449bb3082f001f4ede234365a"} 07:15:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:12 INFO - Contents: 07:15:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612ee642a246bf3bc8401586841b7387e0a221bc940c7a17a5f57060438c04b5845a46d49ba7e10db7f5daa352b1bd53380e27424c65f06d61a50d2fba9fd54d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ea296c97ead0a0b3da09c64e4225dcc419bfe6f3f45d2a0ab8a2d26339a0908bc3c4b6d729beb76ecf1b4691897b10fa5ec344b8440b9eab81eef4b810f6e65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598a010f858243d661520dcc8d13e8d8d4502290094970f9578722b460cdc8d34d87ebe93f3b3883354e537f5b7e37a264c4a0d449bb3082f001f4ede234365a"} 07:15:12 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:12 INFO - Copying logs to upload dir... 07:15:12 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.957158 ========= master_lag: 0.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-30 07:15:13.364843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:15:13.368443) ========= 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.r2eHyYMieu/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.0LNd81Kar9/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612ee642a246bf3bc8401586841b7387e0a221bc940c7a17a5f57060438c04b5845a46d49ba7e10db7f5daa352b1bd53380e27424c65f06d61a50d2fba9fd54d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ea296c97ead0a0b3da09c64e4225dcc419bfe6f3f45d2a0ab8a2d26339a0908bc3c4b6d729beb76ecf1b4691897b10fa5ec344b8440b9eab81eef4b810f6e65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598a010f858243d661520dcc8d13e8d8d4502290094970f9578722b460cdc8d34d87ebe93f3b3883354e537f5b7e37a264c4a0d449bb3082f001f4ede234365a"} build_url:https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/AF9s39fYRuSJXnzZ6FD3KA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/612ee642a246bf3bc8401586841b7387e0a221bc940c7a17a5f57060438c04b5845a46d49ba7e10db7f5daa352b1bd53380e27424c65f06d61a50d2fba9fd54d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ea296c97ead0a0b3da09c64e4225dcc419bfe6f3f45d2a0ab8a2d26339a0908bc3c4b6d729beb76ecf1b4691897b10fa5ec344b8440b9eab81eef4b810f6e65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598a010f858243d661520dcc8d13e8d8d4502290094970f9578722b460cdc8d34d87ebe93f3b3883354e537f5b7e37a264c4a0d449bb3082f001f4ede234365a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:15:13.400199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:15:13.400550) ========= 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.r2eHyYMieu/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.0LNd81Kar9/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.005231 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:15:13.448794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:15:13.449145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:15:13.449483) ========= ========= Total master_lag: 2.37 =========