builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0316 starttime: 1464056712.59 results: success (0) buildid: 20160523170545 builduid: 491cad26aee545b0b5542859a84ca2f7 revision: c126405491b0ed91cdb4120efbed4159a6eab2ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.592724) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.593123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.593403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.612234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.612551) ========= 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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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-05-23 19:25:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-05-23 19:25:12 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.765046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.765371) ========= 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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.020656 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:12.814210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 19:25:12.814625) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c126405491b0ed91cdb4120efbed4159a6eab2ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c126405491b0ed91cdb4120efbed4159a6eab2ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BWvdjewnRl/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.cQ3HNuGbyE/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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-05-23 19:25:12,885 truncating revision to first 12 chars 2016-05-23 19:25:12,885 Setting DEBUG logging. 2016-05-23 19:25:12,885 attempt 1/10 2016-05-23 19:25:12,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c126405491b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 19:25:13,922 unpacking tar archive at: mozilla-beta-c126405491b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.292756 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 19:25:14.125674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:14.126005) ========= script_repo_revision: c126405491b0ed91cdb4120efbed4159a6eab2ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:14.126396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:14.126688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:14.138946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-05-23 19:25:14.139237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BWvdjewnRl/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.cQ3HNuGbyE/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:25:14 INFO - MultiFileLogger online at 20160523 19:25:14 in /builds/slave/test 19:25:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:25:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:25:14 INFO - {'append_to_log': False, 19:25:14 INFO - 'base_work_dir': '/builds/slave/test', 19:25:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:25:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:25:14 INFO - 'branch': 'Mozilla-Beta', 19:25:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:25:14 INFO - 'config_files': ('talos/mac_config.py',), 19:25:14 INFO - 'default_actions': ('clobber', 19:25:14 INFO - 'read-buildbot-config', 19:25:14 INFO - 'download-and-extract', 19:25:14 INFO - 'populate-webroot', 19:25:14 INFO - 'create-virtualenv', 19:25:14 INFO - 'install', 19:25:14 INFO - 'run-tests'), 19:25:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:25:14 INFO - 'download_minidump_stackwalk': True, 19:25:14 INFO - 'download_symbols': 'ondemand', 19:25:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:25:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:25:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:25:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:25:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:25:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:25:14 INFO - 'installer_path': 'installer.exe', 19:25:14 INFO - 'log_level': 'info', 19:25:14 INFO - 'log_name': 'talos', 19:25:14 INFO - 'log_to_console': True, 19:25:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:25:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:25:14 INFO - 'opt_config_files': (), 19:25:14 INFO - 'pip_index': False, 19:25:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:25:14 INFO - 'cmd': ('bash', 19:25:14 INFO - '-c', 19:25:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:25:14 INFO - 'enabled': True, 19:25:14 INFO - 'halt_on_failure': False, 19:25:14 INFO - 'name': 'check_screen_resolution'},), 19:25:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:25:14 INFO - 'cmd': ('bash', 19:25:14 INFO - '-c', 19:25:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:25:14 INFO - 'enabled': True, 19:25:14 INFO - 'halt_on_failure': False, 19:25:14 INFO - 'name': 'check_screen_resolution'},), 19:25:14 INFO - 'run_cmd_checks_enabled': True, 19:25:14 INFO - 'sps_profile': False, 19:25:14 INFO - 'sps_profile_interval': 0, 19:25:14 INFO - 'suite': 'dromaeojs-e10s', 19:25:14 INFO - 'system_bits': '32', 19:25:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:25:14 INFO - 'title': 't-yosemite-r7-0316', 19:25:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:25:14 INFO - 'use_talos_json': True, 19:25:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:25:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:25:14 INFO - 'work_dir': 'build'} 19:25:14 INFO - ##### 19:25:14 INFO - ##### Running clobber step. 19:25:14 INFO - ##### 19:25:14 INFO - Running pre-action listener: _resource_record_pre_action 19:25:14 INFO - Running main action method: clobber 19:25:14 INFO - rmtree: /builds/slave/test/build 19:25:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:25:15 INFO - Running post-action listener: _resource_record_post_action 19:25:15 INFO - ##### 19:25:15 INFO - ##### Running read-buildbot-config step. 19:25:15 INFO - ##### 19:25:15 INFO - Running pre-action listener: _resource_record_pre_action 19:25:15 INFO - Running main action method: read_buildbot_config 19:25:15 INFO - Using buildbot properties: 19:25:15 INFO - { 19:25:15 INFO - "project": "", 19:25:15 INFO - "product": "firefox", 19:25:15 INFO - "script_repo_revision": "production", 19:25:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 19:25:15 INFO - "repository": "", 19:25:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 19:25:15 INFO - "buildid": "20160523170545", 19:25:15 INFO - "pgo_build": "False", 19:25:15 INFO - "basedir": "/builds/slave/test", 19:25:15 INFO - "buildnumber": 3, 19:25:15 INFO - "slavename": "t-yosemite-r7-0316", 19:25:15 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:25:15 INFO - "platform": "yosemite_r7", 19:25:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:25:15 INFO - "branch": "mozilla-beta", 19:25:15 INFO - "repo_path": "releases/mozilla-beta", 19:25:15 INFO - "revision": "c126405491b0ed91cdb4120efbed4159a6eab2ea", 19:25:15 INFO - "stage_platform": "macosx64", 19:25:15 INFO - "builduid": "491cad26aee545b0b5542859a84ca2f7", 19:25:15 INFO - "slavebuilddir": "test" 19:25:15 INFO - } 19:25:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 19:25:15 INFO - Running post-action listener: _resource_record_post_action 19:25:15 INFO - ##### 19:25:15 INFO - ##### Running download-and-extract step. 19:25:15 INFO - ##### 19:25:15 INFO - Running pre-action listener: _resource_record_pre_action 19:25:15 INFO - Running main action method: download_and_extract 19:25:15 INFO - mkdir: /builds/slave/test/build/tests 19:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:25:15 INFO - https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:25:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 19:25:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 19:25:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 19:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 19:25:37 INFO - Downloaded 1241 bytes. 19:25:37 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 19:25:37 INFO - Using the following test package requirements: 19:25:37 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 19:25:37 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:25:37 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 19:25:37 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:25:37 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 19:25:37 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:25:37 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:25:37 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 19:25:37 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 19:25:37 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:25:37 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 19:25:37 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:25:37 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 19:25:37 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:25:37 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 19:25:37 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 19:25:37 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 19:25:37 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 19:25:37 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 19:25: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')]} 19:25:37 INFO - https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 19:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 19:25:39 INFO - Downloaded 17747773 bytes. 19:25:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:25:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:25:42 INFO - Return code: 0 19:25:42 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:25:42 INFO - https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 19:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 19:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 19:25:55 INFO - Downloaded 17747773 bytes. 19:25:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:25:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:25:58 INFO - Return code: 0 19:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:25:58 INFO - https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:25:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 19:25:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 19:25:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 19:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 19:26:00 INFO - Downloaded 10845194 bytes. 19:26:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:26:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:26:00 INFO - Return code: 0 19:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:00 INFO - https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 19:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 19:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 19:26:07 INFO - Downloaded 88417213 bytes. 19:26:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:26:07 INFO - mkdir: /builds/slave/test/properties 19:26:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:26:07 INFO - Writing to file /builds/slave/test/properties/build_url 19:26:07 INFO - Contents: 19:26:07 INFO - build_url:https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg 19:26:09 INFO - Running post-action listener: _resource_record_post_action 19:26:09 INFO - Running post-action listener: set_extra_try_arguments 19:26:09 INFO - ##### 19:26:09 INFO - ##### Running populate-webroot step. 19:26:09 INFO - ##### 19:26:09 INFO - Running pre-action listener: _resource_record_pre_action 19:26:09 INFO - Running main action method: populate_webroot 19:26:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:26:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:26:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:26:09 INFO - '--tppagecycles', 19:26:09 INFO - '7'], 19:26:09 INFO - 'tests': ['tsvgm']}}, 19:26:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:26:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:26:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:26:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:26:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'tests': ['damp', 'tps']}, 19:26:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['damp', 'tps']}, 19:26:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:26:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:26:09 INFO - 'other': {'tests': ['a11yr', 19:26:09 INFO - 'ts_paint', 19:26:09 INFO - 'tpaint', 19:26:09 INFO - 'sessionrestore', 19:26:09 INFO - 'sessionrestore_no_auto_restore', 19:26:09 INFO - 'tabpaint']}, 19:26:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['a11yr', 19:26:09 INFO - 'ts_paint', 19:26:09 INFO - 'tpaint', 19:26:09 INFO - 'sessionrestore', 19:26:09 INFO - 'sessionrestore_no_auto_restore', 19:26:09 INFO - 'tabpaint']}, 19:26:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['a11yr', 19:26:09 INFO - 'ts_paint', 19:26:09 INFO - 'tpaint', 19:26:09 INFO - 'sessionrestore', 19:26:09 INFO - 'sessionrestore_no_auto_restore', 19:26:09 INFO - 'tabpaint']}, 19:26:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['a11yr', 19:26:09 INFO - 'ts_paint', 19:26:09 INFO - 'tpaint', 19:26:09 INFO - 'sessionrestore', 19:26:09 INFO - 'sessionrestore_no_auto_restore', 19:26:09 INFO - 'tabpaint']}, 19:26:09 INFO - 'other_l64': {'tests': ['a11yr', 19:26:09 INFO - 'ts_paint', 19:26:09 INFO - 'tpaint', 19:26:09 INFO - 'sessionrestore', 19:26:09 INFO - 'sessionrestore_no_auto_restore', 19:26:09 INFO - 'tabpaint']}, 19:26:09 INFO - 'other_nol64': {'tests': ['a11yr', 19:26:09 INFO - 'ts_paint', 19:26:09 INFO - 'tpaint', 19:26:09 INFO - 'sessionrestore', 19:26:09 INFO - 'sessionrestore_no_auto_restore', 19:26:09 INFO - 'tabpaint']}, 19:26:09 INFO - 'svgr': {'tests': ['tsvgx', 19:26:09 INFO - 'tsvgr_opacity', 19:26:09 INFO - 'tart', 19:26:09 INFO - 'tscrollx', 19:26:09 INFO - 'cart']}, 19:26:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['tsvgx', 19:26:09 INFO - 'tsvgr_opacity', 19:26:09 INFO - 'tart', 19:26:09 INFO - 'tscrollx', 19:26:09 INFO - 'cart']}, 19:26:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'tests': ['tp5o']}, 19:26:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'talos_options': ['--e10s'], 19:26:09 INFO - 'tests': ['tp5o']}, 19:26:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'talos_options': ['--xperf_path', 19:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:09 INFO - 'tests': ['tp5n']}, 19:26:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:09 INFO - 'talos_options': ['--e10s', 19:26:09 INFO - '--xperf_path', 19:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:09 INFO - 'tests': ['tp5n']}}, 19:26:09 INFO - 'talos.zip': {'path': '', 19:26:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:26:09 INFO - Running post-action listener: _resource_record_post_action 19:26:09 INFO - ##### 19:26:09 INFO - ##### Running create-virtualenv step. 19:26:09 INFO - ##### 19:26:09 INFO - Running pre-action listener: _resource_record_pre_action 19:26:09 INFO - Running main action method: create_virtualenv 19:26:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:26:09 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 19:26:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:26:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:26:09 INFO - Using real prefix '/tools/python27' 19:26:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:26:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:26:13 INFO - Installing pip.................done. 19:26:13 INFO - Return code: 0 19:26:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:26:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:13 INFO - 'HOME': '/Users/cltbld', 19:26:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:13 INFO - 'LOGNAME': 'cltbld', 19:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:13 INFO - 'MOZ_NO_REMOTE': '1', 19:26:13 INFO - 'NO_EM_RESTART': '1', 19:26:13 INFO - 'PAGER': '/bin/cat', 19:26:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:13 INFO - 'PWD': '/builds/slave/test', 19:26:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:13 INFO - 'SHELL': '/bin/bash', 19:26:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:13 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:13 INFO - 'USER': 'cltbld', 19:26:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:13 INFO - 'XPC_FLAGS': '0x0', 19:26:13 INFO - 'XPC_SERVICE_NAME': '0', 19:26:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:13 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 19:26:13 INFO - Cleaning up... 19:26:13 INFO - Return code: 0 19:26:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:26:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:13 INFO - 'HOME': '/Users/cltbld', 19:26:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:13 INFO - 'LOGNAME': 'cltbld', 19:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:13 INFO - 'MOZ_NO_REMOTE': '1', 19:26:13 INFO - 'NO_EM_RESTART': '1', 19:26:13 INFO - 'PAGER': '/bin/cat', 19:26:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:13 INFO - 'PWD': '/builds/slave/test', 19:26:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:13 INFO - 'SHELL': '/bin/bash', 19:26:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:13 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:13 INFO - 'USER': 'cltbld', 19:26:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:13 INFO - 'XPC_FLAGS': '0x0', 19:26:13 INFO - 'XPC_SERVICE_NAME': '0', 19:26:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:14 INFO - Downloading/unpacking psutil>=0.7.1 19:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:26:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:17 INFO - Installing collected packages: psutil 19:26:17 INFO - Running setup.py install for psutil 19:26:17 INFO - building 'psutil._psutil_osx' extension 19:26:17 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 19:26:17 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 19:26:17 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 19:26:17 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 19:26:17 INFO - building 'psutil._psutil_posix' extension 19:26:17 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 19:26:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:26:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:26:17 INFO - ^ 19:26:17 INFO - 1 warning generated. 19:26:17 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 19:26:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:17 INFO - Successfully installed psutil 19:26:17 INFO - Cleaning up... 19:26:18 INFO - Return code: 0 19:26:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:26:18 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')]} 19:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:18 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')]} 19:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:18 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:18 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.0.0'] in /builds/slave/test/build 19:26:18 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.0.0 19:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:18 INFO - 'HOME': '/Users/cltbld', 19:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:18 INFO - 'LOGNAME': 'cltbld', 19:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:18 INFO - 'MOZ_NO_REMOTE': '1', 19:26:18 INFO - 'NO_EM_RESTART': '1', 19:26:18 INFO - 'PAGER': '/bin/cat', 19:26:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:18 INFO - 'PWD': '/builds/slave/test', 19:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:18 INFO - 'SHELL': '/bin/bash', 19:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:18 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:18 INFO - 'USER': 'cltbld', 19:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:18 INFO - 'XPC_FLAGS': '0x0', 19:26:18 INFO - 'XPC_SERVICE_NAME': '0', 19:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:26:20 INFO - Installing collected packages: mozsystemmonitor 19:26:20 INFO - Running setup.py install for mozsystemmonitor 19:26:20 INFO - Successfully installed mozsystemmonitor 19:26:20 INFO - Cleaning up... 19:26:21 INFO - Return code: 0 19:26:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:21 INFO - 'HOME': '/Users/cltbld', 19:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:21 INFO - 'LOGNAME': 'cltbld', 19:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:21 INFO - 'MOZ_NO_REMOTE': '1', 19:26:21 INFO - 'NO_EM_RESTART': '1', 19:26:21 INFO - 'PAGER': '/bin/cat', 19:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:21 INFO - 'PWD': '/builds/slave/test', 19:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:21 INFO - 'SHELL': '/bin/bash', 19:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:21 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:21 INFO - 'USER': 'cltbld', 19:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:21 INFO - 'XPC_FLAGS': '0x0', 19:26:21 INFO - 'XPC_SERVICE_NAME': '0', 19:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:23 INFO - Downloading blobuploader-1.2.4.tar.gz 19:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:26:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:26:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:24 INFO - Downloading docopt-0.6.1.tar.gz 19:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:26:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:26:24 INFO - Running setup.py install for blobuploader 19:26:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:26:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:26:25 INFO - Running setup.py install for requests 19:26:25 INFO - Running setup.py install for docopt 19:26:25 INFO - Successfully installed blobuploader requests docopt 19:26:25 INFO - Cleaning up... 19:26:25 INFO - Return code: 0 19:26:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:25 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 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:25 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 19:26:25 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 19:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:25 INFO - 'HOME': '/Users/cltbld', 19:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:25 INFO - 'LOGNAME': 'cltbld', 19:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:25 INFO - 'MOZ_NO_REMOTE': '1', 19:26:25 INFO - 'NO_EM_RESTART': '1', 19:26:25 INFO - 'PAGER': '/bin/cat', 19:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:25 INFO - 'PWD': '/builds/slave/test', 19:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:25 INFO - 'SHELL': '/bin/bash', 19:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:25 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:25 INFO - 'USER': 'cltbld', 19:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:25 INFO - 'XPC_FLAGS': '0x0', 19:26:25 INFO - 'XPC_SERVICE_NAME': '0', 19:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-20krgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-xBo1Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-2s7DJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-tnnYPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-1pW3eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-6G7YVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-5BD3QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-vPkynK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:26 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-NaKSI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-RTfwJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-yOBBzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-RV332U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-nAyvTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-vJI2xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-69BvfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-rBo_Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:27 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-cqslXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:26:27 INFO - Running setup.py install for manifestparser 19:26:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Running setup.py install for mozcrash 19:26:28 INFO - Running setup.py install for mozdebug 19:26:28 INFO - Running setup.py install for mozdevice 19:26:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Running setup.py install for mozfile 19:26:28 INFO - Running setup.py install for mozhttpd 19:26:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Running setup.py install for mozinfo 19:26:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:26:28 INFO - Running setup.py install for mozInstall 19:26:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozleak 19:26:29 INFO - Running setup.py install for mozlog 19:26:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for moznetwork 19:26:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozprocess 19:26:29 INFO - Running setup.py install for mozprofile 19:26:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:26:29 INFO - Running setup.py install for mozrunner 19:26:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:26:30 INFO - Running setup.py install for mozscreenshot 19:26:30 INFO - Running setup.py install for moztest 19:26:30 INFO - Running setup.py install for mozversion 19:26:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:26:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:26:30 INFO - Cleaning up... 19:26:30 INFO - Return code: 0 19:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26: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')]} 19:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26: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')]} 19:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:30 INFO - 'HOME': '/Users/cltbld', 19:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:30 INFO - 'LOGNAME': 'cltbld', 19:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:30 INFO - 'MOZ_NO_REMOTE': '1', 19:26:30 INFO - 'NO_EM_RESTART': '1', 19:26:30 INFO - 'PAGER': '/bin/cat', 19:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:30 INFO - 'PWD': '/builds/slave/test', 19:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:30 INFO - 'SHELL': '/bin/bash', 19:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:30 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:30 INFO - 'USER': 'cltbld', 19:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:30 INFO - 'XPC_FLAGS': '0x0', 19:26:30 INFO - 'XPC_SERVICE_NAME': '0', 19:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:30 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-oWKkEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:30 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Exm20A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:30 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)) 19:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:30 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-21jDx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-HjNJC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-A5kdo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-zwyC0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-2po4QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-AN06tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-ZzvrSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-6gFWOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-YWTyjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:31 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)) 19:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:31 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-NP_aTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:32 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)) 19:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:32 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-BBESh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:32 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-6OIbz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:32 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)) 19:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:32 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-DNJiaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:32 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-C1kaGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:32 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-n_hNJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:32 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)) 19:26:32 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)) 19:26:32 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)) 19:26:32 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)) 19:26:32 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)) 19:26:32 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)) 19:26:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:34 INFO - Downloading blessings-1.6.tar.gz 19:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:26:35 INFO - Installing collected packages: blessings 19:26:35 INFO - Running setup.py install for blessings 19:26:35 INFO - Successfully installed blessings 19:26:35 INFO - Cleaning up... 19:26:35 INFO - Return code: 0 19:26:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:26:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:35 INFO - Reading from file tmpfile_stdout 19:26:35 INFO - Current package versions: 19:26:35 INFO - blessings == 1.6 19:26:35 INFO - blobuploader == 1.2.4 19:26:35 INFO - docopt == 0.6.1 19:26:35 INFO - manifestparser == 1.1 19:26:35 INFO - mozInstall == 1.12 19:26:35 INFO - mozcrash == 0.17 19:26:35 INFO - mozdebug == 0.1 19:26:35 INFO - mozdevice == 0.48 19:26:35 INFO - mozfile == 1.2 19:26:35 INFO - mozhttpd == 0.7 19:26:35 INFO - mozinfo == 0.9 19:26:35 INFO - mozleak == 0.1 19:26:35 INFO - mozlog == 3.1 19:26:35 INFO - moznetwork == 0.27 19:26:35 INFO - mozprocess == 0.22 19:26:35 INFO - mozprofile == 0.28 19:26:35 INFO - mozrunner == 6.11 19:26:35 INFO - mozscreenshot == 0.1 19:26:35 INFO - mozsystemmonitor == 0.0 19:26:35 INFO - moztest == 0.7 19:26:35 INFO - mozversion == 1.4 19:26:35 INFO - psutil == 3.1.1 19:26:35 INFO - requests == 1.2.3 19:26:35 INFO - wsgiref == 0.1.2 19:26:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:35 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 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:35 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 19:26:35 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 19:26:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:35 INFO - 'HOME': '/Users/cltbld', 19:26:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:35 INFO - 'LOGNAME': 'cltbld', 19:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:35 INFO - 'MOZ_NO_REMOTE': '1', 19:26:35 INFO - 'NO_EM_RESTART': '1', 19:26:35 INFO - 'PAGER': '/bin/cat', 19:26:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:35 INFO - 'PWD': '/builds/slave/test', 19:26:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:35 INFO - 'SHELL': '/bin/bash', 19:26:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:35 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:35 INFO - 'USER': 'cltbld', 19:26:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:35 INFO - 'XPC_FLAGS': '0x0', 19:26:35 INFO - 'XPC_SERVICE_NAME': '0', 19:26:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 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)) 19:26:35 INFO - Cleaning up... 19:26:35 INFO - Return code: 0 19:26:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:26:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:26:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:35 INFO - 'HOME': '/Users/cltbld', 19:26:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:35 INFO - 'LOGNAME': 'cltbld', 19:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:35 INFO - 'MOZ_NO_REMOTE': '1', 19:26:35 INFO - 'NO_EM_RESTART': '1', 19:26:35 INFO - 'PAGER': '/bin/cat', 19:26:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:35 INFO - 'PWD': '/builds/slave/test', 19:26:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:35 INFO - 'SHELL': '/bin/bash', 19:26:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:35 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:35 INFO - 'USER': 'cltbld', 19:26:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:35 INFO - 'XPC_FLAGS': '0x0', 19:26:35 INFO - 'XPC_SERVICE_NAME': '0', 19:26:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:36 INFO - Downloading/unpacking jsonschema 19:26:36 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 19:26:36 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 19:26:36 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 19:26:36 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 19:26:36 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 19:26:36 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 19:26:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:26:38 INFO - Downloading/unpacking functools32 (from jsonschema) 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26:38 INFO - Downloading functools32-3.2.3-2.tar.gz 19:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:26:39 INFO - warning: no files found matching '*.txt' 19:26:39 INFO - no previously-included directories found matching 'build' 19:26:39 INFO - no previously-included directories found matching 'dist' 19:26:39 INFO - no previously-included directories found matching '.git*' 19:26:39 INFO - Installing collected packages: jsonschema, functools32 19:26:39 INFO - Running setup.py install for functools32 19:26:39 INFO - warning: no files found matching '*.txt' 19:26:39 INFO - no previously-included directories found matching 'build' 19:26:39 INFO - no previously-included directories found matching 'dist' 19:26:39 INFO - no previously-included directories found matching '.git*' 19:26:39 INFO - Successfully installed jsonschema functools32 19:26:39 INFO - Cleaning up... 19:26:39 INFO - Return code: 0 19:26:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:26:39 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')]} 19:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:39 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')]} 19:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:39 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ba0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc3bc9c340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, '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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 19:26:39 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', 'flake8'] in /builds/slave/test/build 19:26:39 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 flake8 19:26:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:26:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:39 INFO - 'HOME': '/Users/cltbld', 19:26:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:39 INFO - 'LOGNAME': 'cltbld', 19:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:39 INFO - 'MOZ_NO_REMOTE': '1', 19:26:39 INFO - 'NO_EM_RESTART': '1', 19:26:39 INFO - 'PAGER': '/bin/cat', 19:26:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:39 INFO - 'PWD': '/builds/slave/test', 19:26:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:39 INFO - 'SHELL': '/bin/bash', 19:26:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:26:39 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:26:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:39 INFO - 'USER': 'cltbld', 19:26:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:39 INFO - 'XPC_FLAGS': '0x0', 19:26:39 INFO - 'XPC_SERVICE_NAME': '0', 19:26:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:39 INFO - Downloading/unpacking flake8 19:26:39 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 19:26:39 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 19:26:39 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 19:26:39 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 19:26:39 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 19:26:39 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 19:26:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:26:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:26:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:42 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 19:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:26:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:26:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:26:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:26:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:26:43 INFO - no previously-included directories found matching 'docs/_build' 19:26:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:26:43 INFO - Running setup.py install for pep8 19:26:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:26:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:26:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:26:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:26:43 INFO - no previously-included directories found matching 'docs/_build' 19:26:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:26:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:26:43 INFO - Cleaning up... 19:26:43 INFO - Return code: 0 19:26:43 INFO - Running post-action listener: _resource_record_post_action 19:26:43 INFO - Running post-action listener: _start_resource_monitoring 19:26:43 INFO - Starting resource monitoring. 19:26:43 INFO - ##### 19:26:43 INFO - ##### Running install step. 19:26:43 INFO - ##### 19:26:43 INFO - Running pre-action listener: _resource_record_pre_action 19:26:43 INFO - Running main action method: install 19:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:44 INFO - Reading from file tmpfile_stdout 19:26:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:26:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:26:44 INFO - Reading from file tmpfile_stdout 19:26:44 INFO - Output received: 19:26:44 INFO - Usage: mozinstall [options] installer 19:26:44 INFO - Options: 19:26:44 INFO - -h, --help show this help message and exit 19:26:44 INFO - -d DEST, --destination=DEST 19:26:44 INFO - Directory to install application into. [default: 19:26:44 INFO - "/builds/slave/test"] 19:26:44 INFO - --app=APP Application being installed. [default: firefox] 19:26:44 INFO - mkdir: /builds/slave/test/build/application 19:26:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:27:06 INFO - Reading from file tmpfile_stdout 19:27:06 INFO - Output received: 19:27:06 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:27:06 INFO - Running post-action listener: _resource_record_post_action 19:27:06 INFO - ##### 19:27:06 INFO - ##### Running run-tests step. 19:27:06 INFO - ##### 19:27:06 INFO - Running pre-action listener: _resource_record_pre_action 19:27:06 INFO - Running main action method: run_tests 19:27:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:27:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:27:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:27:06 INFO - 2016-05-23 19:27:06.860 screenresolution[1930:10530] starting screenresolution argv=screenresolution get 19:27:06 INFO - 2016-05-23 19:27:06.863 screenresolution[1930:10530] Display 0: 1600x1200x32@60 19:27:06 INFO - 2016-05-23 19:27:06.868 screenresolution[1931:10533] starting screenresolution argv=screenresolution list 19:27:06 INFO - Available Modes on Display 0 19:27:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:27:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:27:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:27:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:27:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:27:07 INFO - Intel Iris: 19:27:07 INFO - Chipset Model: Intel Iris 19:27:07 INFO - Type: GPU 19:27:07 INFO - Bus: Built-In 19:27:07 INFO - VRAM (Dynamic, Max): 1536 MB 19:27:07 INFO - Vendor: Intel (0x8086) 19:27:07 INFO - Device ID: 0x0a2e 19:27:07 INFO - Revision ID: 0x0009 19:27:07 INFO - Displays: 19:27:07 INFO - Display: 19:27:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:27:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:27:07 INFO - Display Serial Number: 1600x1200 60 19:27:07 INFO - Main Display: Yes 19:27:07 INFO - Mirror: Off 19:27:07 INFO - Online: Yes 19:27:07 INFO - Rotation: Supported 19:27:07 INFO - Return code: 0 19:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:27:07 INFO - Python 2.7.3 19:27:07 INFO - Return code: 0 19:27:07 INFO - grabbing minidump binary from tooltool 19:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:27:07 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a44d30>, '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 0x1038a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a3bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:27:07 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 19:27:07 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 19:27:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:27:07 INFO - Return code: 0 19:27:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:27:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:27:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:27:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:27:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:27:08 INFO - Return code: 0 19:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0316 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BWvdjewnRl/Render', 19:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:08 INFO - 'HOME': '/Users/cltbld', 19:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:08 INFO - 'LOGNAME': 'cltbld', 19:27:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:27:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:08 INFO - 'MOZ_NO_REMOTE': '1', 19:27:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:27:08 INFO - 'NO_EM_RESTART': '1', 19:27:08 INFO - 'PAGER': '/bin/cat', 19:27:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:08 INFO - 'PWD': '/builds/slave/test', 19:27:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:08 INFO - 'SHELL': '/bin/bash', 19:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cQ3HNuGbyE/Listeners', 19:27:08 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 19:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:08 INFO - 'USER': 'cltbld', 19:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:08 INFO - 'XPC_FLAGS': '0x0', 19:27:08 INFO - 'XPC_SERVICE_NAME': '0', 19:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:27:08 INFO - mozversion application_buildid: 20160523170545 19:27:08 INFO - mozversion application_changeset: c126405491b0ed91cdb4120efbed4159a6eab2ea 19:27:08 INFO - mozversion application_display_name: Firefox 19:27:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:27:08 INFO - mozversion application_name: Firefox 19:27:08 INFO - mozversion application_remotingname: firefox 19:27:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:27:08 INFO - mozversion application_vendor: Mozilla 19:27:08 INFO - mozversion application_version: 47.0 19:27:08 INFO - mozversion platform_buildid: 20160523170545 19:27:08 INFO - mozversion platform_changeset: c126405491b0ed91cdb4120efbed4159a6eab2ea 19:27:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:27:08 INFO - mozversion platform_version: 47.0 19:27:08 INFO - using testdate: 1464056828 19:27:08 INFO - actual date: 1464056828 19:27:08 INFO - starting webserver on 'localhost:49430' 19:27:08 INFO - SUITE-START | Running 2 tests 19:27:08 INFO - TEST-START | dromaeo_css 19:27:08 INFO - operating with platform_type : mac_ 19:27:08 INFO - Initialising browser for dromaeo_css test... 19:27:08 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpNNlaS5/profile http://localhost:49430/getInfo.html) 19:27:11 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 19:27:11 INFO - PROCESS | 1949 | colorDepth:24 19:27:11 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 19:27:11 INFO - PROCESS | 1949 | __metrics 19:27:11 ERROR - PROCESS | 1949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 19:27:11 INFO - TEST-INFO | 1949: exit 0 19:27:11 INFO - Browser initialized. 19:27:11 INFO - Running cycle 1/1 for dromaeo_css test... 19:27:11 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpNNlaS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:23 INFO - PROCESS | 1953 | RSS: Main: 167788544 19:27:23 INFO - PROCESS | 1953 | 19:28:13 INFO - PROCESS | 1953 | 1464056893448 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] 19:30:23 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49430/tests/dromaeo/cssquery-ext.html) 19:30:25 INFO - PROCESS | 1953 | RSS: Main: 178282496 19:30:25 INFO - PROCESS | 1953 | 19:33:27 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-ext.html (next: http://localhost:49430/tests/dromaeo/cssquery-jquery.html) 19:33:27 INFO - PROCESS | 1953 | RSS: Main: 189767680 19:33:27 INFO - PROCESS | 1953 | 19:36:29 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49430/tests/dromaeo/cssquery-mootools.html) 19:36:30 INFO - PROCESS | 1953 | RSS: Main: 192258048 19:36:30 INFO - PROCESS | 1953 | 19:39:31 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49430/tests/dromaeo/cssquery-prototype.html) 19:39:32 INFO - PROCESS | 1953 | RSS: Main: 195096576 19:39:32 INFO - PROCESS | 1953 | 19:42:34 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49430/tests/dromaeo/cssquery-yui.html) 19:42:35 INFO - PROCESS | 1953 | RSS: Main: 195063808 19:42:35 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49430/tests/dromaeo/cssquery-yui.html (next: http://localhost:49430/tests/dromaeo/cssquery-dojo.html) 19:45:37 INFO - PROCESS | 1953 | RSS: Main: 199815168 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | __start_tp_report 19:45:37 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 19:45:37 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 19:45:37 INFO - PROCESS | 1953 | |i|pagename|runs| 19:45:37 INFO - PROCESS | 1953 | |0;dojo.html;2848.700886406927;3629.4374371972353;3650.4889315495825;3671.7613355131916;3686.2443199144177;6004.5796794224425;6016.428439298265;6018.428249316319;6037.366076561963;6038.5471089668235;5942.970285148579;6010.368911264309;6013.278406591216;6030;6033.577649564532;4476.440444944374;5383.300170977767;5417.891642167155;5483.259759932418;5521.199426083215;5098.26075219093;5358.223057656637;5469.972650136744;5472.699001554913;5503.972480137593;4069.633732964033;5431.321084864392;5449.972750136244;5450.56395488362;5483.561315094803;5408.0806262935;5441.673499590018;5452.182172674091;5480.588955828329;5496.725163741797;5284.4187139414635;5329.2006199070065;5444.646098003617;5445.482679145514;5498.560115190775;6007.339192688801;6038.758449662008;6049.939500604982;6059.000264956277;6066.332703402666;6186.783462578833;6229.501639868799;6302.842428939267;6304.338044505353;6405.135306733578;6322.304546499928;6342.587731797418;6343.46080583151;6344.524160687967;6356.809295721136;6107.7556897724035;6119.877602447926;6125.540584456139;6135.110408990671;6138.508919286491;5776.826695199151;6378.968105159444;6463.57986730861;6565.868682626417;6569.67151642416;6210.130581718563;6253.906191407133;6258.468030217391;6259.155014073133;6266.404691554295;6175.69121543921;6347.841303967438;6355;6381.553291269566;6382.968085159638;5184.326037615086;5996.4603185713495;6269.216347956505;6275.341089185661;6283.937160628335;6208.348123447064;6262.780802671976;6281.434670879643;6285.120083188357;6292.307846136921;4934.235193545006;4972.5276098770555;4978.925316120261;4982.551570358685;5035.571976382049;4478.373027776114;4511.278195488706;4525.434320709911;4532.297493888453;4540.182767101887;5660.349059858087;6179.412955769195;6196.938030619636;6219.657918814509;6232.626042437469;6231.3145553989025;6262.812115636538;6295.968520157461;6387.520935929824;6420.839479012969;5042.142835717937;6007.339192688801;6131.254333328352;6203.2556093269095;6234.719437625317;5579.163125531203;5583.832485025456;5622.128570071645;5625.690587017753;5627.015272327327;6384.138141350951;6440.452561532228;6478.643674597943;6650.73397064112;6666.300038495888;6319.052142178526;6337.36626337381;6349.3650634937985;6358.7600417918065;6382.297947225708;6634.369734875179;6640.667966601747;6648.368405001517;6653.434458071119;6676.732930682719;6140.19751335002;6175.104609831459;6248.375162483715;6261.7182226799;6288.811335659938;6300.464460520907;6312.936870631235;6338.904916426165;6340.1123842661145;6346.984482482781;5547.195656629686;6221.09794079865;6237.688115594111;6240.906386404298;6246.781362652286;6159.630422174684;6186.381361863778;6245.843853903689;6247.187865577446;6267.592606480746;4934.5805606523845;5940.851478713067;6150.784722534869;6169.722362493609;6234.220722409699;5430.619856609999;6115.575014303803;6185.8144255672405;6248.4688801452385;6253.437190652863;6129.236538068469;6175.9073613894925;6204.720787564661;6217.844553886189;6251.124842522141 19:45:37 INFO - PROCESS | 1953 | |1;ext.html;513.4300925972171;588.0737837905298;601.7983975368252;616.877283344313;647.2815175155578;39034;40171.99570010747;40234.39648405276;40236.79881600592;40258.59741402585;41705.79147104268;42369.15261694764;42398.36402453958;42432.78783606078;42454.575454245445;9698.757531061709;9948;9954.402735835836;9988.1510071644;10009.999000099968;9783.608655653765;10068.848967265498;10069.697909062703;10079.496025198747;10147.492625368739;10025.147862431666;10129.037741414591;10132.037456441627;10144.543495542719;10177;10019.248556358265;10106.090451859294;10109.898901010969;10118;10132.493375331203;9827.90172098277;9972.252081093948;9988.850167247498;10000.099991000845;10018;40915.7954210227;41186.38220426696;41266.9683257921;41267.7936610315;41400.792996035125;3198.3603279344225;3254.1701866024014;3443.793372397639;3594.370985077627;3967.888991082473;24482.632760508608;28878;29380.559291610643;29491.410171796444;29811.701882981328;2758.0484732767163;2799.692033876272;2829.1936798012466;2904.8547572621283;3035.924101897448;500496;501076;503184;503777.48111259576;504292;48968.75515622399;49732;54095;65314.020289694745;66895.99656005164;48115.27827082597;48465;48493.515064849606;48801.5119848797;48814.75592622014;17116.657666846593;17225.74161387555;17250;17376;17438.12809359527;13753;13817.861821381859;13848.930755346159;13891.79162312566;13894.305284735723;15801.841981580037;15859.969102008563;16198.919005404898;16206.59483512898;16241.431549895933;5700.657960522382;6255.530835187288;6631.767888123893;6668.533202675863;6691.397774200345;1045.3414348960107;1046.759245373553;1063.1919740996898;1132.6828488023202;1160.6344001639625;30730.69269307323;30809.69190308113;31179.68820311768;31355.84322078375;31644.683553164636;1153.1236260441956;1183.6863231243726;1220.0605533738972;1235.2397833087814;1256.3592567790492;14337.928310358382;15116.470923517843;15839.52481425559;15848.68302633941;16242;543373;543628;545843;548590;552181;62152;62344;62683.686581567716;62725.68637156785;62735.43161421001;1531.157863175249;1549.132485807951;1564.569743320596;1566.0525382143867;1570.9135997520245;29826.254343641584;30964.69035309708;31709.8414507926;32118.83940580282;33284.500732488545;58264.12603810862;59397.703011484664;59458.51353716192;59595.10607340807;63199.052014218905;400842.9957850192;408390.95804521977;412402;412484;415603;41585;41807.1638567233;42266.94332641709;43065.569344306154;43671.56328436675;47389.81525461753;47656.76171619258;47785.76107119442;48209.27686084641;48773.268400974724;38991.6100838988;39594.60405395909;39783.80108099441;40133.397999029454;40887.1822563553;28937.42125157443;38881.80559097186;39868.80393588197;40400.595994039686;40583.59416405916;36559.08602284964;37742.43386349262;38701.6129838698;39426.422943083104;39974.60025399709;32831.83584082064;33405.83297083499;33627.83186084054;33915.32169356648;34644.6142154311;26482.735172648026;26499.602505962812;26560.335991600365;26719;27142.914283429232 19:45:37 INFO - PROCESS | 1953 | |2;jquery.html;328.4072249589491;343.80059565452035;374.73581125306646;382.9559600645925;392.7270546969857;19713.21147154114;20216.898915505437;20619.587608247824;20811;20827;17344.392946246884;19126.426207213804;20637.690434643493;21228.99999999996;21231;5427.6472029318165;5650.321961364642;5656.066748986433;5660.490555849972;5686.09022556391;5386.353637563498;5520.723963801794;5536.114221724525;5536.75084621191;5581.776728930859;5585.218069470277;5587.972060139694;5619.887602247953;5643.8024669136585;5669.971650141764;5484.314460692393;5644.238027866227;5653.1520271959125;5875.647461152302;6153.446189842935;5407.83776486706;5408;5436.456354364572;5438.129899216146;5442.591805614556;12975.02687298447;13494.865051349558;13552.728945421037;13555.525556605471;22386.328410147722;2071.958560828775;2088.4361222469847;2096.67501537262;2217.977820221793;2263.1173842201556;10235.846462303072;10315.865254821963;10331.32846364984;12981;15024.699506009818;1772.2910835665837;1777.2091419318408;1796.7035439152523;1808.6744386010512;1812.746215529827;92462;99331.50334248427;110431.44784276107;116861.83138168594;116996.66006679904;11396.373199473943;11661;11729.765404691858;11815.468303926344;12012.459439325252;14405.06367086136;14410.927945360207;14411.495597654031;14442.494512692005;14457.92771036138;8846.734597962071;8954.507502087448;9010.27917766577;9019.413738107001;9122.81754364909;8909.73270801877;8933.73198804024;8967.417117887317;9126.954365228132;9344.065593440602;4436.245838207513;4444.355568442623;4581.5647513486165;4633.351330813689;4646.326282688991;1693.9661206775795;1861.9534511637046;1922.432882299697;1945.8248757611882;1962.6663467210608;947.8436058050345;974.449436068619;985.4284514981293;1022.9232807539464;1174.4949671641104;18652.160652770657;20947;21054.947252637307;21611.243606473698;22128.114875404804;1019.5463018956493;1020.4897551224387;1073.5544748929108;1097.8243481042996;1110.3337997201616;11683.415829208505;11707;11759.176857620056;11760.58837940685;11767.23512971654;695114.5244273746;704221;713233;718401;718508;129632.35183824209;129933.70066299404;131219;135289.3235533816;135974;892.3708785306344;947.9335747284305;963.3786207896007;1066.9780765449584;1068;18636.906815465834;19022.904885475484;19144.71282930785;19166.808331917062;19565.217391304188;54832.629184270714;54903;55000.72499637476;56686.433135668114;57752.71123644355;80795;81051;83340.58329708556;83638;85005;6524.445422139172;8313.916860831556;8350.164983501601;8368.66525339004;8634.56827158627;8031.237032481905;12761.553345632858;13445.529406470727;13745.518906838213;13842.65393365174;11457;11845;12042.879571204527;12101.939490302491;12219.51121955112;11565.248258863483;11590.768184636428;11658;11829.704257393634;12131.272123672608;11865.5847045353;11963.64109076729;12055.97524210452;12067.517299307929;12342.074344424025;8269.255766981001;8301.875471867806;8364.790880228044;8520.74437766868;8699.608517616849;11888.34614096233;11889.346085965355;11991.64025079249;12011.399430028288;12150.756984860076 19:45:37 INFO - PROCESS | 1953 | |3;mootools.html;1437.6621493948924;1650.9917450412747;1830.9359172428967;1937.176699902541;2057.393069044632;8356.456830306026;8899.733008009754;9040.638374465021;9220.616907463884;9267.675631352904;8886.022537520868;8906.242969347613;8977.236934860544;8987.730368088967;9128.224100951427;2585.5216784894806;2618.8035897307777;2621.0302188190394;2621.0564196889104;2630.8816103275303;2601.7398260173927;2657.109868194157;2662.840229586231;2667.333166708323;2668.8665566721684;2592.922212333633;2606.7653911147995;2637.630731697564;2641.44529648774;2641.9075332363373;2597.06505657963;2605.5049540587324;2617.9607305890427;2625.8161928665;2627.2249686342575;2587.663603731503;2613.8431694098417;2620.6593142891493;2656.53510635638;2668.786497080229;9245.07549245077;9260.25917926571;9287.814243715087;9321.021292764297;9323.44059356434;5857.179994800731;5909.793157239519;5930.199423077873;5975.940240597582;5986.132010858445;3753.512043434336;3826.4642949987024;3830.540335159799;3835.712321575865;3863.536375634914;1078.1428764132534;1080.778440419712;1083.6183865571381;1126.2116518437126;1133.2124173699283;12234.510619575207;12283.324417157142;12339.5064197432;12388.504459821595;12397.62807115779;4304.80628371724;5172.844814655567;5190.506901844319;5233.973830130901;5290.709011004432;10462.895371046345;10476.842847357295;10562;10646.946765266124;10677.199210059121;5088.796448142107;5677.659340439587;5708.143778433268;5750.137479378127;5768.855778605568;4396.736195828261;4684.6252299816615;5059.8988020239385;5123.8719032023755;5128.8461346159675;3529.170644898447;4151.543330233671;4231.449911511545;4272.9359059614135;4281.807318670667;1368.8494265630773;1388.430743395203;1391.4851504943235;1397.0918902713317;1401.8668226518464;1304.39345704248;1349.6760777413547;1356.9321533923264;1385.591250581081;1446.7178900114377;7958.681652733826;8494.447860889146;8518.105598912025;8542.145785421408;8558.229759321566;466.8412739668529;532.1830989431204;535.4859335038407;539.5494761873879;553.195101127866;6330.525210609223;6347.936520634827;6373.776917807854;6409.166808314889;6410.230772307353;10763.623273185402;11115.333080015225;11152.888471115184;11197.66407007791;11252.26860254081;10760.946195268974;11048.171387145996;11062.280951738112;11150.052245559218;11192.888071119185;8622.137786221454;8657.350698697497;8691.565421728888;8697.608607612672;8713.477191368538;8067.112617612175;8149.7147599833725;8194.426390152632;8216.46592971455;8250.422470427253;9612.038796120332;9753.707388778348;9860.161886239463;9974;10011.399316041061;10031.247656425943;10188.490575471049;10219.1824654026;10311.690649280534;10370.740731481774;7788.182240864628;7848.175941526058;7853.1361550228285;7872.094709108297;7903.249191326815;8517.659293628185;8526.232639062515;8605.139486051345;8651.437656552303;8667.566621668766;7495.40036797044;7569.697212111454;7629.7329593463965;7638.121616014229;7804.804879878048;7405.888911666437;7476.25237476248;7484.176740558425;7571.280728330799;7584.734534291273;7310.720623890691;7918.089419716806;7971.123176450702;7988.081370642451;7989.2809647132035;6848.9657551711925;7102.857942841218;7274.454415918722;7283.2352602975925;7314.670839812327;7418.666160022704;7432.814179645552;7473.8878916817375;7489.288517591038;7490.176080631018 19:45:37 INFO - PROCESS | 1953 | |4;prototype.html;299.13997257883585;342.52218155672836;345.2800910102438;346.7693983500972;349.3414912889203;7033.156021277441;7043.190033146183;7060.082189315394;7075.009498670184;7119.67961441735;7016.894746578805;7038.824029399268;7040.401565866908;7051.717931282743;7073.858522829553;3927.9018024549473;4061.878143655695;5199.454057323983;5204.219367094928;5253.684778913258;5169.3279873616375;5179.585633149339;5185.948140518603;5216.295800067;5240.213967904807;5118.360204974379;5125.333706618135;5132.486751324856;5138.691678499284;5148.3564554430695;5131.307273518065;5139.25480805283;5150.61370397218;5160.509751573594;5164.251183578398;4435.556444355571;4436.534163912775;4450.221211288044;4458.95214624563;4544.613707834838;5498.917516237259;6421.101045853584;6514.218293804726;6701.497387695942;6716.597004179716;5820.476157145878;5835.912461313042;5874.588778785486;5900.7934722284945;5951.2858456985;6000.0999850022845;6695.564788288746;6781.321867813229;7442.702291908371;7451.888221676679;4726.1020406122725;4728.739919304437;4730.172219861511;4731.077439899221;4737.692050016738;7816.6091695415;7905.644246008944;7909.960450197712;7916.406269529751;7939.841203175904;4577.473590537064;4706.95293047072;4714.693544919569;4718.386609740781;4727.101850648434;4230.175115852441;4615.330777037378;4743.217369134054;4803.327534145223;4816.446108697544;5771.509421699118;5838.678872662044;5877.47102760745;5887.852803679856;5889.793857215062;6065.605735627259;7424.554526728413;7451.515651482637;7452.105747310249;7483.962580187173;1666.7333226683672;1685.7134287171211;1689.3327135781544;1691.8900271482314;1692.433034933311;1044.1385856668278;1072.6781965410346;1079.740862193068;1084.1922767538235;1092.6940456672144;6931.549449285781;6962.686679099453;6985.511014229057;6988.19635741886;7000.579965202104;7490.700371985168;7634.580098094658;7661.655225514865;7666.118396384376;7681.1934746850775;7031.578105313595;7210.819729506804;7215.025971493887;7265.200827908926;7273.636318184175;4093.488313960755;4115.156392939441;4118.073433477503;4120.423140760296;4139.668826493873;8099.433039687166;8220;8232.711855085163;8239.835203295901;8247;7620.237976202447;7681.731139410093;8000.559969201633;8017.919820801834;8054.194580541899;8150.551719655476;8186.0586032605825;8196.30331421824;8196.42625016243;8210.835783284181;6483;7757.961210193913;7762.805929851799;7793.2596403341595;7794.805129871798;6157.384261573807;7415.295546923034;7557;7619.238076192337;7649;7935.841283174189;8201.343892488467;8209.917900820916;8229.05365882931;8230;3651.867920944516;4277.786110694515;4766.213574760264;4775.140474714584;4779.498152693917;6196.442320191204;7462.4776265660885;7742.7677169685;7761.495502792301;7761.805954851174;7421;7437.665305061177;7443.888341674771;7445.994790703402;7460.4031677466755;7176;7548;7548.773536793905;7549.50928189666;7632.69469221225;5963.642181469126;7282.45381596393;7358.816029599303;7376.114866216089;7384.593847338448;6609.603423794395;7019.403350715246;7531.661075251517;7539.2083831199125;7574.659140338587;7184.389326907271;7272.490925635367;7375.852482950419;7388.778336649909;7407.59258240802 19:45:37 INFO - PROCESS | 1953 | |5;yui.html;699.7690762048522;725.1044959475047;736.4513437489071;752.5328488530828;760.4258784617613;15323.310451029702;15518.456854010112;15578.688426231469;15585.688286234268;15677.137757423337;14267.643308917282;14274.500392486265;16399;16727.91636041818;16767.748483772753;818.811673315135;825.3562221467265;965.8309795785744;986.1223511075149;988.8170688422665;866.7356456280831;977.6822532676908;978.8531720241949;986.3145114145672;988.4069558265055;880.7754022724197;1041.9062284394404;1050.5115121468516;1050.8738951325852;1054.7099547624389;997.670768646345;1013.5742987945081;1038.7403149212696;1041.245097304452;1053.773438710677;749.3218637133403;760.5550752809557;764.5718397697308;780.7111368793526;781.800640836583;15680.137592432411;15762.448314309058;15896.76154857678;15968.920155399148;16008.199590020453;12733.61799146027;13021.739565208738;13064.477420903153;13144.605661830064;13179.802302965463;10370.429626370547;10388.740281492948;10603.310784799041;10639.148868090535;10650.627228047058;3526.1008442847165;3592.9820350898076;3612.548431446069;3617.963820361815;3798.0694729791103;84071;84262.57868710678;85996.14003859943;86636.13363866344;86850.13149868547;9577.664781732607;9755.9024409755;9804.36271642341;9806.705798826046;9948.502574871227;22308.77301748387;22454.550908982055;22456.43858903508;22473.550528989657;22636.094556217566;7660.310572048543;7703.653335599912;7705.22947705225;7828.334591559667;7911.367090632851;4127.009517715786;4185.121124563815;4218.894527636834;4228.577142285747;4256.9574304257185;3734.1971476132762;3790.8294126764363;3798.0884587699306;3807.4669546263544;3810.0855794609092;666.2504682232488;680.9012693159464;681.8670359279992;690.2372877969872;690.4579904774728;575.194727381669;598.9341172471024;619.665380694429;633.5660072850112;634.4892361648917;8495.447795893371;8506.447080939719;8544.74365769028;8563.743087707378;8647.048824629286;542.9837104886859;602.0999347477865;617.4350469320522;630.0800830787102;632.9430351268408;3823.4073718573663;3898.6491215790716;4032.6572241359227;4043.838246470108;4073.2260870434525;77888.44223115506;79810.60568182963;98420;98637.02725945441;100036;82640.17359826445;83019;83089.58455207806;83219;83751.16248837434;49144.754276229105;69193;69552.65223673951;71033;71863.2813671867;7030.613316267654;8499.74500764978;8870.467771933705;8896;8963.910360896307;51119;52217.477825222784;52469.75302469875;53273.4672653284;53303;47526;73423.63288183739;73659;74121.6293918527;74957.62521187359;10701.19741019411;10968.506417211085;11083.445827708421;11397.487113079766;11595.304281743123;11918.940405297919;11944.617885212056;12108.93945530302;12183.147179697691;12440.066994975594;11631.76736465283;11753.412329383667;11804.881951180721;12010.219335743148;12021.278723276631;11479.942600286946;11764.176507644725;11771.705707357041;12026.218295810744;12136.393180341125;9700.272479564203;11449.48477318506;11480.96671299587;11529.82705259405;11857.940710296394;9537.332386732862;9549.90450095518;9655.565499552396;9706.563204655666;9920.305578609428;9725.854112188465;10071;10082.596696132367;10098.343607665478;10154.949225253826 19:45:37 INFO - PROCESS | 1953 | __end_tp_report 19:45:37 INFO - PROCESS | 1953 | __start_cc_report 19:45:37 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,357 19:45:37 INFO - PROCESS | 1953 | __end_cc_report 19:45:37 INFO - PROCESS | 1953 | __startTimestamp1464057937627__endTimestamp 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | ------- Summary: start ------- 19:45:37 INFO - PROCESS | 1953 | Number of tests: 6 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5883.69 Median:6175.10 stddev:672.38 (10.9%) stddev-sans-first:630.88 19:45:37 INFO - PROCESS | 1953 | Values: 2848.7 3629.4 3650.5 3671.8 3686.2 6004.6 6016.4 6018.4 6037.4 6038.5 5943.0 6010.4 6013.3 6030.0 6033.6 4476.4 5383.3 5417.9 5483.3 5521.2 5098.3 5358.2 5470.0 5472.7 5504.0 4069.6 5431.3 5450.0 5450.6 5483.6 5408.1 5441.7 5452.2 5480.6 5496.7 5284.4 5329.2 5444.6 5445.5 5498.6 6007.3 6038.8 6049.9 6059.0 6066.3 6186.8 6229.5 6302.8 6304.3 6405.1 6322.3 6342.6 6343.5 6344.5 6356.8 6107.8 6119.9 6125.5 6135.1 6138.5 5776.8 6379.0 6463.6 6565.9 6569.7 6210.1 6253.9 6258.5 6259.2 6266.4 6175.7 6347.8 6355.0 6381.6 6383.0 5184.3 5996.5 6269.2 6275.3 6283.9 6208.3 6262.8 6281.4 6285.1 6292.3 4934.2 4972.5 4978.9 4982.6 5035.6 4478.4 4511.3 4525.4 4532.3 4540.2 5660.3 6179.4 6196.9 6219.7 6232.6 6231.3 6262.8 6296.0 6387.5 6420.8 5042.1 6007.3 6131.3 6203.3 6234.7 5579.2 5583.8 5622.1 5625.7 5627.0 6384.1 6440.5 6478.6 6650.7 6666.3 6319.1 6337.4 6349.4 6358.8 6382.3 6634.4 6640.7 6648.4 6653.4 6676.7 6140.2 6175.1 6248.4 6261.7 6288.8 6300.5 6312.9 6338.9 6340.1 6347.0 5547.2 6221.1 6237.7 6240.9 6246.8 6159.6 6186.4 6245.8 6247.2 6267.6 4934.6 5940.9 6150.8 6169.7 6234.2 5430.6 6115.6 6185.8 6248.5 6253.4 6129.2 6175.9 6204.7 6217.8 6251.1 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:63854.79 Median:38936.71 stddev:130089.06 (334.1%) stddev-sans-first:130367.07 19:45:37 INFO - PROCESS | 1953 | Values: 513.4 588.1 601.8 616.9 647.3 39034.0 40172.0 40234.4 40236.8 40258.6 41705.8 42369.2 42398.4 42432.8 42454.6 9698.8 9948.0 9954.4 9988.2 10010.0 9783.6 10068.8 10069.7 10079.5 10147.5 10025.1 10129.0 10132.0 10144.5 10177.0 10019.2 10106.1 10109.9 10118.0 10132.5 9827.9 9972.3 9988.9 10000.1 10018.0 40915.8 41186.4 41267.0 41267.8 41400.8 3198.4 3254.2 3443.8 3594.4 3967.9 24482.6 28878.0 29380.6 29491.4 29811.7 2758.0 2799.7 2829.2 2904.9 3035.9 500496.0 501076.0 503184.0 503777.5 504292.0 48968.8 49732.0 54095.0 65314.0 66896.0 48115.3 48465.0 48493.5 48801.5 48814.8 17116.7 17225.7 17250.0 17376.0 17438.1 13753.0 13817.9 13848.9 13891.8 13894.3 15801.8 15860.0 16198.9 16206.6 16241.4 5700.7 6255.5 6631.8 6668.5 6691.4 1045.3 1046.8 1063.2 1132.7 1160.6 30730.7 30809.7 31179.7 31355.8 31644.7 1153.1 1183.7 1220.1 1235.2 1256.4 14337.9 15116.5 15839.5 15848.7 16242.0 543373.0 543628.0 545843.0 548590.0 552181.0 62152.0 62344.0 62683.7 62725.7 62735.4 1531.2 1549.1 1564.6 1566.1 1570.9 29826.3 30964.7 31709.8 32118.8 33284.5 58264.1 59397.7 59458.5 59595.1 63199.1 400843.0 408391.0 412402.0 412484.0 415603.0 41585.0 41807.2 42266.9 43065.6 43671.6 47389.8 47656.8 47785.8 48209.3 48773.3 38991.6 39594.6 39783.8 40133.4 40887.2 28937.4 38881.8 39868.8 40400.6 40583.6 36559.1 37742.4 38701.6 39426.4 39974.6 32831.8 33405.8 33627.8 33915.3 34644.6 26482.7 26499.6 26560.3 26719.0 27142.9 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:38046.49 Median:11517.72 stddev:117555.60 (1020.7%) stddev-sans-first:117851.26 19:45:37 INFO - PROCESS | 1953 | Values: 328.4 343.8 374.7 383.0 392.7 19713.2 20216.9 20619.6 20811.0 20827.0 17344.4 19126.4 20637.7 21229.0 21231.0 5427.6 5650.3 5656.1 5660.5 5686.1 5386.4 5520.7 5536.1 5536.8 5581.8 5585.2 5588.0 5619.9 5643.8 5670.0 5484.3 5644.2 5653.2 5875.6 6153.4 5407.8 5408.0 5436.5 5438.1 5442.6 12975.0 13494.9 13552.7 13555.5 22386.3 2072.0 2088.4 2096.7 2218.0 2263.1 10235.8 10315.9 10331.3 12981.0 15024.7 1772.3 1777.2 1796.7 1808.7 1812.7 92462.0 99331.5 110431.4 116861.8 116996.7 11396.4 11661.0 11729.8 11815.5 12012.5 14405.1 14410.9 14411.5 14442.5 14457.9 8846.7 8954.5 9010.3 9019.4 9122.8 8909.7 8933.7 8967.4 9127.0 9344.1 4436.2 4444.4 4581.6 4633.4 4646.3 1694.0 1862.0 1922.4 1945.8 1962.7 947.8 974.4 985.4 1022.9 1174.5 18652.2 20947.0 21054.9 21611.2 22128.1 1019.5 1020.5 1073.6 1097.8 1110.3 11683.4 11707.0 11759.2 11760.6 11767.2 695114.5 704221.0 713233.0 718401.0 718508.0 129632.4 129933.7 131219.0 135289.3 135974.0 892.4 947.9 963.4 1067.0 1068.0 18636.9 19022.9 19144.7 19166.8 19565.2 54832.6 54903.0 55000.7 56686.4 57752.7 80795.0 81051.0 83340.6 83638.0 85005.0 6524.4 8313.9 8350.2 8368.7 8634.6 8031.2 12761.6 13445.5 13745.5 13842.7 11457.0 11845.0 12042.9 12101.9 12219.5 11565.2 11590.8 11658.0 11829.7 12131.3 11865.6 11963.6 12056.0 12067.5 12342.1 8269.3 8301.9 8364.8 8520.7 8699.6 11888.3 11889.3 11991.6 12011.4 12150.8 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:6296.32 Median:5212.24 stddev:3312.64 (63.6%) stddev-sans-first:3301.80 19:45:37 INFO - PROCESS | 1953 | Values: 1437.7 1651.0 1830.9 1937.2 2057.4 8356.5 8899.7 9040.6 9220.6 9267.7 8886.0 8906.2 8977.2 8987.7 9128.2 2585.5 2618.8 2621.0 2621.1 2630.9 2601.7 2657.1 2662.8 2667.3 2668.9 2592.9 2606.8 2637.6 2641.4 2641.9 2597.1 2605.5 2618.0 2625.8 2627.2 2587.7 2613.8 2620.7 2656.5 2668.8 9245.1 9260.3 9287.8 9321.0 9323.4 5857.2 5909.8 5930.2 5975.9 5986.1 3753.5 3826.5 3830.5 3835.7 3863.5 1078.1 1080.8 1083.6 1126.2 1133.2 12234.5 12283.3 12339.5 12388.5 12397.6 4304.8 5172.8 5190.5 5234.0 5290.7 10462.9 10476.8 10562.0 10646.9 10677.2 5088.8 5677.7 5708.1 5750.1 5768.9 4396.7 4684.6 5059.9 5123.9 5128.8 3529.2 4151.5 4231.4 4272.9 4281.8 1368.8 1388.4 1391.5 1397.1 1401.9 1304.4 1349.7 1356.9 1385.6 1446.7 7958.7 8494.4 8518.1 8542.1 8558.2 466.8 532.2 535.5 539.5 553.2 6330.5 6347.9 6373.8 6409.2 6410.2 10763.6 11115.3 11152.9 11197.7 11252.3 10760.9 11048.2 11062.3 11150.1 11192.9 8622.1 8657.4 8691.6 8697.6 8713.5 8067.1 8149.7 8194.4 8216.5 8250.4 9612.0 9753.7 9860.2 9974.0 10011.4 10031.2 10188.5 10219.2 10311.7 10370.7 7788.2 7848.2 7853.1 7872.1 7903.2 8517.7 8526.2 8605.1 8651.4 8667.6 7495.4 7569.7 7629.7 7638.1 7804.8 7405.9 7476.3 7484.2 7571.3 7584.7 7310.7 7918.1 7971.1 7988.1 7989.3 6849.0 7102.9 7274.5 7283.2 7314.7 7418.7 7432.8 7473.9 7489.3 7490.2 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:6043.33 Median:6974.10 stddev:1982.47 (28.4%) stddev-sans-first:1940.58 19:45:37 INFO - PROCESS | 1953 | Values: 299.1 342.5 345.3 346.8 349.3 7033.2 7043.2 7060.1 7075.0 7119.7 7016.9 7038.8 7040.4 7051.7 7073.9 3927.9 4061.9 5199.5 5204.2 5253.7 5169.3 5179.6 5185.9 5216.3 5240.2 5118.4 5125.3 5132.5 5138.7 5148.4 5131.3 5139.3 5150.6 5160.5 5164.3 4435.6 4436.5 4450.2 4459.0 4544.6 5498.9 6421.1 6514.2 6701.5 6716.6 5820.5 5835.9 5874.6 5900.8 5951.3 6000.1 6695.6 6781.3 7442.7 7451.9 4726.1 4728.7 4730.2 4731.1 4737.7 7816.6 7905.6 7910.0 7916.4 7939.8 4577.5 4707.0 4714.7 4718.4 4727.1 4230.2 4615.3 4743.2 4803.3 4816.4 5771.5 5838.7 5877.5 5887.9 5889.8 6065.6 7424.6 7451.5 7452.1 7484.0 1666.7 1685.7 1689.3 1691.9 1692.4 1044.1 1072.7 1079.7 1084.2 1092.7 6931.5 6962.7 6985.5 6988.2 7000.6 7490.7 7634.6 7661.7 7666.1 7681.2 7031.6 7210.8 7215.0 7265.2 7273.6 4093.5 4115.2 4118.1 4120.4 4139.7 8099.4 8220.0 8232.7 8239.8 8247.0 7620.2 7681.7 8000.6 8017.9 8054.2 8150.6 8186.1 8196.3 8196.4 8210.8 6483.0 7758.0 7762.8 7793.3 7794.8 6157.4 7415.3 7557.0 7619.2 7649.0 7935.8 8201.3 8209.9 8229.1 8230.0 3651.9 4277.8 4766.2 4775.1 4779.5 6196.4 7462.5 7742.8 7761.5 7761.8 7421.0 7437.7 7443.9 7446.0 7460.4 7176.0 7548.0 7548.8 7549.5 7632.7 5963.6 7282.5 7358.8 7376.1 7384.6 6609.6 7019.4 7531.7 7539.2 7574.7 7184.4 7272.5 7375.9 7388.8 7407.6 19:45:37 INFO - PROCESS | 1953 | 19:45:37 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:18762.90 Median:52343.62 stddev:26289.08 (50.2%) stddev-sans-first:26327.84 19:45:37 INFO - PROCESS | 1953 | Values: 699.8 725.1 736.5 752.5 760.4 15323.3 15518.5 15578.7 15585.7 15677.1 14267.6 14274.5 16399.0 16727.9 16767.7 818.8 825.4 965.8 986.1 988.8 866.7 977.7 978.9 986.3 988.4 880.8 1041.9 1050.5 1050.9 1054.7 997.7 1013.6 1038.7 1041.2 1053.8 749.3 760.6 764.6 780.7 781.8 15680.1 15762.4 15896.8 15968.9 16008.2 12733.6 13021.7 13064.5 13144.6 13179.8 10370.4 10388.7 10603.3 10639.1 10650.6 3526.1 3593.0 3612.5 3618.0 3798.1 84071.0 84262.6 85996.1 86636.1 86850.1 9577.7 9755.9 9804.4 9806.7 9948.5 22308.8 22454.6 22456.4 22473.6 22636.1 7660.3 7703.7 7705.2 7828.3 7911.4 4127.0 4185.1 4218.9 4228.6 4257.0 3734.2 3790.8 3798.1 3807.5 3810.1 666.3 680.9 681.9 690.2 690.5 575.2 598.9 619.7 633.6 634.5 8495.4 8506.4 8544.7 8563.7 8647.0 543.0 602.1 617.4 630.1 632.9 3823.4 3898.6 4032.7 4043.8 4073.2 77888.4 79810.6 98420.0 98637.0 100036.0 82640.2 83019.0 83089.6 83219.0 83751.2 49144.8 69193.0 69552.7 71033.0 71863.3 7030.6 8499.7 8870.5 8896.0 8963.9 51119.0 52217.5 52469.8 53273.5 53303.0 47526.0 73423.6 73659.0 74121.6 74957.6 10701.2 10968.5 11083.4 11397.5 11595.3 11918.9 11944.6 12108.9 12183.1 12440.1 11631.8 11753.4 11804.9 12010.2 12021.3 11479.9 11764.2 11771.7 12026.2 12136.4 9700.3 11449.5 11481.0 11529.8 11857.9 9537.3 9549.9 9655.6 9706.6 9920.3 9725.9 10071.0 10082.6 10098.3 10154.9 19:45:37 INFO - PROCESS | 1953 | -------- Summary: end -------- 19:45:37 INFO - PROCESS | 1953 | 19:45:38 INFO - TEST-INFO | 1953: exit 0 19:45:38 INFO - TEST-OK | dromaeo_css | took 1109562ms 19:45:38 INFO - TEST-START | kraken 19:45:38 INFO - operating with platform_type : mac_ 19:45:38 INFO - Initialising browser for kraken test... 19:45:38 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmp1K7dh2/profile http://localhost:49430/getInfo.html) 19:45:40 INFO - PROCESS | 1959 | __metrics Screen width/height:1600/1200 19:45:40 INFO - PROCESS | 1959 | colorDepth:24 19:45:40 INFO - PROCESS | 1959 | Browser inner width/height: 1024/689 19:45:40 INFO - PROCESS | 1959 | __metrics 19:45:40 ERROR - PROCESS | 1959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 19:45:41 INFO - TEST-INFO | 1959: exit 0 19:45:41 INFO - Browser initialized. 19:45:41 INFO - Running cycle 1/1 for kraken test... 19:45:41 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmp1K7dh2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:53 INFO - PROCESS | 1963 | RSS: Main: 167886848 19:45:53 INFO - PROCESS | 1963 | 19:45:55 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-beat-detection) 19:45:56 INFO - PROCESS | 1963 | RSS: Main: 179527680 19:45:56 INFO - PROCESS | 1963 | 19:45:59 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-dft) 19:45:59 INFO - PROCESS | 1963 | RSS: Main: 188710912 19:45:59 INFO - PROCESS | 1963 | 19:46:02 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-fft) 19:46:03 INFO - PROCESS | 1963 | RSS: Main: 191893504 19:46:03 INFO - PROCESS | 1963 | 19:46:05 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49430/tests/kraken/driver.html?testName=audio-oscillator) 19:46:06 INFO - PROCESS | 1963 | RSS: Main: 193744896 19:46:06 INFO - PROCESS | 1963 | 19:46:08 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:46:08 INFO - PROCESS | 1963 | RSS: Main: 193818624 19:46:08 INFO - PROCESS | 1963 | 19:46:11 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-darkroom) 19:46:12 INFO - PROCESS | 1963 | RSS: Main: 194588672 19:46:12 INFO - PROCESS | 1963 | 19:46:15 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49430/tests/kraken/driver.html?testName=imaging-desaturate) 19:46:15 INFO - PROCESS | 1963 | RSS: Main: 194523136 19:46:15 INFO - PROCESS | 1963 | 19:46:18 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49430/tests/kraken/driver.html?testName=json-parse-financial) 19:46:19 INFO - PROCESS | 1963 | RSS: Main: 194555904 19:46:19 INFO - PROCESS | 1963 | 19:46:20 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:46:21 INFO - PROCESS | 1963 | RSS: Main: 193716224 19:46:21 INFO - PROCESS | 1963 | 19:46:23 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:46:23 INFO - PROCESS | 1963 | RSS: Main: 193855488 19:46:23 INFO - PROCESS | 1963 | 19:46:25 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:46:26 INFO - PROCESS | 1963 | RSS: Main: 194256896 19:46:26 INFO - PROCESS | 1963 | 19:46:28 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:46:29 INFO - PROCESS | 1963 | RSS: Main: 194641920 19:46:29 INFO - PROCESS | 1963 | 19:46:31 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:46:32 INFO - PROCESS | 1963 | RSS: Main: 194244608 19:46:32 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49430/tests/kraken/driver.html?testName=ai-astar) 19:46:34 INFO - PROCESS | 1963 | RSS: Main: 195727360 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | __start_tp_report 19:46:34 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 19:46:34 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 19:46:34 INFO - PROCESS | 1963 | |i|pagename|runs| 19:46:34 INFO - PROCESS | 1963 | |0;ai-astar;116;113;115;115;117;129;115;116;117;159 19:46:34 INFO - PROCESS | 1963 | |1;audio-beat-detection;151;136;187;181;120;136;123;153;149;130 19:46:34 INFO - PROCESS | 1963 | |2;audio-dft;198;198;202;204;194;197;197;199;200;201 19:46:34 INFO - PROCESS | 1963 | |3;audio-fft;66;73;73;122;83;78;82;68;118;59 19:46:34 INFO - PROCESS | 1963 | |4;audio-oscillator;84;79;120;74;76;79;115;78;78;117 19:46:34 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;104;87;88;86;107;114;89;91;134;86 19:46:34 INFO - PROCESS | 1963 | |6;imaging-darkroom;95;94;95;95;104;95;99;129;96;116 19:46:34 INFO - PROCESS | 1963 | |7;imaging-desaturate;91;90;92;90;90;89;90;97;92;91 19:46:34 INFO - PROCESS | 1963 | |8;json-parse-financial;57;59;58;59;59;61;58;62;72;56 19:46:34 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;60;62;62;101;100;103;66;67;68;67 19:46:34 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;82;83;82;81;81;80;105;73;93;111 19:46:34 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;133;139;106;126;134;136;136;130;130;102 19:46:34 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;137;132;127;131;137;135;135;134;136;123 19:46:34 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;68;64;77;94;98;96;94;65;67;96 19:46:34 INFO - PROCESS | 1963 | __end_tp_report 19:46:34 INFO - PROCESS | 1963 | __start_cc_report 19:46:34 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,920 19:46:34 INFO - PROCESS | 1963 | __end_cc_report 19:46:34 INFO - PROCESS | 1963 | __startTimestamp1464057994688__endTimestamp 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | ------- Summary: start ------- 19:46:34 INFO - PROCESS | 1963 | Number of tests: 14 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:121.20 Median:116.50 stddev:13.99 (12.0%) stddev-sans-first:14.71 19:46:34 INFO - PROCESS | 1963 | Values: 116.0 113.0 115.0 115.0 117.0 129.0 115.0 116.0 117.0 159.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:150.00 stddev:22.72 (15.1%) stddev-sans-first:24.04 19:46:34 INFO - PROCESS | 1963 | Values: 151.0 136.0 187.0 181.0 120.0 136.0 123.0 153.0 149.0 130.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:199.00 Median:199.50 stddev:2.87 (1.4%) stddev-sans-first:3.02 19:46:34 INFO - PROCESS | 1963 | Values: 198.0 198.0 202.0 204.0 194.0 197.0 197.0 199.0 200.0 201.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:82.20 Median:73.00 stddev:21.23 (29.1%) stddev-sans-first:21.69 19:46:34 INFO - PROCESS | 1963 | Values: 66.0 73.0 73.0 122.0 83.0 78.0 82.0 68.0 118.0 59.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:78.00 stddev:19.07 (24.4%) stddev-sans-first:20.10 19:46:34 INFO - PROCESS | 1963 | Values: 84.0 79.0 120.0 74.0 76.0 79.0 115.0 78.0 78.0 117.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:98.60 Median:86.50 stddev:16.00 (18.5%) stddev-sans-first:16.85 19:46:34 INFO - PROCESS | 1963 | Values: 104.0 87.0 88.0 86.0 107.0 114.0 89.0 91.0 134.0 86.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:95.00 stddev:11.71 (12.3%) stddev-sans-first:12.16 19:46:34 INFO - PROCESS | 1963 | Values: 95.0 94.0 95.0 95.0 104.0 95.0 99.0 129.0 96.0 116.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:91.00 stddev:2.25 (2.5%) stddev-sans-first:2.39 19:46:34 INFO - PROCESS | 1963 | Values: 91.0 90.0 92.0 90.0 90.0 89.0 90.0 97.0 92.0 91.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:4.53 (7.7%) stddev-sans-first:4.67 19:46:34 INFO - PROCESS | 1963 | Values: 57.0 59.0 58.0 59.0 59.0 61.0 58.0 62.0 72.0 56.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:75.60 Median:64.00 stddev:17.96 (28.1%) stddev-sans-first:18.14 19:46:34 INFO - PROCESS | 1963 | Values: 60.0 62.0 62.0 101.0 100.0 103.0 66.0 67.0 68.0 67.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:81.50 stddev:12.11 (14.9%) stddev-sans-first:12.70 19:46:34 INFO - PROCESS | 1963 | Values: 82.0 83.0 82.0 81.0 81.0 80.0 105.0 73.0 93.0 111.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:133.50 stddev:12.80 (9.6%) stddev-sans-first:13.41 19:46:34 INFO - PROCESS | 1963 | Values: 133.0 139.0 106.0 126.0 134.0 136.0 136.0 130.0 130.0 102.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.70 Median:135.00 stddev:4.60 (3.4%) stddev-sans-first:4.60 19:46:34 INFO - PROCESS | 1963 | Values: 137.0 132.0 127.0 131.0 137.0 135.0 135.0 134.0 136.0 123.0 19:46:34 INFO - PROCESS | 1963 | 19:46:34 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.90 Median:94.00 stddev:14.89 (15.8%) stddev-sans-first:14.92 19:46:34 INFO - PROCESS | 1963 | Values: 68.0 64.0 77.0 94.0 98.0 96.0 94.0 65.0 67.0 96.0 19:46:34 INFO - PROCESS | 1963 | -------- Summary: end -------- 19:46:34 INFO - PROCESS | 1963 | 19:46:35 INFO - TEST-INFO | 1963: exit 0 19:46:35 INFO - TEST-OK | kraken | took 57235ms 19:46:35 INFO - SUITE-END | took 1166s 19:46:35 INFO - Completed test suite (00:19:27) 19:46:35 INFO - javascript benchmark 19:46:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2848.700886406927, 3629.4374371972353, 3650.4889315495825, 3671.7613355131916, 3686.2443199144177, 6004.5796794224425, 6016.428439298265, 6018.428249316319, 6037.366076561963, 6038.5471089668235, 5942.970285148579, 6010.368911264309, 6013.278406591216, 6030.0, 6033.577649564532, 4476.440444944374, 5383.300170977767, 5417.891642167155, 5483.259759932418, 5521.199426083215, 5098.26075219093, 5358.223057656637, 5469.972650136744, 5472.699001554913, 5503.972480137593, 4069.633732964033, 5431.321084864392, 5449.972750136244, 5450.56395488362, 5483.561315094803, 5408.0806262935, 5441.673499590018, 5452.182172674091, 5480.588955828329, 5496.725163741797, 5284.4187139414635, 5329.2006199070065, 5444.646098003617, 5445.482679145514, 5498.560115190775, 6007.339192688801, 6038.758449662008, 6049.939500604982, 6059.000264956277, 6066.332703402666, 6186.783462578833, 6229.501639868799, 6302.842428939267, 6304.338044505353, 6405.135306733578, 6322.304546499928, 6342.587731797418, 6343.46080583151, 6344.524160687967, 6356.809295721136, 6107.7556897724035, 6119.877602447926, 6125.540584456139, 6135.110408990671, 6138.508919286491, 5776.826695199151, 6378.968105159444, 6463.57986730861, 6565.868682626417, 6569.67151642416, 6210.130581718563, 6253.906191407133, 6258.468030217391, 6259.155014073133, 6266.404691554295, 6175.69121543921, 6347.841303967438, 6355.0, 6381.553291269566, 6382.968085159638, 5184.326037615086, 5996.4603185713495, 6269.216347956505, 6275.341089185661, 6283.937160628335, 6208.348123447064, 6262.780802671976, 6281.434670879643, 6285.120083188357, 6292.307846136921, 4934.235193545006, 4972.5276098770555, 4978.925316120261, 4982.551570358685, 5035.571976382049, 4478.373027776114, 4511.278195488706, 4525.434320709911, 4532.297493888453, 4540.182767101887, 5660.349059858087, 6179.412955769195, 6196.938030619636, 6219.657918814509, 6232.626042437469, 6231.3145553989025, 6262.812115636538, 6295.968520157461, 6387.520935929824, 6420.839479012969, 5042.142835717937, 6007.339192688801, 6131.254333328352, 6203.2556093269095, 6234.719437625317, 5579.163125531203, 5583.832485025456, 5622.128570071645, 5625.690587017753, 5627.015272327327, 6384.138141350951, 6440.452561532228, 6478.643674597943, 6650.73397064112, 6666.300038495888, 6319.052142178526, 6337.36626337381, 6349.3650634937985, 6358.7600417918065, 6382.297947225708, 6634.369734875179, 6640.667966601747, 6648.368405001517, 6653.434458071119, 6676.732930682719, 6140.19751335002, 6175.104609831459, 6248.375162483715, 6261.7182226799, 6288.811335659938, 6300.464460520907, 6312.936870631235, 6338.904916426165, 6340.1123842661145, 6346.984482482781, 5547.195656629686, 6221.09794079865, 6237.688115594111, 6240.906386404298, 6246.781362652286, 6159.630422174684, 6186.381361863778, 6245.843853903689, 6247.187865577446, 6267.592606480746, 4934.5805606523845, 5940.851478713067, 6150.784722534869, 6169.722362493609, 6234.220722409699, 5430.619856609999, 6115.575014303803, 6185.8144255672405, 6248.4688801452385, 6253.437190652863, 6129.236538068469, 6175.9073613894925, 6204.720787564661, 6217.844553886189, 6251.124842522141], "unit": "score", "name": "dojo.html", "value": 5842.905297060064}, {"lowerIsBetter": false, "replicates": [513.4300925972171, 588.0737837905298, 601.7983975368252, 616.877283344313, 647.2815175155578, 39034.0, 40171.99570010747, 40234.39648405276, 40236.79881600592, 40258.59741402585, 41705.79147104268, 42369.15261694764, 42398.36402453958, 42432.78783606078, 42454.575454245445, 9698.757531061709, 9948.0, 9954.402735835836, 9988.1510071644, 10009.999000099968, 9783.608655653765, 10068.848967265498, 10069.697909062703, 10079.496025198747, 10147.492625368739, 10025.147862431666, 10129.037741414591, 10132.037456441627, 10144.543495542719, 10177.0, 10019.248556358265, 10106.090451859294, 10109.898901010969, 10118.0, 10132.493375331203, 9827.90172098277, 9972.252081093948, 9988.850167247498, 10000.099991000845, 10018.0, 40915.7954210227, 41186.38220426696, 41266.9683257921, 41267.7936610315, 41400.792996035125, 3198.3603279344225, 3254.1701866024014, 3443.793372397639, 3594.370985077627, 3967.888991082473, 24482.632760508608, 28878.0, 29380.559291610643, 29491.410171796444, 29811.701882981328, 2758.0484732767163, 2799.692033876272, 2829.1936798012466, 2904.8547572621283, 3035.924101897448, 500496.0, 501076.0, 503184.0, 503777.48111259576, 504292.0, 48968.75515622399, 49732.0, 54095.0, 65314.020289694745, 66895.99656005164, 48115.27827082597, 48465.0, 48493.515064849606, 48801.5119848797, 48814.75592622014, 17116.657666846593, 17225.74161387555, 17250.0, 17376.0, 17438.12809359527, 13753.0, 13817.861821381859, 13848.930755346159, 13891.79162312566, 13894.305284735723, 15801.841981580037, 15859.969102008563, 16198.919005404898, 16206.59483512898, 16241.431549895933, 5700.657960522382, 6255.530835187288, 6631.767888123893, 6668.533202675863, 6691.397774200345, 1045.3414348960107, 1046.759245373553, 1063.1919740996898, 1132.6828488023202, 1160.6344001639625, 30730.69269307323, 30809.69190308113, 31179.68820311768, 31355.84322078375, 31644.683553164636, 1153.1236260441956, 1183.6863231243726, 1220.0605533738972, 1235.2397833087814, 1256.3592567790492, 14337.928310358382, 15116.470923517843, 15839.52481425559, 15848.68302633941, 16242.0, 543373.0, 543628.0, 545843.0, 548590.0, 552181.0, 62152.0, 62344.0, 62683.686581567716, 62725.68637156785, 62735.43161421001, 1531.157863175249, 1549.132485807951, 1564.569743320596, 1566.0525382143867, 1570.9135997520245, 29826.254343641584, 30964.69035309708, 31709.8414507926, 32118.83940580282, 33284.500732488545, 58264.12603810862, 59397.703011484664, 59458.51353716192, 59595.10607340807, 63199.052014218905, 400842.9957850192, 408390.95804521977, 412402.0, 412484.0, 415603.0, 41585.0, 41807.1638567233, 42266.94332641709, 43065.569344306154, 43671.56328436675, 47389.81525461753, 47656.76171619258, 47785.76107119442, 48209.27686084641, 48773.268400974724, 38991.6100838988, 39594.60405395909, 39783.80108099441, 40133.397999029454, 40887.1822563553, 28937.42125157443, 38881.80559097186, 39868.80393588197, 40400.595994039686, 40583.59416405916, 36559.08602284964, 37742.43386349262, 38701.6129838698, 39426.422943083104, 39974.60025399709, 32831.83584082064, 33405.83297083499, 33627.83186084054, 33915.32169356648, 34644.6142154311, 26482.735172648026, 26499.602505962812, 26560.335991600365, 26719.0, 27142.914283429232], "unit": "score", "name": "ext.html", "value": 20281.08765448014}, {"lowerIsBetter": false, "replicates": [328.4072249589491, 343.80059565452035, 374.73581125306646, 382.9559600645925, 392.7270546969857, 19713.21147154114, 20216.898915505437, 20619.587608247824, 20811.0, 20827.0, 17344.392946246884, 19126.426207213804, 20637.690434643493, 21228.99999999996, 21231.0, 5427.6472029318165, 5650.321961364642, 5656.066748986433, 5660.490555849972, 5686.09022556391, 5386.353637563498, 5520.723963801794, 5536.114221724525, 5536.75084621191, 5581.776728930859, 5585.218069470277, 5587.972060139694, 5619.887602247953, 5643.8024669136585, 5669.971650141764, 5484.314460692393, 5644.238027866227, 5653.1520271959125, 5875.647461152302, 6153.446189842935, 5407.83776486706, 5408.0, 5436.456354364572, 5438.129899216146, 5442.591805614556, 12975.02687298447, 13494.865051349558, 13552.728945421037, 13555.525556605471, 22386.328410147722, 2071.958560828775, 2088.4361222469847, 2096.67501537262, 2217.977820221793, 2263.1173842201556, 10235.846462303072, 10315.865254821963, 10331.32846364984, 12981.0, 15024.699506009818, 1772.2910835665837, 1777.2091419318408, 1796.7035439152523, 1808.6744386010512, 1812.746215529827, 92462.0, 99331.50334248427, 110431.44784276107, 116861.83138168594, 116996.66006679904, 11396.373199473943, 11661.0, 11729.765404691858, 11815.468303926344, 12012.459439325252, 14405.06367086136, 14410.927945360207, 14411.495597654031, 14442.494512692005, 14457.92771036138, 8846.734597962071, 8954.507502087448, 9010.27917766577, 9019.413738107001, 9122.81754364909, 8909.73270801877, 8933.73198804024, 8967.417117887317, 9126.954365228132, 9344.065593440602, 4436.245838207513, 4444.355568442623, 4581.5647513486165, 4633.351330813689, 4646.326282688991, 1693.9661206775795, 1861.9534511637046, 1922.432882299697, 1945.8248757611882, 1962.6663467210608, 947.8436058050345, 974.449436068619, 985.4284514981293, 1022.9232807539464, 1174.4949671641104, 18652.160652770657, 20947.0, 21054.947252637307, 21611.243606473698, 22128.114875404804, 1019.5463018956493, 1020.4897551224387, 1073.5544748929108, 1097.8243481042996, 1110.3337997201616, 11683.415829208505, 11707.0, 11759.176857620056, 11760.58837940685, 11767.23512971654, 695114.5244273746, 704221.0, 713233.0, 718401.0, 718508.0, 129632.35183824209, 129933.70066299404, 131219.0, 135289.3235533816, 135974.0, 892.3708785306344, 947.9335747284305, 963.3786207896007, 1066.9780765449584, 1068.0, 18636.906815465834, 19022.904885475484, 19144.71282930785, 19166.808331917062, 19565.217391304188, 54832.629184270714, 54903.0, 55000.72499637476, 56686.433135668114, 57752.71123644355, 80795.0, 81051.0, 83340.58329708556, 83638.0, 85005.0, 6524.445422139172, 8313.916860831556, 8350.164983501601, 8368.66525339004, 8634.56827158627, 8031.237032481905, 12761.553345632858, 13445.529406470727, 13745.518906838213, 13842.65393365174, 11457.0, 11845.0, 12042.879571204527, 12101.939490302491, 12219.51121955112, 11565.248258863483, 11590.768184636428, 11658.0, 11829.704257393634, 12131.272123672608, 11865.5847045353, 11963.64109076729, 12055.97524210452, 12067.517299307929, 12342.074344424025, 8269.255766981001, 8301.875471867806, 8364.790880228044, 8520.74437766868, 8699.608517616849, 11888.34614096233, 11889.346085965355, 11991.64025079249, 12011.399430028288, 12150.756984860076], "unit": "score", "name": "jquery.html", "value": 9634.552363111043}, {"lowerIsBetter": false, "replicates": [1437.6621493948924, 1650.9917450412747, 1830.9359172428967, 1937.176699902541, 2057.393069044632, 8356.456830306026, 8899.733008009754, 9040.638374465021, 9220.616907463884, 9267.675631352904, 8886.022537520868, 8906.242969347613, 8977.236934860544, 8987.730368088967, 9128.224100951427, 2585.5216784894806, 2618.8035897307777, 2621.0302188190394, 2621.0564196889104, 2630.8816103275303, 2601.7398260173927, 2657.109868194157, 2662.840229586231, 2667.333166708323, 2668.8665566721684, 2592.922212333633, 2606.7653911147995, 2637.630731697564, 2641.44529648774, 2641.9075332363373, 2597.06505657963, 2605.5049540587324, 2617.9607305890427, 2625.8161928665, 2627.2249686342575, 2587.663603731503, 2613.8431694098417, 2620.6593142891493, 2656.53510635638, 2668.786497080229, 9245.07549245077, 9260.25917926571, 9287.814243715087, 9321.021292764297, 9323.44059356434, 5857.179994800731, 5909.793157239519, 5930.199423077873, 5975.940240597582, 5986.132010858445, 3753.512043434336, 3826.4642949987024, 3830.540335159799, 3835.712321575865, 3863.536375634914, 1078.1428764132534, 1080.778440419712, 1083.6183865571381, 1126.2116518437126, 1133.2124173699283, 12234.510619575207, 12283.324417157142, 12339.5064197432, 12388.504459821595, 12397.62807115779, 4304.80628371724, 5172.844814655567, 5190.506901844319, 5233.973830130901, 5290.709011004432, 10462.895371046345, 10476.842847357295, 10562.0, 10646.946765266124, 10677.199210059121, 5088.796448142107, 5677.659340439587, 5708.143778433268, 5750.137479378127, 5768.855778605568, 4396.736195828261, 4684.6252299816615, 5059.8988020239385, 5123.8719032023755, 5128.8461346159675, 3529.170644898447, 4151.543330233671, 4231.449911511545, 4272.9359059614135, 4281.807318670667, 1368.8494265630773, 1388.430743395203, 1391.4851504943235, 1397.0918902713317, 1401.8668226518464, 1304.39345704248, 1349.6760777413547, 1356.9321533923264, 1385.591250581081, 1446.7178900114377, 7958.681652733826, 8494.447860889146, 8518.105598912025, 8542.145785421408, 8558.229759321566, 466.8412739668529, 532.1830989431204, 535.4859335038407, 539.5494761873879, 553.195101127866, 6330.525210609223, 6347.936520634827, 6373.776917807854, 6409.166808314889, 6410.230772307353, 10763.623273185402, 11115.333080015225, 11152.888471115184, 11197.66407007791, 11252.26860254081, 10760.946195268974, 11048.171387145996, 11062.280951738112, 11150.052245559218, 11192.888071119185, 8622.137786221454, 8657.350698697497, 8691.565421728888, 8697.608607612672, 8713.477191368538, 8067.112617612175, 8149.7147599833725, 8194.426390152632, 8216.46592971455, 8250.422470427253, 9612.038796120332, 9753.707388778348, 9860.161886239463, 9974.0, 10011.399316041061, 10031.247656425943, 10188.490575471049, 10219.1824654026, 10311.690649280534, 10370.740731481774, 7788.182240864628, 7848.175941526058, 7853.1361550228285, 7872.094709108297, 7903.249191326815, 8517.659293628185, 8526.232639062515, 8605.139486051345, 8651.437656552303, 8667.566621668766, 7495.40036797044, 7569.697212111454, 7629.7329593463965, 7638.121616014229, 7804.804879878048, 7405.888911666437, 7476.25237476248, 7484.176740558425, 7571.280728330799, 7584.734534291273, 7310.720623890691, 7918.089419716806, 7971.123176450702, 7988.081370642451, 7989.2809647132035, 6848.9657551711925, 7102.857942841218, 7274.454415918722, 7283.2352602975925, 7314.670839812327, 7418.666160022704, 7432.814179645552, 7473.8878916817375, 7489.288517591038, 7490.176080631018], "unit": "score", "name": "mootools.html", "value": 5065.246408158925}, {"lowerIsBetter": false, "replicates": [299.13997257883585, 342.52218155672836, 345.2800910102438, 346.7693983500972, 349.3414912889203, 7033.156021277441, 7043.190033146183, 7060.082189315394, 7075.009498670184, 7119.67961441735, 7016.894746578805, 7038.824029399268, 7040.401565866908, 7051.717931282743, 7073.858522829553, 3927.9018024549473, 4061.878143655695, 5199.454057323983, 5204.219367094928, 5253.684778913258, 5169.3279873616375, 5179.585633149339, 5185.948140518603, 5216.295800067, 5240.213967904807, 5118.360204974379, 5125.333706618135, 5132.486751324856, 5138.691678499284, 5148.3564554430695, 5131.307273518065, 5139.25480805283, 5150.61370397218, 5160.509751573594, 5164.251183578398, 4435.556444355571, 4436.534163912775, 4450.221211288044, 4458.95214624563, 4544.613707834838, 5498.917516237259, 6421.101045853584, 6514.218293804726, 6701.497387695942, 6716.597004179716, 5820.476157145878, 5835.912461313042, 5874.588778785486, 5900.7934722284945, 5951.2858456985, 6000.0999850022845, 6695.564788288746, 6781.321867813229, 7442.702291908371, 7451.888221676679, 4726.1020406122725, 4728.739919304437, 4730.172219861511, 4731.077439899221, 4737.692050016738, 7816.6091695415, 7905.644246008944, 7909.960450197712, 7916.406269529751, 7939.841203175904, 4577.473590537064, 4706.95293047072, 4714.693544919569, 4718.386609740781, 4727.101850648434, 4230.175115852441, 4615.330777037378, 4743.217369134054, 4803.327534145223, 4816.446108697544, 5771.509421699118, 5838.678872662044, 5877.47102760745, 5887.852803679856, 5889.793857215062, 6065.605735627259, 7424.554526728413, 7451.515651482637, 7452.105747310249, 7483.962580187173, 1666.7333226683672, 1685.7134287171211, 1689.3327135781544, 1691.8900271482314, 1692.433034933311, 1044.1385856668278, 1072.6781965410346, 1079.740862193068, 1084.1922767538235, 1092.6940456672144, 6931.549449285781, 6962.686679099453, 6985.511014229057, 6988.19635741886, 7000.579965202104, 7490.700371985168, 7634.580098094658, 7661.655225514865, 7666.118396384376, 7681.1934746850775, 7031.578105313595, 7210.819729506804, 7215.025971493887, 7265.200827908926, 7273.636318184175, 4093.488313960755, 4115.156392939441, 4118.073433477503, 4120.423140760296, 4139.668826493873, 8099.433039687166, 8220.0, 8232.711855085163, 8239.835203295901, 8247.0, 7620.237976202447, 7681.731139410093, 8000.559969201633, 8017.919820801834, 8054.194580541899, 8150.551719655476, 8186.0586032605825, 8196.30331421824, 8196.42625016243, 8210.835783284181, 6483.0, 7757.961210193913, 7762.805929851799, 7793.2596403341595, 7794.805129871798, 6157.384261573807, 7415.295546923034, 7557.0, 7619.238076192337, 7649.0, 7935.841283174189, 8201.343892488467, 8209.917900820916, 8229.05365882931, 8230.0, 3651.867920944516, 4277.786110694515, 4766.213574760264, 4775.140474714584, 4779.498152693917, 6196.442320191204, 7462.4776265660885, 7742.7677169685, 7761.495502792301, 7761.805954851174, 7421.0, 7437.665305061177, 7443.888341674771, 7445.994790703402, 7460.4031677466755, 7176.0, 7548.0, 7548.773536793905, 7549.50928189666, 7632.69469221225, 5963.642181469126, 7282.45381596393, 7358.816029599303, 7376.114866216089, 7384.593847338448, 6609.603423794395, 7019.403350715246, 7531.661075251517, 7539.2083831199125, 7574.659140338587, 7184.389326907271, 7272.490925635367, 7375.852482950419, 7388.778336649909, 7407.59258240802], "unit": "score", "name": "prototype.html", "value": 5376.974855678657}, {"lowerIsBetter": false, "replicates": [699.7690762048522, 725.1044959475047, 736.4513437489071, 752.5328488530828, 760.4258784617613, 15323.310451029702, 15518.456854010112, 15578.688426231469, 15585.688286234268, 15677.137757423337, 14267.643308917282, 14274.500392486265, 16399.0, 16727.91636041818, 16767.748483772753, 818.811673315135, 825.3562221467265, 965.8309795785744, 986.1223511075149, 988.8170688422665, 866.7356456280831, 977.6822532676908, 978.8531720241949, 986.3145114145672, 988.4069558265055, 880.7754022724197, 1041.9062284394404, 1050.5115121468516, 1050.8738951325852, 1054.7099547624389, 997.670768646345, 1013.5742987945081, 1038.7403149212696, 1041.245097304452, 1053.773438710677, 749.3218637133403, 760.5550752809557, 764.5718397697308, 780.7111368793526, 781.800640836583, 15680.137592432411, 15762.448314309058, 15896.76154857678, 15968.920155399148, 16008.199590020453, 12733.61799146027, 13021.739565208738, 13064.477420903153, 13144.605661830064, 13179.802302965463, 10370.429626370547, 10388.740281492948, 10603.310784799041, 10639.148868090535, 10650.627228047058, 3526.1008442847165, 3592.9820350898076, 3612.548431446069, 3617.963820361815, 3798.0694729791103, 84071.0, 84262.57868710678, 85996.14003859943, 86636.13363866344, 86850.13149868547, 9577.664781732607, 9755.9024409755, 9804.36271642341, 9806.705798826046, 9948.502574871227, 22308.77301748387, 22454.550908982055, 22456.43858903508, 22473.550528989657, 22636.094556217566, 7660.310572048543, 7703.653335599912, 7705.22947705225, 7828.334591559667, 7911.367090632851, 4127.009517715786, 4185.121124563815, 4218.894527636834, 4228.577142285747, 4256.9574304257185, 3734.1971476132762, 3790.8294126764363, 3798.0884587699306, 3807.4669546263544, 3810.0855794609092, 666.2504682232488, 680.9012693159464, 681.8670359279992, 690.2372877969872, 690.4579904774728, 575.194727381669, 598.9341172471024, 619.665380694429, 633.5660072850112, 634.4892361648917, 8495.447795893371, 8506.447080939719, 8544.74365769028, 8563.743087707378, 8647.048824629286, 542.9837104886859, 602.0999347477865, 617.4350469320522, 630.0800830787102, 632.9430351268408, 3823.4073718573663, 3898.6491215790716, 4032.6572241359227, 4043.838246470108, 4073.2260870434525, 77888.44223115506, 79810.60568182963, 98420.0, 98637.02725945441, 100036.0, 82640.17359826445, 83019.0, 83089.58455207806, 83219.0, 83751.16248837434, 49144.754276229105, 69193.0, 69552.65223673951, 71033.0, 71863.2813671867, 7030.613316267654, 8499.74500764978, 8870.467771933705, 8896.0, 8963.910360896307, 51119.0, 52217.477825222784, 52469.75302469875, 53273.4672653284, 53303.0, 47526.0, 73423.63288183739, 73659.0, 74121.6293918527, 74957.62521187359, 10701.19741019411, 10968.506417211085, 11083.445827708421, 11397.487113079766, 11595.304281743123, 11918.940405297919, 11944.617885212056, 12108.93945530302, 12183.147179697691, 12440.066994975594, 11631.76736465283, 11753.412329383667, 11804.881951180721, 12010.219335743148, 12021.278723276631, 11479.942600286946, 11764.176507644725, 11771.705707357041, 12026.218295810744, 12136.393180341125, 9700.272479564203, 11449.48477318506, 11480.96671299587, 11529.82705259405, 11857.940710296394, 9537.332386732862, 9549.90450095518, 9655.565499552396, 9706.563204655666, 9920.305578609428, 9725.854112188465, 10071.0, 10082.596696132367, 10098.343607665478, 10154.949225253826], "unit": "score", "name": "yui.html", "value": 7170.699359348842}], "name": "dromaeo_css", "value": 7787.191088922862}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 113.0, 115.0, 115.0, 117.0, 129.0, 115.0, 116.0, 117.0, 159.0], "unit": "score", "name": "ai-astar", "value": 121.2}, {"lowerIsBetter": true, "replicates": [151.0, 136.0, 187.0, 181.0, 120.0, 136.0, 123.0, 153.0, 149.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [198.0, 198.0, 202.0, 204.0, 194.0, 197.0, 197.0, 199.0, 200.0, 201.0], "unit": "score", "name": "audio-dft", "value": 199.0}, {"lowerIsBetter": true, "replicates": [66.0, 73.0, 73.0, 122.0, 83.0, 78.0, 82.0, 68.0, 118.0, 59.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [84.0, 79.0, 120.0, 74.0, 76.0, 79.0, 115.0, 78.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 90.0}, {"lowerIsBetter": true, "replicates": [104.0, 87.0, 88.0, 86.0, 107.0, 114.0, 89.0, 91.0, 134.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 95.0, 104.0, 95.0, 99.0, 129.0, 96.0, 116.0], "unit": "score", "name": "imaging-darkroom", "value": 101.8}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 92.0, 90.0, 90.0, 89.0, 90.0, 97.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 91.2}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 58.0, 59.0, 59.0, 61.0, 58.0, 62.0, 72.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [60.0, 62.0, 62.0, 101.0, 100.0, 103.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.6}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 82.0, 81.0, 81.0, 80.0, 105.0, 73.0, 93.0, 111.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [133.0, 139.0, 106.0, 126.0, 134.0, 136.0, 136.0, 130.0, 130.0, 102.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [137.0, 132.0, 127.0, 131.0, 137.0, 135.0, 135.0, 134.0, 136.0, 123.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.7}, {"lowerIsBetter": true, "replicates": [68.0, 64.0, 77.0, 94.0, 98.0, 96.0, 94.0, 65.0, 67.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.9}], "name": "kraken", "value": 1495.2}]} 19:46:35 INFO - Return code: 0 19:46:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:46:35 ERROR - # TBPL SUCCESS # 19:46:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:46:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:46:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:46:36 INFO - 2016-05-23 19:46:36.005 screenresolution[1968:13114] starting screenresolution argv=screenresolution get 19:46:36 INFO - 2016-05-23 19:46:36.008 screenresolution[1968:13114] Display 0: 1600x1200x32@60 19:46:36 INFO - 2016-05-23 19:46:36.014 screenresolution[1969:13117] starting screenresolution argv=screenresolution list 19:46:36 INFO - Available Modes on Display 0 19:46:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:46:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:46:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:46:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:46:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:46:36 INFO - Intel Iris: 19:46:36 INFO - Chipset Model: Intel Iris 19:46:36 INFO - Type: GPU 19:46:36 INFO - Bus: Built-In 19:46:36 INFO - VRAM (Dynamic, Max): 1536 MB 19:46:36 INFO - Vendor: Intel (0x8086) 19:46:36 INFO - Device ID: 0x0a2e 19:46:36 INFO - Revision ID: 0x0009 19:46:36 INFO - Displays: 19:46:36 INFO - Display: 19:46:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:46:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:46:36 INFO - Display Serial Number: 1600x1200 60 19:46:36 INFO - Main Display: Yes 19:46:36 INFO - Mirror: Off 19:46:36 INFO - Online: Yes 19:46:36 INFO - Rotation: Supported 19:46:36 INFO - Return code: 0 19:46:36 INFO - Running post-action listener: _resource_record_post_action 19:46:36 INFO - Running post-run listener: _resource_record_post_run 19:46:37 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 704512; Write bytes: 511378944; Read time: 11; Write time: 1621 19:46:37 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 195899904; Write bytes: 198248448; Read time: 17906; Write time: 446 19:46:37 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 704512; Write bytes: 302165504; Read time: 11; Write time: 1135 19:46:37 INFO - Running post-run listener: _upload_blobber_files 19:46:37 INFO - Blob upload gear active. 19:46:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:46:37 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 19:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:46:37 INFO - (blobuploader) - INFO - Open directory for files ... 19:46:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:46:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:38 INFO - (blobuploader) - INFO - Done attempting. 19:46:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:46:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:39 INFO - (blobuploader) - INFO - Done attempting. 19:46:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:46:39 INFO - Return code: 0 19:46:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:46:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:46:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f190c299450e9b9ee1eb5e2371d45a3ce3888653d09cade80a4a7b5b6675085bcce033fbc91a4fd90ca8c56249cf840d42df29c8f67a40df4efbc9136915f2cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/848cfbda02240b2575c1420e448308698dd3d444f6988748dfae1c7fc731903b6ddbe29e1d54075c1f361c7568997f1de0efecd6627f1f0ddf1eb1fe78053f3c"} 19:46:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:46:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:46:39 INFO - Contents: 19:46:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f190c299450e9b9ee1eb5e2371d45a3ce3888653d09cade80a4a7b5b6675085bcce033fbc91a4fd90ca8c56249cf840d42df29c8f67a40df4efbc9136915f2cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/848cfbda02240b2575c1420e448308698dd3d444f6988748dfae1c7fc731903b6ddbe29e1d54075c1f361c7568997f1de0efecd6627f1f0ddf1eb1fe78053f3c"} 19:46:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:46:39 INFO - Copying logs to upload dir... 19:46:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:46:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.797054 ========= master_lag: 0.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-05-23 19:46:40.634855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:40.641993) ========= 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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f190c299450e9b9ee1eb5e2371d45a3ce3888653d09cade80a4a7b5b6675085bcce033fbc91a4fd90ca8c56249cf840d42df29c8f67a40df4efbc9136915f2cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/848cfbda02240b2575c1420e448308698dd3d444f6988748dfae1c7fc731903b6ddbe29e1d54075c1f361c7568997f1de0efecd6627f1f0ddf1eb1fe78053f3c"} build_url:https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010929 build_url: 'https://queue.taskcluster.net/v1/task/JzUZEwSoR-GrgFEvRx935w/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f190c299450e9b9ee1eb5e2371d45a3ce3888653d09cade80a4a7b5b6675085bcce033fbc91a4fd90ca8c56249cf840d42df29c8f67a40df4efbc9136915f2cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/848cfbda02240b2575c1420e448308698dd3d444f6988748dfae1c7fc731903b6ddbe29e1d54075c1f361c7568997f1de0efecd6627f1f0ddf1eb1fe78053f3c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:40.678856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:40.679186) ========= 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.BWvdjewnRl/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.cQ3HNuGbyE/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.004910 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:40.727146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 19:46:40.727465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 19:46:40.730822) ========= ========= Total master_lag: 0.83 =========