builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0070 starttime: 1475757603.5 results: success (0) buildid: 20161006020801 builduid: d958a888ff4246baabc1a52522858be4 revision: 089590fd275493af8294e2603c589d114f2a311a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:03.498347) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:03.498736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-10-06 05:40:03.499020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-10-06 05:40:09.974662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:09.974963) ========= 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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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-10-06 05:40:09-- 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% 26.9M=0s 2016-10-06 05:40:10 (26.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163909 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:10.163271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:10.163615) ========= 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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.035932 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:10.223946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:10.224311) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 089590fd275493af8294e2603c589d114f2a311a --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 089590fd275493af8294e2603c589d114f2a311a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0eOxnBwrpr/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.TnEuvaXG3z/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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-10-06 05:40:10,293 truncating revision to first 12 chars 2016-10-06 05:40:10,293 Setting DEBUG logging. 2016-10-06 05:40:10,293 attempt 1/10 2016-10-06 05:40:10,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/089590fd2754?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 05:40:10,972 unpacking tar archive at: fx-team-089590fd2754/testing/mozharness/ program finished with exit code 0 elapsedTime=0.938471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:11.184523) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:11.184849) ========= script_repo_revision: 089590fd275493af8294e2603c589d114f2a311a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:11.188429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:11.188715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 05:40:11.206618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 05:40:11.206988) ========= /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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40:11 INFO - MultiFileLogger online at 20161006 05:40:11 in /builds/slave/test 05:40:11 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 05:40:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:40:11 INFO - {'append_to_log': False, 05:40:11 INFO - 'base_work_dir': '/builds/slave/test', 05:40:11 INFO - 'blob_upload_branch': 'Fx-Team', 05:40:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:40:11 INFO - 'branch': 'Fx-Team', 05:40:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:11 INFO - 'config_files': ('talos/mac_config.py',), 05:40:11 INFO - 'default_actions': ('clobber', 05:40:11 INFO - 'read-buildbot-config', 05:40:11 INFO - 'download-and-extract', 05:40:11 INFO - 'populate-webroot', 05:40:11 INFO - 'create-virtualenv', 05:40:11 INFO - 'install', 05:40:11 INFO - 'run-tests'), 05:40:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:11 INFO - 'download_minidump_stackwalk': True, 05:40:11 INFO - 'download_symbols': 'ondemand', 05:40:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:11 INFO - 'installer_path': 'installer.exe', 05:40:11 INFO - 'log_level': 'info', 05:40:11 INFO - 'log_name': 'talos', 05:40:11 INFO - 'log_to_console': True, 05:40:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:40:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:40:11 INFO - 'opt_config_files': (), 05:40:11 INFO - 'pip_index': False, 05:40:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:40:11 INFO - 'cmd': ('bash', 05:40:11 INFO - '-c', 05:40:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:40:11 INFO - 'enabled': True, 05:40:11 INFO - 'halt_on_failure': False, 05:40:11 INFO - 'name': 'check_screen_resolution'},), 05:40:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:40:11 INFO - 'cmd': ('bash', 05:40:11 INFO - '-c', 05:40:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:40:11 INFO - 'enabled': True, 05:40:11 INFO - 'halt_on_failure': False, 05:40:11 INFO - 'name': 'check_screen_resolution'},), 05:40:11 INFO - 'run_cmd_checks_enabled': True, 05:40:11 INFO - 'sps_profile': False, 05:40:11 INFO - 'sps_profile_interval': 0, 05:40:11 INFO - 'suite': 'dromaeojs-e10s', 05:40:11 INFO - 'system_bits': '32', 05:40:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:11 INFO - 'title': 't-yosemite-r7-0070', 05:40:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:11 INFO - 'use_talos_json': True, 05:40:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:40:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:11 INFO - 'work_dir': 'build'} 05:40:11 INFO - [mozharness: 2016-10-06 12:40:11.409625Z] Running clobber step. 05:40:11 INFO - Running pre-action listener: _resource_record_pre_action 05:40:11 INFO - Running main action method: clobber 05:40:11 INFO - rmtree: /builds/slave/test/build 05:40:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:40:13 INFO - Running post-action listener: _resource_record_post_action 05:40:13 INFO - [mozharness: 2016-10-06 12:40:13.520496Z] Finished clobber step (success) 05:40:13 INFO - [mozharness: 2016-10-06 12:40:13.520679Z] Running read-buildbot-config step. 05:40:13 INFO - Running pre-action listener: _resource_record_pre_action 05:40:13 INFO - Running main action method: read_buildbot_config 05:40:13 INFO - Using buildbot properties: 05:40:13 INFO - { 05:40:13 INFO - "project": "", 05:40:13 INFO - "product": "firefox", 05:40:13 INFO - "script_repo_revision": "production", 05:40:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:40:13 INFO - "repository": "", 05:40:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:40:13 INFO - "buildid": "20161006020801", 05:40:13 INFO - "pgo_build": "False", 05:40:13 INFO - "basedir": "/builds/slave/test", 05:40:13 INFO - "buildnumber": 37, 05:40:13 INFO - "slavename": "t-yosemite-r7-0070", 05:40:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:40:13 INFO - "platform": "yosemite_r7", 05:40:13 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 05:40:13 INFO - "branch": "fx-team", 05:40:13 INFO - "repo_path": "integration/fx-team", 05:40:13 INFO - "revision": "089590fd275493af8294e2603c589d114f2a311a", 05:40:13 INFO - "stage_platform": "macosx64", 05:40:13 INFO - "builduid": "d958a888ff4246baabc1a52522858be4", 05:40:13 INFO - "slavebuilddir": "test" 05:40:13 INFO - } 05:40:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:40:13 INFO - Running post-action listener: _resource_record_post_action 05:40:13 INFO - [mozharness: 2016-10-06 12:40:13.524164Z] Finished read-buildbot-config step (success) 05:40:13 INFO - [mozharness: 2016-10-06 12:40:13.524301Z] Running download-and-extract step. 05:40:13 INFO - Running pre-action listener: _resource_record_pre_action 05:40:13 INFO - Running main action method: download_and_extract 05:40:13 INFO - mkdir: /builds/slave/test/build/tests 05:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:13 INFO - trying https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:40:13 INFO - Downloading https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:40:14 INFO - Downloaded 1199 bytes. 05:40:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:40:14 INFO - Using the following test package requirements: 05:40:14 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:40:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:40:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:40:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'jsshell-mac.zip'], 05:40:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:40:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:40:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:40:14 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:40:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:40:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:40:14 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:40:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:40:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:40:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:40:14 INFO - Fetch https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:40:15 INFO - Http code: 200 05:40:15 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:40:15 INFO - x-amz-cf-id: UH0jj11hEmXPoOpTZNHjajIBkKUWr9pNj1CayQEVOV1myUWZnnTsWg== 05:40:15 INFO - x-amz-version-id: ILsSuCdpzWFdI.yEL3S365Lw3nmgJmJg 05:40:15 INFO - Expected file size: 16477138 05:40:15 INFO - Obtained file size: 16477138 05:40:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:40:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:40:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:40:22 INFO - Fetch https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:40:22 INFO - Http code: 200 05:40:22 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 05:40:22 INFO - x-amz-cf-id: f93SETpc6RQT0KRUoqy-eOzUMLSSai8BQCJ8G4xoK19WPe507kNdaw== 05:40:22 INFO - x-amz-version-id: ILsSuCdpzWFdI.yEL3S365Lw3nmgJmJg 05:40:23 INFO - Expected file size: 16477138 05:40:23 INFO - Obtained file size: 16477138 05:40:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:40:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:40:29 INFO - Fetch https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:40:30 INFO - Http code: 200 05:40:30 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 05:40:30 INFO - x-amz-cf-id: 4fF7rv80b0nmORUaTltmElUOoHZRkfFFqxviV3sIEbTgF1_L8RIOxA== 05:40:30 INFO - x-amz-version-id: 7CC3XeB6wfKUHYhitmqS2A_KAp4fYmEj 05:40:30 INFO - Expected file size: 14409006 05:40:30 INFO - Obtained file size: 14409006 05:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:31 INFO - trying https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:31 INFO - Downloading https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:40:33 INFO - Downloaded 111663827 bytes. 05:40:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:33 INFO - mkdir: /builds/slave/test/properties 05:40:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:33 INFO - Contents: 05:40:33 INFO - build_url:https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:34 INFO - Running post-action listener: _resource_record_post_action 05:40:34 INFO - Running post-action listener: set_extra_try_arguments 05:40:34 INFO - [mozharness: 2016-10-06 12:40:34.514712Z] Finished download-and-extract step (success) 05:40:34 INFO - [mozharness: 2016-10-06 12:40:34.514867Z] Running populate-webroot step. 05:40:34 INFO - Running pre-action listener: _resource_record_pre_action 05:40:34 INFO - Running main action method: populate_webroot 05:40:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:34 INFO - '--tppagecycles', 05:40:34 INFO - '7'], 05:40:34 INFO - 'tests': ['tsvgm']}}, 05:40:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['damp', 'tps']}, 05:40:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'tests': ['damp', 'tps']}, 05:40:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['dromaeo_dom']}, 05:40:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['basic_compositor_video']}, 05:40:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:40:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['a11yr', 05:40:34 INFO - 'ts_paint', 05:40:34 INFO - 'tpaint', 05:40:34 INFO - 'sessionrestore', 05:40:34 INFO - 'sessionrestore_no_auto_restore', 05:40:34 INFO - 'tabpaint']}, 05:40:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:34 INFO - 'ts_paint', 05:40:34 INFO - 'tpaint', 05:40:34 INFO - 'sessionrestore', 05:40:34 INFO - 'sessionrestore_no_auto_restore', 05:40:34 INFO - 'tabpaint']}, 05:40:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:34 INFO - 'ts_paint', 05:40:34 INFO - 'tpaint', 05:40:34 INFO - 'sessionrestore', 05:40:34 INFO - 'sessionrestore_no_auto_restore', 05:40:34 INFO - 'tabpaint']}, 05:40:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:34 INFO - 'ts_paint', 05:40:34 INFO - 'tpaint', 05:40:34 INFO - 'sessionrestore', 05:40:34 INFO - 'sessionrestore_no_auto_restore', 05:40:34 INFO - 'tabpaint']}, 05:40:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['a11yr', 05:40:34 INFO - 'ts_paint', 05:40:34 INFO - 'tpaint', 05:40:34 INFO - 'sessionrestore', 05:40:34 INFO - 'sessionrestore_no_auto_restore', 05:40:34 INFO - 'tabpaint']}, 05:40:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['a11yr', 05:40:34 INFO - 'ts_paint', 05:40:34 INFO - 'tpaint', 05:40:34 INFO - 'sessionrestore', 05:40:34 INFO - 'sessionrestore_no_auto_restore', 05:40:34 INFO - 'tabpaint']}, 05:40:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['tsvgx', 05:40:34 INFO - 'tsvgr_opacity', 05:40:34 INFO - 'tart', 05:40:34 INFO - 'tscrollx', 05:40:34 INFO - 'cart']}, 05:40:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:34 INFO - 'tsvgr_opacity', 05:40:34 INFO - 'tart', 05:40:34 INFO - 'tscrollx', 05:40:34 INFO - 'cart']}, 05:40:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'talos_options': ['--disable-e10s'], 05:40:34 INFO - 'tests': ['tp5o']}, 05:40:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'tests': ['tp5o']}, 05:40:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'talos_options': ['--disable-e10s', 05:40:34 INFO - '--xperf_path', 05:40:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:34 INFO - 'tests': ['tp5n']}, 05:40:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:34 INFO - 'talos_options': ['--xperf_path', 05:40:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:34 INFO - 'tests': ['tp5n']}}, 05:40:34 INFO - 'talos.zip': {'path': '', 05:40:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:34 INFO - Running post-action listener: _resource_record_post_action 05:40:34 INFO - [mozharness: 2016-10-06 12:40:34.533879Z] Finished populate-webroot step (success) 05:40:34 INFO - [mozharness: 2016-10-06 12:40:34.533991Z] Running create-virtualenv step. 05:40:34 INFO - Running pre-action listener: _resource_record_pre_action 05:40:34 INFO - Running main action method: create_virtualenv 05:40:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:34 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 05:40:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:34 INFO - Using real prefix '/tools/python27' 05:40:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:38 INFO - Installing pip.................done. 05:40:38 INFO - Return code: 0 05:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:40:38 INFO - Reading from file tmpfile_stdout 05:40:38 INFO - Output received: 05:40:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:40:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:40:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:40:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:39 INFO - 'HOME': '/Users/cltbld', 05:40:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:39 INFO - 'LOGNAME': 'cltbld', 05:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:39 INFO - 'MOZ_NO_REMOTE': '1', 05:40:39 INFO - 'NO_EM_RESTART': '1', 05:40:39 INFO - 'PAGER': '/bin/cat', 05:40:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:39 INFO - 'PWD': '/builds/slave/test', 05:40:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:39 INFO - 'SHELL': '/bin/bash', 05:40:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:40:39 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:40:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:39 INFO - 'USER': 'cltbld', 05:40:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:39 INFO - 'XPC_FLAGS': '0x0', 05:40:39 INFO - 'XPC_SERVICE_NAME': '0', 05:40:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:39 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 05:40:39 INFO - Cleaning up... 05:40:39 INFO - Return code: 0 05:40:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:40 INFO - 'HOME': '/Users/cltbld', 05:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:40 INFO - 'LOGNAME': 'cltbld', 05:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:40 INFO - 'MOZ_NO_REMOTE': '1', 05:40:40 INFO - 'NO_EM_RESTART': '1', 05:40:40 INFO - 'PAGER': '/bin/cat', 05:40:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:40 INFO - 'PWD': '/builds/slave/test', 05:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:40 INFO - 'SHELL': '/bin/bash', 05:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:40:40 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:40 INFO - 'USER': 'cltbld', 05:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:40 INFO - 'XPC_FLAGS': '0x0', 05:40:40 INFO - 'XPC_SERVICE_NAME': '0', 05:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:40 INFO - Downloading/unpacking psutil>=3.1.1 05:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:44 INFO - Installing collected packages: psutil 05:40:44 INFO - Running setup.py install for psutil 05:40:44 INFO - building 'psutil._psutil_osx' extension 05:40:44 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 05:40:44 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 05:40:45 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 05:40:45 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 05:40:45 INFO - building 'psutil._psutil_posix' extension 05:40:45 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 05:40:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:40:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:40:45 INFO - ^ 05:40:45 INFO - 1 warning generated. 05:40:45 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 05:40:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:45 INFO - Successfully installed psutil 05:40:45 INFO - Cleaning up... 05:40:45 INFO - Return code: 0 05:40:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:40: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 mozsystemmonitor==0.3 05:40:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:40:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:45 INFO - 'HOME': '/Users/cltbld', 05:40:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:45 INFO - 'LOGNAME': 'cltbld', 05:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:45 INFO - 'MOZ_NO_REMOTE': '1', 05:40:45 INFO - 'NO_EM_RESTART': '1', 05:40:45 INFO - 'PAGER': '/bin/cat', 05:40:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:45 INFO - 'PWD': '/builds/slave/test', 05:40:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:45 INFO - 'SHELL': '/bin/bash', 05:40:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:40:45 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:40:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:45 INFO - 'USER': 'cltbld', 05:40:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:45 INFO - 'XPC_FLAGS': '0x0', 05:40:45 INFO - 'XPC_SERVICE_NAME': '0', 05:40:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:48 INFO - Installing collected packages: mozsystemmonitor 05:40:48 INFO - Running setup.py install for mozsystemmonitor 05:40:48 INFO - Successfully installed mozsystemmonitor 05:40:48 INFO - Cleaning up... 05:40:48 INFO - Return code: 0 05:40:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:40:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:40:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:48 INFO - 'HOME': '/Users/cltbld', 05:40:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:48 INFO - 'LOGNAME': 'cltbld', 05:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:48 INFO - 'MOZ_NO_REMOTE': '1', 05:40:48 INFO - 'NO_EM_RESTART': '1', 05:40:48 INFO - 'PAGER': '/bin/cat', 05:40:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:48 INFO - 'PWD': '/builds/slave/test', 05:40:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:48 INFO - 'SHELL': '/bin/bash', 05:40:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:40:48 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:40:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:48 INFO - 'USER': 'cltbld', 05:40:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:48 INFO - 'XPC_FLAGS': '0x0', 05:40:48 INFO - 'XPC_SERVICE_NAME': '0', 05:40:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:48 INFO - Downloading/unpacking jsonschema==2.5.1 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:51 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 05:40:51 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 05:40:51 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 05:40:51 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 05:40:51 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 05:40:51 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 05:40:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:51 INFO - warning: no files found matching '*.txt' 05:40:51 INFO - no previously-included directories found matching 'build' 05:40:51 INFO - no previously-included directories found matching 'dist' 05:40:51 INFO - no previously-included directories found matching '.git*' 05:40:51 INFO - Installing collected packages: jsonschema, functools32 05:40:51 INFO - Running setup.py install for functools32 05:40:51 INFO - warning: no files found matching '*.txt' 05:40:51 INFO - no previously-included directories found matching 'build' 05:40:51 INFO - no previously-included directories found matching 'dist' 05:40:51 INFO - no previously-included directories found matching '.git*' 05:40:51 INFO - Successfully installed jsonschema functools32 05:40:51 INFO - Cleaning up... 05:40:51 INFO - Return code: 0 05:40:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:52 INFO - 'HOME': '/Users/cltbld', 05:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:52 INFO - 'LOGNAME': 'cltbld', 05:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:52 INFO - 'MOZ_NO_REMOTE': '1', 05:40:52 INFO - 'NO_EM_RESTART': '1', 05:40:52 INFO - 'PAGER': '/bin/cat', 05:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:52 INFO - 'PWD': '/builds/slave/test', 05:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:52 INFO - 'SHELL': '/bin/bash', 05:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:40:52 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:52 INFO - 'USER': 'cltbld', 05:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:52 INFO - 'XPC_FLAGS': '0x0', 05:40:52 INFO - 'XPC_SERVICE_NAME': '0', 05:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:40:52 INFO - Cleaning up... 05:40:52 INFO - Return code: 0 05:40:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:52 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 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40:52 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 05:40:52 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 05:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:52 INFO - 'HOME': '/Users/cltbld', 05:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:52 INFO - 'LOGNAME': 'cltbld', 05:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:52 INFO - 'MOZ_NO_REMOTE': '1', 05:40:52 INFO - 'NO_EM_RESTART': '1', 05:40:52 INFO - 'PAGER': '/bin/cat', 05:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:52 INFO - 'PWD': '/builds/slave/test', 05:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:52 INFO - 'SHELL': '/bin/bash', 05:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:40:52 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:52 INFO - 'USER': 'cltbld', 05:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:52 INFO - 'XPC_FLAGS': '0x0', 05:40:52 INFO - 'XPC_SERVICE_NAME': '0', 05:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:55 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 05:40:55 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 05:40:55 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 05:40:55 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 05:40:55 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 05:40:55 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 05:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:55 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 05:40:55 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 05:40:55 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 05:40:55 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 05:40:55 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 05:40:55 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 05:40:56 INFO - Downloading docopt-0.6.1.tar.gz 05:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:56 INFO - Running setup.py install for blobuploader 05:40:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:56 INFO - Running setup.py install for requests 05:40:56 INFO - Running setup.py install for docopt 05:40:57 INFO - Successfully installed blobuploader requests docopt 05:40:57 INFO - Cleaning up... 05:40:57 INFO - Return code: 0 05:40:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 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 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:40:57 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 05:40:57 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 05:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:57 INFO - 'HOME': '/Users/cltbld', 05:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:57 INFO - 'LOGNAME': 'cltbld', 05:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:57 INFO - 'MOZ_NO_REMOTE': '1', 05:40:57 INFO - 'NO_EM_RESTART': '1', 05:40:57 INFO - 'PAGER': '/bin/cat', 05:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:57 INFO - 'PWD': '/builds/slave/test', 05:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:57 INFO - 'SHELL': '/bin/bash', 05:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:40:57 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:57 INFO - 'USER': 'cltbld', 05:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:57 INFO - 'XPC_FLAGS': '0x0', 05:40:57 INFO - 'XPC_SERVICE_NAME': '0', 05:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-s7kED9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hCjjAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-qgmUqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-u2avjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-aHCbFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:57 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-cjEPXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-lopx7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Z2Xor_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-N_ifW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-XI1cnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-_Q5uSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-9sNLeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-gpNsKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-EsMS8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:58 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-wc_42m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:59 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-LpNj22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:59 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-aG1NEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:59 INFO - Running setup.py install for manifestparser 05:40:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:59 INFO - Running setup.py install for mozcrash 05:40:59 INFO - Running setup.py install for mozdebug 05:40:59 INFO - Running setup.py install for mozdevice 05:40:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:40:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:59 INFO - Running setup.py install for mozfile 05:40:59 INFO - Running setup.py install for mozhttpd 05:41:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozinfo 05:41:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozInstall 05:41:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozleak 05:41:00 INFO - Running setup.py install for mozlog 05:41:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for moznetwork 05:41:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:00 INFO - Running setup.py install for mozprocess 05:41:01 INFO - Running setup.py install for mozprofile 05:41:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Running setup.py install for mozrunner 05:41:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Running setup.py install for mozscreenshot 05:41:01 INFO - Running setup.py install for moztest 05:41:01 INFO - Running setup.py install for mozversion 05:41:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:01 INFO - Cleaning up... 05:41:01 INFO - Return code: 0 05:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:01 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 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:41:01 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 05:41:01 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 05:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:01 INFO - 'HOME': '/Users/cltbld', 05:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:01 INFO - 'LOGNAME': 'cltbld', 05:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:01 INFO - 'MOZ_NO_REMOTE': '1', 05:41:01 INFO - 'NO_EM_RESTART': '1', 05:41:01 INFO - 'PAGER': '/bin/cat', 05:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:01 INFO - 'PWD': '/builds/slave/test', 05:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:01 INFO - 'SHELL': '/bin/bash', 05:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:41:01 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:01 INFO - 'USER': 'cltbld', 05:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:01 INFO - 'XPC_FLAGS': '0x0', 05:41:01 INFO - 'XPC_SERVICE_NAME': '0', 05:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-g8eQiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-jhnQb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-EYFf2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-HDKSiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-sqytB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-HkrbSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-AmFLcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-c_KPSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:02 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)) 05:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:02 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-scPR_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:03 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)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-0uEoNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-vtIJNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:03 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)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-7jIX0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BR5ZUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:03 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)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-uHiW0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-FQgMMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:03 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)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-VA9Was-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:03 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)) 05:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:03 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-7EXebf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:03 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)) 05:41:03 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)) 05:41:03 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)) 05:41:03 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)) 05:41:03 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)) 05:41:03 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)) 05:41:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:03 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 05:41:03 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 05:41:03 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 05:41:03 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 05:41:03 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 05:41:03 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 05:41:06 INFO - Downloading blessings-1.6.tar.gz 05:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:06 INFO - Installing collected packages: blessings 05:41:06 INFO - Running setup.py install for blessings 05:41:06 INFO - Successfully installed blessings 05:41:06 INFO - Cleaning up... 05:41:06 INFO - Return code: 0 05:41:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:07 INFO - Reading from file tmpfile_stdout 05:41:07 INFO - Current package versions: 05:41:07 INFO - blessings == 1.6 05:41:07 INFO - blobuploader == 1.2.4 05:41:07 INFO - docopt == 0.6.1 05:41:07 INFO - functools32 == 3.2.3-2 05:41:07 INFO - jsonschema == 2.5.1 05:41:07 INFO - manifestparser == 1.1 05:41:07 INFO - mozInstall == 1.12 05:41:07 INFO - mozcrash == 0.17 05:41:07 INFO - mozdebug == 0.1 05:41:07 INFO - mozdevice == 0.48 05:41:07 INFO - mozfile == 1.2 05:41:07 INFO - mozhttpd == 0.7 05:41:07 INFO - mozinfo == 0.9 05:41:07 INFO - mozleak == 0.1 05:41:07 INFO - mozlog == 3.4 05:41:07 INFO - moznetwork == 0.27 05:41:07 INFO - mozprocess == 0.23 05:41:07 INFO - mozprofile == 0.28 05:41:07 INFO - mozrunner == 6.12 05:41:07 INFO - mozscreenshot == 0.1 05:41:07 INFO - mozsystemmonitor == 0.3 05:41:07 INFO - moztest == 0.7 05:41:07 INFO - mozversion == 1.4 05:41:07 INFO - psutil == 3.1.1 05:41:07 INFO - requests == 1.2.3 05:41:07 INFO - wsgiref == 0.1.2 05:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 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 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:41:07 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 05:41:07 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 05:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:07 INFO - 'HOME': '/Users/cltbld', 05:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:07 INFO - 'LOGNAME': 'cltbld', 05:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:07 INFO - 'MOZ_NO_REMOTE': '1', 05:41:07 INFO - 'NO_EM_RESTART': '1', 05:41:07 INFO - 'PAGER': '/bin/cat', 05:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:07 INFO - 'PWD': '/builds/slave/test', 05:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:07 INFO - 'SHELL': '/bin/bash', 05:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:41:07 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:07 INFO - 'USER': 'cltbld', 05:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:07 INFO - 'XPC_FLAGS': '0x0', 05:41:07 INFO - 'XPC_SERVICE_NAME': '0', 05:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 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)) 05:41:07 INFO - Cleaning up... 05:41:07 INFO - Return code: 0 05:41:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103348490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032be570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5347a1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, '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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 05:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:07 INFO - 'HOME': '/Users/cltbld', 05:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:07 INFO - 'LOGNAME': 'cltbld', 05:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:07 INFO - 'MOZ_NO_REMOTE': '1', 05:41:07 INFO - 'NO_EM_RESTART': '1', 05:41:07 INFO - 'PAGER': '/bin/cat', 05:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:07 INFO - 'PWD': '/builds/slave/test', 05:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:07 INFO - 'SHELL': '/bin/bash', 05:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:41:07 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:07 INFO - 'USER': 'cltbld', 05:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:07 INFO - 'XPC_FLAGS': '0x0', 05:41:07 INFO - 'XPC_SERVICE_NAME': '0', 05:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:41:07 INFO - Cleaning up... 05:41:07 INFO - Return code: 0 05:41:07 INFO - Running post-action listener: _resource_record_post_action 05:41:07 INFO - Running post-action listener: _start_resource_monitoring 05:41:07 INFO - Starting resource monitoring. 05:41:07 INFO - [mozharness: 2016-10-06 12:41:07.584572Z] Finished create-virtualenv step (success) 05:41:07 INFO - [mozharness: 2016-10-06 12:41:07.585558Z] Running install step. 05:41:07 INFO - Running pre-action listener: _resource_record_pre_action 05:41:07 INFO - Running main action method: install 05:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:07 INFO - Reading from file tmpfile_stdout 05:41:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:07 INFO - Reading from file tmpfile_stdout 05:41:07 INFO - Output received: 05:41:07 INFO - Usage: mozinstall [options] installer 05:41:07 INFO - Options: 05:41:07 INFO - -h, --help show this help message and exit 05:41:07 INFO - -d DEST, --destination=DEST 05:41:07 INFO - Directory to install application into. [default: 05:41:07 INFO - "/builds/slave/test"] 05:41:07 INFO - --app=APP Application being installed. [default: firefox] 05:41:07 INFO - mkdir: /builds/slave/test/build/application 05:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:41:42 INFO - Reading from file tmpfile_stdout 05:41:42 INFO - Output received: 05:41:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:41:42 INFO - Running post-action listener: _resource_record_post_action 05:41:42 INFO - [mozharness: 2016-10-06 12:41:42.173456Z] Finished install step (success) 05:41:42 INFO - [mozharness: 2016-10-06 12:41:42.173605Z] Running run-tests step. 05:41:42 INFO - Running pre-action listener: _resource_record_pre_action 05:41:42 INFO - Running main action method: run_tests 05:41:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:41:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:41:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:41:42 INFO - 2016-10-06 05:41:42.188 screenresolution[1641:7564] starting screenresolution argv=screenresolution get 05:41:42 INFO - 2016-10-06 05:41:42.190 screenresolution[1641:7564] Display 0: 1600x1200x32@60 05:41:42 INFO - 2016-10-06 05:41:42.196 screenresolution[1642:7566] starting screenresolution argv=screenresolution list 05:41:42 INFO - Available Modes on Display 0 05:41:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:41:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:41:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:41:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:41:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:41:42 INFO - Intel Iris: 05:41:42 INFO - Chipset Model: Intel Iris 05:41:42 INFO - Type: GPU 05:41:42 INFO - Bus: Built-In 05:41:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:41:42 INFO - Vendor: Intel (0x8086) 05:41:42 INFO - Device ID: 0x0a2e 05:41:42 INFO - Revision ID: 0x0009 05:41:42 INFO - Displays: 05:41:42 INFO - Display: 05:41:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:41:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:41:42 INFO - Display Serial Number: 1600x1200 60 05:41:42 INFO - Main Display: Yes 05:41:42 INFO - Mirror: Off 05:41:42 INFO - Online: Yes 05:41:42 INFO - Rotation: Supported 05:41:42 INFO - Return code: 0 05:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:42 INFO - Python 2.7.3 05:41:42 INFO - Return code: 0 05:41:42 INFO - grabbing minidump binary from tooltool 05:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10315cd30>, '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 0x102f82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103154b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:42 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 05:41:42 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 05:41:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:41:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:42 INFO - Return code: 0 05:41:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:41:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:41:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:42 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/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 05:41:42 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/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --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 05:41:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0eOxnBwrpr/Render', 05:41:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:42 INFO - 'HOME': '/Users/cltbld', 05:41:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:42 INFO - 'LOGNAME': 'cltbld', 05:41:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:42 INFO - 'MOZ_NO_REMOTE': '1', 05:41:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:42 INFO - 'NO_EM_RESTART': '1', 05:41:42 INFO - 'PAGER': '/bin/cat', 05:41:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:42 INFO - 'PWD': '/builds/slave/test', 05:41:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:42 INFO - 'SHELL': '/bin/bash', 05:41:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TnEuvaXG3z/Listeners', 05:41:42 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 05:41:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:42 INFO - 'USER': 'cltbld', 05:41:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:42 INFO - 'XPC_FLAGS': '0x0', 05:41:42 INFO - 'XPC_SERVICE_NAME': '0', 05:41:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:42 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/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 05:41:42 INFO - mozversion application_buildid: 20161006020801 05:41:42 INFO - mozversion application_changeset: 089590fd275493af8294e2603c589d114f2a311a 05:41:42 INFO - mozversion application_display_name: Nightly 05:41:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:42 INFO - mozversion application_name: Firefox 05:41:42 INFO - mozversion application_remotingname: firefox 05:41:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:41:42 INFO - mozversion application_vendor: Mozilla 05:41:42 INFO - mozversion application_version: 52.0a1 05:41:42 INFO - mozversion platform_buildid: 20161006020801 05:41:42 INFO - mozversion platform_changeset: 089590fd275493af8294e2603c589d114f2a311a 05:41:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:41:42 INFO - mozversion platform_version: 52.0a1 05:41:42 INFO - using testdate: 1475757702 05:41:42 INFO - actual date: 1475757702 05:41:42 INFO - starting webserver on 'localhost:49267' 05:41:42 INFO - SUITE-START | Running 2 tests 05:41:42 INFO - TEST-START | dromaeo_css 05:41:42 INFO - operating with platform_type : mac_ 05:41:42 INFO - Initialising browser for dromaeo_css test... 05:41:42 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpDofA1B/profile http://localhost:49267/getInfo.html) 05:41:45 INFO - PROCESS | 1652 | 2016-10-06 05:41:45.580 plugin-container[1654:7737] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c2b, name = 'com.apple.tsm.portname' 05:41:45 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:45 INFO - PROCESS | 1652 | 2016-10-06 05:41:45.583 plugin-container[1654:7737] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 05:41:45 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:45 INFO - PROCESS | 1652 | 2016-10-06 05:41:45.583 plugin-container[1654:7737] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:41:45 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 05:41:45 INFO - PROCESS | 1652 | colorDepth:24 05:41:45 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 05:41:45 INFO - PROCESS | 1652 | __metrics 05:41:45 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 05:41:46 INFO - TEST-INFO | 1652: exit 0 05:41:46 INFO - Browser initialized. 05:41:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:46 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpDofA1B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:48 INFO - PROCESS | 1655 | 2016-10-06 05:41:48.946 plugin-container[1656:7853] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.tsm.portname' 05:41:48 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:48 INFO - PROCESS | 1655 | 2016-10-06 05:41:48.949 plugin-container[1656:7853] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 05:41:48 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:41:48 INFO - PROCESS | 1655 | 2016-10-06 05:41:48.949 plugin-container[1656:7853] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:41:58 INFO - PROCESS | 1655 | RSS: Main: 239792128 05:41:58 INFO - PROCESS | 1655 | 05:42:48 INFO - PROCESS | 1655 | 1475757768167 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] 05:45:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:45:03 INFO - PROCESS | 1655 | RSS: Main: 253554688 05:45:03 INFO - PROCESS | 1655 | 05:48:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:48:06 INFO - PROCESS | 1655 | RSS: Main: 266924032 05:48:06 INFO - PROCESS | 1655 | 05:51:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 05:51:09 INFO - PROCESS | 1655 | RSS: Main: 270102528 05:51:09 INFO - PROCESS | 1655 | 05:54:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 05:54:11 INFO - PROCESS | 1655 | RSS: Main: 269787136 05:54:11 INFO - PROCESS | 1655 | 05:57:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 05:57:15 INFO - PROCESS | 1655 | RSS: Main: 275234816 05:57:15 INFO - PROCESS | 1655 | 06:00:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 06:00:17 INFO - PROCESS | 1655 | RSS: Main: 277921792 06:00:17 INFO - PROCESS | 1655 | 06:00:17 INFO - PROCESS | 1655 | __start_tp_report 06:00:17 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 06:00:17 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 06:00:17 INFO - PROCESS | 1655 | |i|pagename|runs| 06:00:17 INFO - PROCESS | 1655 | |0;dojo.html;3304.933901321975;3355.7147642450395;3359.5296658467805;3370.0563842124216;3377.0037838837547;5477.096279113952;5521.889562208758;5544.722763861806;5571.498565129137;5621.465960733734;5541.612087153901;5600.52395546378;5617.8033768818095;5658.462446067627;5667.263255776743;5043.848684539451;5087.491250874901;5156.20078887773;5171.9224211636665;5224.138017227172;5209.921851172236;5233.869153271161;5241.344831896013;5258.6318957672975;5277.973610131944;5069.264956581312;5097.413797413271;5111.386633603955;5146.485351464842;5217.530422261977;5116.104681680691;5135.794568217267;5155.896882062338;5159.819406320798;5186.273921650972;5078.085944529983;5091.261767043758;5099.056674515226;5117.002184574009;5186.611004174702;5430.647007944511;5463.508284254396;5479.1781232815;5506.339239291271;5575.749091290861;6102.883130681719;6122.764110201795;6186.783462578833;6197;6203.069539569055;5138.383393992707;6148.108524264001;6206.007038873804;6240.095186198021;6246.968765156191;5388.380336261302;5411.621186516984;5618.606697531133;5753.683547404933;5790.102534107178;6157.138000679908;6215.254169499689;6246.906296405557;6250.406211409909;6255.093011513305;5907.202527658711;6018.789342372996;6048.637081775108;6084.939150608526;6106.908396374058;6035.517158627299;6085.604435711664;6143.96928015366;6159.96920015406;6167.167432396569;6066.090086487062;6104.633721976696;6111.816645500642;6114.6636934969;6131.724072416752;5030.37120359955;5312.814051508179;6103.36797469674;6117.265928088658;6127.816165515042;4821.590164836029;4890.779914903838;4937.654364194472;4944.085344211332;4952.142946395102;4321.854708502249;4337.7614231217585;4357.586029327209;4360.4331436913;4368.716033457878;5613.607047506717;5614;5646.181303711021;5684.488396044293;5730.111832665943;6076.3012253591405;6087.69561521931;6114.145302971479;6123.130109042722;6167.599106058092;4587.243104887656;4670.322803193518;5620.269364982526;5626.099824028136;5660.066089095336;5255.02781985334;5268.736563171903;5281.867953301198;5293.894122117536;5338.039152952429;6101.338204344158;6112.199536562904;6175.104609831459;6187.041008643488;6199.659018754011;6116.457510225511;6139.26328840542;6144.846378840565;6156.538259630456;6163.476104531165;6284.088807123033;6294.590851594632;6297.338779428094;6304.211973503312;6322.241331040304;4927.433345165208;5978.432048955342;6003.90994135097;6015.0676645120075;6060.212172417558;6094.75620975156;6123.447422021661;6137.018077107641;6142.253225532511;6166.876662466636;5849.9177652134495;5934.109883517334;5945.316288626863;5965.135055417027;6001.279846418458;5819.0689489681445;5919.4080591940465;6014.248218972629;6029.60807547508;6076.605020673642;4179.456670632799;5679.829605111853;5720.599558030898;5751.223584815996;5832.679202643895;4928.605711542997;5990.910136348046;6033.276006879027;6033.849153771191;6067.514598831995;5844.094165404369;5873.500752436091;5877.35349111606;5881;5909.6158749681135 06:00:17 INFO - PROCESS | 1655 | |1;ext.html;434.532877157056;479.73614512018383;494.5227855119811;497.5621453121254;525.3065952942117;39222.43110275592;39396;40740;41351.966200844996;41447.17105657889;36785.89642310728;38099.23801523968;40863.97840054;42572;42727.572724272744;9622.326437149402;9741.512924353789;9811.65659201928;9826.459544725038;9868.45723485208;8380.748577542683;9695.36980096295;9708.563114659857;9803.31376803624;9811.65659201928;9751.12239898409;9804.264680148981;9806.313558050939;9826.705198844045;9838.262130340217;9737.95131024344;9748.561314740853;9795.118439340422;9802.117809397118;9813.950930245375;9638.710838674851;9684.128428441474;9720.659776907845;9746.561404736733;9779.657711980117;39568.802155989324;39912.60087399118;40126.79936600327;40238.19523609541;40393.59606403928;3284.917877053069;3693.612170722089;4011;4015.638592526687;4020.618041286073;29489.852550737323;30300.393992120255;30373.544396834066;30632.84683576568;30646.84676576625;3052.2979714665753;3146.716795488394;3187.139472342478;3191.3457741163006;3218.1954511372155;437327;439970.8001459972;443478.78260608815;444497;446521;54276;54561.72719136379;54833.72583137059;54857.72571137119;54939.52772125264;59116.40883591195;59436;59506.404935950086;59737;59826;15876.047437153808;15944.362225511082;16122.919385403233;16133.435329763402;16148.83851161497;12137.757244855053;12609.684757881127;12664.683382915317;12664.81002784959;12672;14059.437622494986;15181.924090379698;15407;15439.606860936572;15520.844791552166;5928.7332070056955;6495.902561461582;6763.864722705518;6880.7270654929;6927.7228910843005;835.2274146414542;835.807764214222;871.2550769092335;926.4580220570907;1026.9127124194526;28755;29426.852865735535;29738;30164.84917575398;30521.08436746901;1041.063043261071;1080.5839751695653;1085.478970094359;1117.6479408986143;1154.9191556591127;14614.85385146135;14664.046836955564;15190.848091519165;15226.162561059027;15431.919765616523;659879;660171;667120;668152;670139;55823.44176558264;56051;56067.15899261514;56174.15738763922;56395;1333.9466421343232;1370.390176371505;1371.91082579632;1390.5828251524501;1401.1453013661658;23837.523249535257;28614.284642884093;29240.415191696473;29842.70157298399;30261.09216723502;48387;49176.75411622919;49177.01645966989;49228.507714922394;49356.01287974292;429473;500914;502496;503307;503475;23570.646440303066;24688.259352219462;26060.8696956514;26445.73554264433;27626.309342266602;45863.31205031861;45991.77004114958;46237.53762462332;46822.76588617035;47616.7619161902;38235;38264.04339891414;38490.615093848704;39601.405978910916;39801;37845.62154378421;38153;38801.6119838798;39064.0233994141;39452.80273598614;34231.486527702604;37176.81411592925;37369.0657733548;37952;38735.22529549449;25348.98604055891;33193.502097468074;34031.659683402846;34742;35169.47245791264;24195.75804241935;24962.875185623954;25289.367765806;26031;26150.215493535223 06:00:18 INFO - PROCESS | 1655 | |2;jquery.html;324.3707208016448;369.6340622783445;373.14735828631564;383.31004192453577;402.7936330689585;18982.240710371585;19428.41714748558;20670;20849.27027554036;20910.581788364223;16803.495895123167;19249.171328723784;19409;20142.39572812818;20288.985550722442;5852.4440178183;5860.120981852713;6055.091736239578;6157.138000679886;6157.568970172089;5910.793122240722;5992.460678538931;6122.63264204147;6131.110988906606;6133.907991380132;6014;6067.848303792396;6084.574079814415;7596.316331530161;8006.399520035991;7631.656575454118;7954.045514538235;8070.475419097769;8075.596220188967;8151.184881511861;7726.188750181206;7879.251471110236;7887.645055972495;7896.605169741548;7901.367890568798;27454.725452745617;28337.57493637597;29056;29071.70928290711;29229.70770292291;1758.4285107340165;2060.6393881070753;2288.8397812153157;2858.9285267868263;3203.2312245061253;13634.727305453835;16523.83476165247;16772.909760865503;17013.48959531216;17495.387661431916;1724.8702100124437;1925.9711104333446;1979.5941831924422;2027.6857087151516;2054.7431571053617;132249;138009;139938.3003084978;139991;140739.29630351783;17396.47810565685;18090.095495225185;18695.626087478173;19364.8063519363;20939.267125650527;31167.844160779503;34697.479537806954;34872;34875;34894.30211395758;9502.382345147544;10586.788264234672;10690.412027338416;10801.621943231949;10924.890751092546;8789.208971192624;8815.338849586307;8855.955720221358;8928.196462318423;8984.46093234408;9452.43285402878;9571;9607.56765945534;9617.807643847083;9672.06558688251;3664.2488289900507;3719.27474142545;3765.6987441004653;3776.735628505978;3789.6399842014966;762.4091329219899;861.7888617288804;972.9805403892024;974.8635191073255;976.0873583199731;18702.81297187038;20581.176752929714;20733.89633051825;20791;20867.269645562334;913.712180663089;917.8302014127274;925.6575067225169;930.4649826349876;1000.939004655068;10389.233830248875;10766.084882785051;10799.514021869034;10810.297330673638;10832.350058996486;576636;578760;579336;600247;616830;123937;130102;132602.33698831443;134588.32705836408;138000;984.2716389871443;992.2508506078009;1030.4178139351243;1030.5208078243652;1035.1563475767225;18564.81435185631;18620;18858.434246972614;19018.947053096574;19220.327288544835;38175.80912095422;39830.402543962446;53481.19778203252;54316.45683543114;54631;68862;72481.82554523373;79382.60308698419;81447.70589911636;81538;7440.813979650552;7562.810929726581;7693.153753087267;7772.611369431619;7808.336291415066;8931.598078086372;12093.33486658207;12143.81784273219;12274.693132671755;12625.305608191638;10704.411257380607;10785.892141078803;10813.891861081604;10977.83533246986;11004.724881878017;8903.866442003504;9369.828771403574;10268.178545716473;10434.68695939123;10686.786264274826;8901.599428025625;9698.51507424612;10043.54368616561;10589.046985771318;11166.16253780986;7732.265434783687;7942.880856787268;7953.880691789744;7978.481398709066;8080.2727754502375;10275.537600807833;10599.364038157735;10655.413952232391;10866.185036122164;11012.39431831257 06:00:18 INFO - PROCESS | 1655 | |3;mootools.html;1535.1479928639603;1574.7322955097632;1797.83819456249;1837.173272027588;1897.1273214321411;7988.880166797503;8356.623951922164;8504.936882889639;9064.728058158249;9089.409188402757;8513;8854.822903541924;8870.290376769859;8960.238379737713;8999.685011024616;2336.229044415343;2370.5140446208484;2372.7508611595795;2387.140629373424;2399.2682231919257;1915.4253723882848;2352.529494101178;2387.594109001474;2392.7726865947707;2397.6763136976547;2363.243761996162;2374.5013547155118;2376.2039716694926;2386.486905315357;2386.7971222446113;2327.2552783109413;2342.7891489765916;2348.9077578925794;2366.727826299963;2367.065009321317;2257.401788526042;2257.672637467558;2262.242148880127;2273.056681477185;2277.19159698308;8911.688090916787;9044.592993315317;9067.637294508211;9086.681966131153;9091.13634204756;5235.869103272448;5425.294711687456;5428.077226871442;5433.483819037185;5453.127499600085;2647.7881769458395;3260.7228385587255;3341.7159541438764;3518.82405879705;3525.982370088159;1043.5564884923876;1050.0811789684026;1053.2679787547656;1064.8030114428855;1066.1577353890418;11869.703257418547;11889.286642801373;12033;12041.39793010346;12066.396680165957;3760.417135344026;4051.858184963512;4132.855350062733;4831.347768051268;4900.730459824673;8484.236418722221;10087.949560252298;10110.292279540361;10154.136898363722;10222.488875556193;5382.219578161144;5391.838244852661;5392.811251606175;5395.21769343443;5406.756695948692;4403.493598236179;4560.6807523473035;4710.552497512731;4874.7562621868765;4933.629977751683;3478.565179352581;3872.690184785267;3929.4302326162547;3985.342418500915;4010.318245898204;1267.512007876974;1269.3209133113924;1277.303869391184;1283.7175821319295;1288.1305119044607;722.3823630795699;831.6839600951599;935.3078721745859;938.6198589571235;940.0787228516092;5887.411258874078;5896.1450589664255;5981;6098.481629061579;6157.138000679908;368.61479753657494;947.9715608531756;952.8380175370204;991.5785791038779;1015.720676813882;3008.9849550752106;3571.142925697866;3622.873199438007;3641.9089522761615;3714.88855334335;10654.57381704723;10795.29830561011;10884.510197041152;10933.835992460119;10966.067884229771;10893.727656808485;10895.782084358269;10910.018098371185;10960.616378426717;10972.561097556169;7747;8232.958835205785;8332.250097491255;8370.497770133812;8386.748397548083;5972.25346831646;6053.303870055;6064.181335519648;6108.419700128481;6213.068039794067;9651.179649729851;9739.561719722771;9887.505624718591;9908.950455247677;10051.246156538142;9336.579853906725;9717.805643887225;10320.638777642747;10321.329113607591;10344.224183186141;7514.211007844097;7518.360939320219;7531.924680753342;7559.28186822251;7635;8149.511029338259;8253.463524870864;8254.628541715518;8266.421350505407;8299.626516806637;7299.124105107208;7375.852482950419;7393.371563417169;7527.1343795462035;7544.041036706328;7243.637818109179;7303.014093097577;7303.707851685873;7330.340269375782;7540.811479713051;6851.383375496229;7013;7026.332498412643;7040.295970402919;7051.753188638373;4377;4916.852494425173;4961.305417241517;5116.334876466036;5134.332536770196;3805.8667946621736;4967.725635703411;5104.285400043923;5181.171012637959;5197.506236907488 06:00:18 INFO - PROCESS | 1655 | |4;prototype.html;274.02447287655946;298.90749311267325;304.9557814116953;307.8491539145819;314.6570238440101;4360.433143691315;4541.114482675879;5140.357455318085;5402.054640437927;5418.837434876955;4819.421669399668;4834.960483496047;5117.773768410744;5344;5365.731713414323;3771.7736935783805;3942.664873485757;3959.9010024749323;4015.7590544567274;4046.0289530512614;3963.5838236985132;4026.2350153470748;4042.4138499917494;4061.3501839705655;4117.567655396185;3730.9253814923686;4047.4131250968594;4056.411820286057;4081.3063378170264;4095.7747323897174;3603.297357015383;3830.253100645375;4015.6185162409524;4084.7140700151003;4168.24971505129;3444.1045328214595;3449.448088305884;3453.6028356739043;3458.239187378773;3465.601455832561;4311.590398912098;5196.61025423091;5212.661177023481;5248.7900483980975;5264.210368444726;3928.6464218220212;3986.54154772202;4302.935455968163;4340.240457919883;4606.378138951232;5558.833235002957;5620.4660557247;5660.377358490563;5680.863827234528;5698.316202055738;3805.46723458716;3806.8286927088348;3818.2008901143263;3839.6352346527037;3842.8078596070086;4596.862094137148;5237.633365664405;5617.297837770278;5628.240187574707;5910.67491287979;3358.3115461330367;3819.2934307153264;3882.281777871103;3887.552931412867;3907.843686252575;3923.5291764988383;3932.508436445444;3934.626210509997;3939.6060393960947;3956.9208615827524;4535.614472769786;4572.314152877028;4581.709145427287;4585.312203169551;4672.509386514435;4396.956030439718;5575.665460072409;5670.234518339971;5713.4000929902595;5754.338251101177;1294.4951468927127;1321.2072756346115;1353.1813252982001;1354.2010213973804;1356.8778809906958;697.7906628011576;699.9160100787836;776.3750181104265;786.4966421490251;820.8522465956066;4943.71243123319;5132.461091585405;5194.844154675366;5254.816081437131;5401.081816091274;5111.667741596859;5353.518183363438;5405.270288511079;5878.617889837233;5880.411958804086;4209;4704.788284527136;4750.881227969328;5028.572571331405;5431.511163995259;3045.6192975878016;3045.6903531481234;3059.1740230138184;3069.55491453738;3092.6907309268895;5950.821475355746;6020.856037352889;6039.577229593974;6043.939560604425;6045.909311360333;4741.478437371955;5432.864178395572;5549.2531197057715;5649.491545760901;5679.261695979579;5014.749262536931;5085.593152547787;5759.724908661055;6037.607555508966;6102.847428814226;4704.905901881874;5474.5894057945015;5854.560907931837;5873.676947767914;5881.617694849821;4271.508776490619;5128.435872054146;5363.2759577456545;5570.551656569241;5870.735816888165;5319.627626066138;5328.747744280168;6030.30651475086;6139.785107521216;6218.22272215973;3767.3030489359558;3844.2888065707934;3849.07971823471;3871.5160604924386;3929.5088113985753;5194.662346947436;5540.944590554042;5821.060364515893;5864.296284445893;5911.458073028467;5421.674699518042;5719.28508936383;5741;5746.856328591819;5806.361300256884;4711.468772648971;5355.544778693855;5408.7566059526625;5553.416891226525;5697.23087383198;4879.95120048795;5255.894882102413;5579.274694289878;5584.609077364546;5599.236240584203;5278.261043453843;5393.83818485446;5399.919001215064;5460.563154947674;5702.344230413555;4745.810167593396;4955.752212389294;4998.900241946766;5301.496357845998;5518.255035570307 06:00:18 INFO - PROCESS | 1655 | |5;yui.html;616.9413905678961;649.710878658997;701.0325750464356;755.964328869449;759.1118391481965;14120.435182592697;14314.141151530916;15099;15168.393264269429;15170.317335719892;13713.31433428327;13871.237081960488;13889.236092014935;13902.582922512316;13905.443782248698;665.4908994619096;690.0339524665484;826.0624191542582;834.2366734437982;851.7572491839827;807.1726480357651;864.3215076165211;864.3560547392202;864.6973559254274;868.1275318305095;890.2610833008588;926.9490178040205;929.005963618928;937.5452905340904;941.8022215334788;904.276578737011;920.2913756407529;921.4149015375218;923.6720964057797;924.0389994405809;671.1275342055309;682.5085938124543;685.9279775623587;686.3376841348123;689.9241083480813;14669.119852808866;14675.97268191227;14683.486077987325;14689.338979745937;14728.042677225945;13744.312784360842;13912.37394317258;13950;13951.093178943438;14040.297985100704;10602.787944241149;10950.78394817993;11071.889281107166;11445.370504622242;11766.176367654267;3733.607971163043;4374.628156606692;4393.604575588212;4403.383526306319;4440.7335559866515;106823.46588267086;107039;108048;108805;110655;10587.788244235073;10596.046355828012;10603.204759642904;10628.787424251472;10784.676459706221;20802;20978.47553811167;20991;21006.579868402852;21040;7395.556266624019;7431.479796414199;7580.924190758132;7597.620118994028;7632.274933881273;4048.473698419187;4170.311898536768;4173.8956526087095;4180.602842729997;4181.142865712522;3047.7866549341334;3136.2786559091082;3172.8101961764337;3173.0639461358955;3177.443947309258;622.2004723929819;629.3863483104028;639.2393052267787;640.2668944059119;655.7999810057978;521.6765605324723;576.6420080709952;581.1457157977766;599.7451083289671;615.227888999303;7162.355388015104;8826.691065812794;9046.457212567135;9406.200472959737;10041.06398931446;577.3793172339751;582.7814569536424;618.6628287583278;618.7586841131962;643.4787821864305;4951.231116926388;4961.424450809899;4979.925301120486;5029.547340739277;5050.696958182521;71457.6427117861;91808.54095729478;137205;144312.27843860714;149420.50579494066;98990;103053;115863;117984;131045;112235;114108;114225;116743.2488512673;118611;9852;9914.30599858032;9924.851127232952;9938.652147174815;9991.850122248317;45949.77025114853;49158.508414916825;55538;58218.126728098265;61576.69211653913;95071.04928950622;98227;100106.4994675022;100294.99705003148;101338;13363.53227637067;13514.459421623025;13702.725945481234;13761.31193440304;13880.930595347363;14570.708585828435;14656.706865862836;14680;14743.336549855068;14983.625409364853;13361;13661.86338136606;13773.862261377259;14143.36354864013;14168.362423690753;13349.144502795065;13551.72896542044;13745.725085498434;13789.172649641054;14019.719605608036;13312.534061307808;13369.458079279664;13527.391267392793;13674.31628418595;13743.244121573009;10979.341239525655;11237.4381280934;11323.660290190977;11557.364344961108;11930.284182949052;8326.209010144026;9381.390209636353;11334.036606888507;11668.299902005907;11670.358130302915 06:00:18 INFO - PROCESS | 1655 | __end_tp_report 06:00:18 INFO - PROCESS | 1655 | __start_cc_report 06:00:18 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,360 06:00:18 INFO - PROCESS | 1655 | __end_cc_report 06:00:18 INFO - PROCESS | 1655 | __startTimestamp1475758817991__endTimestamp 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - PROCESS | 1655 | ------- Summary: start ------- 06:00:18 INFO - PROCESS | 1655 | Number of tests: 6 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5602.03 Median:5753.68 stddev:642.19 (11.2%) stddev-sans-first:618.36 06:00:18 INFO - PROCESS | 1655 | Values: 3304.9 3355.7 3359.5 3370.1 3377.0 5477.1 5521.9 5544.7 5571.5 5621.5 5541.6 5600.5 5617.8 5658.5 5667.3 5043.8 5087.5 5156.2 5171.9 5224.1 5209.9 5233.9 5241.3 5258.6 5278.0 5069.3 5097.4 5111.4 5146.5 5217.5 5116.1 5135.8 5155.9 5159.8 5186.3 5078.1 5091.3 5099.1 5117.0 5186.6 5430.6 5463.5 5479.2 5506.3 5575.7 6102.9 6122.8 6186.8 6197.0 6203.1 5138.4 6148.1 6206.0 6240.1 6247.0 5388.4 5411.6 5618.6 5753.7 5790.1 6157.1 6215.3 6246.9 6250.4 6255.1 5907.2 6018.8 6048.6 6084.9 6106.9 6035.5 6085.6 6144.0 6160.0 6167.2 6066.1 6104.6 6111.8 6114.7 6131.7 5030.4 5312.8 6103.4 6117.3 6127.8 4821.6 4890.8 4937.7 4944.1 4952.1 4321.9 4337.8 4357.6 4360.4 4368.7 5613.6 5614.0 5646.2 5684.5 5730.1 6076.3 6087.7 6114.1 6123.1 6167.6 4587.2 4670.3 5620.3 5626.1 5660.1 5255.0 5268.7 5281.9 5293.9 5338.0 6101.3 6112.2 6175.1 6187.0 6199.7 6116.5 6139.3 6144.8 6156.5 6163.5 6284.1 6294.6 6297.3 6304.2 6322.2 4927.4 5978.4 6003.9 6015.1 6060.2 6094.8 6123.4 6137.0 6142.3 6166.9 5849.9 5934.1 5945.3 5965.1 6001.3 5819.1 5919.4 6014.2 6029.6 6076.6 4179.5 5679.8 5720.6 5751.2 5832.7 4928.6 5990.9 6033.3 6033.8 6067.5 5844.1 5873.5 5877.4 5881.0 5909.6 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:66477.33 Median:22071.22 stddev:144527.48 (654.8%) stddev-sans-first:144847.86 06:00:18 INFO - PROCESS | 1655 | Values: 434.5 479.7 494.5 497.6 525.3 39222.4 39396.0 40740.0 41352.0 41447.2 36785.9 38099.2 40864.0 42572.0 42727.6 9622.3 9741.5 9811.7 9826.5 9868.5 8380.7 9695.4 9708.6 9803.3 9811.7 9751.1 9804.3 9806.3 9826.7 9838.3 9738.0 9748.6 9795.1 9802.1 9814.0 9638.7 9684.1 9720.7 9746.6 9779.7 39568.8 39912.6 40126.8 40238.2 40393.6 3284.9 3693.6 4011.0 4015.6 4020.6 29489.9 30300.4 30373.5 30632.8 30646.8 3052.3 3146.7 3187.1 3191.3 3218.2 437327.0 439970.8 443478.8 444497.0 446521.0 54276.0 54561.7 54833.7 54857.7 54939.5 59116.4 59436.0 59506.4 59737.0 59826.0 15876.0 15944.4 16122.9 16133.4 16148.8 12137.8 12609.7 12664.7 12664.8 12672.0 14059.4 15181.9 15407.0 15439.6 15520.8 5928.7 6495.9 6763.9 6880.7 6927.7 835.2 835.8 871.3 926.5 1026.9 28755.0 29426.9 29738.0 30164.8 30521.1 1041.1 1080.6 1085.5 1117.6 1154.9 14614.9 14664.0 15190.8 15226.2 15431.9 659879.0 660171.0 667120.0 668152.0 670139.0 55823.4 56051.0 56067.2 56174.2 56395.0 1333.9 1370.4 1371.9 1390.6 1401.1 23837.5 28614.3 29240.4 29842.7 30261.1 48387.0 49176.8 49177.0 49228.5 49356.0 429473.0 500914.0 502496.0 503307.0 503475.0 23570.6 24688.3 26060.9 26445.7 27626.3 45863.3 45991.8 46237.5 46822.8 47616.8 38235.0 38264.0 38490.6 39601.4 39801.0 37845.6 38153.0 38801.6 39064.0 39452.8 34231.5 37176.8 37369.1 37952.0 38735.2 25349.0 33193.5 34031.7 34742.0 35169.5 24195.8 24962.9 25289.4 26031.0 26150.2 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:36559.19 Median:34784.74 stddev:99013.29 (284.6%) stddev-sans-first:99253.67 06:00:18 INFO - PROCESS | 1655 | Values: 324.4 369.6 373.1 383.3 402.8 18982.2 19428.4 20670.0 20849.3 20910.6 16803.5 19249.2 19409.0 20142.4 20289.0 5852.4 5860.1 6055.1 6157.1 6157.6 5910.8 5992.5 6122.6 6131.1 6133.9 6014.0 6067.8 6084.6 7596.3 8006.4 7631.7 7954.0 8070.5 8075.6 8151.2 7726.2 7879.3 7887.6 7896.6 7901.4 27454.7 28337.6 29056.0 29071.7 29229.7 1758.4 2060.6 2288.8 2858.9 3203.2 13634.7 16523.8 16772.9 17013.5 17495.4 1724.9 1926.0 1979.6 2027.7 2054.7 132249.0 138009.0 139938.3 139991.0 140739.3 17396.5 18090.1 18695.6 19364.8 20939.3 31167.8 34697.5 34872.0 34875.0 34894.3 9502.4 10586.8 10690.4 10801.6 10924.9 8789.2 8815.3 8856.0 8928.2 8984.5 9452.4 9571.0 9607.6 9617.8 9672.1 3664.2 3719.3 3765.7 3776.7 3789.6 762.4 861.8 973.0 974.9 976.1 18702.8 20581.2 20733.9 20791.0 20867.3 913.7 917.8 925.7 930.5 1000.9 10389.2 10766.1 10799.5 10810.3 10832.4 576636.0 578760.0 579336.0 600247.0 616830.0 123937.0 130102.0 132602.3 134588.3 138000.0 984.3 992.3 1030.4 1030.5 1035.2 18564.8 18620.0 18858.4 19018.9 19220.3 38175.8 39830.4 53481.2 54316.5 54631.0 68862.0 72481.8 79382.6 81447.7 81538.0 7440.8 7562.8 7693.2 7772.6 7808.3 8931.6 12093.3 12143.8 12274.7 12625.3 10704.4 10785.9 10813.9 10977.8 11004.7 8903.9 9369.8 10268.2 10434.7 10686.8 8901.6 9698.5 10043.5 10589.0 11166.2 7732.3 7942.9 7953.9 7978.5 8080.3 10275.5 10599.4 10655.4 10866.2 11012.4 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5705.92 Median:4908.79 stddev:3258.30 (66.4%) stddev-sans-first:3252.36 06:00:18 INFO - PROCESS | 1655 | Values: 1535.1 1574.7 1797.8 1837.2 1897.1 7988.9 8356.6 8504.9 9064.7 9089.4 8513.0 8854.8 8870.3 8960.2 8999.7 2336.2 2370.5 2372.8 2387.1 2399.3 1915.4 2352.5 2387.6 2392.8 2397.7 2363.2 2374.5 2376.2 2386.5 2386.8 2327.3 2342.8 2348.9 2366.7 2367.1 2257.4 2257.7 2262.2 2273.1 2277.2 8911.7 9044.6 9067.6 9086.7 9091.1 5235.9 5425.3 5428.1 5433.5 5453.1 2647.8 3260.7 3341.7 3518.8 3526.0 1043.6 1050.1 1053.3 1064.8 1066.2 11869.7 11889.3 12033.0 12041.4 12066.4 3760.4 4051.9 4132.9 4831.3 4900.7 8484.2 10087.9 10110.3 10154.1 10222.5 5382.2 5391.8 5392.8 5395.2 5406.8 4403.5 4560.7 4710.6 4874.8 4933.6 3478.6 3872.7 3929.4 3985.3 4010.3 1267.5 1269.3 1277.3 1283.7 1288.1 722.4 831.7 935.3 938.6 940.1 5887.4 5896.1 5981.0 6098.5 6157.1 368.6 948.0 952.8 991.6 1015.7 3009.0 3571.1 3622.9 3641.9 3714.9 10654.6 10795.3 10884.5 10933.8 10966.1 10893.7 10895.8 10910.0 10960.6 10972.6 7747.0 8233.0 8332.3 8370.5 8386.7 5972.3 6053.3 6064.2 6108.4 6213.1 9651.2 9739.6 9887.5 9909.0 10051.2 9336.6 9717.8 10320.6 10321.3 10344.2 7514.2 7518.4 7531.9 7559.3 7635.0 8149.5 8253.5 8254.6 8266.4 8299.6 7299.1 7375.9 7393.4 7527.1 7544.0 7243.6 7303.0 7303.7 7330.3 7540.8 6851.4 7013.0 7026.3 7040.3 7051.8 4377.0 4916.9 4961.3 5116.3 5134.3 3805.9 4967.7 5104.3 5181.2 5197.5 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4511.94 Median:5057.08 stddev:1389.48 (27.5%) stddev-sans-first:1356.48 06:00:18 INFO - PROCESS | 1655 | Values: 274.0 298.9 305.0 307.8 314.7 4360.4 4541.1 5140.4 5402.1 5418.8 4819.4 4835.0 5117.8 5344.0 5365.7 3771.8 3942.7 3959.9 4015.8 4046.0 3963.6 4026.2 4042.4 4061.4 4117.6 3730.9 4047.4 4056.4 4081.3 4095.8 3603.3 3830.3 4015.6 4084.7 4168.2 3444.1 3449.4 3453.6 3458.2 3465.6 4311.6 5196.6 5212.7 5248.8 5264.2 3928.6 3986.5 4302.9 4340.2 4606.4 5558.8 5620.5 5660.4 5680.9 5698.3 3805.5 3806.8 3818.2 3839.6 3842.8 4596.9 5237.6 5617.3 5628.2 5910.7 3358.3 3819.3 3882.3 3887.6 3907.8 3923.5 3932.5 3934.6 3939.6 3956.9 4535.6 4572.3 4581.7 4585.3 4672.5 4397.0 5575.7 5670.2 5713.4 5754.3 1294.5 1321.2 1353.2 1354.2 1356.9 697.8 699.9 776.4 786.5 820.9 4943.7 5132.5 5194.8 5254.8 5401.1 5111.7 5353.5 5405.3 5878.6 5880.4 4209.0 4704.8 4750.9 5028.6 5431.5 3045.6 3045.7 3059.2 3069.6 3092.7 5950.8 6020.9 6039.6 6043.9 6045.9 4741.5 5432.9 5549.3 5649.5 5679.3 5014.7 5085.6 5759.7 6037.6 6102.8 4704.9 5474.6 5854.6 5873.7 5881.6 4271.5 5128.4 5363.3 5570.6 5870.7 5319.6 5328.7 6030.3 6139.8 6218.2 3767.3 3844.3 3849.1 3871.5 3929.5 5194.7 5540.9 5821.1 5864.3 5911.5 5421.7 5719.3 5741.0 5746.9 5806.4 4711.5 5355.5 5408.8 5553.4 5697.2 4880.0 5255.9 5579.3 5584.6 5599.2 5278.3 5393.8 5399.9 5460.6 5702.3 4745.8 4955.8 4998.9 5301.5 5518.3 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:23601.78 Median:3154.54 stddev:36926.14 (1170.6%) stddev-sans-first:36989.40 06:00:18 INFO - PROCESS | 1655 | Values: 616.9 649.7 701.0 756.0 759.1 14120.4 14314.1 15099.0 15168.4 15170.3 13713.3 13871.2 13889.2 13902.6 13905.4 665.5 690.0 826.1 834.2 851.8 807.2 864.3 864.4 864.7 868.1 890.3 926.9 929.0 937.5 941.8 904.3 920.3 921.4 923.7 924.0 671.1 682.5 685.9 686.3 689.9 14669.1 14676.0 14683.5 14689.3 14728.0 13744.3 13912.4 13950.0 13951.1 14040.3 10602.8 10950.8 11071.9 11445.4 11766.2 3733.6 4374.6 4393.6 4403.4 4440.7 106823.5 107039.0 108048.0 108805.0 110655.0 10587.8 10596.0 10603.2 10628.8 10784.7 20802.0 20978.5 20991.0 21006.6 21040.0 7395.6 7431.5 7580.9 7597.6 7632.3 4048.5 4170.3 4173.9 4180.6 4181.1 3047.8 3136.3 3172.8 3173.1 3177.4 622.2 629.4 639.2 640.3 655.8 521.7 576.6 581.1 599.7 615.2 7162.4 8826.7 9046.5 9406.2 10041.1 577.4 582.8 618.7 618.8 643.5 4951.2 4961.4 4979.9 5029.5 5050.7 71457.6 91808.5 137205.0 144312.3 149420.5 98990.0 103053.0 115863.0 117984.0 131045.0 112235.0 114108.0 114225.0 116743.2 118611.0 9852.0 9914.3 9924.9 9938.7 9991.9 45949.8 49158.5 55538.0 58218.1 61576.7 95071.0 98227.0 100106.5 100295.0 101338.0 13363.5 13514.5 13702.7 13761.3 13880.9 14570.7 14656.7 14680.0 14743.3 14983.6 13361.0 13661.9 13773.9 14143.4 14168.4 13349.1 13551.7 13745.7 13789.2 14019.7 13312.5 13369.5 13527.4 13674.3 13743.2 10979.3 11237.4 11323.7 11557.4 11930.3 8326.2 9381.4 11334.0 11668.3 11670.4 06:00:18 INFO - PROCESS | 1655 | -------- Summary: end -------- 06:00:18 INFO - PROCESS | 1655 | 06:00:18 INFO - TEST-INFO | 1655: exit 0 06:00:18 INFO - TEST-OK | dromaeo_css | took 1115879ms 06:00:18 INFO - TEST-START | kraken 06:00:18 INFO - operating with platform_type : mac_ 06:00:18 INFO - Initialising browser for kraken test... 06:00:18 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpqFhvii/profile http://localhost:49267/getInfo.html) 06:00:21 INFO - PROCESS | 1663 | 2016-10-06 06:00:21.420 plugin-container[1664:9905] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4513, name = 'com.apple.tsm.portname' 06:00:21 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:21 INFO - PROCESS | 1663 | 2016-10-06 06:00:21.423 plugin-container[1664:9905] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 06:00:21 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:21 INFO - PROCESS | 1663 | 2016-10-06 06:00:21.423 plugin-container[1664:9905] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:00:21 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 06:00:21 INFO - PROCESS | 1663 | colorDepth:24 06:00:21 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 06:00:21 INFO - PROCESS | 1663 | __metrics 06:00:21 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 06:00:22 INFO - TEST-INFO | 1663: exit 0 06:00:22 INFO - Browser initialized. 06:00:22 INFO - Running cycle 1/1 for kraken test... 06:00:22 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpqFhvii/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:24 INFO - PROCESS | 1665 | 2016-10-06 06:00:24.858 plugin-container[1666:10020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a23, name = 'com.apple.tsm.portname' 06:00:24 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:24 INFO - PROCESS | 1665 | 2016-10-06 06:00:24.864 plugin-container[1666:10020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 06:00:24 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:00:24 INFO - PROCESS | 1665 | 2016-10-06 06:00:24.864 plugin-container[1666:10020] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:00:34 INFO - PROCESS | 1665 | RSS: Main: 240074752 06:00:34 INFO - PROCESS | 1665 | 06:00:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:38 INFO - PROCESS | 1665 | RSS: Main: 253648896 06:00:38 INFO - PROCESS | 1665 | 06:00:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 06:00:41 INFO - PROCESS | 1665 | RSS: Main: 261148672 06:00:41 INFO - PROCESS | 1665 | 06:00:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 06:00:45 INFO - PROCESS | 1665 | RSS: Main: 262049792 06:00:45 INFO - PROCESS | 1665 | 06:00:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 06:00:48 INFO - PROCESS | 1665 | RSS: Main: 264470528 06:00:48 INFO - PROCESS | 1665 | 06:00:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:50 INFO - PROCESS | 1665 | RSS: Main: 264904704 06:00:50 INFO - PROCESS | 1665 | 06:00:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:54 INFO - PROCESS | 1665 | RSS: Main: 265351168 06:00:54 INFO - PROCESS | 1665 | 06:00:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:57 INFO - PROCESS | 1665 | RSS: Main: 265482240 06:00:57 INFO - PROCESS | 1665 | 06:01:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 06:01:01 INFO - PROCESS | 1665 | RSS: Main: 265736192 06:01:01 INFO - PROCESS | 1665 | 06:01:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:03 INFO - PROCESS | 1665 | RSS: Main: 265433088 06:01:03 INFO - PROCESS | 1665 | 06:01:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:06 INFO - PROCESS | 1665 | RSS: Main: 265498624 06:01:06 INFO - PROCESS | 1665 | 06:01:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:09 INFO - PROCESS | 1665 | RSS: Main: 265539584 06:01:09 INFO - PROCESS | 1665 | 06:01:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:13 INFO - PROCESS | 1665 | RSS: Main: 266113024 06:01:13 INFO - PROCESS | 1665 | 06:01:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:16 INFO - PROCESS | 1665 | RSS: Main: 265867264 06:01:16 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 06:01:18 INFO - PROCESS | 1665 | RSS: Main: 267345920 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | __start_tp_report 06:01:18 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:01:18 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:01:18 INFO - PROCESS | 1665 | |i|pagename|runs| 06:01:18 INFO - PROCESS | 1665 | |0;ai-astar;108;120;114;111;118;95;169;178;132;117 06:01:18 INFO - PROCESS | 1665 | |1;audio-beat-detection;150;115;121;138;145;148;101;103;157;101 06:01:18 INFO - PROCESS | 1665 | |2;audio-dft;193;195;211;215;198;236;253;201;198;199 06:01:18 INFO - PROCESS | 1665 | |3;audio-fft;84;63;67;95;80;70;52;48;86;86 06:01:18 INFO - PROCESS | 1665 | |4;audio-oscillator;79;65;103;101;70;71;95;84;58;108 06:01:18 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;82;133;136;87;88;86;105;111;89;90 06:01:18 INFO - PROCESS | 1665 | |6;imaging-darkroom;139;95;95;96;95;119;96;96;96;153 06:01:18 INFO - PROCESS | 1665 | |7;imaging-desaturate;123;92;90;91;149;151;95;125;152;114 06:01:18 INFO - PROCESS | 1665 | |8;json-parse-financial;57;55;57;58;57;59;57;59;57;56 06:01:18 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;74;71;72;82;72;68;71;71;71;71 06:01:18 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;91;87;93;90;91;90;91;94;88;132 06:01:18 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;146;154;131;155;163;162;154;165;175;148 06:01:18 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;176;176;174;174;213;218;178;174;175;177 06:01:18 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;71;71;71;69;69;73;96;89;67;60 06:01:18 INFO - PROCESS | 1665 | __end_tp_report 06:01:18 INFO - PROCESS | 1665 | __start_cc_report 06:01:18 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,931 06:01:18 INFO - PROCESS | 1665 | __end_cc_report 06:01:18 INFO - PROCESS | 1665 | __startTimestamp1475758878621__endTimestamp 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:01:18 INFO - PROCESS | 1665 | Number of tests: 14 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:126.20 Median:126.00 stddev:26.72 (21.2%) stddev-sans-first:27.51 06:01:18 INFO - PROCESS | 1665 | Values: 108.0 120.0 114.0 111.0 118.0 95.0 169.0 178.0 132.0 117.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:141.50 stddev:22.15 (15.7%) stddev-sans-first:22.00 06:01:18 INFO - PROCESS | 1665 | Values: 150.0 115.0 121.0 138.0 145.0 148.0 101.0 103.0 157.0 101.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:209.90 Median:206.00 stddev:19.87 (9.6%) stddev-sans-first:20.12 06:01:18 INFO - PROCESS | 1665 | Values: 193.0 195.0 211.0 215.0 198.0 236.0 253.0 201.0 198.0 199.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:73.10 Median:82.00 stddev:15.65 (19.1%) stddev-sans-first:16.09 06:01:18 INFO - PROCESS | 1665 | Values: 84.0 63.0 67.0 95.0 80.0 70.0 52.0 48.0 86.0 86.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:83.40 Median:70.50 stddev:17.54 (24.9%) stddev-sans-first:18.54 06:01:18 INFO - PROCESS | 1665 | Values: 79.0 65.0 103.0 101.0 70.0 71.0 95.0 84.0 58.0 108.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:100.70 Median:86.50 stddev:19.94 (23.1%) stddev-sans-first:19.97 06:01:18 INFO - PROCESS | 1665 | Values: 82.0 133.0 136.0 87.0 88.0 86.0 105.0 111.0 89.0 90.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:95.50 stddev:21.58 (22.6%) stddev-sans-first:19.76 06:01:18 INFO - PROCESS | 1665 | Values: 139.0 95.0 95.0 96.0 95.0 119.0 96.0 96.0 96.0 153.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:118.20 Median:121.00 stddev:25.85 (21.4%) stddev-sans-first:27.36 06:01:18 INFO - PROCESS | 1665 | Values: 123.0 92.0 90.0 91.0 149.0 151.0 95.0 125.0 152.0 114.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.23 (2.2%) stddev-sans-first:1.30 06:01:18 INFO - PROCESS | 1665 | Values: 57.0 55.0 57.0 58.0 57.0 59.0 57.0 59.0 57.0 56.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:71.50 stddev:3.71 (5.2%) stddev-sans-first:3.89 06:01:18 INFO - PROCESS | 1665 | Values: 74.0 71.0 72.0 82.0 72.0 68.0 71.0 71.0 71.0 71.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:94.70 Median:91.00 stddev:13.27 (14.6%) stddev-sans-first:14.00 06:01:18 INFO - PROCESS | 1665 | Values: 91.0 87.0 93.0 90.0 91.0 90.0 91.0 94.0 88.0 132.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:155.30 Median:158.50 stddev:12.11 (7.6%) stddev-sans-first:12.37 06:01:18 INFO - PROCESS | 1665 | Values: 146.0 154.0 131.0 155.0 163.0 162.0 154.0 165.0 175.0 148.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:176.50 stddev:16.96 (9.6%) stddev-sans-first:17.77 06:01:18 INFO - PROCESS | 1665 | Values: 176.0 176.0 174.0 174.0 213.0 218.0 178.0 174.0 175.0 177.0 06:01:18 INFO - PROCESS | 1665 | 06:01:18 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:71.00 stddev:10.70 (15.1%) stddev-sans-first:11.31 06:01:18 INFO - PROCESS | 1665 | Values: 71.0 71.0 71.0 69.0 69.0 73.0 96.0 89.0 67.0 60.0 06:01:18 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:01:18 INFO - PROCESS | 1665 | 06:01:19 INFO - TEST-INFO | 1665: exit 0 06:01:19 INFO - TEST-OK | kraken | took 60822ms 06:01:19 INFO - SUITE-END | took 1176s 06:01:19 INFO - Completed test suite (00:19:37) 06:01:19 INFO - javascript benchmark 06:01:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7397.416146990892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.933901321975, 3355.7147642450395, 3359.5296658467805, 3370.0563842124216, 3377.0037838837547, 5477.096279113952, 5521.889562208758, 5544.722763861806, 5571.498565129137, 5621.465960733734, 5541.612087153901, 5600.52395546378, 5617.8033768818095, 5658.462446067627, 5667.263255776743, 5043.848684539451, 5087.491250874901, 5156.20078887773, 5171.9224211636665, 5224.138017227172, 5209.921851172236, 5233.869153271161, 5241.344831896013, 5258.6318957672975, 5277.973610131944, 5069.264956581312, 5097.413797413271, 5111.386633603955, 5146.485351464842, 5217.530422261977, 5116.104681680691, 5135.794568217267, 5155.896882062338, 5159.819406320798, 5186.273921650972, 5078.085944529983, 5091.261767043758, 5099.056674515226, 5117.002184574009, 5186.611004174702, 5430.647007944511, 5463.508284254396, 5479.1781232815, 5506.339239291271, 5575.749091290861, 6102.883130681719, 6122.764110201795, 6186.783462578833, 6197.0, 6203.069539569055, 5138.383393992707, 6148.108524264001, 6206.007038873804, 6240.095186198021, 6246.968765156191, 5388.380336261302, 5411.621186516984, 5618.606697531133, 5753.683547404933, 5790.102534107178, 6157.138000679908, 6215.254169499689, 6246.906296405557, 6250.406211409909, 6255.093011513305, 5907.202527658711, 6018.789342372996, 6048.637081775108, 6084.939150608526, 6106.908396374058, 6035.517158627299, 6085.604435711664, 6143.96928015366, 6159.96920015406, 6167.167432396569, 6066.090086487062, 6104.633721976696, 6111.816645500642, 6114.6636934969, 6131.724072416752, 5030.37120359955, 5312.814051508179, 6103.36797469674, 6117.265928088658, 6127.816165515042, 4821.590164836029, 4890.779914903838, 4937.654364194472, 4944.085344211332, 4952.142946395102, 4321.854708502249, 4337.7614231217585, 4357.586029327209, 4360.4331436913, 4368.716033457878, 5613.607047506717, 5614.0, 5646.181303711021, 5684.488396044293, 5730.111832665943, 6076.3012253591405, 6087.69561521931, 6114.145302971479, 6123.130109042722, 6167.599106058092, 4587.243104887656, 4670.322803193518, 5620.269364982526, 5626.099824028136, 5660.066089095336, 5255.02781985334, 5268.736563171903, 5281.867953301198, 5293.894122117536, 5338.039152952429, 6101.338204344158, 6112.199536562904, 6175.104609831459, 6187.041008643488, 6199.659018754011, 6116.457510225511, 6139.26328840542, 6144.846378840565, 6156.538259630456, 6163.476104531165, 6284.088807123033, 6294.590851594632, 6297.338779428094, 6304.211973503312, 6322.241331040304, 4927.433345165208, 5978.432048955342, 6003.90994135097, 6015.0676645120075, 6060.212172417558, 6094.75620975156, 6123.447422021661, 6137.018077107641, 6142.253225532511, 6166.876662466636, 5849.9177652134495, 5934.109883517334, 5945.316288626863, 5965.135055417027, 6001.279846418458, 5819.0689489681445, 5919.4080591940465, 6014.248218972629, 6029.60807547508, 6076.605020673642, 4179.456670632799, 5679.829605111853, 5720.599558030898, 5751.223584815996, 5832.679202643895, 4928.605711542997, 5990.910136348046, 6033.276006879027, 6033.849153771191, 6067.514598831995, 5844.094165404369, 5873.500752436091, 5877.35349111606, 5881.0, 5909.6158749681135], "value": 5563.86421401534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.532877157056, 479.73614512018383, 494.5227855119811, 497.5621453121254, 525.3065952942117, 39222.43110275592, 39396.0, 40740.0, 41351.966200844996, 41447.17105657889, 36785.89642310728, 38099.23801523968, 40863.97840054, 42572.0, 42727.572724272744, 9622.326437149402, 9741.512924353789, 9811.65659201928, 9826.459544725038, 9868.45723485208, 8380.748577542683, 9695.36980096295, 9708.563114659857, 9803.31376803624, 9811.65659201928, 9751.12239898409, 9804.264680148981, 9806.313558050939, 9826.705198844045, 9838.262130340217, 9737.95131024344, 9748.561314740853, 9795.118439340422, 9802.117809397118, 9813.950930245375, 9638.710838674851, 9684.128428441474, 9720.659776907845, 9746.561404736733, 9779.657711980117, 39568.802155989324, 39912.60087399118, 40126.79936600327, 40238.19523609541, 40393.59606403928, 3284.917877053069, 3693.612170722089, 4011.0, 4015.638592526687, 4020.618041286073, 29489.852550737323, 30300.393992120255, 30373.544396834066, 30632.84683576568, 30646.84676576625, 3052.2979714665753, 3146.716795488394, 3187.139472342478, 3191.3457741163006, 3218.1954511372155, 437327.0, 439970.8001459972, 443478.78260608815, 444497.0, 446521.0, 54276.0, 54561.72719136379, 54833.72583137059, 54857.72571137119, 54939.52772125264, 59116.40883591195, 59436.0, 59506.404935950086, 59737.0, 59826.0, 15876.047437153808, 15944.362225511082, 16122.919385403233, 16133.435329763402, 16148.83851161497, 12137.757244855053, 12609.684757881127, 12664.683382915317, 12664.81002784959, 12672.0, 14059.437622494986, 15181.924090379698, 15407.0, 15439.606860936572, 15520.844791552166, 5928.7332070056955, 6495.902561461582, 6763.864722705518, 6880.7270654929, 6927.7228910843005, 835.2274146414542, 835.807764214222, 871.2550769092335, 926.4580220570907, 1026.9127124194526, 28755.0, 29426.852865735535, 29738.0, 30164.84917575398, 30521.08436746901, 1041.063043261071, 1080.5839751695653, 1085.478970094359, 1117.6479408986143, 1154.9191556591127, 14614.85385146135, 14664.046836955564, 15190.848091519165, 15226.162561059027, 15431.919765616523, 659879.0, 660171.0, 667120.0, 668152.0, 670139.0, 55823.44176558264, 56051.0, 56067.15899261514, 56174.15738763922, 56395.0, 1333.9466421343232, 1370.390176371505, 1371.91082579632, 1390.5828251524501, 1401.1453013661658, 23837.523249535257, 28614.284642884093, 29240.415191696473, 29842.70157298399, 30261.09216723502, 48387.0, 49176.75411622919, 49177.01645966989, 49228.507714922394, 49356.01287974292, 429473.0, 500914.0, 502496.0, 503307.0, 503475.0, 23570.646440303066, 24688.259352219462, 26060.8696956514, 26445.73554264433, 27626.309342266602, 45863.31205031861, 45991.77004114958, 46237.53762462332, 46822.76588617035, 47616.7619161902, 38235.0, 38264.04339891414, 38490.615093848704, 39601.405978910916, 39801.0, 37845.62154378421, 38153.0, 38801.6119838798, 39064.0233994141, 39452.80273598614, 34231.486527702604, 37176.81411592925, 37369.0657733548, 37952.0, 38735.22529549449, 25348.98604055891, 33193.502097468074, 34031.659683402846, 34742.0, 35169.47245791264, 24195.75804241935, 24962.875185623954, 25289.367765806, 26031.0, 26150.215493535223], "value": 19430.376358616177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.3707208016448, 369.6340622783445, 373.14735828631564, 383.31004192453577, 402.7936330689585, 18982.240710371585, 19428.41714748558, 20670.0, 20849.27027554036, 20910.581788364223, 16803.495895123167, 19249.171328723784, 19409.0, 20142.39572812818, 20288.985550722442, 5852.4440178183, 5860.120981852713, 6055.091736239578, 6157.138000679886, 6157.568970172089, 5910.793122240722, 5992.460678538931, 6122.63264204147, 6131.110988906606, 6133.907991380132, 6014.0, 6067.848303792396, 6084.574079814415, 7596.316331530161, 8006.399520035991, 7631.656575454118, 7954.045514538235, 8070.475419097769, 8075.596220188967, 8151.184881511861, 7726.188750181206, 7879.251471110236, 7887.645055972495, 7896.605169741548, 7901.367890568798, 27454.725452745617, 28337.57493637597, 29056.0, 29071.70928290711, 29229.70770292291, 1758.4285107340165, 2060.6393881070753, 2288.8397812153157, 2858.9285267868263, 3203.2312245061253, 13634.727305453835, 16523.83476165247, 16772.909760865503, 17013.48959531216, 17495.387661431916, 1724.8702100124437, 1925.9711104333446, 1979.5941831924422, 2027.6857087151516, 2054.7431571053617, 132249.0, 138009.0, 139938.3003084978, 139991.0, 140739.29630351783, 17396.47810565685, 18090.095495225185, 18695.626087478173, 19364.8063519363, 20939.267125650527, 31167.844160779503, 34697.479537806954, 34872.0, 34875.0, 34894.30211395758, 9502.382345147544, 10586.788264234672, 10690.412027338416, 10801.621943231949, 10924.890751092546, 8789.208971192624, 8815.338849586307, 8855.955720221358, 8928.196462318423, 8984.46093234408, 9452.43285402878, 9571.0, 9607.56765945534, 9617.807643847083, 9672.06558688251, 3664.2488289900507, 3719.27474142545, 3765.6987441004653, 3776.735628505978, 3789.6399842014966, 762.4091329219899, 861.7888617288804, 972.9805403892024, 974.8635191073255, 976.0873583199731, 18702.81297187038, 20581.176752929714, 20733.89633051825, 20791.0, 20867.269645562334, 913.712180663089, 917.8302014127274, 925.6575067225169, 930.4649826349876, 1000.939004655068, 10389.233830248875, 10766.084882785051, 10799.514021869034, 10810.297330673638, 10832.350058996486, 576636.0, 578760.0, 579336.0, 600247.0, 616830.0, 123937.0, 130102.0, 132602.33698831443, 134588.32705836408, 138000.0, 984.2716389871443, 992.2508506078009, 1030.4178139351243, 1030.5208078243652, 1035.1563475767225, 18564.81435185631, 18620.0, 18858.434246972614, 19018.947053096574, 19220.327288544835, 38175.80912095422, 39830.402543962446, 53481.19778203252, 54316.45683543114, 54631.0, 68862.0, 72481.82554523373, 79382.60308698419, 81447.70589911636, 81538.0, 7440.813979650552, 7562.810929726581, 7693.153753087267, 7772.611369431619, 7808.336291415066, 8931.598078086372, 12093.33486658207, 12143.81784273219, 12274.693132671755, 12625.305608191638, 10704.411257380607, 10785.892141078803, 10813.891861081604, 10977.83533246986, 11004.724881878017, 8903.866442003504, 9369.828771403574, 10268.178545716473, 10434.68695939123, 10686.786264274826, 8901.599428025625, 9698.51507424612, 10043.54368616561, 10589.046985771318, 11166.16253780986, 7732.265434783687, 7942.880856787268, 7953.880691789744, 7978.481398709066, 8080.2727754502375, 10275.537600807833, 10599.364038157735, 10655.413952232391, 10866.185036122164, 11012.39431831257], "value": 10720.313970035506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.1479928639603, 1574.7322955097632, 1797.83819456249, 1837.173272027588, 1897.1273214321411, 7988.880166797503, 8356.623951922164, 8504.936882889639, 9064.728058158249, 9089.409188402757, 8513.0, 8854.822903541924, 8870.290376769859, 8960.238379737713, 8999.685011024616, 2336.229044415343, 2370.5140446208484, 2372.7508611595795, 2387.140629373424, 2399.2682231919257, 1915.4253723882848, 2352.529494101178, 2387.594109001474, 2392.7726865947707, 2397.6763136976547, 2363.243761996162, 2374.5013547155118, 2376.2039716694926, 2386.486905315357, 2386.7971222446113, 2327.2552783109413, 2342.7891489765916, 2348.9077578925794, 2366.727826299963, 2367.065009321317, 2257.401788526042, 2257.672637467558, 2262.242148880127, 2273.056681477185, 2277.19159698308, 8911.688090916787, 9044.592993315317, 9067.637294508211, 9086.681966131153, 9091.13634204756, 5235.869103272448, 5425.294711687456, 5428.077226871442, 5433.483819037185, 5453.127499600085, 2647.7881769458395, 3260.7228385587255, 3341.7159541438764, 3518.82405879705, 3525.982370088159, 1043.5564884923876, 1050.0811789684026, 1053.2679787547656, 1064.8030114428855, 1066.1577353890418, 11869.703257418547, 11889.286642801373, 12033.0, 12041.39793010346, 12066.396680165957, 3760.417135344026, 4051.858184963512, 4132.855350062733, 4831.347768051268, 4900.730459824673, 8484.236418722221, 10087.949560252298, 10110.292279540361, 10154.136898363722, 10222.488875556193, 5382.219578161144, 5391.838244852661, 5392.811251606175, 5395.21769343443, 5406.756695948692, 4403.493598236179, 4560.6807523473035, 4710.552497512731, 4874.7562621868765, 4933.629977751683, 3478.565179352581, 3872.690184785267, 3929.4302326162547, 3985.342418500915, 4010.318245898204, 1267.512007876974, 1269.3209133113924, 1277.303869391184, 1283.7175821319295, 1288.1305119044607, 722.3823630795699, 831.6839600951599, 935.3078721745859, 938.6198589571235, 940.0787228516092, 5887.411258874078, 5896.1450589664255, 5981.0, 6098.481629061579, 6157.138000679908, 368.61479753657494, 947.9715608531756, 952.8380175370204, 991.5785791038779, 1015.720676813882, 3008.9849550752106, 3571.142925697866, 3622.873199438007, 3641.9089522761615, 3714.88855334335, 10654.57381704723, 10795.29830561011, 10884.510197041152, 10933.835992460119, 10966.067884229771, 10893.727656808485, 10895.782084358269, 10910.018098371185, 10960.616378426717, 10972.561097556169, 7747.0, 8232.958835205785, 8332.250097491255, 8370.497770133812, 8386.748397548083, 5972.25346831646, 6053.303870055, 6064.181335519648, 6108.419700128481, 6213.068039794067, 9651.179649729851, 9739.561719722771, 9887.505624718591, 9908.950455247677, 10051.246156538142, 9336.579853906725, 9717.805643887225, 10320.638777642747, 10321.329113607591, 10344.224183186141, 7514.211007844097, 7518.360939320219, 7531.924680753342, 7559.28186822251, 7635.0, 8149.511029338259, 8253.463524870864, 8254.628541715518, 8266.421350505407, 8299.626516806637, 7299.124105107208, 7375.852482950419, 7393.371563417169, 7527.1343795462035, 7544.041036706328, 7243.637818109179, 7303.014093097577, 7303.707851685873, 7330.340269375782, 7540.811479713051, 6851.383375496229, 7013.0, 7026.332498412643, 7040.295970402919, 7051.753188638373, 4377.0, 4916.852494425173, 4961.305417241517, 5116.334876466036, 5134.332536770196, 3805.8667946621736, 4967.725635703411, 5104.285400043923, 5181.171012637959, 5197.506236907488], "value": 4553.662084553061, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.02447287655946, 298.90749311267325, 304.9557814116953, 307.8491539145819, 314.6570238440101, 4360.433143691315, 4541.114482675879, 5140.357455318085, 5402.054640437927, 5418.837434876955, 4819.421669399668, 4834.960483496047, 5117.773768410744, 5344.0, 5365.731713414323, 3771.7736935783805, 3942.664873485757, 3959.9010024749323, 4015.7590544567274, 4046.0289530512614, 3963.5838236985132, 4026.2350153470748, 4042.4138499917494, 4061.3501839705655, 4117.567655396185, 3730.9253814923686, 4047.4131250968594, 4056.411820286057, 4081.3063378170264, 4095.7747323897174, 3603.297357015383, 3830.253100645375, 4015.6185162409524, 4084.7140700151003, 4168.24971505129, 3444.1045328214595, 3449.448088305884, 3453.6028356739043, 3458.239187378773, 3465.601455832561, 4311.590398912098, 5196.61025423091, 5212.661177023481, 5248.7900483980975, 5264.210368444726, 3928.6464218220212, 3986.54154772202, 4302.935455968163, 4340.240457919883, 4606.378138951232, 5558.833235002957, 5620.4660557247, 5660.377358490563, 5680.863827234528, 5698.316202055738, 3805.46723458716, 3806.8286927088348, 3818.2008901143263, 3839.6352346527037, 3842.8078596070086, 4596.862094137148, 5237.633365664405, 5617.297837770278, 5628.240187574707, 5910.67491287979, 3358.3115461330367, 3819.2934307153264, 3882.281777871103, 3887.552931412867, 3907.843686252575, 3923.5291764988383, 3932.508436445444, 3934.626210509997, 3939.6060393960947, 3956.9208615827524, 4535.614472769786, 4572.314152877028, 4581.709145427287, 4585.312203169551, 4672.509386514435, 4396.956030439718, 5575.665460072409, 5670.234518339971, 5713.4000929902595, 5754.338251101177, 1294.4951468927127, 1321.2072756346115, 1353.1813252982001, 1354.2010213973804, 1356.8778809906958, 697.7906628011576, 699.9160100787836, 776.3750181104265, 786.4966421490251, 820.8522465956066, 4943.71243123319, 5132.461091585405, 5194.844154675366, 5254.816081437131, 5401.081816091274, 5111.667741596859, 5353.518183363438, 5405.270288511079, 5878.617889837233, 5880.411958804086, 4209.0, 4704.788284527136, 4750.881227969328, 5028.572571331405, 5431.511163995259, 3045.6192975878016, 3045.6903531481234, 3059.1740230138184, 3069.55491453738, 3092.6907309268895, 5950.821475355746, 6020.856037352889, 6039.577229593974, 6043.939560604425, 6045.909311360333, 4741.478437371955, 5432.864178395572, 5549.2531197057715, 5649.491545760901, 5679.261695979579, 5014.749262536931, 5085.593152547787, 5759.724908661055, 6037.607555508966, 6102.847428814226, 4704.905901881874, 5474.5894057945015, 5854.560907931837, 5873.676947767914, 5881.617694849821, 4271.508776490619, 5128.435872054146, 5363.2759577456545, 5570.551656569241, 5870.735816888165, 5319.627626066138, 5328.747744280168, 6030.30651475086, 6139.785107521216, 6218.22272215973, 3767.3030489359558, 3844.2888065707934, 3849.07971823471, 3871.5160604924386, 3929.5088113985753, 5194.662346947436, 5540.944590554042, 5821.060364515893, 5864.296284445893, 5911.458073028467, 5421.674699518042, 5719.28508936383, 5741.0, 5746.856328591819, 5806.361300256884, 4711.468772648971, 5355.544778693855, 5408.7566059526625, 5553.416891226525, 5697.23087383198, 4879.95120048795, 5255.894882102413, 5579.274694289878, 5584.609077364546, 5599.236240584203, 5278.261043453843, 5393.83818485446, 5399.919001215064, 5460.563154947674, 5702.344230413555, 4745.810167593396, 4955.752212389294, 4998.900241946766, 5301.496357845998, 5518.255035570307], "value": 4058.8451890821875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.9413905678961, 649.710878658997, 701.0325750464356, 755.964328869449, 759.1118391481965, 14120.435182592697, 14314.141151530916, 15099.0, 15168.393264269429, 15170.317335719892, 13713.31433428327, 13871.237081960488, 13889.236092014935, 13902.582922512316, 13905.443782248698, 665.4908994619096, 690.0339524665484, 826.0624191542582, 834.2366734437982, 851.7572491839827, 807.1726480357651, 864.3215076165211, 864.3560547392202, 864.6973559254274, 868.1275318305095, 890.2610833008588, 926.9490178040205, 929.005963618928, 937.5452905340904, 941.8022215334788, 904.276578737011, 920.2913756407529, 921.4149015375218, 923.6720964057797, 924.0389994405809, 671.1275342055309, 682.5085938124543, 685.9279775623587, 686.3376841348123, 689.9241083480813, 14669.119852808866, 14675.97268191227, 14683.486077987325, 14689.338979745937, 14728.042677225945, 13744.312784360842, 13912.37394317258, 13950.0, 13951.093178943438, 14040.297985100704, 10602.787944241149, 10950.78394817993, 11071.889281107166, 11445.370504622242, 11766.176367654267, 3733.607971163043, 4374.628156606692, 4393.604575588212, 4403.383526306319, 4440.7335559866515, 106823.46588267086, 107039.0, 108048.0, 108805.0, 110655.0, 10587.788244235073, 10596.046355828012, 10603.204759642904, 10628.787424251472, 10784.676459706221, 20802.0, 20978.47553811167, 20991.0, 21006.579868402852, 21040.0, 7395.556266624019, 7431.479796414199, 7580.924190758132, 7597.620118994028, 7632.274933881273, 4048.473698419187, 4170.311898536768, 4173.8956526087095, 4180.602842729997, 4181.142865712522, 3047.7866549341334, 3136.2786559091082, 3172.8101961764337, 3173.0639461358955, 3177.443947309258, 622.2004723929819, 629.3863483104028, 639.2393052267787, 640.2668944059119, 655.7999810057978, 521.6765605324723, 576.6420080709952, 581.1457157977766, 599.7451083289671, 615.227888999303, 7162.355388015104, 8826.691065812794, 9046.457212567135, 9406.200472959737, 10041.06398931446, 577.3793172339751, 582.7814569536424, 618.6628287583278, 618.7586841131962, 643.4787821864305, 4951.231116926388, 4961.424450809899, 4979.925301120486, 5029.547340739277, 5050.696958182521, 71457.6427117861, 91808.54095729478, 137205.0, 144312.27843860714, 149420.50579494066, 98990.0, 103053.0, 115863.0, 117984.0, 131045.0, 112235.0, 114108.0, 114225.0, 116743.2488512673, 118611.0, 9852.0, 9914.30599858032, 9924.851127232952, 9938.652147174815, 9991.850122248317, 45949.77025114853, 49158.508414916825, 55538.0, 58218.126728098265, 61576.69211653913, 95071.04928950622, 98227.0, 100106.4994675022, 100294.99705003148, 101338.0, 13363.53227637067, 13514.459421623025, 13702.725945481234, 13761.31193440304, 13880.930595347363, 14570.708585828435, 14656.706865862836, 14680.0, 14743.336549855068, 14983.625409364853, 13361.0, 13661.86338136606, 13773.862261377259, 14143.36354864013, 14168.362423690753, 13349.144502795065, 13551.72896542044, 13745.725085498434, 13789.172649641054, 14019.719605608036, 13312.534061307808, 13369.458079279664, 13527.391267392793, 13674.31628418595, 13743.244121573009, 10979.341239525655, 11237.4381280934, 11323.660290190977, 11557.364344961108, 11930.284182949052, 8326.209010144026, 9381.390209636353, 11334.036606888507, 11668.299902005907, 11670.358130302915], "value": 7648.987945926833, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 120.0, 114.0, 111.0, 118.0, 95.0, 169.0, 178.0, 132.0, 117.0], "value": 126.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 121.0, 138.0, 145.0, 148.0, 101.0, 103.0, 157.0, 101.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 195.0, 211.0, 215.0, 198.0, 236.0, 253.0, 201.0, 198.0, 199.0], "value": 209.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 63.0, 67.0, 95.0, 80.0, 70.0, 52.0, 48.0, 86.0, 86.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 65.0, 103.0, 101.0, 70.0, 71.0, 95.0, 84.0, 58.0, 108.0], "value": 83.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 133.0, 136.0, 87.0, 88.0, 86.0, 105.0, 111.0, 89.0, 90.0], "value": 100.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 95.0, 95.0, 96.0, 95.0, 119.0, 96.0, 96.0, 96.0, 153.0], "value": 108.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 92.0, 90.0, 91.0, 149.0, 151.0, 95.0, 125.0, 152.0, 114.0], "value": 118.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 58.0, 57.0, 59.0, 57.0, 59.0, 57.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 72.0, 82.0, 72.0, 68.0, 71.0, 71.0, 71.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 93.0, 90.0, 91.0, 90.0, 91.0, 94.0, 88.0, 132.0], "value": 94.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 154.0, 131.0, 155.0, 163.0, 162.0, 154.0, 165.0, 175.0, 148.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 174.0, 174.0, 213.0, 218.0, 178.0, 174.0, 175.0, 177.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 69.0, 69.0, 73.0, 96.0, 89.0, 67.0, 60.0], "value": 73.6, "unit": "score"}]}]} 06:01:19 INFO - Return code: 0 06:01:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:19 ERROR - # TBPL SUCCESS # 06:01:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:01:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:01:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:01:19 INFO - 2016-10-06 06:01:19.943 screenresolution[1670:10403] starting screenresolution argv=screenresolution get 06:01:19 INFO - 2016-10-06 06:01:19.945 screenresolution[1670:10403] Display 0: 1600x1200x32@60 06:01:19 INFO - 2016-10-06 06:01:19.952 screenresolution[1671:10406] starting screenresolution argv=screenresolution list 06:01:19 INFO - Available Modes on Display 0 06:01:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:01:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:01:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:01:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:01:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:01:20 INFO - Intel Iris: 06:01:20 INFO - Chipset Model: Intel Iris 06:01:20 INFO - Type: GPU 06:01:20 INFO - Bus: Built-In 06:01:20 INFO - VRAM (Dynamic, Max): 1536 MB 06:01:20 INFO - Vendor: Intel (0x8086) 06:01:20 INFO - Device ID: 0x0a2e 06:01:20 INFO - Revision ID: 0x0009 06:01:20 INFO - Displays: 06:01:20 INFO - Display: 06:01:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:01:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:01:20 INFO - Display Serial Number: 1600x1200 60 06:01:20 INFO - Main Display: Yes 06:01:20 INFO - Mirror: Off 06:01:20 INFO - Online: Yes 06:01:20 INFO - Rotation: Supported 06:01:20 INFO - Return code: 0 06:01:20 INFO - Running post-action listener: _resource_record_post_action 06:01:20 INFO - [mozharness: 2016-10-06 13:01:20.187259Z] Finished run-tests step (success) 06:01:20 INFO - Running post-run listener: _resource_record_post_run 06:01:20 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 39172608; Write bytes: 711266304; Read time: 383; Write time: 2280 06:01:20 INFO - TinderboxPrint: CPU usage
54.3% 06:01:20 INFO - TinderboxPrint: I/O read bytes / time
39,172,608 / 383 06:01:20 INFO - TinderboxPrint: I/O write bytes / time
711,266,304 / 2,280 06:01:20 INFO - TinderboxPrint: CPU idle
2,216.2 (45.7%) 06:01:20 INFO - TinderboxPrint: CPU system
980.5 (20.2%) 06:01:20 INFO - TinderboxPrint: CPU user
1,653.0 (34.1%) 06:01:20 INFO - TinderboxPrint: Swap in / out
447,234,048 / 0 06:01:20 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 403382784; Write bytes: 391915520; Read time: 29599; Write time: 706 06:01:20 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31932928; Write bytes: 299390976; Read time: 299; Write time: 1530 06:01:20 INFO - Running post-run listener: _upload_blobber_files 06:01:20 INFO - Blob upload gear active. 06:01:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:20 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 06:01:20 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'] 06:01:20 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 06:01:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:22 INFO - (blobuploader) - INFO - Done attempting. 06:01:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:01:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:23 INFO - (blobuploader) - INFO - Done attempting. 06:01:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:25 INFO - (blobuploader) - INFO - Done attempting. 06:01:25 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:25 INFO - Return code: 0 06:01:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2feead47e7bfa05a4bc149b620bf55d1735cd21c509088745b02506ff29ce57dc3bb5afcbc2bfb89d38b6bde3f1db2513626d5b01444c7695e2a843e5e546c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5540e83aa0a85962c6454b50266592e3e1002359f6fe453edfbb270d9c2a5fdc6f4ddabfcae743752c620492184a09c9c223d3968e71a8945c2fc2216439f23e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ba45a17a5deaa44585ac03665759e17b705fda010060c36372c18e4aa87474d5e9f547b6ce4897dcdc3b2b8e44b01b0ed61595a3212570efa48acab7629f985"} 06:01:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:25 INFO - Contents: 06:01:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2feead47e7bfa05a4bc149b620bf55d1735cd21c509088745b02506ff29ce57dc3bb5afcbc2bfb89d38b6bde3f1db2513626d5b01444c7695e2a843e5e546c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5540e83aa0a85962c6454b50266592e3e1002359f6fe453edfbb270d9c2a5fdc6f4ddabfcae743752c620492184a09c9c223d3968e71a8945c2fc2216439f23e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ba45a17a5deaa44585ac03665759e17b705fda010060c36372c18e4aa87474d5e9f547b6ce4897dcdc3b2b8e44b01b0ed61595a3212570efa48acab7629f985"} 06:01:25 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:25 INFO - Copying logs to upload dir... 06:01:25 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.277145 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 06:01:25.534252) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 06:01:25.541237) ========= 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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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/2feead47e7bfa05a4bc149b620bf55d1735cd21c509088745b02506ff29ce57dc3bb5afcbc2bfb89d38b6bde3f1db2513626d5b01444c7695e2a843e5e546c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5540e83aa0a85962c6454b50266592e3e1002359f6fe453edfbb270d9c2a5fdc6f4ddabfcae743752c620492184a09c9c223d3968e71a8945c2fc2216439f23e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ba45a17a5deaa44585ac03665759e17b705fda010060c36372c18e4aa87474d5e9f547b6ce4897dcdc3b2b8e44b01b0ed61595a3212570efa48acab7629f985"} build_url:https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2feead47e7bfa05a4bc149b620bf55d1735cd21c509088745b02506ff29ce57dc3bb5afcbc2bfb89d38b6bde3f1db2513626d5b01444c7695e2a843e5e546c23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5540e83aa0a85962c6454b50266592e3e1002359f6fe453edfbb270d9c2a5fdc6f4ddabfcae743752c620492184a09c9c223d3968e71a8945c2fc2216439f23e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ba45a17a5deaa44585ac03665759e17b705fda010060c36372c18e4aa87474d5e9f547b6ce4897dcdc3b2b8e44b01b0ed61595a3212570efa48acab7629f985"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 06:01:25.576393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:01:25.576682) ========= 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.0eOxnBwrpr/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.TnEuvaXG3z/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005132 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:01:25.624271) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 06:01:25.624539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 06:01:25.624819) ========= ========= Total master_lag: 0.19 =========