builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0050 starttime: 1460707374.58 results: success (0) buildid: 20160414215914 builduid: df1f749045324d89b1c656357ec84319 revision: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.577624) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.578056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.578345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.599164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.599456) ========= 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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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-04-15 01:02:54-- 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% 14.8M=0.001s 2016-04-15 01:02:54 (14.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119618 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.770496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.770808) ========= 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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.025214 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:54.819748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 01:02:54.820105) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d8JRuSEqyO/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.cO6zbPXqoi/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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-04-15 01:02:54,956 truncating revision to first 12 chars 2016-04-15 01:02:54,956 Setting DEBUG logging. 2016-04-15 01:02:54,956 attempt 1/10 2016-04-15 01:02:54,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a88d4e4b4e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 01:02:56,746 unpacking tar archive at: fx-team-5a88d4e4b4e0/testing/mozharness/ program finished with exit code 0 elapsedTime=2.028776 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 01:02:56.868430) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:56.868763) ========= script_repo_revision: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:56.869181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:56.869446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 01:02:56.883286) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-15 01:02:56.883677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.d8JRuSEqyO/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.cO6zbPXqoi/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:02:57 INFO - MultiFileLogger online at 20160415 01:02:57 in /builds/slave/test 01:02:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:02:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:02:57 INFO - {'append_to_log': False, 01:02:57 INFO - 'base_work_dir': '/builds/slave/test', 01:02:57 INFO - 'blob_upload_branch': 'Fx-Team', 01:02:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:02:57 INFO - 'branch': 'Fx-Team', 01:02:57 INFO - 'buildbot_json_path': 'buildprops.json', 01:02:57 INFO - 'config_files': ('talos/mac_config.py',), 01:02:57 INFO - 'default_actions': ('clobber', 01:02:57 INFO - 'read-buildbot-config', 01:02:57 INFO - 'download-and-extract', 01:02:57 INFO - 'populate-webroot', 01:02:57 INFO - 'create-virtualenv', 01:02:57 INFO - 'install', 01:02:57 INFO - 'run-tests'), 01:02:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:02:57 INFO - 'download_minidump_stackwalk': True, 01:02:57 INFO - 'download_symbols': 'ondemand', 01:02:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:02:57 INFO - 'tooltool.py': '/tools/tooltool.py', 01:02:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:02:57 INFO - '/tools/misc-python/virtualenv.py')}, 01:02:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:02:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:02:57 INFO - 'installer_path': 'installer.exe', 01:02:57 INFO - 'log_level': 'info', 01:02:57 INFO - 'log_name': 'talos', 01:02:57 INFO - 'log_to_console': True, 01:02:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:02:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:02:57 INFO - 'opt_config_files': (), 01:02:57 INFO - 'pip_index': False, 01:02:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:02:57 INFO - 'cmd': ('bash', 01:02:57 INFO - '-c', 01:02:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:02:57 INFO - 'enabled': True, 01:02:57 INFO - 'halt_on_failure': False, 01:02:57 INFO - 'name': 'check_screen_resolution'},), 01:02:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:02:57 INFO - 'cmd': ('bash', 01:02:57 INFO - '-c', 01:02:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:02:57 INFO - 'enabled': True, 01:02:57 INFO - 'halt_on_failure': False, 01:02:57 INFO - 'name': 'check_screen_resolution'},), 01:02:57 INFO - 'run_cmd_checks_enabled': True, 01:02:57 INFO - 'sps_profile': False, 01:02:57 INFO - 'sps_profile_interval': 0, 01:02:57 INFO - 'suite': 'dromaeojs-e10s', 01:02:57 INFO - 'system_bits': '32', 01:02:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:02:57 INFO - 'title': 't-yosemite-r7-0050', 01:02:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:02:57 INFO - 'use_talos_json': True, 01:02:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:02:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:02:57 INFO - 'work_dir': 'build'} 01:02:57 INFO - ##### 01:02:57 INFO - ##### Running clobber step. 01:02:57 INFO - ##### 01:02:57 INFO - Running pre-action listener: _resource_record_pre_action 01:02:57 INFO - Running main action method: clobber 01:02:57 INFO - rmtree: /builds/slave/test/build 01:02:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:02:58 INFO - Running post-action listener: _resource_record_post_action 01:02:58 INFO - ##### 01:02:58 INFO - ##### Running read-buildbot-config step. 01:02:58 INFO - ##### 01:02:58 INFO - Running pre-action listener: _resource_record_pre_action 01:02:58 INFO - Running main action method: read_buildbot_config 01:02:58 INFO - Using buildbot properties: 01:02:58 INFO - { 01:02:58 INFO - "project": "", 01:02:58 INFO - "product": "firefox", 01:02:58 INFO - "script_repo_revision": "production", 01:02:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:02:58 INFO - "repository": "", 01:02:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:02:58 INFO - "buildid": "20160414215914", 01:02:58 INFO - "pgo_build": "False", 01:02:58 INFO - "basedir": "/builds/slave/test", 01:02:58 INFO - "buildnumber": 692, 01:02:58 INFO - "slavename": "t-yosemite-r7-0050", 01:02:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:02:58 INFO - "platform": "yosemite_r7", 01:02:58 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 01:02:58 INFO - "branch": "fx-team", 01:02:58 INFO - "repo_path": "integration/fx-team", 01:02:58 INFO - "revision": "5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816", 01:02:58 INFO - "stage_platform": "macosx64", 01:02:58 INFO - "builduid": "df1f749045324d89b1c656357ec84319", 01:02:58 INFO - "slavebuilddir": "test" 01:02:58 INFO - } 01:02:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:02:58 INFO - Running post-action listener: _resource_record_post_action 01:02:58 INFO - ##### 01:02:58 INFO - ##### Running download-and-extract step. 01:02:58 INFO - ##### 01:02:58 INFO - Running pre-action listener: _resource_record_pre_action 01:02:58 INFO - Running main action method: download_and_extract 01:02:58 INFO - mkdir: /builds/slave/test/build/tests 01:02: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')]} 01:02:58 INFO - https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:02:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:02:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:02:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:02:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 01:03:01 INFO - Downloaded 1199 bytes. 01:03:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:03:01 INFO - Using the following test package requirements: 01:03:01 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:03:01 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:03:01 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:03:01 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'jsshell-mac.zip'], 01:03:01 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:03:01 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:03:01 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:03:01 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:03:01 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:03:01 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:03:01 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:03:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:01 INFO - https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:03:02 INFO - Downloaded 18031252 bytes. 01:03:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:03:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:03:05 INFO - Return code: 0 01:03:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:05 INFO - https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:03:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:03:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:03:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:03:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:03:06 INFO - Downloaded 18031252 bytes. 01:03:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:03:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:03:10 INFO - Return code: 0 01:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:10 INFO - https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:03:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:03:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:03:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:03:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:03:11 INFO - Downloaded 10841076 bytes. 01:03:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:03:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:03:11 INFO - Return code: 0 01:03:11 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')]} 01:03:11 INFO - https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:03:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:03:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:03:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:03:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 01:03:14 INFO - Downloaded 109836095 bytes. 01:03:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:03:14 INFO - mkdir: /builds/slave/test/properties 01:03:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:03:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:03:14 INFO - Contents: 01:03:14 INFO - build_url:https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:03:16 INFO - Running post-action listener: _resource_record_post_action 01:03:16 INFO - Running post-action listener: set_extra_try_arguments 01:03:16 INFO - ##### 01:03:16 INFO - ##### Running populate-webroot step. 01:03:16 INFO - ##### 01:03:16 INFO - Running pre-action listener: _resource_record_pre_action 01:03:16 INFO - Running main action method: populate_webroot 01:03:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:03:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:03:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:03:16 INFO - '--tppagecycles', 01:03:16 INFO - '7'], 01:03:16 INFO - 'tests': ['tsvgm']}}, 01:03:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:03:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:03:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:03:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:03:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:03:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:03:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['damp', 'tps']}, 01:03:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'tests': ['damp', 'tps']}, 01:03:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['dromaeo_dom']}, 01:03:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:03:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['a11yr', 01:03:16 INFO - 'ts_paint', 01:03:16 INFO - 'tpaint', 01:03:16 INFO - 'sessionrestore', 01:03:16 INFO - 'sessionrestore_no_auto_restore', 01:03:16 INFO - 'tabpaint']}, 01:03:16 INFO - 'other-e10s': {'tests': ['a11yr', 01:03:16 INFO - 'ts_paint', 01:03:16 INFO - 'tpaint', 01:03:16 INFO - 'sessionrestore', 01:03:16 INFO - 'sessionrestore_no_auto_restore', 01:03:16 INFO - 'tabpaint']}, 01:03:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:03:16 INFO - 'ts_paint', 01:03:16 INFO - 'tpaint', 01:03:16 INFO - 'sessionrestore', 01:03:16 INFO - 'sessionrestore_no_auto_restore', 01:03:16 INFO - 'tabpaint']}, 01:03:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:03:16 INFO - 'ts_paint', 01:03:16 INFO - 'tpaint', 01:03:16 INFO - 'sessionrestore', 01:03:16 INFO - 'sessionrestore_no_auto_restore', 01:03:16 INFO - 'tabpaint']}, 01:03:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['a11yr', 01:03:16 INFO - 'ts_paint', 01:03:16 INFO - 'tpaint', 01:03:16 INFO - 'sessionrestore', 01:03:16 INFO - 'sessionrestore_no_auto_restore', 01:03:16 INFO - 'tabpaint']}, 01:03:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['a11yr', 01:03:16 INFO - 'ts_paint', 01:03:16 INFO - 'tpaint', 01:03:16 INFO - 'sessionrestore', 01:03:16 INFO - 'sessionrestore_no_auto_restore', 01:03:16 INFO - 'tabpaint']}, 01:03:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['tsvgx', 01:03:16 INFO - 'tsvgr_opacity', 01:03:16 INFO - 'tart', 01:03:16 INFO - 'tscrollx', 01:03:16 INFO - 'cart']}, 01:03:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:03:16 INFO - 'tsvgr_opacity', 01:03:16 INFO - 'tart', 01:03:16 INFO - 'tscrollx', 01:03:16 INFO - 'cart']}, 01:03:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'talos_options': ['--disable-e10s'], 01:03:16 INFO - 'tests': ['tp5o']}, 01:03:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'tests': ['tp5o']}, 01:03:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'talos_options': ['--disable-e10s', 01:03:16 INFO - '--xperf_path', 01:03:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:03:16 INFO - 'tests': ['tp5n']}, 01:03:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:16 INFO - 'talos_options': ['--xperf_path', 01:03:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:03:16 INFO - 'tests': ['tp5n']}}, 01:03:16 INFO - 'talos.zip': {'path': '', 01:03:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:03:16 INFO - Running post-action listener: _resource_record_post_action 01:03:16 INFO - ##### 01:03:16 INFO - ##### Running create-virtualenv step. 01:03:16 INFO - ##### 01:03:16 INFO - Running pre-action listener: _resource_record_pre_action 01:03:16 INFO - Running main action method: create_virtualenv 01:03:16 INFO - Creating virtualenv /builds/slave/test/build/venv 01:03:16 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 01:03:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:03:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:03:16 INFO - Using real prefix '/tools/python27' 01:03:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:03:16 INFO - Installing distribute.............................................................................................................................................................................................done. 01:03:19 INFO - Installing pip.................done. 01:03:19 INFO - Return code: 0 01:03:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:03:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:19 INFO - 'HOME': '/Users/cltbld', 01:03:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:19 INFO - 'LOGNAME': 'cltbld', 01:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:19 INFO - 'MOZ_NO_REMOTE': '1', 01:03:19 INFO - 'NO_EM_RESTART': '1', 01:03:19 INFO - 'PAGER': '/bin/cat', 01:03:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:19 INFO - 'PWD': '/builds/slave/test', 01:03:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:19 INFO - 'SHELL': '/bin/bash', 01:03:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:19 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:19 INFO - 'USER': 'cltbld', 01:03:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:19 INFO - 'XPC_FLAGS': '0x0', 01:03:19 INFO - 'XPC_SERVICE_NAME': '0', 01:03:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:20 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 01:03:20 INFO - Cleaning up... 01:03:20 INFO - Return code: 0 01:03:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:20 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 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:20 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 01:03:20 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 01:03:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:20 INFO - 'HOME': '/Users/cltbld', 01:03:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:20 INFO - 'LOGNAME': 'cltbld', 01:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:20 INFO - 'MOZ_NO_REMOTE': '1', 01:03:20 INFO - 'NO_EM_RESTART': '1', 01:03:20 INFO - 'PAGER': '/bin/cat', 01:03:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:20 INFO - 'PWD': '/builds/slave/test', 01:03:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:20 INFO - 'SHELL': '/bin/bash', 01:03:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:20 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:20 INFO - 'USER': 'cltbld', 01:03:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:20 INFO - 'XPC_FLAGS': '0x0', 01:03:20 INFO - 'XPC_SERVICE_NAME': '0', 01:03:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:20 INFO - Downloading/unpacking psutil>=0.7.1 01:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:03:23 INFO - Installing collected packages: psutil 01:03:23 INFO - Running setup.py install for psutil 01:03:23 INFO - building 'psutil._psutil_osx' extension 01:03:23 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 01:03:23 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 01:03:24 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 01:03:24 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 01:03:24 INFO - building 'psutil._psutil_posix' extension 01:03:24 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 01:03:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:03:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:03:24 INFO - ^ 01:03:24 INFO - 1 warning generated. 01:03:24 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 01:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:03:24 INFO - Successfully installed psutil 01:03:24 INFO - Cleaning up... 01:03:24 INFO - Return code: 0 01:03:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:24 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 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:24 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 01:03:24 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 01:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:24 INFO - 'HOME': '/Users/cltbld', 01:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:24 INFO - 'LOGNAME': 'cltbld', 01:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:24 INFO - 'MOZ_NO_REMOTE': '1', 01:03:24 INFO - 'NO_EM_RESTART': '1', 01:03:24 INFO - 'PAGER': '/bin/cat', 01:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:24 INFO - 'PWD': '/builds/slave/test', 01:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:24 INFO - 'SHELL': '/bin/bash', 01:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:24 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:24 INFO - 'USER': 'cltbld', 01:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:24 INFO - 'XPC_FLAGS': '0x0', 01:03:24 INFO - 'XPC_SERVICE_NAME': '0', 01:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:03:27 INFO - Installing collected packages: mozsystemmonitor 01:03:27 INFO - Running setup.py install for mozsystemmonitor 01:03:27 INFO - Successfully installed mozsystemmonitor 01:03:27 INFO - Cleaning up... 01:03:27 INFO - Return code: 0 01:03:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:27 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 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:27 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 01:03:27 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 01:03:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:27 INFO - 'HOME': '/Users/cltbld', 01:03:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:27 INFO - 'LOGNAME': 'cltbld', 01:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:27 INFO - 'MOZ_NO_REMOTE': '1', 01:03:27 INFO - 'NO_EM_RESTART': '1', 01:03:27 INFO - 'PAGER': '/bin/cat', 01:03:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:27 INFO - 'PWD': '/builds/slave/test', 01:03:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:27 INFO - 'SHELL': '/bin/bash', 01:03:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:27 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:27 INFO - 'USER': 'cltbld', 01:03:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:27 INFO - 'XPC_FLAGS': '0x0', 01:03:27 INFO - 'XPC_SERVICE_NAME': '0', 01:03:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:27 INFO - Downloading/unpacking blobuploader==1.2.4 01:03:27 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 01:03:27 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 01:03:27 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 01:03:27 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 01:03:27 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 01:03:27 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 01:03:30 INFO - Downloading blobuploader-1.2.4.tar.gz 01:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:03:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:03:30 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 01:03:30 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 01:03:30 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 01:03:30 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 01:03:30 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 01:03:30 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 01:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:03:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:03:30 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 01:03:30 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 01:03:30 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 01:03:30 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 01:03:30 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 01:03:30 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 01:03:31 INFO - Downloading docopt-0.6.1.tar.gz 01:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:03:31 INFO - Installing collected packages: blobuploader, requests, docopt 01:03:31 INFO - Running setup.py install for blobuploader 01:03:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:03:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:03:31 INFO - Running setup.py install for requests 01:03:32 INFO - Running setup.py install for docopt 01:03:32 INFO - Successfully installed blobuploader requests docopt 01:03:32 INFO - Cleaning up... 01:03:32 INFO - Return code: 0 01:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:32 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')]} 01:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:32 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')]} 01:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:32 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 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:32 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 01:03:32 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 01:03:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:32 INFO - 'HOME': '/Users/cltbld', 01:03:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:32 INFO - 'LOGNAME': 'cltbld', 01:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:32 INFO - 'MOZ_NO_REMOTE': '1', 01:03:32 INFO - 'NO_EM_RESTART': '1', 01:03:32 INFO - 'PAGER': '/bin/cat', 01:03:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:32 INFO - 'PWD': '/builds/slave/test', 01:03:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:32 INFO - 'SHELL': '/bin/bash', 01:03:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:32 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:32 INFO - 'USER': 'cltbld', 01:03:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:32 INFO - 'XPC_FLAGS': '0x0', 01:03:32 INFO - 'XPC_SERVICE_NAME': '0', 01:03:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-YnxSY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-h4LIs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-88J2QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-jlxh26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-gPY3pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-NOK4Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-dEWR9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-t5RSye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-IdlEi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-F1YwiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-JAG_d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-GfPXQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-nXpu3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-LT_kFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:33 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-J7VQ0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:34 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-YeRGdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:34 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Yf5bf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:03:34 INFO - Running setup.py install for manifestparser 01:03:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:03:34 INFO - Running setup.py install for mozcrash 01:03:34 INFO - Running setup.py install for mozdebug 01:03:34 INFO - Running setup.py install for mozdevice 01:03:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:03:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:03:34 INFO - Running setup.py install for mozfile 01:03:35 INFO - Running setup.py install for mozhttpd 01:03:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Running setup.py install for mozinfo 01:03:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Running setup.py install for mozInstall 01:03:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Running setup.py install for mozleak 01:03:35 INFO - Running setup.py install for mozlog 01:03:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Running setup.py install for moznetwork 01:03:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:03:35 INFO - Running setup.py install for mozprocess 01:03:36 INFO - Running setup.py install for mozprofile 01:03:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:03:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:03:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:03:36 INFO - Running setup.py install for mozrunner 01:03:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:03:36 INFO - Running setup.py install for mozscreenshot 01:03:36 INFO - Running setup.py install for moztest 01:03:36 INFO - Running setup.py install for mozversion 01:03:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:03:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:03:36 INFO - Cleaning up... 01:03:36 INFO - Return code: 0 01:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:36 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')]} 01:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:36 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')]} 01:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:36 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 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:36 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 01:03:36 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 01:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:36 INFO - 'HOME': '/Users/cltbld', 01:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:36 INFO - 'LOGNAME': 'cltbld', 01:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:36 INFO - 'MOZ_NO_REMOTE': '1', 01:03:36 INFO - 'NO_EM_RESTART': '1', 01:03:36 INFO - 'PAGER': '/bin/cat', 01:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:36 INFO - 'PWD': '/builds/slave/test', 01:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:36 INFO - 'SHELL': '/bin/bash', 01:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:36 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:36 INFO - 'USER': 'cltbld', 01:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:36 INFO - 'XPC_FLAGS': '0x0', 01:03:36 INFO - 'XPC_SERVICE_NAME': '0', 01:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-T8y647-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-MPqnvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-WpHjky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-md4VnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-bZogQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-A2aSuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-CNGYlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-VcmvXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:37 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)) 01:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-VsZOms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-SSeMeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-VquO9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-pGA3kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-3wMfaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-WMC1Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-2MvHql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-R4VJSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:38 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)) 01:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:38 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-YJ9MCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:38 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)) 01:03:38 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)) 01:03:38 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)) 01:03:38 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)) 01:03:38 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)) 01:03:38 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)) 01:03:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03:41 INFO - Downloading blessings-1.6.tar.gz 01:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:03:41 INFO - Installing collected packages: blessings 01:03:41 INFO - Running setup.py install for blessings 01:03:41 INFO - Successfully installed blessings 01:03:41 INFO - Cleaning up... 01:03:41 INFO - Return code: 0 01:03:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:42 INFO - Reading from file tmpfile_stdout 01:03:42 INFO - Current package versions: 01:03:42 INFO - blessings == 1.6 01:03:42 INFO - blobuploader == 1.2.4 01:03:42 INFO - docopt == 0.6.1 01:03:42 INFO - manifestparser == 1.1 01:03:42 INFO - mozInstall == 1.12 01:03:42 INFO - mozcrash == 0.17 01:03:42 INFO - mozdebug == 0.1 01:03:42 INFO - mozdevice == 0.48 01:03:42 INFO - mozfile == 1.2 01:03:42 INFO - mozhttpd == 0.7 01:03:42 INFO - mozinfo == 0.9 01:03:42 INFO - mozleak == 0.1 01:03:42 INFO - mozlog == 3.1 01:03:42 INFO - moznetwork == 0.27 01:03:42 INFO - mozprocess == 0.22 01:03:42 INFO - mozprofile == 0.28 01:03:42 INFO - mozrunner == 6.11 01:03:42 INFO - mozscreenshot == 0.1 01:03:42 INFO - mozsystemmonitor == 0.0 01:03:42 INFO - moztest == 0.7 01:03:42 INFO - mozversion == 1.4 01:03:42 INFO - psutil == 3.1.1 01:03:42 INFO - requests == 1.2.3 01:03:42 INFO - wsgiref == 0.1.2 01:03:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03: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')]} 01:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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')]} 01:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:42 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 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:42 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 01:03:42 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 01:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:42 INFO - 'HOME': '/Users/cltbld', 01:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:42 INFO - 'LOGNAME': 'cltbld', 01:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:42 INFO - 'MOZ_NO_REMOTE': '1', 01:03:42 INFO - 'NO_EM_RESTART': '1', 01:03:42 INFO - 'PAGER': '/bin/cat', 01:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:42 INFO - 'PWD': '/builds/slave/test', 01:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:42 INFO - 'SHELL': '/bin/bash', 01:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:42 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:42 INFO - 'USER': 'cltbld', 01:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:42 INFO - 'XPC_FLAGS': '0x0', 01:03:42 INFO - 'XPC_SERVICE_NAME': '0', 01:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 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)) 01:03:42 INFO - Cleaning up... 01:03:42 INFO - Return code: 0 01:03:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:03: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')]} 01:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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')]} 01:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:42 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 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:42 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 01:03:42 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 01:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:42 INFO - 'HOME': '/Users/cltbld', 01:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:42 INFO - 'LOGNAME': 'cltbld', 01:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:42 INFO - 'MOZ_NO_REMOTE': '1', 01:03:42 INFO - 'NO_EM_RESTART': '1', 01:03:42 INFO - 'PAGER': '/bin/cat', 01:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:42 INFO - 'PWD': '/builds/slave/test', 01:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:42 INFO - 'SHELL': '/bin/bash', 01:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:42 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:42 INFO - 'USER': 'cltbld', 01:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:42 INFO - 'XPC_FLAGS': '0x0', 01:03:42 INFO - 'XPC_SERVICE_NAME': '0', 01:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:42 INFO - Downloading/unpacking jsonschema 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03: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 01:03:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:03:44 INFO - Downloading/unpacking functools32 (from jsonschema) 01:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:45 INFO - Downloading functools32-3.2.3-2.tar.gz 01:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:03:45 INFO - warning: no files found matching '*.txt' 01:03:45 INFO - no previously-included directories found matching 'build' 01:03:45 INFO - no previously-included directories found matching 'dist' 01:03:45 INFO - no previously-included directories found matching '.git*' 01:03:45 INFO - Installing collected packages: jsonschema, functools32 01:03:45 INFO - Running setup.py install for functools32 01:03:45 INFO - warning: no files found matching '*.txt' 01:03:45 INFO - no previously-included directories found matching 'build' 01:03:45 INFO - no previously-included directories found matching 'dist' 01:03:45 INFO - no previously-included directories found matching '.git*' 01:03:45 INFO - Successfully installed jsonschema functools32 01:03:45 INFO - Cleaning up... 01:03:45 INFO - Return code: 0 01:03:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c334d7420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, '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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:45 INFO - 'HOME': '/Users/cltbld', 01:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:45 INFO - 'LOGNAME': 'cltbld', 01:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:45 INFO - 'MOZ_NO_REMOTE': '1', 01:03:45 INFO - 'NO_EM_RESTART': '1', 01:03:45 INFO - 'PAGER': '/bin/cat', 01:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:45 INFO - 'PWD': '/builds/slave/test', 01:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:45 INFO - 'SHELL': '/bin/bash', 01:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:03:45 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:45 INFO - 'USER': 'cltbld', 01:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:45 INFO - 'XPC_FLAGS': '0x0', 01:03:45 INFO - 'XPC_SERVICE_NAME': '0', 01:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:45 INFO - Downloading/unpacking flake8 01:03:45 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 01:03:45 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 01:03:45 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 01:03:45 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 01:03:45 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 01:03:45 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 01:03:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:03:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:03:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:48 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 01:03:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:03:49 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 01:03:49 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 01:03:49 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 01:03:49 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 01:03:49 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 01:03:49 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 01:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:03:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:03:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:03:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:03:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:03:49 INFO - no previously-included directories found matching 'docs/_build' 01:03:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:03:49 INFO - Running setup.py install for pep8 01:03:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:03:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:03:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:03:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:03:49 INFO - no previously-included directories found matching 'docs/_build' 01:03:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:03:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:03:50 INFO - Cleaning up... 01:03:50 INFO - Return code: 0 01:03:50 INFO - Running post-action listener: _resource_record_post_action 01:03:50 INFO - Running post-action listener: _start_resource_monitoring 01:03:50 INFO - Starting resource monitoring. 01:03:50 INFO - ##### 01:03:50 INFO - ##### Running install step. 01:03:50 INFO - ##### 01:03:50 INFO - Running pre-action listener: _resource_record_pre_action 01:03:50 INFO - Running main action method: install 01:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:50 INFO - Reading from file tmpfile_stdout 01:03:50 INFO - Detecting whether we're running mozinstall >=1.0... 01:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:03:50 INFO - Reading from file tmpfile_stdout 01:03:50 INFO - Output received: 01:03:50 INFO - Usage: mozinstall [options] installer 01:03:50 INFO - Options: 01:03:50 INFO - -h, --help show this help message and exit 01:03:50 INFO - -d DEST, --destination=DEST 01:03:50 INFO - Directory to install application into. [default: 01:03:50 INFO - "/builds/slave/test"] 01:03:50 INFO - --app=APP Application being installed. [default: firefox] 01:03:50 INFO - mkdir: /builds/slave/test/build/application 01:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:04:24 INFO - Reading from file tmpfile_stdout 01:04:24 INFO - Output received: 01:04:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:04:24 INFO - Running post-action listener: _resource_record_post_action 01:04:24 INFO - ##### 01:04:24 INFO - ##### Running run-tests step. 01:04:24 INFO - ##### 01:04:24 INFO - Running pre-action listener: _resource_record_pre_action 01:04:24 INFO - Running main action method: run_tests 01:04:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:04:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:04:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:04:24 INFO - 2016-04-15 01:04:24.103 screenresolution[1639:7434] starting screenresolution argv=screenresolution get 01:04:24 INFO - 2016-04-15 01:04:24.106 screenresolution[1639:7434] Display 0: 1600x1200x32@60 01:04:24 INFO - 2016-04-15 01:04:24.112 screenresolution[1640:7436] starting screenresolution argv=screenresolution list 01:04:24 INFO - Available Modes on Display 0 01:04:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:04:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:04:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:04:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:04:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:04:24 INFO - Intel Iris: 01:04:24 INFO - Chipset Model: Intel Iris 01:04:24 INFO - Type: GPU 01:04:24 INFO - Bus: Built-In 01:04:24 INFO - VRAM (Dynamic, Max): 1536 MB 01:04:24 INFO - Vendor: Intel (0x8086) 01:04:24 INFO - Device ID: 0x0a2e 01:04:24 INFO - Revision ID: 0x0009 01:04:24 INFO - Displays: 01:04:24 INFO - Display: 01:04:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:04:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:04:24 INFO - Display Serial Number: 1600x1200 60 01:04:24 INFO - Main Display: Yes 01:04:24 INFO - Mirror: Off 01:04:24 INFO - Online: Yes 01:04:24 INFO - Rotation: Supported 01:04:24 INFO - Return code: 0 01:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:04:24 INFO - Python 2.7.3 01:04:24 INFO - Return code: 0 01:04:24 INFO - grabbing minidump binary from tooltool 01:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:04:24 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 0x10d26ce00>, '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 0x10d0d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d267b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:04:24 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 01:04:24 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 01:04:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:04:24 INFO - Return code: 0 01:04:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:04:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:04:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:04:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:04:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:04:25 INFO - Return code: 0 01:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 01:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --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 01:04:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.d8JRuSEqyO/Render', 01:04:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:04:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:04:25 INFO - 'HOME': '/Users/cltbld', 01:04:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:04:25 INFO - 'LOGNAME': 'cltbld', 01:04:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:04:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:25 INFO - 'MOZ_NO_REMOTE': '1', 01:04:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:04:25 INFO - 'NO_EM_RESTART': '1', 01:04:25 INFO - 'PAGER': '/bin/cat', 01:04:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:25 INFO - 'PWD': '/builds/slave/test', 01:04:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:04:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:04:25 INFO - 'SHELL': '/bin/bash', 01:04:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cO6zbPXqoi/Listeners', 01:04:25 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:04:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:04:25 INFO - 'USER': 'cltbld', 01:04:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:04:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:25 INFO - 'XPC_FLAGS': '0x0', 01:04:25 INFO - 'XPC_SERVICE_NAME': '0', 01:04:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:04:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 01:04:25 INFO - mozversion application_buildid: 20160414215914 01:04:25 INFO - mozversion application_changeset: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 01:04:25 INFO - mozversion application_display_name: Nightly 01:04:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:04:25 INFO - mozversion application_name: Firefox 01:04:25 INFO - mozversion application_remotingname: firefox 01:04:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:04:25 INFO - mozversion application_vendor: Mozilla 01:04:25 INFO - mozversion application_version: 48.0a1 01:04:25 INFO - mozversion platform_buildid: 20160414215914 01:04:25 INFO - mozversion platform_changeset: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 01:04:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:04:25 INFO - mozversion platform_version: 48.0a1 01:04:25 INFO - using testdate: 1460707465 01:04:25 INFO - actual date: 1460707465 01:04:25 INFO - starting webserver on 'localhost:49273' 01:04:25 INFO - SUITE-START | Running 2 tests 01:04:25 INFO - TEST-START | dromaeo_css 01:04:25 INFO - operating with platform_type : mac_ 01:04:25 INFO - Initialising browser for dromaeo_css test... 01:04:25 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpS6pGY8/profile http://localhost:49273/getInfo.html) 01:04:28 INFO - PROCESS | 1658 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 01:04:28 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 01:04:28 INFO - PROCESS | 1658 | colorDepth:24 01:04:28 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 01:04:28 INFO - PROCESS | 1658 | __metrics 01:04:28 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:04:29 INFO - TEST-INFO | 1658: exit 0 01:04:29 INFO - Browser initialized. 01:04:29 INFO - Running cycle 1/1 for dromaeo_css test... 01:04:29 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpS6pGY8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:04:41 INFO - PROCESS | 1661 | RSS: Main: 248225792 01:04:41 INFO - PROCESS | 1661 | 01:05:31 INFO - PROCESS | 1661 | 1460707531089 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] 01:07:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 01:07:42 INFO - PROCESS | 1661 | RSS: Main: 260153344 01:07:42 INFO - PROCESS | 1661 | 01:10:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 01:10:44 INFO - PROCESS | 1661 | RSS: Main: 271982592 01:10:44 INFO - PROCESS | 1661 | 01:13:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 01:13:47 INFO - PROCESS | 1661 | RSS: Main: 273895424 01:13:47 INFO - PROCESS | 1661 | 01:16:49 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 01:16:49 INFO - PROCESS | 1661 | RSS: Main: 275570688 01:16:49 INFO - PROCESS | 1661 | 01:19:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 01:19:52 INFO - PROCESS | 1661 | RSS: Main: 278503424 01:19:52 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 01:22:55 INFO - PROCESS | 1661 | RSS: Main: 279379968 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | __start_tp_report 01:22:55 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 01:22:55 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 01:22:55 INFO - PROCESS | 1661 | |i|pagename|runs| 01:22:55 INFO - PROCESS | 1661 | |0;dojo.html;2693.6902256240533;2696.797740169488;2807.5928990296406;3573.6962358199553;3576.2668652926154;5810.941890581098;5871.76512939483;5891.116332550119;5905.911411328833;5953;4616.976915115428;5214.322138122039;5847.5614328925285;5913.615614985023;6063.060225665029;5274.182501712241;5312.362516498007;5382.9730851345685;5384.219288203209;5402.9729851350685;375.5256544436993;5305.734713264341;5322.680639161663;5328.973355133238;5393.056215162351;5277.182036784286;5292.206169074631;5327;5337.332833395825;5340.198970154508;5223.973880130613;5384.138537833967;5423.566114710814;5435.021696094701;5437.755301011464;5218.843434696965;5248.186531087687;5310.654807437543;5322.281491998569;5327.600429967768;5726.255586773693;5829.562782791308;5831.358550559435;5856.882862342729;5862.530997520188;6046.395360463918;6122.418474876053;6197.411245931629;6209.6895155242055;6220.222472190976;6184.19605451293;6288.811335659938;6289.245290565115;6290.87418251637;6294.433500984934;5978.940210597882;6020.789272375489;6032.306284777219;6043;6052.766943502473;6224.906626400517;6381.329960354096;6436.903446448307;6484.319146489551;6487.156669633012;6146.108814221912;6159.969200153971;6182.165407669997;6194.194754681953;6205.565610407228;6227.439530442282;6252.687365631791;6274.905876411857;6279.152314437584;6281.7173227204885;6107.877842443127;6110.042400473247;6199;6212.937870621236;6267.310595834455;6157.230346206724;6199.721012554446;6262.342454042351;6263.874722505524;6286.9056964145575;4946.9010619787405;5009.198528235464;5026.371703537058;5035.924461133086;5055.443901170868;4390.297552391666;4431.8670439886855;4509.6392288616835;4580.679352445363;4594.173048851172;5100.413452452941;5718.313802343662;5866.823995280149;5939.346671866091;5976.551758618034;6276.780312689034;6279.686015699197;6287.402696743802;6292.779752708725;6300.338464461257;4930.6795058321095;5779.422057794271;5943.435373639497;5978.970105149533;6007.8197654070445;5498.202760599771;5518.503334699896;5529.115341545334;5533.22534845122;5544.500994910397;5307.442718514578;6483;6547.148870646785;6576.309487503839;6605.57063790852;4676.08816280822;5791.478766910998;6258.874822503433;6262.2172228471445;6278.46633036197;6513.576617519846;6519.41325280708;6546.639934803631;6549.770758023446;6568.27748947625;5227.032998895064;6153.230846144232;6170.784022559189;6183.536234782499;6184.783532576338;6182.629042257479;6223.533235007483;6263.655498947602;6274.717637706223;6279.466245369012;5517.44825517445;5961.344252132349;6131.570790044832;6152.292486363946;6154.323024467216;6087.239095113111;6115.969420152871;6129.450483694133;6131.110988906495;6163.445289923929;5999.760009599567;6070.696465176812;6143.266246520256;6168.537359697951;6171.938280617316;5565.638233514808;5788.507976822018;6011.218541589566;6202.782902598387;6204.503639708722;5958.374370691015;6101.359357267601;6109.327973922776;6115.816525504242;6145.340757995227 01:22:55 INFO - PROCESS | 1661 | |1;ext.html;522.2610006840321;540.1411755309058;574.6067995137943;590.1590233916673;590.7548367427516;37125.81437092814;37641.24717505648;37980.430293545585;38013.42979855304;38122.42816357753;39287.21425571487;39781;39812.60187398125;39880.60119398805;39890.80054599723;9362.95318523408;9455.57449914752;9570.90429095707;9614.182794462478;9663.323567350288;9325.207357374597;9526.85709714355;9542;9548.570314335837;9568.23454123672;9414.246860251164;9517.762055948588;9549;9575.664851730191;9587.568559414809;9500.524973751284;9507.857382139273;9523.999980002138;9576.712698619052;9608.135267825894;9483.193928516084;9551.952240238754;9679.70960871175;9703.223742100685;9721.027897210293;32409.83795081033;38662.420063699064;38930;39054.41418378727;39108.82673519799;2991.9401611967637;3035.893743718981;3101.736352410025;3260.152360386293;3358.412277851366;27153.77807998645;28178.718212817814;28363.290917727016;28532.286692832844;28619.57070643942;2333.9066437342485;2712.6609173853267;2775.0703514322727;2822.3508593023516;2858.285428642839;412526;413338;417480;419313.90343048394;421952;61682;61847;62040;62131.06803397953;62780;62892.68553657294;63105;63235.36764632295;63591.410214745;63658.40853978688;16742.83257167437;16963.660726785394;16977.320907163576;16981.98108113517;16995.23521441538;12958.546450874363;12997.870021299666;13013.21920684762;13045.47818087285;13061.281629510278;18707;19250.518737031405;19324.71012934807;19460.610787784164;19628.018599070274;7824.804379890435;7848.254415830487;8087.37160422865;8256.504609723315;8292.792680182924;857.5583574459158;910.5902343945119;983.0660872171466;1023.6059117239768;1049.18163832211;25420.618690719653;28769.71230287712;28965;29022.854885725435;29464.705352946625;986.2307400227834;996.2478328861663;1078.9676309710721;1111.2054880760295;1236.746466974268;15392.692146157015;15499.5350139496;15507.99198052123;15532.378704851906;16059;557654;626599;628658;640091;645149;54815.72592137014;59812.401875980686;61663;62188.06717899235;62494.75010499855;1411.4424802203073;1458.6207586027708;1479.9408023679148;1503.7744338349335;1505.8870584706192;24079.759202407753;29432.852835735684;29519.55720664149;29549.55675664824;30508.779648813797;51547.48452515427;52101.7394913023;52292.73853630707;52344.73827630837;52368.21447678364;550004;555053;560407;562576;567952;26527.867360663844;41293.38059929043;43805.12389752123;43846.90382740457;43905.56094439015;45299.547004530854;47749.283760742925;48059;48081.038379232916;48750.562471876976;36125.27749444944;36145.27709445849;36645;37068.25863482769;37642.623573763914;31793.841030794698;35465.468017979234;35808.10479738027;36032.81983590065;36250.274994499436;34637;35450.64549354473;36008.459873102445;36763.89708308755;37622.683206087655;31669.683303167596;32479.837600811843;33379.666203337656;33409.331813364086;33494.83252583721;23968.400789979692;24465.755342446348;24571.631425528987;24740;25130.497390052464 01:22:55 INFO - PROCESS | 1661 | |2;jquery.html;391.0419472292882;393.3038521816385;393.49239481069424;396.09097122104765;403.8202999665148;12138.332391718452;15322.846771532282;18320.908395458006;19519.12163952622;19629.411117666456;19383.515412114702;19426.737262077953;19877.403677889688;20658.69011964818;20974.265900693477;5503.697296648683;5722.656640601556;5856.180134781134;5881.3530511643685;5928.584999050068;5676.262085928824;5774.191613174138;5793.913091303634;5806.477417032466;5833.562482813784;6343.0802533632595;6366.140571022899;6469.029645553182;6585.0451684505715;6585.769498067569;5813.389594092644;5915.615484993483;5967.343592204854;6627.23786764521;6629.204495460552;5652.689102099383;5770.6249093808765;5841.007028805071;5860.560457965627;5881.05903055509;12782.23306601607;13656.863431365759;13670;13680.452781888713;13724.794128088086;2027.4323189506815;2071.2543484345774;2240.1599400224914;2279.954400911989;2314.8032417244553;10019.348742331726;10219.284650074498;10254.846177307347;11546.36494992775;15278.847211527853;1666.6333406650517;1730.5846596816673;1811.4656176427986;1831.111910723298;1834.7889992650883;118480;121196;122088;122541;126209.36895315557;9431.669891553762;9739.805203896025;11362.431878406047;11674.708132296591;11718.179727419169;14630.487932922297;14952.775708364383;15012.699746005019;15015.924920375328;15045.699086018218;8485.703000394957;8559.186877246651;8604.0965698602;8869.334799890034;8891.91108088911;7425.591592462466;8379.743038544268;8541.615627296787;8633.007204171476;8721.43310684816;4592.058627981256;4670.8365207217585;4685.391028185829;4686.95313046872;4690.507496712864;1870.7839904062469;1902.2391043582402;1949.6393167264102;2005.7593088829433;2011;900.9864852027225;911.2436677557612;987.2842189412619;998.5057396588589;1044.4882007816116;18534.53663658392;19586.21655133807;19948.90025549863;20036.799632003494;20265.79734202639;950.4249928792981;969.4619486185094;991.0782971836118;995.1640621877658;997.5560875410373;8738.563071846509;10539.10417614496;10676;10729.678109656723;11153.721156970978;598942;621064;635950;640157;640288.5971140323;104195;125568;126004.36997814952;128783;135023.32488337497;1005.1807776661997;1025.7692019295598;1055.9155267578576;1057.080340104099;1059.6026490066224;14568.781468278195;14996.625084372978;16041.919790400972;17839.286428542713;17946.37187698424;40287.388504460665;51346;51379.74310128426;51792.48207517876;53250;74954;79223;79387.60306198432;80654.91813523309;81939;5427.457254274541;6232.657203853832;7182.554095538534;8055.187582793825;8171.468854524437;8695;9956;10612.681619551426;11666.241694289844;11799.292042477478;10959.945200273947;11094.500747466545;11095.778084438427;11271.154663400113;11284.492197850952;9519.28605354615;10928.50821713009;10974.286671366335;11016.449177541252;11054.889451105386;11125.610603628835;11358.204925655125;11370.43147842588;11600.767984640428;11755.88244117548;8057.717979870677;8131.186881311822;8165.959170204349;8171.101178870438;8398.790030249293;10928.672139835817;11023.007929286403;11059.115270778157;11097.833532496858;11397.259178153394 01:22:55 INFO - PROCESS | 1661 | |3;mootools.html;1590.1095386583513;1624.131089866921;1871.2047379863554;1949.3469687654635;1960.4804726747404;8159.469634473755;8646.740597782062;8812.559372031397;9076.137766912148;9101.544922753861;8687.13128687131;8752.29981601472;8792.428492148007;8841.160089791476;8854.33592480565;2439.9390015249583;2461.433870209853;2469.1481438903547;2471.147454128323;2478.8264821462503;2362.4684445999596;2477.380654836291;2488.4401009772746;2493.3543861051708;2501.4496810701708;2460.7662272084212;2465.6917885264343;2487.3532881450865;2505.8747062646885;2513.6606558114695;2408.987955060231;2423.9515209695883;2453.472503411766;2466.519028789387;2467.5311690778876;2443.1204766284122;2455.1407007547396;2459.508098380331;2459.9754002460104;2483.0316176691103;8851.291896648252;8980.236679882219;8990.100989901022;9009.549522523848;9019.23336516397;4761.238201887716;5305.867353316159;5437.510624043815;5521.337439507285;5537.501624853742;2941.3970136122257;3411.539442175324;3416.0605833395766;3484.686378225972;3499.387607168761;1031.6337700116426;1033.101201954297;1045.3048722599538;1049.470017641094;1084.5444913136503;10514.369137851754;11243.60647377346;11433.314001159873;11590.304581725039;11702.590409335633;4808.63935204861;4851.34506841579;4851.95148048515;4929.654924155275;4941.851744447672;9911.851322230172;9949.253805964581;10022.448765317831;10104.888462269144;10249.38503689781;5353;5357.08929481989;5399.622026458111;5464.0711079116645;5501.724913754297;4510.300903359985;4854.101991131652;4889.511048895082;5008.474110218374;5011.674241174312;4098.569650186688;4102.753834769924;4108.898286045221;4166.375043743463;4184.790760461965;1349.7233067221196;1353.2557093598482;1362.2439546052037;1375.1817668487233;1385.8752712255946;814.9022117345957;926.3191554207652;935.5556110847293;936.6628013914985;958.0563145301873;5926.525877929842;5935.584509084409;5982.850428739316;6006.669633170218;6087.916589647605;447.1236376701701;448.53128480737706;458.43841294414074;464.8489240996622;466.65467554009786;3437.8281085945605;3751.3435148848844;4020.3969404589548;4031.717779755389;4108.014076621649;10399.740006499747;10662.306950048222;10867.130629549618;10902.236843421044;10964.342139471657;9672.322937394314;10905.618303359344;10953.123750099972;10964.56141754337;10970.341779493096;8010.919890801018;8183.549904755177;8300.87548686758;8348.624311905978;8453.619587118594;5877.853053673522;5901.498372638373;5946.98901186808;5964.075568286922;5989.071693887455;9794.75513112178;9875.703728888146;10081.193504519768;10130.341527800669;10141.695749127539;8220.93127893394;9688.85466718014;9928.503574821374;10041.347312424668;10196.184305255414;6506.60960342381;6955.304469553004;7007.334303241184;7343.412526997934;7603.543787372775;8176.141505141874;8189.877151842847;8440.493570385797;8481.575921203792;8528.872066919126;6478.4169424752;7344.779656610311;7345.192028876926;7372.59450730215;7625.046869141357;7230.855382892418;7421;7485.925140748523;7514.849703006019;7601.315881570686;6627.713438863584;6809.5573787705625;7113.928860711534;7127.786166415016;7191.82020449472;4758.143534163745;4856.878578035577;4889.3888263967;4966.081274964144;5080.898382032413;4429.80065897029;4882.511748825089;4948.480409556944;5030.421501527371;5206.453322401093 01:22:55 INFO - PROCESS | 1661 | |4;prototype.html;314.6821710072827;323.50665235515834;330.9867605295788;331.3555135261916;332.69724550658907;5441.156620723794;6156.907646385308;6172.938270617293;6233.812985610439;6314.305426403098;6134.662593557353;6160.59956102853;6200.68996550173;6203.751849926009;6208.2550093988675;3632.346177688015;4433.229231730169;4606.5393460654;4634.930476042845;4647.093816705744;3644.6173151819075;4095.9590404095875;4544.363789069533;4551.931721024187;4583.885402864922;4261.744295342274;4438.7780610969485;4496.213162696531;4530.275155975029;4548.704334218265;4422.115576884636;4512.706674066191;4524.411826462571;4546.8863278417975;4550;3237.854296556637;3578.8926332210076;3729.6083911189207;3802.448644946495;3839.1745774658584;5401.567874570025;5880.089355768879;5894.440028197358;5952.404759524056;5960.956832554329;5308.575313974911;5314.256004159421;5319.813806516753;5322;5323.733813309319;6123.724432400552;6521.217453905514;6531.93468065318;6566.310537393552;6583.769568065095;4233.343831706091;4269.274223382002;4279.272523670952;4303.91392172158;4304.526502084768;5316.066111077813;6420.625905761636;6881.380675739158;6993.6503174841055;7029.156501219835;3546.361654902091;4098.282800509899;4343.391925130484;4347.174036932973;4347.608715215646;3930.5479869814767;4382.452193475816;4431.446069241345;4443.466783985942;4465.106978604292;5231.398389185217;5261.868453288698;5263.315768950012;5274.077036518671;5281.207818827206;6137.693115344304;6251.3123556408755;6538.5615164663695;6603.867922641521;6616.966915165393;1266.6896610330527;1300.3433266200698;1386.4107754204422;1420.6448387903024;1528.9847101529065;914.6707185413246;940.7507010642186;970.8737864077625;984.6799790068256;996.6561536269975;6085.117657939662;6094.908576371358;6111.9694401528595;6119.694015299217;6150.815475535741;5946.791862284886;6085.695715214221;6840.760573379908;6842.349976752201;6863.862722745517;5303.7878484860175;5831.212786273799;6104.511639068953;6127.417895299939;6148.6635078669815;3455.36075825973;3591.586967498719;3601.837917293728;3626.3472574936764;3632.727545434103;6918.481113916376;7004.194517630436;7076.646167691595;7151.42788576923;7172.242800513804;6978.302169783083;7017.578945263301;7031;7060;7082.858342833218;5793.986052440806;6842.6578671066245;7159.713611455483;7182.56904585737;7249.818754531179;5859.56053296013;6375.872482550416;6892.896606551006;6900.171979362308;6925.376716095576;5883.910682075916;6585.835354116185;6779.796606101825;6832.624205668736;6833.521653484408;5843.766249350148;7127.429805615642;7179.317964793337;7223;7265.782026539212;4075.7962101894195;4310.116426132698;4350.934735979026;4354.670251415478;4357.803898824497;6042.851858146938;6670.032845237316;6679.126106858108;6808.38724514796;6824.7952561423235;5722.5421966241765;6607.339266073354;6632.104665870046;6652.866942661217;6695.698693558704;5562.332520097614;5666;6235.438810506895;6295.181626388723;6585.604863708193;5086.720230387365;5668.064769313017;5848;6489.448396886318;6508.772192973223;5589.748461319332;6408.263049749152;6564.737410503526;6597.406233439014;6607.438367738796;5430.321209848769;6394.552381333262;6453.322401147811;6475.190601174853;6477.643729594917 01:22:55 INFO - PROCESS | 1661 | |5;yui.html;684.5653010338435;734.2033893225849;734.9007883935669;764.5756605084183;780.6799212322949;15023.849761502383;15028.323725432354;15444.996075255101;15455.07269563827;15504.92247538762;14278.00053996218;14317.713645727104;14341.13953162811;14362.640933976656;14380.209088500129;724.8332883436813;915.8031023329983;920.8480600700893;938.1509733691021;939.910708482693;930.5440334236243;931.818295432391;934.9065093490631;937.4703292639637;941.5245301122924;993.2798720927342;995.7411073120968;999.8050380175869;1000.0249756487403;1002.5939494504701;918.3433844800933;947.6683160893666;979.4025644356936;991.2862738828032;994.6419289055971;689.8034060292842;694.3369082526175;738.6565247160096;746.6528064450057;748.3751067858345;15157.621059473491;15425.228738563026;15436.073835569789;15457.149856757875;15486.380544778196;10272.897271027268;13353.39909704056;13404.86595134046;13441.39513721885;13534.526291579847;10338.0178883006;10348.896511034869;10367.118794902442;10567.577296908114;10678.679639610746;3525.11872031992;3581.9104522387147;3583.928321433557;3618.0412190769466;3686.152184997439;75328;77862.22137778663;89357.65963510552;92870;92879.60680589797;9427;9634.373765705206;9667.613295468103;9948.950255248677;9987.450690212108;21049;21065.578688426147;21093.15627374888;21120.577588448145;21134.943252837296;7556.735514257085;7664.808379790438;7667.654955527015;7697.345725613273;7778.64996075178;3513.578370595545;3751.4560388744026;4156.709030367906;4202.705810593229;4276.2516559601945;3376.307856889332;3569.696575791087;3580.0691820126954;3598.8200589970397;3694.722895782827;592.973316200772;611.3641812515024;617.7528988404584;654.7970129259945;672.8217022489044;578.1991941161438;584.9766009359663;603.3664652115349;603.3815339277276;604.8820480006444;7853.960730196427;7910.881336779953;8041.356691464669;8094.28374861661;8365.28895043928;519.6752029981262;583.5564970622273;607.4940868915722;611.2084850119106;628.1990462160782;4060.553339132693;4149.8340066397;4230.873073807791;4252.979284971647;4302.763348015889;85443.57278213694;90836;91449.08550914406;96064;97320.51339743397;65726.01410978839;68511.62976740536;70930.9360359595;78592;79879.20120798718;62816.371836281054;63365;63365.68317158385;63704.68147659232;63705.36294637087;8069.273765361146;8186.959065204635;8239.464434811718;8272.751817445485;8403.201695838885;42904;42959.78520107379;43171;43297.350539741296;43976.56023439725;55929.720351397984;61175;61233.69383153056;61363;61386.69306653438;10544.156467482737;10904.672859814218;10911.618093366695;11038.227324087558;11176.283136489552;11763.411829408324;11857.644270671894;11886.881131188924;12140.453679584263;12174.695632609255;10496.52765625564;11369.204155709022;11470.197086203885;11637.243579167327;11689.064874810165;11218.158638102012;11317.943410282896;11501.769964600828;11556.42217889119;11689.123315751183;10994.28537145083;11338.263012904135;11384.772304554028;11408.657740267805;11468;9397.812043759222;9544.188743956563;9545.856812147962;9562.521873906138;9752.366096203725;9373.85939210926;9537.332386732862;9594.808103837744;9662.661806836726;9695.806083878424 01:22:55 INFO - PROCESS | 1661 | __end_tp_report 01:22:55 INFO - PROCESS | 1661 | __start_cc_report 01:22:55 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,371 01:22:55 INFO - PROCESS | 1661 | __end_cc_report 01:22:55 INFO - PROCESS | 1661 | __startTimestamp1460708575665__endTimestamp 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | ------- Summary: start ------- 01:22:55 INFO - PROCESS | 1661 | Number of tests: 6 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5747.28 Median:6032.31 stddev:810.06 (13.4%) stddev-sans-first:776.31 01:22:55 INFO - PROCESS | 1661 | Values: 2693.7 2696.8 2807.6 3573.7 3576.3 5810.9 5871.8 5891.1 5905.9 5953.0 4617.0 5214.3 5847.6 5913.6 6063.1 5274.2 5312.4 5383.0 5384.2 5403.0 375.5 5305.7 5322.7 5329.0 5393.1 5277.2 5292.2 5327.0 5337.3 5340.2 5224.0 5384.1 5423.6 5435.0 5437.8 5218.8 5248.2 5310.7 5322.3 5327.6 5726.3 5829.6 5831.4 5856.9 5862.5 6046.4 6122.4 6197.4 6209.7 6220.2 6184.2 6288.8 6289.2 6290.9 6294.4 5978.9 6020.8 6032.3 6043.0 6052.8 6224.9 6381.3 6436.9 6484.3 6487.2 6146.1 6160.0 6182.2 6194.2 6205.6 6227.4 6252.7 6274.9 6279.2 6281.7 6107.9 6110.0 6199.0 6212.9 6267.3 6157.2 6199.7 6262.3 6263.9 6286.9 4946.9 5009.2 5026.4 5035.9 5055.4 4390.3 4431.9 4509.6 4580.7 4594.2 5100.4 5718.3 5866.8 5939.3 5976.6 6276.8 6279.7 6287.4 6292.8 6300.3 4930.7 5779.4 5943.4 5979.0 6007.8 5498.2 5518.5 5529.1 5533.2 5544.5 5307.4 6483.0 6547.1 6576.3 6605.6 4676.1 5791.5 6258.9 6262.2 6278.5 6513.6 6519.4 6546.6 6549.8 6568.3 5227.0 6153.2 6170.8 6183.5 6184.8 6182.6 6223.5 6263.7 6274.7 6279.5 5517.4 5961.3 6131.6 6152.3 6154.3 6087.2 6116.0 6129.5 6131.1 6163.4 5999.8 6070.7 6143.3 6168.5 6171.9 5565.6 5788.5 6011.2 6202.8 6204.5 5958.4 6101.4 6109.3 6115.8 6145.3 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:67141.47 Median:39198.02 stddev:143907.08 (367.1%) stddev-sans-first:144223.85 01:22:55 INFO - PROCESS | 1661 | Values: 522.3 540.1 574.6 590.2 590.8 37125.8 37641.2 37980.4 38013.4 38122.4 39287.2 39781.0 39812.6 39880.6 39890.8 9363.0 9455.6 9570.9 9614.2 9663.3 9325.2 9526.9 9542.0 9548.6 9568.2 9414.2 9517.8 9549.0 9575.7 9587.6 9500.5 9507.9 9524.0 9576.7 9608.1 9483.2 9552.0 9679.7 9703.2 9721.0 32409.8 38662.4 38930.0 39054.4 39108.8 2991.9 3035.9 3101.7 3260.2 3358.4 27153.8 28178.7 28363.3 28532.3 28619.6 2333.9 2712.7 2775.1 2822.4 2858.3 412526.0 413338.0 417480.0 419313.9 421952.0 61682.0 61847.0 62040.0 62131.1 62780.0 62892.7 63105.0 63235.4 63591.4 63658.4 16742.8 16963.7 16977.3 16982.0 16995.2 12958.5 12997.9 13013.2 13045.5 13061.3 18707.0 19250.5 19324.7 19460.6 19628.0 7824.8 7848.3 8087.4 8256.5 8292.8 857.6 910.6 983.1 1023.6 1049.2 25420.6 28769.7 28965.0 29022.9 29464.7 986.2 996.2 1079.0 1111.2 1236.7 15392.7 15499.5 15508.0 15532.4 16059.0 557654.0 626599.0 628658.0 640091.0 645149.0 54815.7 59812.4 61663.0 62188.1 62494.8 1411.4 1458.6 1479.9 1503.8 1505.9 24079.8 29432.9 29519.6 29549.6 30508.8 51547.5 52101.7 52292.7 52344.7 52368.2 550004.0 555053.0 560407.0 562576.0 567952.0 26527.9 41293.4 43805.1 43846.9 43905.6 45299.5 47749.3 48059.0 48081.0 48750.6 36125.3 36145.3 36645.0 37068.3 37642.6 31793.8 35465.5 35808.1 36032.8 36250.3 34637.0 35450.6 36008.5 36763.9 37622.7 31669.7 32479.8 33379.7 33409.3 33494.8 23968.4 24465.8 24571.6 24740.0 25130.5 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35203.40 Median:11522.76 stddev:104569.96 (907.5%) stddev-sans-first:104830.63 01:22:55 INFO - PROCESS | 1661 | Values: 391.0 393.3 393.5 396.1 403.8 12138.3 15322.8 18320.9 19519.1 19629.4 19383.5 19426.7 19877.4 20658.7 20974.3 5503.7 5722.7 5856.2 5881.4 5928.6 5676.3 5774.2 5793.9 5806.5 5833.6 6343.1 6366.1 6469.0 6585.0 6585.8 5813.4 5915.6 5967.3 6627.2 6629.2 5652.7 5770.6 5841.0 5860.6 5881.1 12782.2 13656.9 13670.0 13680.5 13724.8 2027.4 2071.3 2240.2 2280.0 2314.8 10019.3 10219.3 10254.8 11546.4 15278.8 1666.6 1730.6 1811.5 1831.1 1834.8 118480.0 121196.0 122088.0 122541.0 126209.4 9431.7 9739.8 11362.4 11674.7 11718.2 14630.5 14952.8 15012.7 15015.9 15045.7 8485.7 8559.2 8604.1 8869.3 8891.9 7425.6 8379.7 8541.6 8633.0 8721.4 4592.1 4670.8 4685.4 4687.0 4690.5 1870.8 1902.2 1949.6 2005.8 2011.0 901.0 911.2 987.3 998.5 1044.5 18534.5 19586.2 19948.9 20036.8 20265.8 950.4 969.5 991.1 995.2 997.6 8738.6 10539.1 10676.0 10729.7 11153.7 598942.0 621064.0 635950.0 640157.0 640288.6 104195.0 125568.0 126004.4 128783.0 135023.3 1005.2 1025.8 1055.9 1057.1 1059.6 14568.8 14996.6 16041.9 17839.3 17946.4 40287.4 51346.0 51379.7 51792.5 53250.0 74954.0 79223.0 79387.6 80654.9 81939.0 5427.5 6232.7 7182.6 8055.2 8171.5 8695.0 9956.0 10612.7 11666.2 11799.3 10959.9 11094.5 11095.8 11271.2 11284.5 9519.3 10928.5 10974.3 11016.4 11054.9 11125.6 11358.2 11370.4 11600.8 11755.9 8057.7 8131.2 8166.0 8171.1 8398.8 10928.7 11023.0 11059.1 11097.8 11397.3 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5715.16 Median:4869.70 stddev:3177.35 (65.2%) stddev-sans-first:3171.14 01:22:55 INFO - PROCESS | 1661 | Values: 1590.1 1624.1 1871.2 1949.3 1960.5 8159.5 8646.7 8812.6 9076.1 9101.5 8687.1 8752.3 8792.4 8841.2 8854.3 2439.9 2461.4 2469.1 2471.1 2478.8 2362.5 2477.4 2488.4 2493.4 2501.4 2460.8 2465.7 2487.4 2505.9 2513.7 2409.0 2424.0 2453.5 2466.5 2467.5 2443.1 2455.1 2459.5 2460.0 2483.0 8851.3 8980.2 8990.1 9009.5 9019.2 4761.2 5305.9 5437.5 5521.3 5537.5 2941.4 3411.5 3416.1 3484.7 3499.4 1031.6 1033.1 1045.3 1049.5 1084.5 10514.4 11243.6 11433.3 11590.3 11702.6 4808.6 4851.3 4852.0 4929.7 4941.9 9911.9 9949.3 10022.4 10104.9 10249.4 5353.0 5357.1 5399.6 5464.1 5501.7 4510.3 4854.1 4889.5 5008.5 5011.7 4098.6 4102.8 4108.9 4166.4 4184.8 1349.7 1353.3 1362.2 1375.2 1385.9 814.9 926.3 935.6 936.7 958.1 5926.5 5935.6 5982.9 6006.7 6087.9 447.1 448.5 458.4 464.8 466.7 3437.8 3751.3 4020.4 4031.7 4108.0 10399.7 10662.3 10867.1 10902.2 10964.3 9672.3 10905.6 10953.1 10964.6 10970.3 8010.9 8183.5 8300.9 8348.6 8453.6 5877.9 5901.5 5947.0 5964.1 5989.1 9794.8 9875.7 10081.2 10130.3 10141.7 8220.9 9688.9 9928.5 10041.3 10196.2 6506.6 6955.3 7007.3 7343.4 7603.5 8176.1 8189.9 8440.5 8481.6 8528.9 6478.4 7344.8 7345.2 7372.6 7625.0 7230.9 7421.0 7485.9 7514.8 7601.3 6627.7 6809.6 7113.9 7127.8 7191.8 4758.1 4856.9 4889.4 4966.1 5080.9 4429.8 4882.5 4948.5 5030.4 5206.5 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5274.02 Median:5956.68 stddev:1706.40 (28.6%) stddev-sans-first:1670.09 01:22:55 INFO - PROCESS | 1661 | Values: 314.7 323.5 331.0 331.4 332.7 5441.2 6156.9 6172.9 6233.8 6314.3 6134.7 6160.6 6200.7 6203.8 6208.3 3632.3 4433.2 4606.5 4634.9 4647.1 3644.6 4096.0 4544.4 4551.9 4583.9 4261.7 4438.8 4496.2 4530.3 4548.7 4422.1 4512.7 4524.4 4546.9 4550.0 3237.9 3578.9 3729.6 3802.4 3839.2 5401.6 5880.1 5894.4 5952.4 5961.0 5308.6 5314.3 5319.8 5322.0 5323.7 6123.7 6521.2 6531.9 6566.3 6583.8 4233.3 4269.3 4279.3 4303.9 4304.5 5316.1 6420.6 6881.4 6993.7 7029.2 3546.4 4098.3 4343.4 4347.2 4347.6 3930.5 4382.5 4431.4 4443.5 4465.1 5231.4 5261.9 5263.3 5274.1 5281.2 6137.7 6251.3 6538.6 6603.9 6617.0 1266.7 1300.3 1386.4 1420.6 1529.0 914.7 940.8 970.9 984.7 996.7 6085.1 6094.9 6112.0 6119.7 6150.8 5946.8 6085.7 6840.8 6842.3 6863.9 5303.8 5831.2 6104.5 6127.4 6148.7 3455.4 3591.6 3601.8 3626.3 3632.7 6918.5 7004.2 7076.6 7151.4 7172.2 6978.3 7017.6 7031.0 7060.0 7082.9 5794.0 6842.7 7159.7 7182.6 7249.8 5859.6 6375.9 6892.9 6900.2 6925.4 5883.9 6585.8 6779.8 6832.6 6833.5 5843.8 7127.4 7179.3 7223.0 7265.8 4075.8 4310.1 4350.9 4354.7 4357.8 6042.9 6670.0 6679.1 6808.4 6824.8 5722.5 6607.3 6632.1 6652.9 6695.7 5562.3 5666.0 6235.4 6295.2 6585.6 5086.7 5668.1 5848.0 6489.4 6508.8 5589.7 6408.3 6564.7 6597.4 6607.4 5430.3 6394.6 6453.3 6475.2 6477.6 01:22:55 INFO - PROCESS | 1661 | 01:22:55 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17752.16 Median:606.19 stddev:24786.79 (4089.0%) stddev-sans-first:24823.20 01:22:55 INFO - PROCESS | 1661 | Values: 684.6 734.2 734.9 764.6 780.7 15023.8 15028.3 15445.0 15455.1 15504.9 14278.0 14317.7 14341.1 14362.6 14380.2 724.8 915.8 920.8 938.2 939.9 930.5 931.8 934.9 937.5 941.5 993.3 995.7 999.8 1000.0 1002.6 918.3 947.7 979.4 991.3 994.6 689.8 694.3 738.7 746.7 748.4 15157.6 15425.2 15436.1 15457.1 15486.4 10272.9 13353.4 13404.9 13441.4 13534.5 10338.0 10348.9 10367.1 10567.6 10678.7 3525.1 3581.9 3583.9 3618.0 3686.2 75328.0 77862.2 89357.7 92870.0 92879.6 9427.0 9634.4 9667.6 9949.0 9987.5 21049.0 21065.6 21093.2 21120.6 21134.9 7556.7 7664.8 7667.7 7697.3 7778.6 3513.6 3751.5 4156.7 4202.7 4276.3 3376.3 3569.7 3580.1 3598.8 3694.7 593.0 611.4 617.8 654.8 672.8 578.2 585.0 603.4 603.4 604.9 7854.0 7910.9 8041.4 8094.3 8365.3 519.7 583.6 607.5 611.2 628.2 4060.6 4149.8 4230.9 4253.0 4302.8 85443.6 90836.0 91449.1 96064.0 97320.5 65726.0 68511.6 70930.9 78592.0 79879.2 62816.4 63365.0 63365.7 63704.7 63705.4 8069.3 8187.0 8239.5 8272.8 8403.2 42904.0 42959.8 43171.0 43297.4 43976.6 55929.7 61175.0 61233.7 61363.0 61386.7 10544.2 10904.7 10911.6 11038.2 11176.3 11763.4 11857.6 11886.9 12140.5 12174.7 10496.5 11369.2 11470.2 11637.2 11689.1 11218.2 11317.9 11501.8 11556.4 11689.1 10994.3 11338.3 11384.8 11408.7 11468.0 9397.8 9544.2 9545.9 9562.5 9752.4 9373.9 9537.3 9594.8 9662.7 9695.8 01:22:55 INFO - PROCESS | 1661 | -------- Summary: end -------- 01:22:55 INFO - PROCESS | 1661 | 01:22:56 INFO - TEST-INFO | 1661: exit 0 01:22:56 INFO - TEST-OK | dromaeo_css | took 1110301ms 01:22:56 INFO - TEST-START | kraken 01:22:56 INFO - operating with platform_type : mac_ 01:22:56 INFO - Initialising browser for kraken test... 01:22:56 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmphvj2j5/profile http://localhost:49273/getInfo.html) 01:22:58 INFO - PROCESS | 1672 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 01:22:58 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 01:22:58 INFO - PROCESS | 1672 | colorDepth:24 01:22:58 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 01:22:58 INFO - PROCESS | 1672 | __metrics 01:22:59 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:22:59 INFO - TEST-INFO | 1672: exit 0 01:22:59 INFO - Browser initialized. 01:22:59 INFO - Running cycle 1/1 for kraken test... 01:22:59 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmphvj2j5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:23:11 INFO - PROCESS | 1675 | RSS: Main: 247898112 01:23:11 INFO - PROCESS | 1675 | 01:23:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 01:23:15 INFO - PROCESS | 1675 | RSS: Main: 260079616 01:23:15 INFO - PROCESS | 1675 | 01:23:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 01:23:18 INFO - PROCESS | 1675 | RSS: Main: 268943360 01:23:18 INFO - PROCESS | 1675 | 01:23:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 01:23:22 INFO - PROCESS | 1675 | RSS: Main: 272211968 01:23:22 INFO - PROCESS | 1675 | 01:23:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 01:23:24 INFO - PROCESS | 1675 | RSS: Main: 274157568 01:23:24 INFO - PROCESS | 1675 | 01:23:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:23:27 INFO - PROCESS | 1675 | RSS: Main: 275091456 01:23:27 INFO - PROCESS | 1675 | 01:23:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 01:23:31 INFO - PROCESS | 1675 | RSS: Main: 274874368 01:23:31 INFO - PROCESS | 1675 | 01:23:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 01:23:34 INFO - PROCESS | 1675 | RSS: Main: 274747392 01:23:34 INFO - PROCESS | 1675 | 01:23:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 01:23:38 INFO - PROCESS | 1675 | RSS: Main: 274927616 01:23:38 INFO - PROCESS | 1675 | 01:23:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:23:40 INFO - PROCESS | 1675 | RSS: Main: 275382272 01:23:40 INFO - PROCESS | 1675 | 01:23:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:23:43 INFO - PROCESS | 1675 | RSS: Main: 275070976 01:23:43 INFO - PROCESS | 1675 | 01:23:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:23:46 INFO - PROCESS | 1675 | RSS: Main: 275185664 01:23:46 INFO - PROCESS | 1675 | 01:23:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:23:49 INFO - PROCESS | 1675 | RSS: Main: 275378176 01:23:49 INFO - PROCESS | 1675 | 01:23:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:23:53 INFO - PROCESS | 1675 | RSS: Main: 275193856 01:23:53 INFO - PROCESS | 1675 | 01:23:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 01:23:55 INFO - PROCESS | 1675 | RSS: Main: 276856832 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | __start_tp_report 01:23:55 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 01:23:55 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 01:23:55 INFO - PROCESS | 1675 | |i|pagename|runs| 01:23:55 INFO - PROCESS | 1675 | |0;ai-astar;119;109;117;127;172;135;118;118;117;117 01:23:55 INFO - PROCESS | 1675 | |1;audio-beat-detection;146;124;147;164;127;140;140;122;171;123 01:23:55 INFO - PROCESS | 1675 | |2;audio-dft;200;202;195;212;228;232;247;202;197;204 01:23:55 INFO - PROCESS | 1675 | |3;audio-fft;65;80;76;148;56;56;57;83;130;56 01:23:55 INFO - PROCESS | 1675 | |4;audio-oscillator;77;85;111;113;117;121;143;79;79;115 01:23:55 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;88;85;88;85;88;85;88;85;92;85 01:23:55 INFO - PROCESS | 1675 | |6;imaging-darkroom;115;150;95;97;96;134;147;136;95;114 01:23:55 INFO - PROCESS | 1675 | |7;imaging-desaturate;115;147;98;151;148;91;96;91;91;93 01:23:55 INFO - PROCESS | 1675 | |8;json-parse-financial;66;59;59;50;57;72;90;96;53;52 01:23:55 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;62;64;66;72;70;72;70;68;66;64 01:23:55 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;87;85;101;86;84;108;112;112;88;86 01:23:55 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;149;147;154;150;162;149;147;146;181;149 01:23:55 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;172;172;168;169;173;171;167;170;173;173 01:23:55 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;68;71;83;62;68;70;68;65;70;69 01:23:55 INFO - PROCESS | 1675 | __end_tp_report 01:23:55 INFO - PROCESS | 1675 | __start_cc_report 01:23:55 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,971 01:23:55 INFO - PROCESS | 1675 | __end_cc_report 01:23:55 INFO - PROCESS | 1675 | __startTimestamp1460708635060__endTimestamp 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | ------- Summary: start ------- 01:23:55 INFO - PROCESS | 1675 | Number of tests: 14 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:124.90 Median:118.50 stddev:17.93 (15.1%) stddev-sans-first:18.90 01:23:55 INFO - PROCESS | 1675 | Values: 119.0 109.0 117.0 127.0 172.0 135.0 118.0 118.0 117.0 117.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:143.00 stddev:17.19 (12.0%) stddev-sans-first:18.11 01:23:55 INFO - PROCESS | 1675 | Values: 146.0 124.0 147.0 164.0 127.0 140.0 140.0 122.0 171.0 123.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:211.90 Median:208.00 stddev:17.65 (8.5%) stddev-sans-first:18.19 01:23:55 INFO - PROCESS | 1675 | Values: 200.0 202.0 195.0 212.0 228.0 232.0 247.0 202.0 197.0 204.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:80.70 Median:61.00 stddev:32.70 (53.6%) stddev-sans-first:34.19 01:23:55 INFO - PROCESS | 1675 | Values: 65.0 80.0 76.0 148.0 56.0 56.0 57.0 83.0 130.0 56.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:110.00 stddev:22.53 (20.5%) stddev-sans-first:21.68 01:23:55 INFO - PROCESS | 1675 | Values: 77.0 85.0 111.0 113.0 117.0 121.0 143.0 79.0 79.0 115.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:2.33 (2.6%) stddev-sans-first:2.44 01:23:55 INFO - PROCESS | 1675 | Values: 88.0 85.0 88.0 85.0 88.0 85.0 88.0 85.0 92.0 85.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:117.90 Median:122.50 stddev:22.24 (18.2%) stddev-sans-first:23.57 01:23:55 INFO - PROCESS | 1675 | Values: 115.0 150.0 95.0 97.0 96.0 134.0 147.0 136.0 95.0 114.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:112.10 Median:91.00 stddev:26.22 (28.8%) stddev-sans-first:27.79 01:23:55 INFO - PROCESS | 1675 | Values: 115.0 147.0 98.0 151.0 148.0 91.0 96.0 91.0 91.0 93.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:62.50 stddev:16.02 (25.6%) stddev-sans-first:16.99 01:23:55 INFO - PROCESS | 1675 | Values: 66.0 59.0 59.0 50.0 57.0 72.0 90.0 96.0 53.0 52.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:69.00 stddev:3.53 (5.1%) stddev-sans-first:3.16 01:23:55 INFO - PROCESS | 1675 | Values: 62.0 64.0 66.0 72.0 70.0 72.0 70.0 68.0 66.0 64.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:85.50 stddev:11.92 (13.9%) stddev-sans-first:12.30 01:23:55 INFO - PROCESS | 1675 | Values: 87.0 85.0 101.0 86.0 84.0 108.0 112.0 112.0 88.0 86.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:149.50 stddev:10.76 (7.2%) stddev-sans-first:11.30 01:23:55 INFO - PROCESS | 1675 | Values: 149.0 147.0 154.0 150.0 162.0 149.0 147.0 146.0 181.0 149.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:172.00 stddev:2.20 (1.3%) stddev-sans-first:2.29 01:23:55 INFO - PROCESS | 1675 | Values: 172.0 172.0 168.0 169.0 173.0 171.0 167.0 170.0 173.0 173.0 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:5.46 (7.9%) stddev-sans-first:5.77 01:23:55 INFO - PROCESS | 1675 | Values: 68.0 71.0 83.0 62.0 68.0 70.0 68.0 65.0 70.0 69.0 01:23:55 INFO - PROCESS | 1675 | -------- Summary: end -------- 01:23:55 INFO - PROCESS | 1675 | 01:23:55 INFO - TEST-INFO | 1675: exit 0 01:23:55 INFO - TEST-OK | kraken | took 59654ms 01:23:55 INFO - SUITE-END | took 1169s 01:23:56 INFO - Completed test suite (00:19:30) 01:23:56 INFO - javascript benchmark 01:23:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.6902256240533, 2696.797740169488, 2807.5928990296406, 3573.6962358199553, 3576.2668652926154, 5810.941890581098, 5871.76512939483, 5891.116332550119, 5905.911411328833, 5953.0, 4616.976915115428, 5214.322138122039, 5847.5614328925285, 5913.615614985023, 6063.060225665029, 5274.182501712241, 5312.362516498007, 5382.9730851345685, 5384.219288203209, 5402.9729851350685, 375.5256544436993, 5305.734713264341, 5322.680639161663, 5328.973355133238, 5393.056215162351, 5277.182036784286, 5292.206169074631, 5327.0, 5337.332833395825, 5340.198970154508, 5223.973880130613, 5384.138537833967, 5423.566114710814, 5435.021696094701, 5437.755301011464, 5218.843434696965, 5248.186531087687, 5310.654807437543, 5322.281491998569, 5327.600429967768, 5726.255586773693, 5829.562782791308, 5831.358550559435, 5856.882862342729, 5862.530997520188, 6046.395360463918, 6122.418474876053, 6197.411245931629, 6209.6895155242055, 6220.222472190976, 6184.19605451293, 6288.811335659938, 6289.245290565115, 6290.87418251637, 6294.433500984934, 5978.940210597882, 6020.789272375489, 6032.306284777219, 6043.0, 6052.766943502473, 6224.906626400517, 6381.329960354096, 6436.903446448307, 6484.319146489551, 6487.156669633012, 6146.108814221912, 6159.969200153971, 6182.165407669997, 6194.194754681953, 6205.565610407228, 6227.439530442282, 6252.687365631791, 6274.905876411857, 6279.152314437584, 6281.7173227204885, 6107.877842443127, 6110.042400473247, 6199.0, 6212.937870621236, 6267.310595834455, 6157.230346206724, 6199.721012554446, 6262.342454042351, 6263.874722505524, 6286.9056964145575, 4946.9010619787405, 5009.198528235464, 5026.371703537058, 5035.924461133086, 5055.443901170868, 4390.297552391666, 4431.8670439886855, 4509.6392288616835, 4580.679352445363, 4594.173048851172, 5100.413452452941, 5718.313802343662, 5866.823995280149, 5939.346671866091, 5976.551758618034, 6276.780312689034, 6279.686015699197, 6287.402696743802, 6292.779752708725, 6300.338464461257, 4930.6795058321095, 5779.422057794271, 5943.435373639497, 5978.970105149533, 6007.8197654070445, 5498.202760599771, 5518.503334699896, 5529.115341545334, 5533.22534845122, 5544.500994910397, 5307.442718514578, 6483.0, 6547.148870646785, 6576.309487503839, 6605.57063790852, 4676.08816280822, 5791.478766910998, 6258.874822503433, 6262.2172228471445, 6278.46633036197, 6513.576617519846, 6519.41325280708, 6546.639934803631, 6549.770758023446, 6568.27748947625, 5227.032998895064, 6153.230846144232, 6170.784022559189, 6183.536234782499, 6184.783532576338, 6182.629042257479, 6223.533235007483, 6263.655498947602, 6274.717637706223, 6279.466245369012, 5517.44825517445, 5961.344252132349, 6131.570790044832, 6152.292486363946, 6154.323024467216, 6087.239095113111, 6115.969420152871, 6129.450483694133, 6131.110988906495, 6163.445289923929, 5999.760009599567, 6070.696465176812, 6143.266246520256, 6168.537359697951, 6171.938280617316, 5565.638233514808, 5788.507976822018, 6011.218541589566, 6202.782902598387, 6204.503639708722, 5958.374370691015, 6101.359357267601, 6109.327973922776, 6115.816525504242, 6145.340757995227], "value": 5695.0450859025195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.2610006840321, 540.1411755309058, 574.6067995137943, 590.1590233916673, 590.7548367427516, 37125.81437092814, 37641.24717505648, 37980.430293545585, 38013.42979855304, 38122.42816357753, 39287.21425571487, 39781.0, 39812.60187398125, 39880.60119398805, 39890.80054599723, 9362.95318523408, 9455.57449914752, 9570.90429095707, 9614.182794462478, 9663.323567350288, 9325.207357374597, 9526.85709714355, 9542.0, 9548.570314335837, 9568.23454123672, 9414.246860251164, 9517.762055948588, 9549.0, 9575.664851730191, 9587.568559414809, 9500.524973751284, 9507.857382139273, 9523.999980002138, 9576.712698619052, 9608.135267825894, 9483.193928516084, 9551.952240238754, 9679.70960871175, 9703.223742100685, 9721.027897210293, 32409.83795081033, 38662.420063699064, 38930.0, 39054.41418378727, 39108.82673519799, 2991.9401611967637, 3035.893743718981, 3101.736352410025, 3260.152360386293, 3358.412277851366, 27153.77807998645, 28178.718212817814, 28363.290917727016, 28532.286692832844, 28619.57070643942, 2333.9066437342485, 2712.6609173853267, 2775.0703514322727, 2822.3508593023516, 2858.285428642839, 412526.0, 413338.0, 417480.0, 419313.90343048394, 421952.0, 61682.0, 61847.0, 62040.0, 62131.06803397953, 62780.0, 62892.68553657294, 63105.0, 63235.36764632295, 63591.410214745, 63658.40853978688, 16742.83257167437, 16963.660726785394, 16977.320907163576, 16981.98108113517, 16995.23521441538, 12958.546450874363, 12997.870021299666, 13013.21920684762, 13045.47818087285, 13061.281629510278, 18707.0, 19250.518737031405, 19324.71012934807, 19460.610787784164, 19628.018599070274, 7824.804379890435, 7848.254415830487, 8087.37160422865, 8256.504609723315, 8292.792680182924, 857.5583574459158, 910.5902343945119, 983.0660872171466, 1023.6059117239768, 1049.18163832211, 25420.618690719653, 28769.71230287712, 28965.0, 29022.854885725435, 29464.705352946625, 986.2307400227834, 996.2478328861663, 1078.9676309710721, 1111.2054880760295, 1236.746466974268, 15392.692146157015, 15499.5350139496, 15507.99198052123, 15532.378704851906, 16059.0, 557654.0, 626599.0, 628658.0, 640091.0, 645149.0, 54815.72592137014, 59812.401875980686, 61663.0, 62188.06717899235, 62494.75010499855, 1411.4424802203073, 1458.6207586027708, 1479.9408023679148, 1503.7744338349335, 1505.8870584706192, 24079.759202407753, 29432.852835735684, 29519.55720664149, 29549.55675664824, 30508.779648813797, 51547.48452515427, 52101.7394913023, 52292.73853630707, 52344.73827630837, 52368.21447678364, 550004.0, 555053.0, 560407.0, 562576.0, 567952.0, 26527.867360663844, 41293.38059929043, 43805.12389752123, 43846.90382740457, 43905.56094439015, 45299.547004530854, 47749.283760742925, 48059.0, 48081.038379232916, 48750.562471876976, 36125.27749444944, 36145.27709445849, 36645.0, 37068.25863482769, 37642.623573763914, 31793.841030794698, 35465.468017979234, 35808.10479738027, 36032.81983590065, 36250.274994499436, 34637.0, 35450.64549354473, 36008.459873102445, 36763.89708308755, 37622.683206087655, 31669.683303167596, 32479.837600811843, 33379.666203337656, 33409.331813364086, 33494.83252583721, 23968.400789979692, 24465.755342446348, 24571.631425528987, 24740.0, 25130.497390052464], "value": 19838.966662055136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.0419472292882, 393.3038521816385, 393.49239481069424, 396.09097122104765, 403.8202999665148, 12138.332391718452, 15322.846771532282, 18320.908395458006, 19519.12163952622, 19629.411117666456, 19383.515412114702, 19426.737262077953, 19877.403677889688, 20658.69011964818, 20974.265900693477, 5503.697296648683, 5722.656640601556, 5856.180134781134, 5881.3530511643685, 5928.584999050068, 5676.262085928824, 5774.191613174138, 5793.913091303634, 5806.477417032466, 5833.562482813784, 6343.0802533632595, 6366.140571022899, 6469.029645553182, 6585.0451684505715, 6585.769498067569, 5813.389594092644, 5915.615484993483, 5967.343592204854, 6627.23786764521, 6629.204495460552, 5652.689102099383, 5770.6249093808765, 5841.007028805071, 5860.560457965627, 5881.05903055509, 12782.23306601607, 13656.863431365759, 13670.0, 13680.452781888713, 13724.794128088086, 2027.4323189506815, 2071.2543484345774, 2240.1599400224914, 2279.954400911989, 2314.8032417244553, 10019.348742331726, 10219.284650074498, 10254.846177307347, 11546.36494992775, 15278.847211527853, 1666.6333406650517, 1730.5846596816673, 1811.4656176427986, 1831.111910723298, 1834.7889992650883, 118480.0, 121196.0, 122088.0, 122541.0, 126209.36895315557, 9431.669891553762, 9739.805203896025, 11362.431878406047, 11674.708132296591, 11718.179727419169, 14630.487932922297, 14952.775708364383, 15012.699746005019, 15015.924920375328, 15045.699086018218, 8485.703000394957, 8559.186877246651, 8604.0965698602, 8869.334799890034, 8891.91108088911, 7425.591592462466, 8379.743038544268, 8541.615627296787, 8633.007204171476, 8721.43310684816, 4592.058627981256, 4670.8365207217585, 4685.391028185829, 4686.95313046872, 4690.507496712864, 1870.7839904062469, 1902.2391043582402, 1949.6393167264102, 2005.7593088829433, 2011.0, 900.9864852027225, 911.2436677557612, 987.2842189412619, 998.5057396588589, 1044.4882007816116, 18534.53663658392, 19586.21655133807, 19948.90025549863, 20036.799632003494, 20265.79734202639, 950.4249928792981, 969.4619486185094, 991.0782971836118, 995.1640621877658, 997.5560875410373, 8738.563071846509, 10539.10417614496, 10676.0, 10729.678109656723, 11153.721156970978, 598942.0, 621064.0, 635950.0, 640157.0, 640288.5971140323, 104195.0, 125568.0, 126004.36997814952, 128783.0, 135023.32488337497, 1005.1807776661997, 1025.7692019295598, 1055.9155267578576, 1057.080340104099, 1059.6026490066224, 14568.781468278195, 14996.625084372978, 16041.919790400972, 17839.286428542713, 17946.37187698424, 40287.388504460665, 51346.0, 51379.74310128426, 51792.48207517876, 53250.0, 74954.0, 79223.0, 79387.60306198432, 80654.91813523309, 81939.0, 5427.457254274541, 6232.657203853832, 7182.554095538534, 8055.187582793825, 8171.468854524437, 8695.0, 9956.0, 10612.681619551426, 11666.241694289844, 11799.292042477478, 10959.945200273947, 11094.500747466545, 11095.778084438427, 11271.154663400113, 11284.492197850952, 9519.28605354615, 10928.50821713009, 10974.286671366335, 11016.449177541252, 11054.889451105386, 11125.610603628835, 11358.204925655125, 11370.43147842588, 11600.767984640428, 11755.88244117548, 8057.717979870677, 8131.186881311822, 8165.959170204349, 8171.101178870438, 8398.790030249293, 10928.672139835817, 11023.007929286403, 11059.115270778157, 11097.833532496858, 11397.259178153394], "value": 9306.29852761401, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1590.1095386583513, 1624.131089866921, 1871.2047379863554, 1949.3469687654635, 1960.4804726747404, 8159.469634473755, 8646.740597782062, 8812.559372031397, 9076.137766912148, 9101.544922753861, 8687.13128687131, 8752.29981601472, 8792.428492148007, 8841.160089791476, 8854.33592480565, 2439.9390015249583, 2461.433870209853, 2469.1481438903547, 2471.147454128323, 2478.8264821462503, 2362.4684445999596, 2477.380654836291, 2488.4401009772746, 2493.3543861051708, 2501.4496810701708, 2460.7662272084212, 2465.6917885264343, 2487.3532881450865, 2505.8747062646885, 2513.6606558114695, 2408.987955060231, 2423.9515209695883, 2453.472503411766, 2466.519028789387, 2467.5311690778876, 2443.1204766284122, 2455.1407007547396, 2459.508098380331, 2459.9754002460104, 2483.0316176691103, 8851.291896648252, 8980.236679882219, 8990.100989901022, 9009.549522523848, 9019.23336516397, 4761.238201887716, 5305.867353316159, 5437.510624043815, 5521.337439507285, 5537.501624853742, 2941.3970136122257, 3411.539442175324, 3416.0605833395766, 3484.686378225972, 3499.387607168761, 1031.6337700116426, 1033.101201954297, 1045.3048722599538, 1049.470017641094, 1084.5444913136503, 10514.369137851754, 11243.60647377346, 11433.314001159873, 11590.304581725039, 11702.590409335633, 4808.63935204861, 4851.34506841579, 4851.95148048515, 4929.654924155275, 4941.851744447672, 9911.851322230172, 9949.253805964581, 10022.448765317831, 10104.888462269144, 10249.38503689781, 5353.0, 5357.08929481989, 5399.622026458111, 5464.0711079116645, 5501.724913754297, 4510.300903359985, 4854.101991131652, 4889.511048895082, 5008.474110218374, 5011.674241174312, 4098.569650186688, 4102.753834769924, 4108.898286045221, 4166.375043743463, 4184.790760461965, 1349.7233067221196, 1353.2557093598482, 1362.2439546052037, 1375.1817668487233, 1385.8752712255946, 814.9022117345957, 926.3191554207652, 935.5556110847293, 936.6628013914985, 958.0563145301873, 5926.525877929842, 5935.584509084409, 5982.850428739316, 6006.669633170218, 6087.916589647605, 447.1236376701701, 448.53128480737706, 458.43841294414074, 464.8489240996622, 466.65467554009786, 3437.8281085945605, 3751.3435148848844, 4020.3969404589548, 4031.717779755389, 4108.014076621649, 10399.740006499747, 10662.306950048222, 10867.130629549618, 10902.236843421044, 10964.342139471657, 9672.322937394314, 10905.618303359344, 10953.123750099972, 10964.56141754337, 10970.341779493096, 8010.919890801018, 8183.549904755177, 8300.87548686758, 8348.624311905978, 8453.619587118594, 5877.853053673522, 5901.498372638373, 5946.98901186808, 5964.075568286922, 5989.071693887455, 9794.75513112178, 9875.703728888146, 10081.193504519768, 10130.341527800669, 10141.695749127539, 8220.93127893394, 9688.85466718014, 9928.503574821374, 10041.347312424668, 10196.184305255414, 6506.60960342381, 6955.304469553004, 7007.334303241184, 7343.412526997934, 7603.543787372775, 8176.141505141874, 8189.877151842847, 8440.493570385797, 8481.575921203792, 8528.872066919126, 6478.4169424752, 7344.779656610311, 7345.192028876926, 7372.59450730215, 7625.046869141357, 7230.855382892418, 7421.0, 7485.925140748523, 7514.849703006019, 7601.315881570686, 6627.713438863584, 6809.5573787705625, 7113.928860711534, 7127.786166415016, 7191.82020449472, 4758.143534163745, 4856.878578035577, 4889.3888263967, 4966.081274964144, 5080.898382032413, 4429.80065897029, 4882.511748825089, 4948.480409556944, 5030.421501527371, 5206.453322401093], "value": 4550.089456875748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.6821710072827, 323.50665235515834, 330.9867605295788, 331.3555135261916, 332.69724550658907, 5441.156620723794, 6156.907646385308, 6172.938270617293, 6233.812985610439, 6314.305426403098, 6134.662593557353, 6160.59956102853, 6200.68996550173, 6203.751849926009, 6208.2550093988675, 3632.346177688015, 4433.229231730169, 4606.5393460654, 4634.930476042845, 4647.093816705744, 3644.6173151819075, 4095.9590404095875, 4544.363789069533, 4551.931721024187, 4583.885402864922, 4261.744295342274, 4438.7780610969485, 4496.213162696531, 4530.275155975029, 4548.704334218265, 4422.115576884636, 4512.706674066191, 4524.411826462571, 4546.8863278417975, 4550.0, 3237.854296556637, 3578.8926332210076, 3729.6083911189207, 3802.448644946495, 3839.1745774658584, 5401.567874570025, 5880.089355768879, 5894.440028197358, 5952.404759524056, 5960.956832554329, 5308.575313974911, 5314.256004159421, 5319.813806516753, 5322.0, 5323.733813309319, 6123.724432400552, 6521.217453905514, 6531.93468065318, 6566.310537393552, 6583.769568065095, 4233.343831706091, 4269.274223382002, 4279.272523670952, 4303.91392172158, 4304.526502084768, 5316.066111077813, 6420.625905761636, 6881.380675739158, 6993.6503174841055, 7029.156501219835, 3546.361654902091, 4098.282800509899, 4343.391925130484, 4347.174036932973, 4347.608715215646, 3930.5479869814767, 4382.452193475816, 4431.446069241345, 4443.466783985942, 4465.106978604292, 5231.398389185217, 5261.868453288698, 5263.315768950012, 5274.077036518671, 5281.207818827206, 6137.693115344304, 6251.3123556408755, 6538.5615164663695, 6603.867922641521, 6616.966915165393, 1266.6896610330527, 1300.3433266200698, 1386.4107754204422, 1420.6448387903024, 1528.9847101529065, 914.6707185413246, 940.7507010642186, 970.8737864077625, 984.6799790068256, 996.6561536269975, 6085.117657939662, 6094.908576371358, 6111.9694401528595, 6119.694015299217, 6150.815475535741, 5946.791862284886, 6085.695715214221, 6840.760573379908, 6842.349976752201, 6863.862722745517, 5303.7878484860175, 5831.212786273799, 6104.511639068953, 6127.417895299939, 6148.6635078669815, 3455.36075825973, 3591.586967498719, 3601.837917293728, 3626.3472574936764, 3632.727545434103, 6918.481113916376, 7004.194517630436, 7076.646167691595, 7151.42788576923, 7172.242800513804, 6978.302169783083, 7017.578945263301, 7031.0, 7060.0, 7082.858342833218, 5793.986052440806, 6842.6578671066245, 7159.713611455483, 7182.56904585737, 7249.818754531179, 5859.56053296013, 6375.872482550416, 6892.896606551006, 6900.171979362308, 6925.376716095576, 5883.910682075916, 6585.835354116185, 6779.796606101825, 6832.624205668736, 6833.521653484408, 5843.766249350148, 7127.429805615642, 7179.317964793337, 7223.0, 7265.782026539212, 4075.7962101894195, 4310.116426132698, 4350.934735979026, 4354.670251415478, 4357.803898824497, 6042.851858146938, 6670.032845237316, 6679.126106858108, 6808.38724514796, 6824.7952561423235, 5722.5421966241765, 6607.339266073354, 6632.104665870046, 6652.866942661217, 6695.698693558704, 5562.332520097614, 5666.0, 6235.438810506895, 6295.181626388723, 6585.604863708193, 5086.720230387365, 5668.064769313017, 5848.0, 6489.448396886318, 6508.772192973223, 5589.748461319332, 6408.263049749152, 6564.737410503526, 6597.406233439014, 6607.438367738796, 5430.321209848769, 6394.552381333262, 6453.322401147811, 6475.190601174853, 6477.643729594917], "value": 4711.045621487576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5653010338435, 734.2033893225849, 734.9007883935669, 764.5756605084183, 780.6799212322949, 15023.849761502383, 15028.323725432354, 15444.996075255101, 15455.07269563827, 15504.92247538762, 14278.00053996218, 14317.713645727104, 14341.13953162811, 14362.640933976656, 14380.209088500129, 724.8332883436813, 915.8031023329983, 920.8480600700893, 938.1509733691021, 939.910708482693, 930.5440334236243, 931.818295432391, 934.9065093490631, 937.4703292639637, 941.5245301122924, 993.2798720927342, 995.7411073120968, 999.8050380175869, 1000.0249756487403, 1002.5939494504701, 918.3433844800933, 947.6683160893666, 979.4025644356936, 991.2862738828032, 994.6419289055971, 689.8034060292842, 694.3369082526175, 738.6565247160096, 746.6528064450057, 748.3751067858345, 15157.621059473491, 15425.228738563026, 15436.073835569789, 15457.149856757875, 15486.380544778196, 10272.897271027268, 13353.39909704056, 13404.86595134046, 13441.39513721885, 13534.526291579847, 10338.0178883006, 10348.896511034869, 10367.118794902442, 10567.577296908114, 10678.679639610746, 3525.11872031992, 3581.9104522387147, 3583.928321433557, 3618.0412190769466, 3686.152184997439, 75328.0, 77862.22137778663, 89357.65963510552, 92870.0, 92879.60680589797, 9427.0, 9634.373765705206, 9667.613295468103, 9948.950255248677, 9987.450690212108, 21049.0, 21065.578688426147, 21093.15627374888, 21120.577588448145, 21134.943252837296, 7556.735514257085, 7664.808379790438, 7667.654955527015, 7697.345725613273, 7778.64996075178, 3513.578370595545, 3751.4560388744026, 4156.709030367906, 4202.705810593229, 4276.2516559601945, 3376.307856889332, 3569.696575791087, 3580.0691820126954, 3598.8200589970397, 3694.722895782827, 592.973316200772, 611.3641812515024, 617.7528988404584, 654.7970129259945, 672.8217022489044, 578.1991941161438, 584.9766009359663, 603.3664652115349, 603.3815339277276, 604.8820480006444, 7853.960730196427, 7910.881336779953, 8041.356691464669, 8094.28374861661, 8365.28895043928, 519.6752029981262, 583.5564970622273, 607.4940868915722, 611.2084850119106, 628.1990462160782, 4060.553339132693, 4149.8340066397, 4230.873073807791, 4252.979284971647, 4302.763348015889, 85443.57278213694, 90836.0, 91449.08550914406, 96064.0, 97320.51339743397, 65726.01410978839, 68511.62976740536, 70930.9360359595, 78592.0, 79879.20120798718, 62816.371836281054, 63365.0, 63365.68317158385, 63704.68147659232, 63705.36294637087, 8069.273765361146, 8186.959065204635, 8239.464434811718, 8272.751817445485, 8403.201695838885, 42904.0, 42959.78520107379, 43171.0, 43297.350539741296, 43976.56023439725, 55929.720351397984, 61175.0, 61233.69383153056, 61363.0, 61386.69306653438, 10544.156467482737, 10904.672859814218, 10911.618093366695, 11038.227324087558, 11176.283136489552, 11763.411829408324, 11857.644270671894, 11886.881131188924, 12140.453679584263, 12174.695632609255, 10496.52765625564, 11369.204155709022, 11470.197086203885, 11637.243579167327, 11689.064874810165, 11218.158638102012, 11317.943410282896, 11501.769964600828, 11556.42217889119, 11689.123315751183, 10994.28537145083, 11338.263012904135, 11384.772304554028, 11408.657740267805, 11468.0, 9397.812043759222, 9544.188743956563, 9545.856812147962, 9562.521873906138, 9752.366096203725, 9373.85939210926, 9537.332386732862, 9594.808103837744, 9662.661806836726, 9695.806083878424], "value": 6904.118659160645, "unit": "score"}], "name": "dromaeo_css", "value": 7334.093725482609, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 109.0, 117.0, 127.0, 172.0, 135.0, 118.0, 118.0, 117.0, 117.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 147.0, 164.0, 127.0, 140.0, 140.0, 122.0, 171.0, 123.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 195.0, 212.0, 228.0, 232.0, 247.0, 202.0, 197.0, 204.0], "value": 211.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 80.0, 76.0, 148.0, 56.0, 56.0, 57.0, 83.0, 130.0, 56.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 111.0, 113.0, 117.0, 121.0, 143.0, 79.0, 79.0, 115.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 85.0, 88.0, 85.0, 92.0, 85.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 150.0, 95.0, 97.0, 96.0, 134.0, 147.0, 136.0, 95.0, 114.0], "value": 117.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 147.0, 98.0, 151.0, 148.0, 91.0, 96.0, 91.0, 91.0, 93.0], "value": 112.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 59.0, 59.0, 50.0, 57.0, 72.0, 90.0, 96.0, 53.0, 52.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 66.0, 72.0, 70.0, 72.0, 70.0, 68.0, 66.0, 64.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 101.0, 86.0, 84.0, 108.0, 112.0, 112.0, 88.0, 86.0], "value": 94.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 154.0, 150.0, 162.0, 149.0, 147.0, 146.0, 181.0, 149.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 168.0, 169.0, 173.0, 171.0, 167.0, 170.0, 173.0, 173.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 83.0, 62.0, 68.0, 70.0, 68.0, 65.0, 70.0, 69.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1600.1000000000004, "alertThreshold": 2.0}]} 01:23:56 INFO - Return code: 0 01:23:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:23:56 ERROR - # TBPL SUCCESS # 01:23:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:23:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:23:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:23:56 INFO - 2016-04-15 01:23:56.401 screenresolution[1680:10226] starting screenresolution argv=screenresolution get 01:23:56 INFO - 2016-04-15 01:23:56.404 screenresolution[1680:10226] Display 0: 1600x1200x32@60 01:23:56 INFO - 2016-04-15 01:23:56.410 screenresolution[1681:10229] starting screenresolution argv=screenresolution list 01:23:56 INFO - Available Modes on Display 0 01:23:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:23:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:23:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:23:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:23:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:23:56 INFO - Intel Iris: 01:23:56 INFO - Chipset Model: Intel Iris 01:23:56 INFO - Type: GPU 01:23:56 INFO - Bus: Built-In 01:23:56 INFO - VRAM (Dynamic, Max): 1536 MB 01:23:56 INFO - Vendor: Intel (0x8086) 01:23:56 INFO - Device ID: 0x0a2e 01:23:56 INFO - Revision ID: 0x0009 01:23:56 INFO - Displays: 01:23:56 INFO - Display: 01:23:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:23:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:23:56 INFO - Display Serial Number: 1600x1200 60 01:23:56 INFO - Main Display: Yes 01:23:56 INFO - Mirror: Off 01:23:56 INFO - Online: Yes 01:23:56 INFO - Rotation: Supported 01:23:56 INFO - Return code: 0 01:23:56 INFO - Running post-action listener: _resource_record_post_action 01:23:56 INFO - Running post-run listener: _resource_record_post_run 01:23:57 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 37815808; Write bytes: 696963584; Read time: 393; Write time: 2056 01:23:57 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 373254656; Write bytes: 367678976; Read time: 28190; Write time: 710 01:23:57 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 36832768; Write bytes: 299990016; Read time: 376; Write time: 1292 01:23:57 INFO - Running post-run listener: _upload_blobber_files 01:23:57 INFO - Blob upload gear active. 01:23:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:23:57 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 01:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:23:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:59 INFO - (blobuploader) - INFO - Done attempting. 01:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:00 INFO - (blobuploader) - INFO - Done attempting. 01:24:00 INFO - (blobuploader) - INFO - Iteration through files over. 01:24:00 INFO - Return code: 0 01:24:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:24:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:24:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd811b79c336a413eecfb45b1ceb02de348fe4a24183429948f870a2ebd7501a570e550382f8527b4dea33fcdf6afd71494277cf842e8cd3bd050edcec89d742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd2e9617bf42d83bb800f3c625b5a1778ead7dc3533aac2ed4a683e5a339d51eccdfc76c0e953833d9e0c8173c1983d8a8e95fcf7143e04bc2c0d7849fa96a2"} 01:24:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:24:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:24:00 INFO - Contents: 01:24:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd811b79c336a413eecfb45b1ceb02de348fe4a24183429948f870a2ebd7501a570e550382f8527b4dea33fcdf6afd71494277cf842e8cd3bd050edcec89d742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd2e9617bf42d83bb800f3c625b5a1778ead7dc3533aac2ed4a683e5a339d51eccdfc76c0e953833d9e0c8173c1983d8a8e95fcf7143e04bc2c0d7849fa96a2"} 01:24:00 INFO - Running post-run listener: copy_logs_to_upload_dir 01:24:00 INFO - Copying logs to upload dir... 01:24:00 INFO - mkdir: /builds/slave/test/build/upload/logs 01:24:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.359803 ========= master_lag: 3.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-15 01:24:03.857840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-15 01:24:03.858958) ========= 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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd811b79c336a413eecfb45b1ceb02de348fe4a24183429948f870a2ebd7501a570e550382f8527b4dea33fcdf6afd71494277cf842e8cd3bd050edcec89d742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd2e9617bf42d83bb800f3c625b5a1778ead7dc3533aac2ed4a683e5a339d51eccdfc76c0e953833d9e0c8173c1983d8a8e95fcf7143e04bc2c0d7849fa96a2"} build_url:https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011075 build_url: 'https://queue.taskcluster.net/v1/task/EaDFXm0VRQSa-lzMGt2fTg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd811b79c336a413eecfb45b1ceb02de348fe4a24183429948f870a2ebd7501a570e550382f8527b4dea33fcdf6afd71494277cf842e8cd3bd050edcec89d742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd2e9617bf42d83bb800f3c625b5a1778ead7dc3533aac2ed4a683e5a339d51eccdfc76c0e953833d9e0c8173c1983d8a8e95fcf7143e04bc2c0d7849fa96a2"}' ========= master_lag: 1.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-15 01:24:05.322450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:24:05.322782) ========= 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.d8JRuSEqyO/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.cO6zbPXqoi/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005245 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 01:24:05.370518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 01:24:05.370817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 01:24:05.375700) ========= ========= Total master_lag: 5.20 =========