builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0246 starttime: 1464438553.62 results: success (0) buildid: 20160528030208 builduid: 7043601e68e948f1ac82a28f18c06c34 revision: ea15028498ed95677844fb7f30be5efcaf8b2621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:13.617741) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:13.618175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:13.618534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:13.850295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:13.850678) ========= 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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-28 05:29:13-- 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% 8.04M=0.001s 2016-05-28 05:29:14 (8.04 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.648496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:14.522440) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:14.522768) ========= 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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.020911 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:14.615676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:14.616047) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea15028498ed95677844fb7f30be5efcaf8b2621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ea15028498ed95677844fb7f30be5efcaf8b2621 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-28 05:29:14,696 truncating revision to first 12 chars 2016-05-28 05:29:14,696 Setting DEBUG logging. 2016-05-28 05:29:14,696 attempt 1/10 2016-05-28 05:29:14,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea15028498ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 05:29:15,362 unpacking tar archive at: mozilla-central-ea15028498ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933979 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:15.600402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:15.600677) ========= script_repo_revision: ea15028498ed95677844fb7f30be5efcaf8b2621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:15.601064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:15.601335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 05:29:15.640793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 36 secs) (at 2016-05-28 05:29:15.641136) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:29:15 INFO - MultiFileLogger online at 20160528 05:29:15 in /builds/slave/test 05:29:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:29:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:15 INFO - {'append_to_log': False, 05:29:15 INFO - 'base_work_dir': '/builds/slave/test', 05:29:15 INFO - 'blob_upload_branch': 'Firefox', 05:29:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:15 INFO - 'branch': 'Firefox', 05:29:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:15 INFO - 'config_files': ('talos/mac_config.py',), 05:29:15 INFO - 'default_actions': ('clobber', 05:29:15 INFO - 'read-buildbot-config', 05:29:15 INFO - 'download-and-extract', 05:29:15 INFO - 'populate-webroot', 05:29:15 INFO - 'create-virtualenv', 05:29:15 INFO - 'install', 05:29:15 INFO - 'run-tests'), 05:29:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:15 INFO - 'download_minidump_stackwalk': True, 05:29:15 INFO - 'download_symbols': 'ondemand', 05:29:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:15 INFO - 'installer_path': 'installer.exe', 05:29:15 INFO - 'log_level': 'info', 05:29:15 INFO - 'log_name': 'talos', 05:29:15 INFO - 'log_to_console': True, 05:29:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:15 INFO - 'opt_config_files': (), 05:29:15 INFO - 'pip_index': False, 05:29:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:15 INFO - 'cmd': ('bash', 05:29:15 INFO - '-c', 05:29:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:15 INFO - 'enabled': True, 05:29:15 INFO - 'halt_on_failure': False, 05:29:15 INFO - 'name': 'check_screen_resolution'},), 05:29:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:15 INFO - 'cmd': ('bash', 05:29:15 INFO - '-c', 05:29:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:15 INFO - 'enabled': True, 05:29:15 INFO - 'halt_on_failure': False, 05:29:15 INFO - 'name': 'check_screen_resolution'},), 05:29:15 INFO - 'run_cmd_checks_enabled': True, 05:29:15 INFO - 'sps_profile': False, 05:29:15 INFO - 'sps_profile_interval': 0, 05:29:15 INFO - 'suite': 'dromaeojs', 05:29:15 INFO - 'system_bits': '32', 05:29:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:15 INFO - 'title': 't-yosemite-r7-0246', 05:29:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:15 INFO - 'use_talos_json': True, 05:29:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:15 INFO - 'work_dir': 'build'} 05:29:15 INFO - ##### 05:29:15 INFO - ##### Running clobber step. 05:29:15 INFO - ##### 05:29:15 INFO - Running pre-action listener: _resource_record_pre_action 05:29:15 INFO - Running main action method: clobber 05:29:15 INFO - rmtree: /builds/slave/test/build 05:29:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:17 INFO - Running post-action listener: _resource_record_post_action 05:29:17 INFO - ##### 05:29:17 INFO - ##### Finished clobber step (success) 05:29:17 INFO - ##### 05:29:17 INFO - ##### 05:29:17 INFO - ##### Running read-buildbot-config step. 05:29:17 INFO - ##### 05:29:17 INFO - Running pre-action listener: _resource_record_pre_action 05:29:17 INFO - Running main action method: read_buildbot_config 05:29:17 INFO - Using buildbot properties: 05:29:17 INFO - { 05:29:17 INFO - "project": "", 05:29:17 INFO - "product": "firefox", 05:29:17 INFO - "script_repo_revision": "production", 05:29:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:29:17 INFO - "repository": "", 05:29:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:29:17 INFO - "buildid": "20160528030208", 05:29:17 INFO - "stage_platform": "macosx64", 05:29:17 INFO - "basedir": "/builds/slave/test", 05:29:17 INFO - "nightly_build": "True", 05:29:17 INFO - "buildnumber": 255, 05:29:17 INFO - "slavename": "t-yosemite-r7-0246", 05:29:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:29:17 INFO - "platform": "yosemite_r7", 05:29:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:29:17 INFO - "branch": "mozilla-central", 05:29:17 INFO - "repo_path": "mozilla-central", 05:29:17 INFO - "revision": "ea15028498ed95677844fb7f30be5efcaf8b2621", 05:29:17 INFO - "pgo_build": "False", 05:29:17 INFO - "builduid": "7043601e68e948f1ac82a28f18c06c34", 05:29:17 INFO - "slavebuilddir": "test" 05:29:17 INFO - } 05:29:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:29:17 INFO - Running post-action listener: _resource_record_post_action 05:29:17 INFO - ##### 05:29:17 INFO - ##### Finished read-buildbot-config step (success) 05:29:17 INFO - ##### 05:29:17 INFO - ##### 05:29:17 INFO - ##### Running download-and-extract step. 05:29:17 INFO - ##### 05:29:17 INFO - Running pre-action listener: _resource_record_pre_action 05:29:17 INFO - Running main action method: download_and_extract 05:29:17 INFO - mkdir: /builds/slave/test/build/tests 05:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:17 INFO - https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:29:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:29:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:29:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:29:47 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 05:29:47 INFO - retry: attempt #1 caught exception: timed out 05:29:47 INFO - retry: Failed, sleeping 30 seconds before retrying 05:30:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #2 05:30:36 INFO - Downloaded 1199 bytes. 05:30:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:30:36 INFO - Using the following test package requirements: 05:30:36 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:30:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:30:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:30:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'jsshell-mac.zip'], 05:30:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:30:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:30:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:30:36 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:30:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:30:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:30:36 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:30:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:36 INFO - https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:41 INFO - Downloaded 18684845 bytes. 05:30:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:45 INFO - Return code: 0 05:30:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:45 INFO - https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:49 INFO - Downloaded 18684845 bytes. 05:30:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:52 INFO - Return code: 0 05:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:52 INFO - https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:30:53 INFO - Downloaded 10834034 bytes. 05:30:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:30:53 INFO - Return code: 0 05:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:53 INFO - https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:30:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:30:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:30:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:30:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:31:00 INFO - Downloaded 110643421 bytes. 05:31:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:31:00 INFO - mkdir: /builds/slave/test/properties 05:31:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:00 INFO - Contents: 05:31:00 INFO - build_url:https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:31:01 INFO - Running post-action listener: _resource_record_post_action 05:31:01 INFO - Running post-action listener: set_extra_try_arguments 05:31:01 INFO - ##### 05:31:01 INFO - ##### Finished download-and-extract step (success) 05:31:01 INFO - ##### 05:31:01 INFO - ##### 05:31:01 INFO - ##### Running populate-webroot step. 05:31:01 INFO - ##### 05:31:01 INFO - Running pre-action listener: _resource_record_pre_action 05:31:01 INFO - Running main action method: populate_webroot 05:31:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:01 INFO - '--tppagecycles', 05:31:01 INFO - '7'], 05:31:01 INFO - 'tests': ['tsvgm']}}, 05:31:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:31:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:31:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['damp', 'tps']}, 05:31:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'tests': ['damp', 'tps']}, 05:31:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['dromaeo_dom']}, 05:31:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['a11yr', 05:31:01 INFO - 'ts_paint', 05:31:01 INFO - 'tpaint', 05:31:01 INFO - 'sessionrestore', 05:31:01 INFO - 'sessionrestore_no_auto_restore', 05:31:01 INFO - 'tabpaint']}, 05:31:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:31:01 INFO - 'ts_paint', 05:31:01 INFO - 'tpaint', 05:31:01 INFO - 'sessionrestore', 05:31:01 INFO - 'sessionrestore_no_auto_restore', 05:31:01 INFO - 'tabpaint']}, 05:31:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:31:01 INFO - 'ts_paint', 05:31:01 INFO - 'tpaint', 05:31:01 INFO - 'sessionrestore', 05:31:01 INFO - 'sessionrestore_no_auto_restore', 05:31:01 INFO - 'tabpaint']}, 05:31:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:31:01 INFO - 'ts_paint', 05:31:01 INFO - 'tpaint', 05:31:01 INFO - 'sessionrestore', 05:31:01 INFO - 'sessionrestore_no_auto_restore', 05:31:01 INFO - 'tabpaint']}, 05:31:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['a11yr', 05:31:01 INFO - 'ts_paint', 05:31:01 INFO - 'tpaint', 05:31:01 INFO - 'sessionrestore', 05:31:01 INFO - 'sessionrestore_no_auto_restore', 05:31:01 INFO - 'tabpaint']}, 05:31:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['a11yr', 05:31:01 INFO - 'ts_paint', 05:31:01 INFO - 'tpaint', 05:31:01 INFO - 'sessionrestore', 05:31:01 INFO - 'sessionrestore_no_auto_restore', 05:31:01 INFO - 'tabpaint']}, 05:31:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['tsvgx', 05:31:01 INFO - 'tsvgr_opacity', 05:31:01 INFO - 'tart', 05:31:01 INFO - 'tscrollx', 05:31:01 INFO - 'cart']}, 05:31:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:31:01 INFO - 'tsvgr_opacity', 05:31:01 INFO - 'tart', 05:31:01 INFO - 'tscrollx', 05:31:01 INFO - 'cart']}, 05:31:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'talos_options': ['--disable-e10s'], 05:31:01 INFO - 'tests': ['tp5o']}, 05:31:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'tests': ['tp5o']}, 05:31:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'talos_options': ['--disable-e10s', 05:31:01 INFO - '--xperf_path', 05:31:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:01 INFO - 'tests': ['tp5n']}, 05:31:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:01 INFO - 'talos_options': ['--xperf_path', 05:31:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:01 INFO - 'tests': ['tp5n']}}, 05:31:01 INFO - 'talos.zip': {'path': '', 05:31:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:01 INFO - Running post-action listener: _resource_record_post_action 05:31:01 INFO - ##### 05:31:01 INFO - ##### Finished populate-webroot step (success) 05:31:01 INFO - ##### 05:31:01 INFO - ##### 05:31:01 INFO - ##### Running create-virtualenv step. 05:31:01 INFO - ##### 05:31:01 INFO - Running pre-action listener: _resource_record_pre_action 05:31:01 INFO - Running main action method: create_virtualenv 05:31:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:01 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:31:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:01 INFO - Using real prefix '/tools/python27' 05:31:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:05 INFO - Installing pip.................done. 05:31:05 INFO - Return code: 0 05:31:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:05 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 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:05 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:31:05 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:31:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:05 INFO - 'HOME': '/Users/cltbld', 05:31:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:05 INFO - 'LOGNAME': 'cltbld', 05:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:05 INFO - 'MOZ_NO_REMOTE': '1', 05:31:05 INFO - 'NO_EM_RESTART': '1', 05:31:05 INFO - 'PAGER': '/bin/cat', 05:31:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:05 INFO - 'PWD': '/builds/slave/test', 05:31:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:05 INFO - 'SHELL': '/bin/bash', 05:31:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:05 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:05 INFO - 'USER': 'cltbld', 05:31:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:05 INFO - 'XPC_FLAGS': '0x0', 05:31:05 INFO - 'XPC_SERVICE_NAME': '0', 05:31:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:05 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:31:05 INFO - Cleaning up... 05:31:05 INFO - Return code: 0 05:31:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:05 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 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:05 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:31:05 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:31:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:05 INFO - 'HOME': '/Users/cltbld', 05:31:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:05 INFO - 'LOGNAME': 'cltbld', 05:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:05 INFO - 'MOZ_NO_REMOTE': '1', 05:31:05 INFO - 'NO_EM_RESTART': '1', 05:31:05 INFO - 'PAGER': '/bin/cat', 05:31:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:05 INFO - 'PWD': '/builds/slave/test', 05:31:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:05 INFO - 'SHELL': '/bin/bash', 05:31:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:05 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:05 INFO - 'USER': 'cltbld', 05:31:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:05 INFO - 'XPC_FLAGS': '0x0', 05:31:05 INFO - 'XPC_SERVICE_NAME': '0', 05:31:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:05 INFO - Downloading/unpacking psutil>=3.1.1 05:31:05 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:31:05 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:31:05 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:31:05 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:31:05 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:31:05 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:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:08 INFO - Installing collected packages: psutil 05:31:08 INFO - Running setup.py install for psutil 05:31:08 INFO - building 'psutil._psutil_osx' extension 05:31:08 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:31:08 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:31:08 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:31:08 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:31:08 INFO - building 'psutil._psutil_posix' extension 05:31:08 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:31:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:31:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:31:08 INFO - ^ 05:31:08 INFO - 1 warning generated. 05:31:08 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:31:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:09 INFO - Successfully installed psutil 05:31:09 INFO - Cleaning up... 05:31:09 INFO - Return code: 0 05:31:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:09 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 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:09 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:31:09 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:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:09 INFO - 'HOME': '/Users/cltbld', 05:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:09 INFO - 'LOGNAME': 'cltbld', 05:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:09 INFO - 'MOZ_NO_REMOTE': '1', 05:31:09 INFO - 'NO_EM_RESTART': '1', 05:31:09 INFO - 'PAGER': '/bin/cat', 05:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:09 INFO - 'PWD': '/builds/slave/test', 05:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:09 INFO - 'SHELL': '/bin/bash', 05:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:09 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:09 INFO - 'USER': 'cltbld', 05:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:09 INFO - 'XPC_FLAGS': '0x0', 05:31:09 INFO - 'XPC_SERVICE_NAME': '0', 05:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:31:11 INFO - Installing collected packages: mozsystemmonitor 05:31:11 INFO - Running setup.py install for mozsystemmonitor 05:31:11 INFO - Successfully installed mozsystemmonitor 05:31:11 INFO - Cleaning up... 05:31:12 INFO - Return code: 0 05:31:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:31:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:12 INFO - 'HOME': '/Users/cltbld', 05:31:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:12 INFO - 'LOGNAME': 'cltbld', 05:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:12 INFO - 'MOZ_NO_REMOTE': '1', 05:31:12 INFO - 'NO_EM_RESTART': '1', 05:31:12 INFO - 'PAGER': '/bin/cat', 05:31:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:12 INFO - 'PWD': '/builds/slave/test', 05:31:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:12 INFO - 'SHELL': '/bin/bash', 05:31:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:12 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:12 INFO - 'USER': 'cltbld', 05:31:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:12 INFO - 'XPC_FLAGS': '0x0', 05:31:12 INFO - 'XPC_SERVICE_NAME': '0', 05:31:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:31:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:15 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:31:15 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:31:15 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:31:15 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:31:15 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:31:15 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:31:15 INFO - Downloading docopt-0.6.1.tar.gz 05:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:31:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:31:16 INFO - Running setup.py install for blobuploader 05:31:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:31:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:31:16 INFO - Running setup.py install for requests 05:31:16 INFO - Running setup.py install for docopt 05:31:16 INFO - Successfully installed blobuploader requests docopt 05:31:16 INFO - Cleaning up... 05:31:16 INFO - Return code: 0 05:31:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 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 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:16 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:31:16 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:31:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:16 INFO - 'HOME': '/Users/cltbld', 05:31:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:16 INFO - 'LOGNAME': 'cltbld', 05:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:16 INFO - 'MOZ_NO_REMOTE': '1', 05:31:16 INFO - 'NO_EM_RESTART': '1', 05:31:16 INFO - 'PAGER': '/bin/cat', 05:31:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:16 INFO - 'PWD': '/builds/slave/test', 05:31:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:16 INFO - 'SHELL': '/bin/bash', 05:31:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:16 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:16 INFO - 'USER': 'cltbld', 05:31:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:16 INFO - 'XPC_FLAGS': '0x0', 05:31:16 INFO - 'XPC_SERVICE_NAME': '0', 05:31:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-S9gOXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-EKM_69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-IbvBOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-mxyu5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-RBeQL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-M5HUd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-YRpQ2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:17 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-VEzLT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-NUeIoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-gPxJCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Py6Gbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-A7XaWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-JzukIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-GlQWY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-aWX7O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-BFxw5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:18 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-1k2uDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:18 INFO - Running setup.py install for manifestparser 05:31:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:31:19 INFO - Running setup.py install for mozcrash 05:31:19 INFO - Running setup.py install for mozdebug 05:31:19 INFO - Running setup.py install for mozdevice 05:31:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:31:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:31:19 INFO - Running setup.py install for mozfile 05:31:19 INFO - Running setup.py install for mozhttpd 05:31:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:31:19 INFO - Running setup.py install for mozinfo 05:31:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:31:19 INFO - Running setup.py install for mozInstall 05:31:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Running setup.py install for mozleak 05:31:20 INFO - Running setup.py install for mozlog 05:31:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Running setup.py install for moznetwork 05:31:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Running setup.py install for mozprocess 05:31:20 INFO - Running setup.py install for mozprofile 05:31:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:31:20 INFO - Running setup.py install for mozrunner 05:31:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:31:21 INFO - Running setup.py install for mozscreenshot 05:31:21 INFO - Running setup.py install for moztest 05:31:21 INFO - Running setup.py install for mozversion 05:31:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:31:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:21 INFO - Cleaning up... 05:31:21 INFO - Return code: 0 05:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:21 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 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:21 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:31:21 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:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:21 INFO - 'HOME': '/Users/cltbld', 05:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:21 INFO - 'LOGNAME': 'cltbld', 05:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:21 INFO - 'MOZ_NO_REMOTE': '1', 05:31:21 INFO - 'NO_EM_RESTART': '1', 05:31:21 INFO - 'PAGER': '/bin/cat', 05:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:21 INFO - 'PWD': '/builds/slave/test', 05:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:21 INFO - 'SHELL': '/bin/bash', 05:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:21 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:21 INFO - 'USER': 'cltbld', 05:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:21 INFO - 'XPC_FLAGS': '0x0', 05:31:21 INFO - 'XPC_SERVICE_NAME': '0', 05:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-lxuwHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:21 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:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-byXtud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ixqyXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-3xvvKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Y529mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-5ixdjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-DVWy7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-kh0mxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-YU9Nvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-RwpmrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-6OL2Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:22 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:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:22 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-grn2xE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:23 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-0KZaQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:23 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:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:23 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-CvXYJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:23 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-gYAujd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:23 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:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:23 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4VSIGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:23 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:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:23 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-I7aCQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:23 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:31:23 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:31:23 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:31:23 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:31:23 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:31:23 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:31:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:26 INFO - Downloading blessings-1.6.tar.gz 05:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:26 INFO - Installing collected packages: blessings 05:31:26 INFO - Running setup.py install for blessings 05:31:26 INFO - Successfully installed blessings 05:31:26 INFO - Cleaning up... 05:31:26 INFO - Return code: 0 05:31:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:27 INFO - Reading from file tmpfile_stdout 05:31:27 INFO - Current package versions: 05:31:27 INFO - blessings == 1.6 05:31:27 INFO - blobuploader == 1.2.4 05:31:27 INFO - docopt == 0.6.1 05:31:27 INFO - manifestparser == 1.1 05:31:27 INFO - mozInstall == 1.12 05:31:27 INFO - mozcrash == 0.17 05:31:27 INFO - mozdebug == 0.1 05:31:27 INFO - mozdevice == 0.48 05:31:27 INFO - mozfile == 1.2 05:31:27 INFO - mozhttpd == 0.7 05:31:27 INFO - mozinfo == 0.9 05:31:27 INFO - mozleak == 0.1 05:31:27 INFO - mozlog == 3.2 05:31:27 INFO - moznetwork == 0.27 05:31:27 INFO - mozprocess == 0.22 05:31:27 INFO - mozprofile == 0.28 05:31:27 INFO - mozrunner == 6.11 05:31:27 INFO - mozscreenshot == 0.1 05:31:27 INFO - mozsystemmonitor == 0.3 05:31:27 INFO - moztest == 0.7 05:31:27 INFO - mozversion == 1.4 05:31:27 INFO - psutil == 3.1.1 05:31:27 INFO - requests == 1.2.3 05:31:27 INFO - wsgiref == 0.1.2 05:31:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 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 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:27 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:31:27 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:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:27 INFO - 'HOME': '/Users/cltbld', 05:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:27 INFO - 'LOGNAME': 'cltbld', 05:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:27 INFO - 'MOZ_NO_REMOTE': '1', 05:31:27 INFO - 'NO_EM_RESTART': '1', 05:31:27 INFO - 'PAGER': '/bin/cat', 05:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:27 INFO - 'PWD': '/builds/slave/test', 05:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:27 INFO - 'SHELL': '/bin/bash', 05:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:27 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:27 INFO - 'USER': 'cltbld', 05:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:27 INFO - 'XPC_FLAGS': '0x0', 05:31:27 INFO - 'XPC_SERVICE_NAME': '0', 05:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 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:31:27 INFO - Cleaning up... 05:31:27 INFO - Return code: 0 05:31:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:27 INFO - 'HOME': '/Users/cltbld', 05:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:27 INFO - 'LOGNAME': 'cltbld', 05:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:27 INFO - 'MOZ_NO_REMOTE': '1', 05:31:27 INFO - 'NO_EM_RESTART': '1', 05:31:27 INFO - 'PAGER': '/bin/cat', 05:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:27 INFO - 'PWD': '/builds/slave/test', 05:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:27 INFO - 'SHELL': '/bin/bash', 05:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:27 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:27 INFO - 'USER': 'cltbld', 05:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:27 INFO - 'XPC_FLAGS': '0x0', 05:31:27 INFO - 'XPC_SERVICE_NAME': '0', 05:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:27 INFO - Downloading/unpacking jsonschema 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:29 INFO - Downloading/unpacking functools32 (from jsonschema) 05:31:29 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:31:29 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:31:29 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:31:29 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:31:29 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:31:29 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:31:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:30 INFO - warning: no files found matching '*.txt' 05:31:30 INFO - no previously-included directories found matching 'build' 05:31:30 INFO - no previously-included directories found matching 'dist' 05:31:30 INFO - no previously-included directories found matching '.git*' 05:31:30 INFO - Installing collected packages: jsonschema, functools32 05:31:30 INFO - Running setup.py install for functools32 05:31:30 INFO - warning: no files found matching '*.txt' 05:31:30 INFO - no previously-included directories found matching 'build' 05:31:30 INFO - no previously-included directories found matching 'dist' 05:31:30 INFO - no previously-included directories found matching '.git*' 05:31:30 INFO - Successfully installed jsonschema functools32 05:31:30 INFO - Cleaning up... 05:31:30 INFO - Return code: 0 05:31:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb13598880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, '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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:31:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:31:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:30 INFO - 'HOME': '/Users/cltbld', 05:31:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:30 INFO - 'LOGNAME': 'cltbld', 05:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:30 INFO - 'MOZ_NO_REMOTE': '1', 05:31:30 INFO - 'NO_EM_RESTART': '1', 05:31:30 INFO - 'PAGER': '/bin/cat', 05:31:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:30 INFO - 'PWD': '/builds/slave/test', 05:31:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:30 INFO - 'SHELL': '/bin/bash', 05:31:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:31:30 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:31:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:30 INFO - 'USER': 'cltbld', 05:31:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:30 INFO - 'XPC_FLAGS': '0x0', 05:31:30 INFO - 'XPC_SERVICE_NAME': '0', 05:31:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:30 INFO - Downloading/unpacking flake8 05:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:31:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:31:33 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:31:33 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:31:33 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:31:33 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:31:33 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:31:33 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:31:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:31:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:31:33 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:31:33 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:31:33 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:31:33 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:31:33 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:31:33 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:31:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:31:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:34 INFO - no previously-included directories found matching 'docs/_build' 05:31:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:31:34 INFO - Running setup.py install for pep8 05:31:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:34 INFO - no previously-included directories found matching 'docs/_build' 05:31:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:31:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:31:34 INFO - Cleaning up... 05:31:35 INFO - Return code: 0 05:31:35 INFO - Running post-action listener: _resource_record_post_action 05:31:35 INFO - Running post-action listener: _start_resource_monitoring 05:31:35 INFO - Starting resource monitoring. 05:31:35 INFO - ##### 05:31:35 INFO - ##### Finished create-virtualenv step (success) 05:31:35 INFO - ##### 05:31:35 INFO - ##### 05:31:35 INFO - ##### Running install step. 05:31:35 INFO - ##### 05:31:35 INFO - Running pre-action listener: _resource_record_pre_action 05:31:35 INFO - Running main action method: install 05:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:35 INFO - Reading from file tmpfile_stdout 05:31:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:31:35 INFO - Reading from file tmpfile_stdout 05:31:35 INFO - Output received: 05:31:35 INFO - Usage: mozinstall [options] installer 05:31:35 INFO - Options: 05:31:35 INFO - -h, --help show this help message and exit 05:31:35 INFO - -d DEST, --destination=DEST 05:31:35 INFO - Directory to install application into. [default: 05:31:35 INFO - "/builds/slave/test"] 05:31:35 INFO - --app=APP Application being installed. [default: firefox] 05:31:35 INFO - mkdir: /builds/slave/test/build/application 05:31:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:32:09 INFO - Reading from file tmpfile_stdout 05:32:09 INFO - Output received: 05:32:09 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:32:09 INFO - Running post-action listener: _resource_record_post_action 05:32:09 INFO - ##### 05:32:09 INFO - ##### Finished install step (success) 05:32:09 INFO - ##### 05:32:09 INFO - ##### 05:32:09 INFO - ##### Running run-tests step. 05:32:09 INFO - ##### 05:32:09 INFO - Running pre-action listener: _resource_record_pre_action 05:32:09 INFO - Running main action method: run_tests 05:32:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:32:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:32:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:32:09 INFO - 2016-05-28 05:32:09.243 screenresolution[7106:124808] starting screenresolution argv=screenresolution get 05:32:09 INFO - 2016-05-28 05:32:09.246 screenresolution[7106:124808] Display 0: 1600x1200x32@60 05:32:09 INFO - 2016-05-28 05:32:09.252 screenresolution[7107:124811] starting screenresolution argv=screenresolution list 05:32:09 INFO - Available Modes on Display 0 05:32:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:32:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:32:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:32:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:32:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:32:09 INFO - Intel Iris: 05:32:09 INFO - Chipset Model: Intel Iris 05:32:09 INFO - Type: GPU 05:32:09 INFO - Bus: Built-In 05:32:09 INFO - VRAM (Dynamic, Max): 1536 MB 05:32:09 INFO - Vendor: Intel (0x8086) 05:32:09 INFO - Device ID: 0x0a2e 05:32:09 INFO - Revision ID: 0x0009 05:32:09 INFO - Displays: 05:32:09 INFO - Display: 05:32:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:32:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:32:09 INFO - Display Serial Number: 1600x1200 60 05:32:09 INFO - Main Display: Yes 05:32:09 INFO - Mirror: Off 05:32:09 INFO - Online: Yes 05:32:09 INFO - Rotation: Supported 05:32:09 INFO - Return code: 0 05:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:09 INFO - Python 2.7.3 05:32:09 INFO - Return code: 0 05:32:09 INFO - grabbing minidump binary from tooltool 05:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:09 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 0x1058ffd30>, '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 0x105723db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1058f6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:09 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:32:09 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:32:09 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:32:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:09 INFO - Return code: 0 05:32:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:32:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:32:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:32:10 INFO - Return code: 0 05:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0246 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k5eLUcPlYo/Render', 05:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:10 INFO - 'HOME': '/Users/cltbld', 05:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:10 INFO - 'LOGNAME': 'cltbld', 05:32:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:10 INFO - 'MOZ_NO_REMOTE': '1', 05:32:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:10 INFO - 'NO_EM_RESTART': '1', 05:32:10 INFO - 'PAGER': '/bin/cat', 05:32:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:10 INFO - 'PWD': '/builds/slave/test', 05:32:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:10 INFO - 'SHELL': '/bin/bash', 05:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdnaJjT2Ff/Listeners', 05:32:10 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 05:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:10 INFO - 'USER': 'cltbld', 05:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:10 INFO - 'XPC_FLAGS': '0x0', 05:32:10 INFO - 'XPC_SERVICE_NAME': '0', 05:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:32:10 INFO - mozversion application_buildid: 20160528030208 05:32:10 INFO - mozversion application_changeset: ea15028498ed95677844fb7f30be5efcaf8b2621 05:32:10 INFO - mozversion application_display_name: Nightly 05:32:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:10 INFO - mozversion application_name: Firefox 05:32:10 INFO - mozversion application_remotingname: firefox 05:32:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:32:10 INFO - mozversion application_vendor: Mozilla 05:32:10 INFO - mozversion application_version: 49.0a1 05:32:10 INFO - mozversion platform_buildid: 20160528030208 05:32:10 INFO - mozversion platform_changeset: ea15028498ed95677844fb7f30be5efcaf8b2621 05:32:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:32:10 INFO - mozversion platform_version: 49.0a1 05:32:10 INFO - using testdate: 1464438730 05:32:10 INFO - actual date: 1464438730 05:32:10 INFO - starting webserver on 'localhost:50263' 05:32:10 INFO - SUITE-START | Running 2 tests 05:32:10 INFO - TEST-START | dromaeo_css 05:32:10 INFO - operating with platform_type : mac_ 05:32:10 INFO - Initialising browser for dromaeo_css test... 05:32:10 INFO - TEST-INFO | started process 7125 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpA9H_Qp/profile http://localhost:50263/getInfo.html) 05:32:13 INFO - PROCESS | 7125 | __metrics Screen width/height:1600/1200 05:32:13 INFO - PROCESS | 7125 | colorDepth:24 05:32:13 INFO - PROCESS | 7125 | Browser inner width/height: 1024/689 05:32:13 INFO - PROCESS | 7125 | __metrics 05:32:13 INFO - PROCESS | 7125 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:32:13 ERROR - PROCESS | 7125 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:32:13 INFO - TEST-INFO | 7125: exit 0 05:32:13 INFO - Browser initialized. 05:32:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:13 INFO - TEST-INFO | started process 7127 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpA9H_Qp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:25 INFO - PROCESS | 7127 | RSS: Main: 241463296 05:32:25 INFO - PROCESS | 7127 | 05:33:17 INFO - PROCESS | 7127 | 1464438797388 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:35:27 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:50263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50263/tests/dromaeo/cssquery-ext.html) 05:35:29 INFO - PROCESS | 7127 | RSS: Main: 358748160 05:35:29 INFO - PROCESS | 7127 | 05:38:32 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:50263/tests/dromaeo/cssquery-ext.html (next: http://localhost:50263/tests/dromaeo/cssquery-jquery.html) 05:38:32 INFO - PROCESS | 7127 | RSS: Main: 377012224 05:38:32 INFO - PROCESS | 7127 | 05:41:34 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:50263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50263/tests/dromaeo/cssquery-mootools.html) 05:41:35 INFO - PROCESS | 7127 | RSS: Main: 372371456 05:41:35 INFO - PROCESS | 7127 | 05:44:37 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:50263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50263/tests/dromaeo/cssquery-prototype.html) 05:44:38 INFO - PROCESS | 7127 | RSS: Main: 372121600 05:44:38 INFO - PROCESS | 7127 | 05:47:41 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:50263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50263/tests/dromaeo/cssquery-yui.html) 05:47:42 INFO - PROCESS | 7127 | RSS: Main: 344588288 05:47:42 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:50263/tests/dromaeo/cssquery-yui.html (next: http://localhost:50263/tests/dromaeo/cssquery-dojo.html) 05:50:45 INFO - PROCESS | 7127 | RSS: Main: 378060800 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | __start_tp_report 05:50:45 INFO - PROCESS | 7127 | _x_x_mozilla_page_load 05:50:45 INFO - PROCESS | 7127 | _x_x_mozilla_page_load_details 05:50:45 INFO - PROCESS | 7127 | |i|pagename|runs| 05:50:45 INFO - PROCESS | 7127 | |0;dojo.html;3431.828408579572;3437.3984552703278;3444.448888177891;3457.913552161197;3520.7183425325975;5644.887102257962;5654.943450565494;5727.914081288784;5786.363500014995;5787.305523337205;5698.51562617177;5700.828975130742;5811.157382179582;5846.678432686201;5889.705514724257;5114.079465696173;5154.381474223099;5227.86930326743;5229.86925326868;5334;5313.043652142613;5339.359276886759;5358.946410535903;5364.517193452589;5395.919061214085;4479.619232365253;5110.4634013428795;5130.38435387754;5219.947800521984;5256.973715131419;5172.974135129338;5174.275601415768;5184.403793563751;5191.454897235773;5202.739863006872;4912.091263116335;5223.059849227137;5226.372835259755;5260.736963151865;5289.074411977888;5525.198846167284;5543.279373681436;5683.857903552403;5697.1739097831;5763.020286551255;6193.566450348478;6264.968675156595;6270.216222972129;6274.717637706314;6290.716917738713;6220.911340515392;6246.718897649616;6260.029695397221;6274.152989346426;6274.341194174592;5677.460641239076;5750.5112065474905;5819.79630712923;5877.85305367365;5883.676397798119;5351.625386222927;6281.654509001957;6285;6296.929521981274;6301.936980630227;6140.938590614126;6156.322804491502;6159.106929495288;6167.044108163242;6178.783742569079;6052.243469566304;6126.578745377165;6158.04550294705;6249.50003999688;6259.624422534663;6161.568690191643;6211.782587609412;6255.186825712719;6262.34245404226;6269.435750782452;6252.187215661935;6267.2165979252595;6277.686115694197;6280.717367718464;6287.2140982377205;4826.61387089032;4865.6107511399005;4867.1969125093965;4905.264210368473;4968.453470118284;3757.774533527997;4402.889927751832;4403.53762854902;4452.4211852458975;4509.413776209138;5754.827355179351;5769;5780.624259423124;5783.132530120515;5857.677827719516;6108.7670647404;6110.163888792202;6192.59748116371;6195.752169913243;6256.74973001084;5652.689102099424;5705.400932902068;5714.9714251429305;5721.77112915487;5765.538756899438;5342.54588359986;5349.170878513836;5351.277577527062;5357.946420535823;5360.088784906575;4946.530079642428;6179.969100154471;6260.843478913063;6302.369763023661;6308.211473565804;6247.656378899204;6274.152989346562;6287.591306565058;6290.087937248982;6295.18162638854;6306.873862522815;6315.147455093687;6326.114343991753;6343.524235682435;6347.96826015867;5147.253648221062;6050.576459647782;6078.149059131637;6115.296740874856;6123.7244324006415;6083.117947897442;6142.877142457215;6219.813405597839;6233.657148856675;6255.968720156552;6096.969515152396;6104.9389506106145;6127.295361033538;6137.631742095488;6143.109249158936;5975.25309336333;6032.517398608188;6107.419795119635;6117.20476338091;6124.601900876607;6025.307089684742;6043.063325184604;6048.818535443944;6064.9393506066135;6090.725917333642;6102.139324235651;6118.474653736909;6122.112293717297;6130.601510901777;6144.754209831557;5895.882082358415;5935.0503919372695;5974.910376344272;6031.7587296507645;6082.300535438481 05:50:45 INFO - PROCESS | 7127 | |1;ext.html;485.83724452308473;495.88594623236634;518.2588897876037;528.8572085536905;561.6742289472106;31784;35042.12394690131;41800.79099604501;42813.35779963303;42951.35572966408;44813;45248;45405.7729711351;45430.318545221846;45435.31847022297;8572.871406928902;9598.520073996307;9818.263630227726;9833.950830245838;9838.212942964547;8789.296856251485;11607.709807254843;11926.7614647707;11936.582219622314;12202.938985305062;11937.403129843517;11982.40087995601;11983.101267404936;11986.940065299661;12001.399930003508;8701.347398945041;8948.8657670135;8964.731058068268;11742.357969456847;11943.522259109624;8924.553772311423;12052.819207711891;12105.757884842254;12127.151099423045;12161.391930403444;41408.58591414108;41924.742257732316;42040.3693944588;42086.947826304284;42324.1535169298;3535.9116022099397;3542.8405721742583;3574.767640103385;3590.856365745367;3599.6760291573883;26818.195454136407;28661;31831.681683183335;32254.516182257285;33077.834610826794;3331.41700202466;3356.8153751543655;3406.7615266931325;3444.5866496020385;3478.7043101336417;467727;468780;469049;469541.65229173977;470718;64612.35387646157;64870.67564662241;64920.35079649143;65193.02210466847;65266;69155.65422172958;69194.30805691979;69207;69371.65314173397;69450.30549694438;15312.387504499919;16936.899101558607;17159.914200428917;17207.397741079003;17229.56926076833;11752.118591105702;12132.939335303443;12711.173773704679;12906.032047596467;12930.353482325847;18837.434876953714;18972.525686857938;19016.429507114808;19016.61966760657;19036.33372831944;5161.458046905096;7999.36005119589;8006.879896801553;8041.3968952328805;8135.227153420416;929.846575315079;1004.7287232447344;1036.6164519127972;1076.4348716923678;1077.5851297250615;30159.492025398642;30212.94254701075;30370.392592148033;30864.537031944088;30944.535831962537;1028.3932479836933;1041.4272150317295;1060.7825395793843;1093.6500319897557;1100.2848148703406;13823;15486.457973970857;15931.840681593036;15978.520644380687;16283.918580407022;682155;687743;689136.8690504747;692224;694700;60990;62749.372506275264;62757.372426276066;62904;63052;1285.395863943945;1313.6650154210615;1331.0083987429427;1412.0821466046946;1445.3351458329287;23321.883390582938;31270.68729312678;31576.684233158292;31711.524327135572;32481.837590811894;53424.73287633537;54003.459965399845;54064.18903716526;54065;54127.45872541382;545718.2714086404;563002;567211;568318;571469;36101.277974439836;37475.43786843145;42594;43226.78386608047;43590.56409435992;47962.52037479581;48526;48964.51035489742;49538.75230623824;50180.74909625429;29943.55084673775;39866.40200397054;40144.1971160581;40989.38515922204;41002.01439996814;39102.82691519259;39480.80259598799;39526;40076.398854017796;40352.7982360098;38298.0425489365;38978.02554936149;38985;39192;39539.604603953594;32966.34067318688;34035.65964340325;34372.48441273333;34543.963681089605;34760.47859282164;25322.987080516574;25453.61819572745;25792.355191120372;25856.48287034211;25888.8705556471 05:50:45 INFO - PROCESS | 7127 | |2;jquery.html;329.55016402610437;388.5570449687357;392.46820558143696;405.92896243157475;411.54524250702974;15583.532494025168;16156.434524791635;18814.341498047554;22208.22334213263;22363.664545031817;20653.17387304506;21290;21572.460688482795;21945.231916882913;21946.89026554869;5492.588055895823;5769.076947688371;5983.192269043689;6017.39826017397;6024.096385542181;5989.940100599004;6007.18902948103;6051.667158306292;6058.3032951210735;6061.272647282332;5615.550755939515;5926.555508336871;5932.317783454893;5932.822015339525;5986.580939334227;5565.66606003637;5802.042662960606;5822.068469044953;5855.121731740252;5861.4724674779045;5118.84643460693;5124.538791508745;5148.0476111919415;5149.485051494858;5155.793768249266;16100.75848862268;20641.96790160501;25643.487130257476;25701.97192112313;26016.34959126018;2502.3869152057864;2564.7178810331034;2572.62696908949;2576.935576610581;3030.92402197219;15190.468333608382;15704.371825126982;16160.676786464323;16410.507684769476;16445.67108657832;1853.0271607406219;1853.1197681101503;1862.0317434933759;1887.3488646416963;1915.7509523761962;117852.41073794576;118006;119655;119769.99999999913;121335;9980.45107519079;10504.894951050544;10557.894421055691;10933.961273678988;11224.438778061065;13892.652683682989;13967.37146828395;14010.50963216303;14019.649508762159;14045.859541404456;8484.19400156984;8739.694110706096;8754.343424243207;8873.157050080232;8894.377393582387;8793.912060879436;8804.691835785718;8805.295576353876;8911.37620366581;9012.918449785937;6471.9029214561815;6571.4085732283365;6572.901406478906;6621.404073633396;6637.1703537057865;1588.7131423546964;1814.954626134357;1844.8247416495412;1851.1392202625843;1852.2313240005517;910.2308549275851;937.5078084005816;959.8992105828927;1022.0341777020644;1058.30680904008;20884.164633414493;21621.67567486489;21826.672599911013;22058.227962021254;22090.11639534433;969.2488321550854;982.4940155819759;983.9409635421897;1028.2956175020136;1062.3625824505234;10000.799984000425;11490.195686301879;11839.644810655695;11896.583619573274;11903.70240743971;563678;584036;586696;590923;614466;115570.42214788872;118359;119702;122990;123002;968.6222373274429;1055.2718624149313;1069.7855439240698;1073.7208325835184;1075.1506310015156;17100;18784.718229226844;18826.05869706482;19217.423477295702;19219.903900480407;50994;51228.74385628048;51962;52549;52710;72497;72881.90677139953;73502.52994939964;74512.50974980362;77678;7845.333146682596;7990.6004699765945;8067.290577025654;8081.757547273592;8212.46618969765;8863.24662403677;11663;12088.51645934188;12815.807762883751;13012.609621710984;10167.593296268362;10664.46677666098;11068.778624427627;11117.05505032049;11330.433478326215;10902.509387077442;10965.396903170402;11373.725254948879;11386;11748.471318790846;11260.605878794202;11490.029395408053;11591.6522504325;11805.586804461802;11949.820752688544;8170.182981701782;8226.67927536296;8246.793830154054;8340.874886876823;8409.705660301861;8317.667293308443;10448.791024179625;11633;11668.766624667629;11681.591144309908 05:50:45 INFO - PROCESS | 7127 | |3;mootools.html;1342.7717288061028;1553.083680628429;1578.9605259868501;1809.619979804241;1935.9419217423483;7757.767266981992;8480.491170529765;8715.477071375723;8722.694705685302;8823.647054117844;8559.700410485635;8671.783205419868;8755.124487551242;8768.78078048049;8777.2100510954;2353.52929414117;2382.475855311837;2382.5473160099527;2385.3321070100315;2385.725641551218;1974.5261137327009;2278.840481166319;2290.347251033456;2293.266154830455;2294.7705229477;2173.250228671106;2186.180182431588;2195.319450970196;2226.7530183097438;2229.9331020069426;2126.691629713698;2233.4081468410886;2344.495933374324;2354.564405584964;2354.693889794324;2264.8867556622104;2267.3764714703425;2270.1146552844402;2270.2735124760084;2276.362618466832;8522.446041007377;8707.216350528419;8787.42881712693;8790.428622139605;8791.032986371494;5239.711815850127;5427.43011983744;5429.1584804355;5431.83704488862;5434.2935418395355;3584.7132229421845;3668;3676.9080772980624;3742.925141497155;3743.7192210584044;1006.1296978113952;1087.2280680716701;1100.757833276678;1111.6498303034518;1115.1803424482998;11646.41767911601;11715.7071073223;11759.94120029403;11784.764304713857;11785.882141178565;4461.10777844426;4488.730676159441;4610.515895830889;4617.168909596305;4626.467956185014;9216.262698984065;9229.769255768526;9242.676506322381;9244.029376915461;9249.398789078688;5243.318368612056;5243.924995375939;5249.868753281198;5255.159174532057;5268.92096618551;4236.661067114624;4361.672874534423;4536.72779633223;4828.179209534387;4858.684185527929;3746.550413950343;3760.3231418344963;3817.560980487224;3866.4586957825927;3871.8644847430205;1168.661088284405;1169.8069818479855;1174.671092094215;1174.74155685749;1180.6281021478208;920.9309301802392;925.9583318750672;927.4806108579218;942.1426501883253;979.3095867413457;5731.914021289684;5849.356570777211;5859.707014649251;5963.910541341883;6057.545684073712;412.95870412959067;422.98096585653104;441.17720451357985;441.933709943511;451.97288162710345;3875.8643447479203;3914.0019295079574;3959.544652365015;3962.821673024721;3966.3257246268204;10295.227857910686;10604.151667866552;10803.405812680221;10807.67576972692;10820.404877731642;10685.465726713634;10737.731556710989;10739.409332486632;10758.354498730101;10787.946060269649;7929.484583502054;8175.468594541336;8178.550179740052;8266.628001739937;8273.793155171168;5723.942760572341;5765.538756899354;5792;5841.007028805028;5850.0932355484965;9728.708138755848;10113.69658910234;10119.443430611387;10120.493975301353;10138.847917281098;9822.165115964937;10253;10310.742231443974;10318.48407579633;10357.585696572052;6480.416762491398;6677.632730199885;6773.559718618274;6832.077669514552;7089.680964356719;8314.334853211607;8319.750407487785;8341.41610087288;8402.32781377476;8406;7287.344139027513;7385.704571817282;7532.510386825058;7612.1246056704185;7711.498752581064;7240.312170343809;7315.926840731738;7351.669174887036;7438.92561074404;7458.403327733877;6987.545809522365;7050.753223637148;7101.680424381018;7102.573845569283;7103.396211321889;4343.1747967886;4844.539768721966;4994.325766021686;5051.520105589963;5084.3898732152375;4970.378702662168;5063.645544811975;5081.8729531762;5100.362454693163;5162.716050617252 05:50:45 INFO - PROCESS | 7127 | |4;prototype.html;300.2733385207797;305.17145948749146;307.4849626874984;315.2827317851888;319.16697419734476;4627.889306566425;4861.659683822134;5305.840824775263;5387.946120538793;5410.648307859991;4433.467983841935;5327.668082979255;5338.519533242007;5340.866478338044;5345.973270133644;3497.0208341664375;3808.8286027128847;3881.5342158940966;3967.801609919507;3983.342748446503;4000.1999600079953;4000.6199411055904;4037.546483266022;4075.9592404076025;4130.669546436293;3583.5341405617232;4031.6169963853386;4065.715399922007;4073.327900896363;4080.6735461163034;3415.121683074299;3844.5394947233794;3980.2835489611857;3985.70107241958;4031.3751368537924;2946;3170.429322721909;3493.0917961329983;3513.101691104823;3523.982380088083;4236.598337120196;4465.575770301849;4550.840720574764;4602.976985115087;5092.694438333675;4096.508418989741;4328.3250684627465;4620.514845941195;4627.676062675614;4631.86519302773;4546;5268.710220937847;5497.8075767348355;5507.284053073115;5547.976352887686;3886.7667939923413;3893.7274390792654;3895.922081558353;3906.374980003186;3913.393424019253;5023.32185155003;5487.972560137174;5829.804889997583;5857.70711464425;5909.3204281507315;3109.3470371222297;3225.145336485833;3273.5908011498564;3854.1520865409566;3875.70932180082;3926.8821935341984;3935.4293627423863;3936.940945885814;3938.960610393917;3945.408188771707;4042.8679969608556;4540.387047748578;4568.97198130418;4578.519255478127;4606.539346065367;4948.331975183376;5324.5740340772645;5374.381946076173;5628.437156284339;5671.773129074873;1284.6467221514158;1360.9520669084948;1378.9655258618616;1384;1390.32569203936;718;731.9926800731924;856.6530555125184;859.9637436888535;867.5792240763225;4588.678792484494;4903.234835459232;5103.642745007888;5111.961550375162;5113.411957624847;5080.59355251579;5424.403315635277;5679.744411501492;5729.169270455761;5735.913961290584;4887.828925987574;4899.657024008286;5100.744962751847;5144.61415393847;5167.405748338989;2563.76926076654;2948.231061363208;2991.6559595646345;3049.9847500762353;3058.4800583900346;5523.337199536001;5992.31088424828;6030.668313242726;6048.60684055535;6073.848153796191;4623.606993405531;5621.5221706155435;5639.379668236491;5931.199288096138;5956.5532585055425;5273.78904843802;5998.450658470133;6042.486388656926;6056.848578785565;6064.848378790389;5419.620626556103;5785.27684039495;5794.884102318014;5795.971020144872;5817.7963771267805;4883.825513416308;5700.543956483554;5704.315482142004;5732.8534293142375;5735.684537350319;4897.722559010077;5711.200431939615;5954.880902382015;6040.486558642388;6065.0288656187795;3115.797473164237;3242.4060751398315;3310.817905015247;3327.467605183159;3380.4084285250474;4135.359019351885;4469.7594244172715;4876.829310974099;4891.6575839692305;4923.679960802537;4220.746755194698;4318.719283246579;4690.906181876411;4759.8822771085;4850.14985014985;3947.9407808883466;4236.76697781625;4359.934600980924;4406.7576283304725;4715.585324402597;3756.750410894611;4184.623383895464;4587.564181402761;4658.790354434126;4681.133990211822;5283.656562323436;5502.889942201214;5506.284183056177;5516.558675305886;5565.88682263557;4383;4821.276808478756;4875.488073752205;5043.35224007399;5337.03794394115 05:50:45 INFO - PROCESS | 7127 | |5;yui.html;696.3976160621063;766.8351304469538;799.8120441696204;827.702027270183;875.1773333066915;12277.693057673552;15156.77264841027;15221.467248646299;15366.23168841559;15511.689766204683;14179.220142892136;14209.147451152938;14218.14691118531;14244.28778561073;14290.714185716279;727.2073439950453;817.8773184022415;825.108882406999;832.0971745655941;833.912439193885;737.8634952533798;883.3507372081515;913.853783394657;915.8397280475923;922.1055576091214;961.038961038961;966.6809952715587;971.3637567393368;976.3604838830578;979.1530326267798;761.8095476130967;970.6263088710897;973.4062222044547;977.8386566216566;978.1001478639633;688.0711040095881;713.6324792731747;715.9284071592851;716.2980279326238;716.3839098375392;14535;14610.853891461056;14916.925415372962;14920.925395373062;14928.701425971529;13543.86456135436;13839.446422143103;13868.375923083486;13889.79165312521;13998.72002559943;12287.447064882102;12416.82040206188;12531.06017048725;12563.560275390317;12952.740945181044;4575.290829921368;4639.095376401603;4678.7660616969015;4772.642051846091;4815.9036819263765;74827.5034499307;75488.6225568874;77089.614551928;77473.61263193704;78205.60897195477;9414.905850941539;11024;11144.108471322275;11274.267172633752;11618.825717614243;21449.57100857974;21464;21464.24875129363;21473.14107435716;21600.675989860163;7909;7943.64253608589;7991.0810256821205;8025.759227223192;8057.073436554754;3971.523417189898;4465.553444655573;4468.463784345834;4527.728336299832;4538.205813982539;3388.9830550847087;3486.8082255475683;3490.9650903491147;3499.562554680665;3505.5618047744033;677.6374639567807;687.8280429892527;688.8932215506604;703.6200451756097;705.4673721340355;530.3927003580878;567.8324894156234;612.7732738886551;661.6865521938947;667.7362441835447;7478.962605186939;9024.458532488072;9140.405873618327;9143.177114059767;9202.677906273248;568.4656422962402;597.6055803169887;627.9748810047638;638.5402510192654;670.4435318685479;4188.350805625072;4266.466691663542;4270.658347332206;4352.151330490524;4411.09572537629;71641;73735.26264737285;73773;79550.80673789898;80031.59984200042;70908.64545677342;74940.62529687317;75130.24869751342;75598;76638.85041724378;67242.66378668173;68892.655536722;69496.62584353912;69642;69805.65097174482;8434.95782521108;8521.318294536546;9443;9544.10139487636;9735.123838854537;36887.44668829916;43393;43867.78066109649;44209.115817682825;44286;47618.285725714835;57282.42717572771;58081.54796130131;60550.69724651348;61572;11509.827352589886;12631.368431578201;12645.873541264838;12702.682432939251;13363.799543006668;14361.784573231202;14527.636809079857;14576.125432474086;14953.252337383305;15023.924880375529;13287.202767833574;13552.93223533876;13567.050306478846;13627.591172264847;13636.590902272948;11385.886141138482;13393.799093013418;13474.52839150625;13577.389017494039;13579.45682172702;12892.548760793326;12945.029122816015;13009.609711708665;13391.933040334736;13653.79519307231;11065.557377705123;11185.049270812073;11409.486573104396;11422.771544568895;11450.885491145315;9359.85960210611;10873.130149587856;10959.945200273947;11177.608783692533;11276.32342059479 05:50:45 INFO - PROCESS | 7127 | __end_tp_report 05:50:45 INFO - PROCESS | 7127 | __start_cc_report 05:50:45 INFO - PROCESS | 7127 | _x_x_mozilla_cycle_collect,1309 05:50:45 INFO - PROCESS | 7127 | __end_cc_report 05:50:45 INFO - PROCESS | 7127 | __startTimestamp1464439845735__endTimestamp 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | ------- Summary: start ------- 05:50:45 INFO - PROCESS | 7127 | Number of tests: 6 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | [#0] dojo.html Cycles:165 Average:5730.55 Median:6025.31 stddev:647.06 (10.7%) stddev-sans-first:623.41 05:50:45 INFO - PROCESS | 7127 | Values: 3431.8 3437.4 3444.4 3457.9 3520.7 5644.9 5654.9 5727.9 5786.4 5787.3 5698.5 5700.8 5811.2 5846.7 5889.7 5114.1 5154.4 5227.9 5229.9 5334.0 5313.0 5339.4 5358.9 5364.5 5395.9 4479.6 5110.5 5130.4 5219.9 5257.0 5173.0 5174.3 5184.4 5191.5 5202.7 4912.1 5223.1 5226.4 5260.7 5289.1 5525.2 5543.3 5683.9 5697.2 5763.0 6193.6 6265.0 6270.2 6274.7 6290.7 6220.9 6246.7 6260.0 6274.2 6274.3 5677.5 5750.5 5819.8 5877.9 5883.7 5351.6 6281.7 6285.0 6296.9 6301.9 6140.9 6156.3 6159.1 6167.0 6178.8 6052.2 6126.6 6158.0 6249.5 6259.6 6161.6 6211.8 6255.2 6262.3 6269.4 6252.2 6267.2 6277.7 6280.7 6287.2 4826.6 4865.6 4867.2 4905.3 4968.5 3757.8 4402.9 4403.5 4452.4 4509.4 5754.8 5769.0 5780.6 5783.1 5857.7 6108.8 6110.2 6192.6 6195.8 6256.7 5652.7 5705.4 5715.0 5721.8 5765.5 5342.5 5349.2 5351.3 5357.9 5360.1 4946.5 6180.0 6260.8 6302.4 6308.2 6247.7 6274.2 6287.6 6290.1 6295.2 6306.9 6315.1 6326.1 6343.5 6348.0 5147.3 6050.6 6078.1 6115.3 6123.7 6083.1 6142.9 6219.8 6233.7 6256.0 6097.0 6104.9 6127.3 6137.6 6143.1 5975.3 6032.5 6107.4 6117.2 6124.6 6025.3 6043.1 6048.8 6064.9 6090.7 6102.1 6118.5 6122.1 6130.6 6144.8 5895.9 5935.1 5974.9 6031.8 6082.3 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | [#1] ext.html Cycles:180 Average:72010.86 Median:38981.51 stddev:155155.07 (398.0%) stddev-sans-first:155497.39 05:50:45 INFO - PROCESS | 7127 | Values: 485.8 495.9 518.3 528.9 561.7 31784.0 35042.1 41800.8 42813.4 42951.4 44813.0 45248.0 45405.8 45430.3 45435.3 8572.9 9598.5 9818.3 9834.0 9838.2 8789.3 11607.7 11926.8 11936.6 12202.9 11937.4 11982.4 11983.1 11986.9 12001.4 8701.3 8948.9 8964.7 11742.4 11943.5 8924.6 12052.8 12105.8 12127.2 12161.4 41408.6 41924.7 42040.4 42086.9 42324.2 3535.9 3542.8 3574.8 3590.9 3599.7 26818.2 28661.0 31831.7 32254.5 33077.8 3331.4 3356.8 3406.8 3444.6 3478.7 467727.0 468780.0 469049.0 469541.7 470718.0 64612.4 64870.7 64920.4 65193.0 65266.0 69155.7 69194.3 69207.0 69371.7 69450.3 15312.4 16936.9 17159.9 17207.4 17229.6 11752.1 12132.9 12711.2 12906.0 12930.4 18837.4 18972.5 19016.4 19016.6 19036.3 5161.5 7999.4 8006.9 8041.4 8135.2 929.8 1004.7 1036.6 1076.4 1077.6 30159.5 30212.9 30370.4 30864.5 30944.5 1028.4 1041.4 1060.8 1093.7 1100.3 13823.0 15486.5 15931.8 15978.5 16283.9 682155.0 687743.0 689136.9 692224.0 694700.0 60990.0 62749.4 62757.4 62904.0 63052.0 1285.4 1313.7 1331.0 1412.1 1445.3 23321.9 31270.7 31576.7 31711.5 32481.8 53424.7 54003.5 54064.2 54065.0 54127.5 545718.3 563002.0 567211.0 568318.0 571469.0 36101.3 37475.4 42594.0 43226.8 43590.6 47962.5 48526.0 48964.5 49538.8 50180.7 29943.6 39866.4 40144.2 40989.4 41002.0 39102.8 39480.8 39526.0 40076.4 40352.8 38298.0 38978.0 38985.0 39192.0 39539.6 32966.3 34035.7 34372.5 34544.0 34760.5 25323.0 25453.6 25792.4 25856.5 25888.9 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | [#2] jquery.html Cycles:180 Average:34559.26 Median:22285.94 stddev:98001.09 (439.7%) stddev-sans-first:98242.31 05:50:45 INFO - PROCESS | 7127 | Values: 329.6 388.6 392.5 405.9 411.5 15583.5 16156.4 18814.3 22208.2 22363.7 20653.2 21290.0 21572.5 21945.2 21946.9 5492.6 5769.1 5983.2 6017.4 6024.1 5989.9 6007.2 6051.7 6058.3 6061.3 5615.6 5926.6 5932.3 5932.8 5986.6 5565.7 5802.0 5822.1 5855.1 5861.5 5118.8 5124.5 5148.0 5149.5 5155.8 16100.8 20642.0 25643.5 25702.0 26016.3 2502.4 2564.7 2572.6 2576.9 3030.9 15190.5 15704.4 16160.7 16410.5 16445.7 1853.0 1853.1 1862.0 1887.3 1915.8 117852.4 118006.0 119655.0 119770.0 121335.0 9980.5 10504.9 10557.9 10934.0 11224.4 13892.7 13967.4 14010.5 14019.6 14045.9 8484.2 8739.7 8754.3 8873.2 8894.4 8793.9 8804.7 8805.3 8911.4 9012.9 6471.9 6571.4 6572.9 6621.4 6637.2 1588.7 1815.0 1844.8 1851.1 1852.2 910.2 937.5 959.9 1022.0 1058.3 20884.2 21621.7 21826.7 22058.2 22090.1 969.2 982.5 983.9 1028.3 1062.4 10000.8 11490.2 11839.6 11896.6 11903.7 563678.0 584036.0 586696.0 590923.0 614466.0 115570.4 118359.0 119702.0 122990.0 123002.0 968.6 1055.3 1069.8 1073.7 1075.2 17100.0 18784.7 18826.1 19217.4 19219.9 50994.0 51228.7 51962.0 52549.0 52710.0 72497.0 72881.9 73502.5 74512.5 77678.0 7845.3 7990.6 8067.3 8081.8 8212.5 8863.2 11663.0 12088.5 12815.8 13012.6 10167.6 10664.5 11068.8 11117.1 11330.4 10902.5 10965.4 11373.7 11386.0 11748.5 11260.6 11490.0 11591.7 11805.6 11949.8 8170.2 8226.7 8246.8 8340.9 8409.7 8317.7 10448.8 11633.0 11668.8 11681.6 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | [#3] mootools.html Cycles:180 Average:5646.01 Median:4621.82 stddev:3211.10 (69.5%) stddev-sans-first:3203.83 05:50:45 INFO - PROCESS | 7127 | Values: 1342.8 1553.1 1579.0 1809.6 1935.9 7757.8 8480.5 8715.5 8722.7 8823.6 8559.7 8671.8 8755.1 8768.8 8777.2 2353.5 2382.5 2382.5 2385.3 2385.7 1974.5 2278.8 2290.3 2293.3 2294.8 2173.3 2186.2 2195.3 2226.8 2229.9 2126.7 2233.4 2344.5 2354.6 2354.7 2264.9 2267.4 2270.1 2270.3 2276.4 8522.4 8707.2 8787.4 8790.4 8791.0 5239.7 5427.4 5429.2 5431.8 5434.3 3584.7 3668.0 3676.9 3742.9 3743.7 1006.1 1087.2 1100.8 1111.6 1115.2 11646.4 11715.7 11759.9 11784.8 11785.9 4461.1 4488.7 4610.5 4617.2 4626.5 9216.3 9229.8 9242.7 9244.0 9249.4 5243.3 5243.9 5249.9 5255.2 5268.9 4236.7 4361.7 4536.7 4828.2 4858.7 3746.6 3760.3 3817.6 3866.5 3871.9 1168.7 1169.8 1174.7 1174.7 1180.6 920.9 926.0 927.5 942.1 979.3 5731.9 5849.4 5859.7 5963.9 6057.5 413.0 423.0 441.2 441.9 452.0 3875.9 3914.0 3959.5 3962.8 3966.3 10295.2 10604.2 10803.4 10807.7 10820.4 10685.5 10737.7 10739.4 10758.4 10787.9 7929.5 8175.5 8178.6 8266.6 8273.8 5723.9 5765.5 5792.0 5841.0 5850.1 9728.7 10113.7 10119.4 10120.5 10138.8 9822.2 10253.0 10310.7 10318.5 10357.6 6480.4 6677.6 6773.6 6832.1 7089.7 8314.3 8319.8 8341.4 8402.3 8406.0 7287.3 7385.7 7532.5 7612.1 7711.5 7240.3 7315.9 7351.7 7438.9 7458.4 6987.5 7050.8 7101.7 7102.6 7103.4 4343.2 4844.5 4994.3 5051.5 5084.4 4970.4 5063.6 5081.9 5100.4 5162.7 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | [#4] prototype.html Cycles:180 Average:4369.45 Median:4645.33 stddev:1364.71 (29.4%) stddev-sans-first:1333.92 05:50:45 INFO - PROCESS | 7127 | Values: 300.3 305.2 307.5 315.3 319.2 4627.9 4861.7 5305.8 5387.9 5410.6 4433.5 5327.7 5338.5 5340.9 5346.0 3497.0 3808.8 3881.5 3967.8 3983.3 4000.2 4000.6 4037.5 4076.0 4130.7 3583.5 4031.6 4065.7 4073.3 4080.7 3415.1 3844.5 3980.3 3985.7 4031.4 2946.0 3170.4 3493.1 3513.1 3524.0 4236.6 4465.6 4550.8 4603.0 5092.7 4096.5 4328.3 4620.5 4627.7 4631.9 4546.0 5268.7 5497.8 5507.3 5548.0 3886.8 3893.7 3895.9 3906.4 3913.4 5023.3 5488.0 5829.8 5857.7 5909.3 3109.3 3225.1 3273.6 3854.2 3875.7 3926.9 3935.4 3936.9 3939.0 3945.4 4042.9 4540.4 4569.0 4578.5 4606.5 4948.3 5324.6 5374.4 5628.4 5671.8 1284.6 1361.0 1379.0 1384.0 1390.3 718.0 732.0 856.7 860.0 867.6 4588.7 4903.2 5103.6 5112.0 5113.4 5080.6 5424.4 5679.7 5729.2 5735.9 4887.8 4899.7 5100.7 5144.6 5167.4 2563.8 2948.2 2991.7 3050.0 3058.5 5523.3 5992.3 6030.7 6048.6 6073.8 4623.6 5621.5 5639.4 5931.2 5956.6 5273.8 5998.5 6042.5 6056.8 6064.8 5419.6 5785.3 5794.9 5796.0 5817.8 4883.8 5700.5 5704.3 5732.9 5735.7 4897.7 5711.2 5954.9 6040.5 6065.0 3115.8 3242.4 3310.8 3327.5 3380.4 4135.4 4469.8 4876.8 4891.7 4923.7 4220.7 4318.7 4690.9 4759.9 4850.1 3947.9 4236.8 4359.9 4406.8 4715.6 3756.8 4184.6 4587.6 4658.8 4681.1 5283.7 5502.9 5506.3 5516.6 5565.9 4383.0 4821.3 4875.5 5043.4 5337.0 05:50:45 INFO - PROCESS | 7127 | 05:50:45 INFO - PROCESS | 7127 | [#5] yui.html Cycles:180 Average:17692.65 Median:26148.53 stddev:22917.20 (87.6%) stddev-sans-first:22945.95 05:50:45 INFO - PROCESS | 7127 | Values: 696.4 766.8 799.8 827.7 875.2 12277.7 15156.8 15221.5 15366.2 15511.7 14179.2 14209.1 14218.1 14244.3 14290.7 727.2 817.9 825.1 832.1 833.9 737.9 883.4 913.9 915.8 922.1 961.0 966.7 971.4 976.4 979.2 761.8 970.6 973.4 977.8 978.1 688.1 713.6 715.9 716.3 716.4 14535.0 14610.9 14916.9 14920.9 14928.7 13543.9 13839.4 13868.4 13889.8 13998.7 12287.4 12416.8 12531.1 12563.6 12952.7 4575.3 4639.1 4678.8 4772.6 4815.9 74827.5 75488.6 77089.6 77473.6 78205.6 9414.9 11024.0 11144.1 11274.3 11618.8 21449.6 21464.0 21464.2 21473.1 21600.7 7909.0 7943.6 7991.1 8025.8 8057.1 3971.5 4465.6 4468.5 4527.7 4538.2 3389.0 3486.8 3491.0 3499.6 3505.6 677.6 687.8 688.9 703.6 705.5 530.4 567.8 612.8 661.7 667.7 7479.0 9024.5 9140.4 9143.2 9202.7 568.5 597.6 628.0 638.5 670.4 4188.4 4266.5 4270.7 4352.2 4411.1 71641.0 73735.3 73773.0 79550.8 80031.6 70908.6 74940.6 75130.2 75598.0 76638.9 67242.7 68892.7 69496.6 69642.0 69805.7 8435.0 8521.3 9443.0 9544.1 9735.1 36887.4 43393.0 43867.8 44209.1 44286.0 47618.3 57282.4 58081.5 60550.7 61572.0 11509.8 12631.4 12645.9 12702.7 13363.8 14361.8 14527.6 14576.1 14953.3 15023.9 13287.2 13552.9 13567.1 13627.6 13636.6 11385.9 13393.8 13474.5 13577.4 13579.5 12892.5 12945.0 13009.6 13391.9 13653.8 11065.6 11185.0 11409.5 11422.8 11450.9 9359.9 10873.1 10959.9 11177.6 11276.3 05:50:45 INFO - PROCESS | 7127 | -------- Summary: end -------- 05:50:45 INFO - PROCESS | 7127 | 05:50:46 INFO - TEST-INFO | 7127: exit 0 05:50:46 INFO - TEST-OK | dromaeo_css | took 1115355ms 05:50:46 INFO - TEST-START | kraken 05:50:46 INFO - operating with platform_type : mac_ 05:50:46 INFO - Initialising browser for kraken test... 05:50:46 INFO - TEST-INFO | started process 7131 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpxWFnDt/profile http://localhost:50263/getInfo.html) 05:50:48 INFO - PROCESS | 7131 | __metrics Screen width/height:1600/1200 05:50:48 INFO - PROCESS | 7131 | colorDepth:24 05:50:48 INFO - PROCESS | 7131 | Browser inner width/height: 1024/689 05:50:48 INFO - PROCESS | 7131 | __metrics 05:50:48 INFO - PROCESS | 7131 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:50:48 ERROR - PROCESS | 7131 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:50:49 INFO - TEST-INFO | 7131: exit 0 05:50:49 INFO - Browser initialized. 05:50:49 INFO - Running cycle 1/1 for kraken test... 05:50:49 INFO - TEST-INFO | started process 7133 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpxWFnDt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:01 INFO - PROCESS | 7133 | RSS: Main: 241598464 05:51:01 INFO - PROCESS | 7133 | 05:51:03 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50263/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:04 INFO - PROCESS | 7133 | RSS: Main: 291901440 05:51:04 INFO - PROCESS | 7133 | 05:51:07 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50263/tests/kraken/driver.html?testName=audio-dft) 05:51:08 INFO - PROCESS | 7133 | RSS: Main: 301465600 05:51:08 INFO - PROCESS | 7133 | 05:51:11 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50263/tests/kraken/driver.html?testName=audio-fft) 05:51:12 INFO - PROCESS | 7133 | RSS: Main: 385818624 05:51:12 INFO - PROCESS | 7133 | 05:51:14 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50263/tests/kraken/driver.html?testName=audio-oscillator) 05:51:15 INFO - PROCESS | 7133 | RSS: Main: 287203328 05:51:15 INFO - PROCESS | 7133 | 05:51:17 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:17 INFO - PROCESS | 7133 | RSS: Main: 291217408 05:51:17 INFO - PROCESS | 7133 | 05:51:20 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50263/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:21 INFO - PROCESS | 7133 | RSS: Main: 328790016 05:51:21 INFO - PROCESS | 7133 | 05:51:24 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50263/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:24 INFO - PROCESS | 7133 | RSS: Main: 329162752 05:51:24 INFO - PROCESS | 7133 | 05:51:27 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50263/tests/kraken/driver.html?testName=json-parse-financial) 05:51:28 INFO - PROCESS | 7133 | RSS: Main: 327520256 05:51:28 INFO - PROCESS | 7133 | 05:51:29 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:30 INFO - PROCESS | 7133 | RSS: Main: 309870592 05:51:30 INFO - PROCESS | 7133 | 05:51:32 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:32 INFO - PROCESS | 7133 | RSS: Main: 317014016 05:51:32 INFO - PROCESS | 7133 | 05:51:35 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:35 INFO - PROCESS | 7133 | RSS: Main: 321265664 05:51:35 INFO - PROCESS | 7133 | 05:51:38 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:39 INFO - PROCESS | 7133 | RSS: Main: 323665920 05:51:39 INFO - PROCESS | 7133 | 05:51:42 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:42 INFO - PROCESS | 7133 | RSS: Main: 323121152 05:51:42 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | Cycle 1(1): loaded http://localhost:50263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50263/tests/kraken/driver.html?testName=ai-astar) 05:51:44 INFO - PROCESS | 7133 | RSS: Main: 367030272 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | __start_tp_report 05:51:44 INFO - PROCESS | 7133 | _x_x_mozilla_page_load 05:51:44 INFO - PROCESS | 7133 | _x_x_mozilla_page_load_details 05:51:44 INFO - PROCESS | 7133 | |i|pagename|runs| 05:51:44 INFO - PROCESS | 7133 | |0;ai-astar;112;105;112;113;112;113;112;112;111;111 05:51:44 INFO - PROCESS | 7133 | |1;audio-beat-detection;155;118;117;166;114;116;139;117;150;116 05:51:44 INFO - PROCESS | 7133 | |2;audio-dft;184;184;183;186;186;181;183;182;184;182 05:51:44 INFO - PROCESS | 7133 | |3;audio-fft;81;76;56;120;78;80;86;64;87;73 05:51:44 INFO - PROCESS | 7133 | |4;audio-oscillator;82;91;94;98;100;98;114;70;68;104 05:51:44 INFO - PROCESS | 7133 | |5;imaging-gaussian-blur;87;86;89;84;86;83;86;83;86;83 05:51:44 INFO - PROCESS | 7133 | |6;imaging-darkroom;93;92;93;97;93;92;93;92;93;92 05:51:44 INFO - PROCESS | 7133 | |7;imaging-desaturate;84;100;131;131;86;84;84;84;84;85 05:51:44 INFO - PROCESS | 7133 | |8;json-parse-financial;56;56;55;56;55;54;55;54;53;56 05:51:44 INFO - PROCESS | 7133 | |9;json-stringify-tinderbox;67;73;77;78;71;72;70;72;72;72 05:51:44 INFO - PROCESS | 7133 | |10;stanford-crypto-aes;86;90;107;73;99;106;104;106;139;87 05:51:44 INFO - PROCESS | 7133 | |11;stanford-crypto-ccm;175;153;146;136;137;135;138;137;147;122 05:51:44 INFO - PROCESS | 7133 | |12;stanford-crypto-pbkdf2;162;222;164;165;166;162;163;168;163;162 05:51:44 INFO - PROCESS | 7133 | |13;stanford-crypto-sha256-iterative;66;66;66;66;65;67;66;67;65;67 05:51:44 INFO - PROCESS | 7133 | __end_tp_report 05:51:44 INFO - PROCESS | 7133 | __start_cc_report 05:51:44 INFO - PROCESS | 7133 | _x_x_mozilla_cycle_collect,2021 05:51:44 INFO - PROCESS | 7133 | __end_cc_report 05:51:44 INFO - PROCESS | 7133 | __startTimestamp1464439904829__endTimestamp 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | ------- Summary: start ------- 05:51:44 INFO - PROCESS | 7133 | Number of tests: 14 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.31 (2.1%) stddev-sans-first:2.44 05:51:44 INFO - PROCESS | 7133 | Values: 112.0 105.0 112.0 113.0 112.0 113.0 112.0 112.0 111.0 111.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:128.50 stddev:19.79 (15.4%) stddev-sans-first:18.96 05:51:44 INFO - PROCESS | 7133 | Values: 155.0 118.0 117.0 166.0 114.0 116.0 139.0 117.0 150.0 116.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.65 (0.9%) stddev-sans-first:1.74 05:51:44 INFO - PROCESS | 7133 | Values: 184.0 184.0 183.0 186.0 186.0 181.0 183.0 182.0 184.0 182.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#3] audio-fft Cycles:10 Average:80.10 Median:79.00 stddev:16.95 (21.5%) stddev-sans-first:17.98 05:51:44 INFO - PROCESS | 7133 | Values: 81.0 76.0 56.0 120.0 78.0 80.0 86.0 64.0 87.0 73.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:86.50 stddev:14.64 (16.9%) stddev-sans-first:15.08 05:51:44 INFO - PROCESS | 7133 | Values: 82.0 91.0 94.0 98.0 100.0 98.0 114.0 70.0 68.0 104.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.00 stddev:2.00 (2.3%) stddev-sans-first:2.03 05:51:44 INFO - PROCESS | 7133 | Values: 87.0 86.0 89.0 84.0 86.0 83.0 86.0 83.0 86.0 83.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 05:51:44 INFO - PROCESS | 7133 | Values: 93.0 92.0 93.0 97.0 93.0 92.0 93.0 92.0 93.0 92.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:84.00 stddev:19.44 (23.1%) stddev-sans-first:20.19 05:51:44 INFO - PROCESS | 7133 | Values: 84.0 100.0 131.0 131.0 86.0 84.0 84.0 84.0 84.0 85.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.05 (1.9%) stddev-sans-first:1.05 05:51:44 INFO - PROCESS | 7133 | Values: 56.0 56.0 55.0 56.0 55.0 54.0 55.0 54.0 53.0 56.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.00 stddev:3.17 (4.4%) stddev-sans-first:2.69 05:51:44 INFO - PROCESS | 7133 | Values: 67.0 73.0 77.0 78.0 71.0 72.0 70.0 72.0 72.0 72.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#10] stanford-crypto-aes Cycles:10 Average:99.70 Median:79.50 stddev:17.80 (22.4%) stddev-sans-first:18.18 05:51:44 INFO - PROCESS | 7133 | Values: 86.0 90.0 107.0 73.0 99.0 106.0 104.0 106.0 139.0 87.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:142.00 stddev:14.14 (10.0%) stddev-sans-first:8.89 05:51:44 INFO - PROCESS | 7133 | Values: 175.0 153.0 146.0 136.0 137.0 135.0 138.0 137.0 147.0 122.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:164.50 stddev:18.48 (11.2%) stddev-sans-first:19.39 05:51:44 INFO - PROCESS | 7133 | Values: 162.0 222.0 164.0 165.0 166.0 162.0 163.0 168.0 163.0 162.0 05:51:44 INFO - PROCESS | 7133 | 05:51:44 INFO - PROCESS | 7133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 05:51:44 INFO - PROCESS | 7133 | Values: 66.0 66.0 66.0 66.0 65.0 67.0 66.0 67.0 65.0 67.0 05:51:44 INFO - PROCESS | 7133 | -------- Summary: end -------- 05:51:44 INFO - PROCESS | 7133 | 05:51:45 INFO - TEST-INFO | 7133: exit 0 05:51:45 INFO - TEST-OK | kraken | took 59321ms 05:51:45 INFO - SUITE-END | took 1174s 05:51:46 INFO - Completed test suite (00:19:35) 05:51:46 INFO - javascript benchmark 05:51:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3431.828408579572, 3437.3984552703278, 3444.448888177891, 3457.913552161197, 3520.7183425325975, 5644.887102257962, 5654.943450565494, 5727.914081288784, 5786.363500014995, 5787.305523337205, 5698.51562617177, 5700.828975130742, 5811.157382179582, 5846.678432686201, 5889.705514724257, 5114.079465696173, 5154.381474223099, 5227.86930326743, 5229.86925326868, 5334.0, 5313.043652142613, 5339.359276886759, 5358.946410535903, 5364.517193452589, 5395.919061214085, 4479.619232365253, 5110.4634013428795, 5130.38435387754, 5219.947800521984, 5256.973715131419, 5172.974135129338, 5174.275601415768, 5184.403793563751, 5191.454897235773, 5202.739863006872, 4912.091263116335, 5223.059849227137, 5226.372835259755, 5260.736963151865, 5289.074411977888, 5525.198846167284, 5543.279373681436, 5683.857903552403, 5697.1739097831, 5763.020286551255, 6193.566450348478, 6264.968675156595, 6270.216222972129, 6274.717637706314, 6290.716917738713, 6220.911340515392, 6246.718897649616, 6260.029695397221, 6274.152989346426, 6274.341194174592, 5677.460641239076, 5750.5112065474905, 5819.79630712923, 5877.85305367365, 5883.676397798119, 5351.625386222927, 6281.654509001957, 6285.0, 6296.929521981274, 6301.936980630227, 6140.938590614126, 6156.322804491502, 6159.106929495288, 6167.044108163242, 6178.783742569079, 6052.243469566304, 6126.578745377165, 6158.04550294705, 6249.50003999688, 6259.624422534663, 6161.568690191643, 6211.782587609412, 6255.186825712719, 6262.34245404226, 6269.435750782452, 6252.187215661935, 6267.2165979252595, 6277.686115694197, 6280.717367718464, 6287.2140982377205, 4826.61387089032, 4865.6107511399005, 4867.1969125093965, 4905.264210368473, 4968.453470118284, 3757.774533527997, 4402.889927751832, 4403.53762854902, 4452.4211852458975, 4509.413776209138, 5754.827355179351, 5769.0, 5780.624259423124, 5783.132530120515, 5857.677827719516, 6108.7670647404, 6110.163888792202, 6192.59748116371, 6195.752169913243, 6256.74973001084, 5652.689102099424, 5705.400932902068, 5714.9714251429305, 5721.77112915487, 5765.538756899438, 5342.54588359986, 5349.170878513836, 5351.277577527062, 5357.946420535823, 5360.088784906575, 4946.530079642428, 6179.969100154471, 6260.843478913063, 6302.369763023661, 6308.211473565804, 6247.656378899204, 6274.152989346562, 6287.591306565058, 6290.087937248982, 6295.18162638854, 6306.873862522815, 6315.147455093687, 6326.114343991753, 6343.524235682435, 6347.96826015867, 5147.253648221062, 6050.576459647782, 6078.149059131637, 6115.296740874856, 6123.7244324006415, 6083.117947897442, 6142.877142457215, 6219.813405597839, 6233.657148856675, 6255.968720156552, 6096.969515152396, 6104.9389506106145, 6127.295361033538, 6137.631742095488, 6143.109249158936, 5975.25309336333, 6032.517398608188, 6107.419795119635, 6117.20476338091, 6124.601900876607, 6025.307089684742, 6043.063325184604, 6048.818535443944, 6064.9393506066135, 6090.725917333642, 6102.139324235651, 6118.474653736909, 6122.112293717297, 6130.601510901777, 6144.754209831557, 5895.882082358415, 5935.0503919372695, 5974.910376344272, 6031.7587296507645, 6082.300535438481], "value": 5690.175040311662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.83724452308473, 495.88594623236634, 518.2588897876037, 528.8572085536905, 561.6742289472106, 31784.0, 35042.12394690131, 41800.79099604501, 42813.35779963303, 42951.35572966408, 44813.0, 45248.0, 45405.7729711351, 45430.318545221846, 45435.31847022297, 8572.871406928902, 9598.520073996307, 9818.263630227726, 9833.950830245838, 9838.212942964547, 8789.296856251485, 11607.709807254843, 11926.7614647707, 11936.582219622314, 12202.938985305062, 11937.403129843517, 11982.40087995601, 11983.101267404936, 11986.940065299661, 12001.399930003508, 8701.347398945041, 8948.8657670135, 8964.731058068268, 11742.357969456847, 11943.522259109624, 8924.553772311423, 12052.819207711891, 12105.757884842254, 12127.151099423045, 12161.391930403444, 41408.58591414108, 41924.742257732316, 42040.3693944588, 42086.947826304284, 42324.1535169298, 3535.9116022099397, 3542.8405721742583, 3574.767640103385, 3590.856365745367, 3599.6760291573883, 26818.195454136407, 28661.0, 31831.681683183335, 32254.516182257285, 33077.834610826794, 3331.41700202466, 3356.8153751543655, 3406.7615266931325, 3444.5866496020385, 3478.7043101336417, 467727.0, 468780.0, 469049.0, 469541.65229173977, 470718.0, 64612.35387646157, 64870.67564662241, 64920.35079649143, 65193.02210466847, 65266.0, 69155.65422172958, 69194.30805691979, 69207.0, 69371.65314173397, 69450.30549694438, 15312.387504499919, 16936.899101558607, 17159.914200428917, 17207.397741079003, 17229.56926076833, 11752.118591105702, 12132.939335303443, 12711.173773704679, 12906.032047596467, 12930.353482325847, 18837.434876953714, 18972.525686857938, 19016.429507114808, 19016.61966760657, 19036.33372831944, 5161.458046905096, 7999.36005119589, 8006.879896801553, 8041.3968952328805, 8135.227153420416, 929.846575315079, 1004.7287232447344, 1036.6164519127972, 1076.4348716923678, 1077.5851297250615, 30159.492025398642, 30212.94254701075, 30370.392592148033, 30864.537031944088, 30944.535831962537, 1028.3932479836933, 1041.4272150317295, 1060.7825395793843, 1093.6500319897557, 1100.2848148703406, 13823.0, 15486.457973970857, 15931.840681593036, 15978.520644380687, 16283.918580407022, 682155.0, 687743.0, 689136.8690504747, 692224.0, 694700.0, 60990.0, 62749.372506275264, 62757.372426276066, 62904.0, 63052.0, 1285.395863943945, 1313.6650154210615, 1331.0083987429427, 1412.0821466046946, 1445.3351458329287, 23321.883390582938, 31270.68729312678, 31576.684233158292, 31711.524327135572, 32481.837590811894, 53424.73287633537, 54003.459965399845, 54064.18903716526, 54065.0, 54127.45872541382, 545718.2714086404, 563002.0, 567211.0, 568318.0, 571469.0, 36101.277974439836, 37475.43786843145, 42594.0, 43226.78386608047, 43590.56409435992, 47962.52037479581, 48526.0, 48964.51035489742, 49538.75230623824, 50180.74909625429, 29943.55084673775, 39866.40200397054, 40144.1971160581, 40989.38515922204, 41002.01439996814, 39102.82691519259, 39480.80259598799, 39526.0, 40076.398854017796, 40352.7982360098, 38298.0425489365, 38978.02554936149, 38985.0, 39192.0, 39539.604603953594, 32966.34067318688, 34035.65964340325, 34372.48441273333, 34543.963681089605, 34760.47859282164, 25322.987080516574, 25453.61819572745, 25792.355191120372, 25856.48287034211, 25888.8705556471], "value": 20972.98864390889, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.55016402610437, 388.5570449687357, 392.46820558143696, 405.92896243157475, 411.54524250702974, 15583.532494025168, 16156.434524791635, 18814.341498047554, 22208.22334213263, 22363.664545031817, 20653.17387304506, 21290.0, 21572.460688482795, 21945.231916882913, 21946.89026554869, 5492.588055895823, 5769.076947688371, 5983.192269043689, 6017.39826017397, 6024.096385542181, 5989.940100599004, 6007.18902948103, 6051.667158306292, 6058.3032951210735, 6061.272647282332, 5615.550755939515, 5926.555508336871, 5932.317783454893, 5932.822015339525, 5986.580939334227, 5565.66606003637, 5802.042662960606, 5822.068469044953, 5855.121731740252, 5861.4724674779045, 5118.84643460693, 5124.538791508745, 5148.0476111919415, 5149.485051494858, 5155.793768249266, 16100.75848862268, 20641.96790160501, 25643.487130257476, 25701.97192112313, 26016.34959126018, 2502.3869152057864, 2564.7178810331034, 2572.62696908949, 2576.935576610581, 3030.92402197219, 15190.468333608382, 15704.371825126982, 16160.676786464323, 16410.507684769476, 16445.67108657832, 1853.0271607406219, 1853.1197681101503, 1862.0317434933759, 1887.3488646416963, 1915.7509523761962, 117852.41073794576, 118006.0, 119655.0, 119769.99999999913, 121335.0, 9980.45107519079, 10504.894951050544, 10557.894421055691, 10933.961273678988, 11224.438778061065, 13892.652683682989, 13967.37146828395, 14010.50963216303, 14019.649508762159, 14045.859541404456, 8484.19400156984, 8739.694110706096, 8754.343424243207, 8873.157050080232, 8894.377393582387, 8793.912060879436, 8804.691835785718, 8805.295576353876, 8911.37620366581, 9012.918449785937, 6471.9029214561815, 6571.4085732283365, 6572.901406478906, 6621.404073633396, 6637.1703537057865, 1588.7131423546964, 1814.954626134357, 1844.8247416495412, 1851.1392202625843, 1852.2313240005517, 910.2308549275851, 937.5078084005816, 959.8992105828927, 1022.0341777020644, 1058.30680904008, 20884.164633414493, 21621.67567486489, 21826.672599911013, 22058.227962021254, 22090.11639534433, 969.2488321550854, 982.4940155819759, 983.9409635421897, 1028.2956175020136, 1062.3625824505234, 10000.799984000425, 11490.195686301879, 11839.644810655695, 11896.583619573274, 11903.70240743971, 563678.0, 584036.0, 586696.0, 590923.0, 614466.0, 115570.42214788872, 118359.0, 119702.0, 122990.0, 123002.0, 968.6222373274429, 1055.2718624149313, 1069.7855439240698, 1073.7208325835184, 1075.1506310015156, 17100.0, 18784.718229226844, 18826.05869706482, 19217.423477295702, 19219.903900480407, 50994.0, 51228.74385628048, 51962.0, 52549.0, 52710.0, 72497.0, 72881.90677139953, 73502.52994939964, 74512.50974980362, 77678.0, 7845.333146682596, 7990.6004699765945, 8067.290577025654, 8081.757547273592, 8212.46618969765, 8863.24662403677, 11663.0, 12088.51645934188, 12815.807762883751, 13012.609621710984, 10167.593296268362, 10664.46677666098, 11068.778624427627, 11117.05505032049, 11330.433478326215, 10902.509387077442, 10965.396903170402, 11373.725254948879, 11386.0, 11748.471318790846, 11260.605878794202, 11490.029395408053, 11591.6522504325, 11805.586804461802, 11949.820752688544, 8170.182981701782, 8226.67927536296, 8246.793830154054, 8340.874886876823, 8409.705660301861, 8317.667293308443, 10448.791024179625, 11633.0, 11668.766624667629, 11681.591144309908], "value": 9775.944373899158, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.7717288061028, 1553.083680628429, 1578.9605259868501, 1809.619979804241, 1935.9419217423483, 7757.767266981992, 8480.491170529765, 8715.477071375723, 8722.694705685302, 8823.647054117844, 8559.700410485635, 8671.783205419868, 8755.124487551242, 8768.78078048049, 8777.2100510954, 2353.52929414117, 2382.475855311837, 2382.5473160099527, 2385.3321070100315, 2385.725641551218, 1974.5261137327009, 2278.840481166319, 2290.347251033456, 2293.266154830455, 2294.7705229477, 2173.250228671106, 2186.180182431588, 2195.319450970196, 2226.7530183097438, 2229.9331020069426, 2126.691629713698, 2233.4081468410886, 2344.495933374324, 2354.564405584964, 2354.693889794324, 2264.8867556622104, 2267.3764714703425, 2270.1146552844402, 2270.2735124760084, 2276.362618466832, 8522.446041007377, 8707.216350528419, 8787.42881712693, 8790.428622139605, 8791.032986371494, 5239.711815850127, 5427.43011983744, 5429.1584804355, 5431.83704488862, 5434.2935418395355, 3584.7132229421845, 3668.0, 3676.9080772980624, 3742.925141497155, 3743.7192210584044, 1006.1296978113952, 1087.2280680716701, 1100.757833276678, 1111.6498303034518, 1115.1803424482998, 11646.41767911601, 11715.7071073223, 11759.94120029403, 11784.764304713857, 11785.882141178565, 4461.10777844426, 4488.730676159441, 4610.515895830889, 4617.168909596305, 4626.467956185014, 9216.262698984065, 9229.769255768526, 9242.676506322381, 9244.029376915461, 9249.398789078688, 5243.318368612056, 5243.924995375939, 5249.868753281198, 5255.159174532057, 5268.92096618551, 4236.661067114624, 4361.672874534423, 4536.72779633223, 4828.179209534387, 4858.684185527929, 3746.550413950343, 3760.3231418344963, 3817.560980487224, 3866.4586957825927, 3871.8644847430205, 1168.661088284405, 1169.8069818479855, 1174.671092094215, 1174.74155685749, 1180.6281021478208, 920.9309301802392, 925.9583318750672, 927.4806108579218, 942.1426501883253, 979.3095867413457, 5731.914021289684, 5849.356570777211, 5859.707014649251, 5963.910541341883, 6057.545684073712, 412.95870412959067, 422.98096585653104, 441.17720451357985, 441.933709943511, 451.97288162710345, 3875.8643447479203, 3914.0019295079574, 3959.544652365015, 3962.821673024721, 3966.3257246268204, 10295.227857910686, 10604.151667866552, 10803.405812680221, 10807.67576972692, 10820.404877731642, 10685.465726713634, 10737.731556710989, 10739.409332486632, 10758.354498730101, 10787.946060269649, 7929.484583502054, 8175.468594541336, 8178.550179740052, 8266.628001739937, 8273.793155171168, 5723.942760572341, 5765.538756899354, 5792.0, 5841.007028805028, 5850.0932355484965, 9728.708138755848, 10113.69658910234, 10119.443430611387, 10120.493975301353, 10138.847917281098, 9822.165115964937, 10253.0, 10310.742231443974, 10318.48407579633, 10357.585696572052, 6480.416762491398, 6677.632730199885, 6773.559718618274, 6832.077669514552, 7089.680964356719, 8314.334853211607, 8319.750407487785, 8341.41610087288, 8402.32781377476, 8406.0, 7287.344139027513, 7385.704571817282, 7532.510386825058, 7612.1246056704185, 7711.498752581064, 7240.312170343809, 7315.926840731738, 7351.669174887036, 7438.92561074404, 7458.403327733877, 6987.545809522365, 7050.753223637148, 7101.680424381018, 7102.573845569283, 7103.396211321889, 4343.1747967886, 4844.539768721966, 4994.325766021686, 5051.520105589963, 5084.3898732152375, 4970.378702662168, 5063.645544811975, 5081.8729531762, 5100.362454693163, 5162.716050617252], "value": 4445.169872669266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2733385207797, 305.17145948749146, 307.4849626874984, 315.2827317851888, 319.16697419734476, 4627.889306566425, 4861.659683822134, 5305.840824775263, 5387.946120538793, 5410.648307859991, 4433.467983841935, 5327.668082979255, 5338.519533242007, 5340.866478338044, 5345.973270133644, 3497.0208341664375, 3808.8286027128847, 3881.5342158940966, 3967.801609919507, 3983.342748446503, 4000.1999600079953, 4000.6199411055904, 4037.546483266022, 4075.9592404076025, 4130.669546436293, 3583.5341405617232, 4031.6169963853386, 4065.715399922007, 4073.327900896363, 4080.6735461163034, 3415.121683074299, 3844.5394947233794, 3980.2835489611857, 3985.70107241958, 4031.3751368537924, 2946.0, 3170.429322721909, 3493.0917961329983, 3513.101691104823, 3523.982380088083, 4236.598337120196, 4465.575770301849, 4550.840720574764, 4602.976985115087, 5092.694438333675, 4096.508418989741, 4328.3250684627465, 4620.514845941195, 4627.676062675614, 4631.86519302773, 4546.0, 5268.710220937847, 5497.8075767348355, 5507.284053073115, 5547.976352887686, 3886.7667939923413, 3893.7274390792654, 3895.922081558353, 3906.374980003186, 3913.393424019253, 5023.32185155003, 5487.972560137174, 5829.804889997583, 5857.70711464425, 5909.3204281507315, 3109.3470371222297, 3225.145336485833, 3273.5908011498564, 3854.1520865409566, 3875.70932180082, 3926.8821935341984, 3935.4293627423863, 3936.940945885814, 3938.960610393917, 3945.408188771707, 4042.8679969608556, 4540.387047748578, 4568.97198130418, 4578.519255478127, 4606.539346065367, 4948.331975183376, 5324.5740340772645, 5374.381946076173, 5628.437156284339, 5671.773129074873, 1284.6467221514158, 1360.9520669084948, 1378.9655258618616, 1384.0, 1390.32569203936, 718.0, 731.9926800731924, 856.6530555125184, 859.9637436888535, 867.5792240763225, 4588.678792484494, 4903.234835459232, 5103.642745007888, 5111.961550375162, 5113.411957624847, 5080.59355251579, 5424.403315635277, 5679.744411501492, 5729.169270455761, 5735.913961290584, 4887.828925987574, 4899.657024008286, 5100.744962751847, 5144.61415393847, 5167.405748338989, 2563.76926076654, 2948.231061363208, 2991.6559595646345, 3049.9847500762353, 3058.4800583900346, 5523.337199536001, 5992.31088424828, 6030.668313242726, 6048.60684055535, 6073.848153796191, 4623.606993405531, 5621.5221706155435, 5639.379668236491, 5931.199288096138, 5956.5532585055425, 5273.78904843802, 5998.450658470133, 6042.486388656926, 6056.848578785565, 6064.848378790389, 5419.620626556103, 5785.27684039495, 5794.884102318014, 5795.971020144872, 5817.7963771267805, 4883.825513416308, 5700.543956483554, 5704.315482142004, 5732.8534293142375, 5735.684537350319, 4897.722559010077, 5711.200431939615, 5954.880902382015, 6040.486558642388, 6065.0288656187795, 3115.797473164237, 3242.4060751398315, 3310.817905015247, 3327.467605183159, 3380.4084285250474, 4135.359019351885, 4469.7594244172715, 4876.829310974099, 4891.6575839692305, 4923.679960802537, 4220.746755194698, 4318.719283246579, 4690.906181876411, 4759.8822771085, 4850.14985014985, 3947.9407808883466, 4236.76697781625, 4359.934600980924, 4406.7576283304725, 4715.585324402597, 3756.750410894611, 4184.623383895464, 4587.564181402761, 4658.790354434126, 4681.133990211822, 5283.656562323436, 5502.889942201214, 5506.284183056177, 5516.558675305886, 5565.88682263557, 4383.0, 4821.276808478756, 4875.488073752205, 5043.35224007399, 5337.03794394115], "value": 3941.9408626300738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.3976160621063, 766.8351304469538, 799.8120441696204, 827.702027270183, 875.1773333066915, 12277.693057673552, 15156.77264841027, 15221.467248646299, 15366.23168841559, 15511.689766204683, 14179.220142892136, 14209.147451152938, 14218.14691118531, 14244.28778561073, 14290.714185716279, 727.2073439950453, 817.8773184022415, 825.108882406999, 832.0971745655941, 833.912439193885, 737.8634952533798, 883.3507372081515, 913.853783394657, 915.8397280475923, 922.1055576091214, 961.038961038961, 966.6809952715587, 971.3637567393368, 976.3604838830578, 979.1530326267798, 761.8095476130967, 970.6263088710897, 973.4062222044547, 977.8386566216566, 978.1001478639633, 688.0711040095881, 713.6324792731747, 715.9284071592851, 716.2980279326238, 716.3839098375392, 14535.0, 14610.853891461056, 14916.925415372962, 14920.925395373062, 14928.701425971529, 13543.86456135436, 13839.446422143103, 13868.375923083486, 13889.79165312521, 13998.72002559943, 12287.447064882102, 12416.82040206188, 12531.06017048725, 12563.560275390317, 12952.740945181044, 4575.290829921368, 4639.095376401603, 4678.7660616969015, 4772.642051846091, 4815.9036819263765, 74827.5034499307, 75488.6225568874, 77089.614551928, 77473.61263193704, 78205.60897195477, 9414.905850941539, 11024.0, 11144.108471322275, 11274.267172633752, 11618.825717614243, 21449.57100857974, 21464.0, 21464.24875129363, 21473.14107435716, 21600.675989860163, 7909.0, 7943.64253608589, 7991.0810256821205, 8025.759227223192, 8057.073436554754, 3971.523417189898, 4465.553444655573, 4468.463784345834, 4527.728336299832, 4538.205813982539, 3388.9830550847087, 3486.8082255475683, 3490.9650903491147, 3499.562554680665, 3505.5618047744033, 677.6374639567807, 687.8280429892527, 688.8932215506604, 703.6200451756097, 705.4673721340355, 530.3927003580878, 567.8324894156234, 612.7732738886551, 661.6865521938947, 667.7362441835447, 7478.962605186939, 9024.458532488072, 9140.405873618327, 9143.177114059767, 9202.677906273248, 568.4656422962402, 597.6055803169887, 627.9748810047638, 638.5402510192654, 670.4435318685479, 4188.350805625072, 4266.466691663542, 4270.658347332206, 4352.151330490524, 4411.09572537629, 71641.0, 73735.26264737285, 73773.0, 79550.80673789898, 80031.59984200042, 70908.64545677342, 74940.62529687317, 75130.24869751342, 75598.0, 76638.85041724378, 67242.66378668173, 68892.655536722, 69496.62584353912, 69642.0, 69805.65097174482, 8434.95782521108, 8521.318294536546, 9443.0, 9544.10139487636, 9735.123838854537, 36887.44668829916, 43393.0, 43867.78066109649, 44209.115817682825, 44286.0, 47618.285725714835, 57282.42717572771, 58081.54796130131, 60550.69724651348, 61572.0, 11509.827352589886, 12631.368431578201, 12645.873541264838, 12702.682432939251, 13363.799543006668, 14361.784573231202, 14527.636809079857, 14576.125432474086, 14953.252337383305, 15023.924880375529, 13287.202767833574, 13552.93223533876, 13567.050306478846, 13627.591172264847, 13636.590902272948, 11385.886141138482, 13393.799093013418, 13474.52839150625, 13577.389017494039, 13579.45682172702, 12892.548760793326, 12945.029122816015, 13009.609711708665, 13391.933040334736, 13653.79519307231, 11065.557377705123, 11185.049270812073, 11409.486573104396, 11422.771544568895, 11450.885491145315, 9359.85960210611, 10873.130149587856, 10959.945200273947, 11177.608783692533, 11276.32342059479], "value": 7240.511034374845, "unit": "score"}], "name": "dromaeo_css", "value": 7273.228480755288, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 117.0, 166.0, 114.0, 116.0, 139.0, 117.0, 150.0, 116.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 186.0, 186.0, 181.0, 183.0, 182.0, 184.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 56.0, 120.0, 78.0, 80.0, 86.0, 64.0, 87.0, 73.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 91.0, 94.0, 98.0, 100.0, 98.0, 114.0, 70.0, 68.0, 104.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 84.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 97.0, 93.0, 92.0, 93.0, 92.0, 93.0, 92.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 100.0, 131.0, 131.0, 86.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 55.0, 54.0, 55.0, 54.0, 53.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 77.0, 78.0, 71.0, 72.0, 70.0, 72.0, 72.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 107.0, 73.0, 99.0, 106.0, 104.0, 106.0, 139.0, 87.0], "value": 99.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 153.0, 146.0, 136.0, 137.0, 135.0, 138.0, 137.0, 147.0, 122.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 222.0, 164.0, 165.0, 166.0, 162.0, 163.0, 168.0, 163.0, 162.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 67.0, 65.0, 67.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1476.6999999999998, "alertThreshold": 2.0}]} 05:51:46 INFO - Return code: 0 05:51:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:51:46 ERROR - # TBPL SUCCESS # 05:51:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:46 INFO - 2016-05-28 05:51:46.136 screenresolution[7137:126675] starting screenresolution argv=screenresolution get 05:51:46 INFO - 2016-05-28 05:51:46.138 screenresolution[7137:126675] Display 0: 1600x1200x32@60 05:51:46 INFO - 2016-05-28 05:51:46.144 screenresolution[7138:126678] starting screenresolution argv=screenresolution list 05:51:46 INFO - Available Modes on Display 0 05:51:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:46 INFO - Intel Iris: 05:51:46 INFO - Chipset Model: Intel Iris 05:51:46 INFO - Type: GPU 05:51:46 INFO - Bus: Built-In 05:51:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:51:46 INFO - Vendor: Intel (0x8086) 05:51:46 INFO - Device ID: 0x0a2e 05:51:46 INFO - Revision ID: 0x0009 05:51:46 INFO - Displays: 05:51:46 INFO - Display: 05:51:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:46 INFO - Display Serial Number: 1600x1200 60 05:51:46 INFO - Main Display: Yes 05:51:46 INFO - Mirror: Off 05:51:46 INFO - Online: Yes 05:51:46 INFO - Rotation: Supported 05:51:46 INFO - Return code: 0 05:51:46 INFO - Running post-action listener: _resource_record_post_action 05:51:46 INFO - ##### 05:51:46 INFO - ##### Finished run-tests step (success) 05:51:46 INFO - ##### 05:51:46 INFO - Running post-run listener: _resource_record_post_run 05:51:46 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32768; Write bytes: 694965248; Read time: 2; Write time: 1964 05:51:46 INFO - TinderboxPrint: CPU usage
53.9% 05:51:46 INFO - TinderboxPrint: I/O read bytes / time
32,768 / 2 05:51:46 INFO - TinderboxPrint: I/O write bytes / time
694,965,248 / 1,964 05:51:46 INFO - TinderboxPrint: CPU idle
2,233.9 (46.1%) 05:51:46 INFO - TinderboxPrint: CPU system
968.5 (20.0%) 05:51:46 INFO - TinderboxPrint: CPU user
1,639.2 (33.9%) 05:51:46 INFO - TinderboxPrint: Swap in / out
397,111,296 / 0 05:51:46 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397863424; Write bytes: 392009216; Read time: 29900; Write time: 846 05:51:46 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 32768; Write bytes: 290203136; Read time: 2; Write time: 1067 05:51:46 INFO - Running post-run listener: _upload_blobber_files 05:51:46 INFO - Blob upload gear active. 05:51:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:51:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:51:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:48 INFO - (blobuploader) - INFO - Done attempting. 05:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:49 INFO - (blobuploader) - INFO - Done attempting. 05:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:51 INFO - (blobuploader) - INFO - Done attempting. 05:51:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:51 INFO - Return code: 0 05:51:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d8af90d0b3e0960a564aab0c59b42669651ec1b6a2928611cc377b93016d8226ddce4c9888ccd47b780100bfd4f7479a17f880d0af745dfa349312c70a425a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fffb4ba45807c86950e6fc7c24c2baedb136394835a4a5ba73ead9b4c732ef6c1f2721dff3daf46124242d92aded730278ca1ae9d04d0c47ddbe7eca2f378f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e95686cbf7ae5b09060a6b5617c071d56c2cc96c631553f2f42770e53d682fa784947fb858c73ad1a50397085ac7573fe88792f1eab0543783f032abb4e1b5"} 05:51:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:51 INFO - Contents: 05:51:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d8af90d0b3e0960a564aab0c59b42669651ec1b6a2928611cc377b93016d8226ddce4c9888ccd47b780100bfd4f7479a17f880d0af745dfa349312c70a425a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fffb4ba45807c86950e6fc7c24c2baedb136394835a4a5ba73ead9b4c732ef6c1f2721dff3daf46124242d92aded730278ca1ae9d04d0c47ddbe7eca2f378f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e95686cbf7ae5b09060a6b5617c071d56c2cc96c631553f2f42770e53d682fa784947fb858c73ad1a50397085ac7573fe88792f1eab0543783f032abb4e1b5"} 05:51:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:51 INFO - Copying logs to upload dir... 05:51:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1356.098989 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 36 secs) (at 2016-05-28 05:51:51.887669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 05:51:51.891196) ========= 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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d8af90d0b3e0960a564aab0c59b42669651ec1b6a2928611cc377b93016d8226ddce4c9888ccd47b780100bfd4f7479a17f880d0af745dfa349312c70a425a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fffb4ba45807c86950e6fc7c24c2baedb136394835a4a5ba73ead9b4c732ef6c1f2721dff3daf46124242d92aded730278ca1ae9d04d0c47ddbe7eca2f378f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e95686cbf7ae5b09060a6b5617c071d56c2cc96c631553f2f42770e53d682fa784947fb858c73ad1a50397085ac7573fe88792f1eab0543783f032abb4e1b5"} build_url:https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010292 build_url: 'https://queue.taskcluster.net/v1/task/OugdlCz-T0aiPoqIs7oESw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d8af90d0b3e0960a564aab0c59b42669651ec1b6a2928611cc377b93016d8226ddce4c9888ccd47b780100bfd4f7479a17f880d0af745dfa349312c70a425a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fffb4ba45807c86950e6fc7c24c2baedb136394835a4a5ba73ead9b4c732ef6c1f2721dff3daf46124242d92aded730278ca1ae9d04d0c47ddbe7eca2f378f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e95686cbf7ae5b09060a6b5617c071d56c2cc96c631553f2f42770e53d682fa784947fb858c73ad1a50397085ac7573fe88792f1eab0543783f032abb4e1b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 05:51:51.919850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:51:51.920193) ========= 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.k5eLUcPlYo/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.kdnaJjT2Ff/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:51:51.970316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:51:51.970855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:51:51.971418) ========= ========= Total master_lag: 0.36 =========