builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0162 starttime: 1458066398.85 results: success (0) buildid: 20160315100924 builduid: eea22b055d93489f8daf7b779205b412 revision: 3cb1c3284e5fb5e737769a0d54c072709ffa822b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:38.854023) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:38.854467) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:38.854753) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005659 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:38.879242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:38.879547) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.000801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.001169) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005896 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.022082) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.022394) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.022740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.023026) ========= 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.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-03-15 11:26:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 141M=0s 2016-03-15 11:26:39 (141 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.191264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.191579) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.026070 ========= master_lag: 0.45 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:39.669272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-15 11:26:39.669629) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cb1c3284e5fb5e737769a0d54c072709ffa822b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3cb1c3284e5fb5e737769a0d54c072709ffa822b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-03-15 11:26:39,752 truncating revision to first 12 chars 2016-03-15 11:26:39,752 Setting DEBUG logging. 2016-03-15 11:26:39,752 attempt 1/10 2016-03-15 11:26:39,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cb1c3284e5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 11:26:41,062 unpacking tar archive at: fx-team-3cb1c3284e5f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.554926 ========= master_lag: 3.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-15 11:26:45.064693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:45.065044) ========= echo 3cb1c3284e5fb5e737769a0d54c072709ffa822b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3cb1c3284e5fb5e737769a0d54c072709ffa822b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 3cb1c3284e5fb5e737769a0d54c072709ffa822b program finished with exit code 0 elapsedTime=0.006116 script_repo_revision: '3cb1c3284e5fb5e737769a0d54c072709ffa822b' ========= master_lag: 0.35 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:45.420941) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:45.421255) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 11:26:45.443473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-15 11:26:45.443767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:26:45 INFO - MultiFileLogger online at 20160315 11:26:45 in /builds/slave/test 11:26:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:26:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:45 INFO - {'append_to_log': False, 11:26:45 INFO - 'base_work_dir': '/builds/slave/test', 11:26:45 INFO - 'blob_upload_branch': 'Fx-Team', 11:26:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:45 INFO - 'branch': 'Fx-Team', 11:26:45 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:45 INFO - 'config_files': ('talos/mac_config.py',), 11:26:45 INFO - 'default_actions': ('clobber', 11:26:45 INFO - 'read-buildbot-config', 11:26:45 INFO - 'download-and-extract', 11:26:45 INFO - 'populate-webroot', 11:26:45 INFO - 'create-virtualenv', 11:26:45 INFO - 'install', 11:26:45 INFO - 'run-tests'), 11:26:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:45 INFO - 'download_minidump_stackwalk': True, 11:26:45 INFO - 'download_symbols': 'ondemand', 11:26:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:45 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:45 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:45 INFO - 'installer_path': 'installer.exe', 11:26:45 INFO - 'log_level': 'info', 11:26:45 INFO - 'log_name': 'talos', 11:26:45 INFO - 'log_to_console': True, 11:26:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:26:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:26:45 INFO - 'opt_config_files': (), 11:26:45 INFO - 'pip_index': False, 11:26:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:45 INFO - 'cmd': ('bash', 11:26:45 INFO - '-c', 11:26:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:45 INFO - 'enabled': True, 11:26:45 INFO - 'halt_on_failure': False, 11:26:45 INFO - 'name': 'check_screen_resolution'},), 11:26:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:45 INFO - 'cmd': ('bash', 11:26:45 INFO - '-c', 11:26:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:45 INFO - 'enabled': True, 11:26:45 INFO - 'halt_on_failure': False, 11:26:45 INFO - 'name': 'check_screen_resolution'},), 11:26:45 INFO - 'run_cmd_checks_enabled': True, 11:26:45 INFO - 'sps_profile': False, 11:26:45 INFO - 'sps_profile_interval': 0, 11:26:45 INFO - 'suite': 'dromaeojs', 11:26:45 INFO - 'system_bits': '32', 11:26:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:45 INFO - 'title': 't-yosemite-r7-0162', 11:26:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:45 INFO - 'use_talos_json': True, 11:26:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:45 INFO - 'work_dir': 'build'} 11:26:45 INFO - ##### 11:26:45 INFO - ##### Running clobber step. 11:26:45 INFO - ##### 11:26:45 INFO - Running pre-action listener: _resource_record_pre_action 11:26:45 INFO - Running main action method: clobber 11:26:45 INFO - rmtree: /builds/slave/test/build 11:26:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:47 INFO - Running post-action listener: _resource_record_post_action 11:26:47 INFO - ##### 11:26:47 INFO - ##### Running read-buildbot-config step. 11:26:47 INFO - ##### 11:26:47 INFO - Running pre-action listener: _resource_record_pre_action 11:26:47 INFO - Running main action method: read_buildbot_config 11:26:47 INFO - Using buildbot properties: 11:26:47 INFO - { 11:26:47 INFO - "project": "", 11:26:47 INFO - "product": "firefox", 11:26:47 INFO - "script_repo_revision": "production", 11:26:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:26:47 INFO - "repository": "", 11:26:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:26:47 INFO - "buildid": "20160315100924", 11:26:47 INFO - "pgo_build": "False", 11:26:47 INFO - "basedir": "/builds/slave/test", 11:26:47 INFO - "buildnumber": 501, 11:26:47 INFO - "slavename": "t-yosemite-r7-0162", 11:26:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:26:47 INFO - "platform": "yosemite_r7", 11:26:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:26:47 INFO - "branch": "fx-team", 11:26:47 INFO - "repo_path": "integration/fx-team", 11:26:47 INFO - "revision": "3cb1c3284e5fb5e737769a0d54c072709ffa822b", 11:26:47 INFO - "stage_platform": "macosx64", 11:26:47 INFO - "builduid": "eea22b055d93489f8daf7b779205b412", 11:26:47 INFO - "slavebuilddir": "test" 11:26:47 INFO - } 11:26:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:26:47 INFO - Running post-action listener: _resource_record_post_action 11:26:47 INFO - ##### 11:26:47 INFO - ##### Running download-and-extract step. 11:26:47 INFO - ##### 11:26:47 INFO - Running pre-action listener: _resource_record_pre_action 11:26:47 INFO - Running main action method: download_and_extract 11:26:47 INFO - mkdir: /builds/slave/test/build/tests 11:26:47 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')]} 11:26:47 INFO - https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 11:26:48 INFO - Downloaded 1199 bytes. 11:26:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:26:48 INFO - Using the following test package requirements: 11:26:48 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:26:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:26:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:26:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'jsshell-mac.zip'], 11:26:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:26:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:26:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:26:48 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:26:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:26:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:26:48 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:26:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:26:48 INFO - https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:26:49 INFO - Downloaded 17853727 bytes. 11:26:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:26:52 INFO - Return code: 0 11:26:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:26: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')]} 11:26:52 INFO - https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:26:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:26:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:26:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:26:53 INFO - Downloaded 17853727 bytes. 11:26:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:26:56 INFO - Return code: 0 11:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:56 INFO - https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:26:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:26:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:26:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:26:57 INFO - Downloaded 10845263 bytes. 11:26:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:26:58 INFO - Return code: 0 11:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:58 INFO - https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:26:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:26:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:26:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:26:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 11:27:00 INFO - Downloaded 111186063 bytes. 11:27:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:27:00 INFO - mkdir: /builds/slave/test/properties 11:27:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:27:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:27:00 INFO - Contents: 11:27:00 INFO - build_url:https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:27:02 INFO - Running post-action listener: _resource_record_post_action 11:27:02 INFO - Running post-action listener: set_extra_try_arguments 11:27:02 INFO - ##### 11:27:02 INFO - ##### Running populate-webroot step. 11:27:02 INFO - ##### 11:27:02 INFO - Running pre-action listener: _resource_record_pre_action 11:27:02 INFO - Running main action method: populate_webroot 11:27:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:27:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:27:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:27:02 INFO - '--tppagecycles', 11:27:02 INFO - '7'], 11:27:02 INFO - 'tests': ['tsvgm']}}, 11:27:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:27:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:27:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:27:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:27:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'tests': ['damp', 'tps']}, 11:27:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['damp', 'tps']}, 11:27:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:27:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:27:02 INFO - 'other': {'tests': ['a11yr', 11:27:02 INFO - 'ts_paint', 11:27:02 INFO - 'tpaint', 11:27:02 INFO - 'sessionrestore', 11:27:02 INFO - 'sessionrestore_no_auto_restore', 11:27:02 INFO - 'tabpaint']}, 11:27:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['a11yr', 11:27:02 INFO - 'ts_paint', 11:27:02 INFO - 'tpaint', 11:27:02 INFO - 'sessionrestore', 11:27:02 INFO - 'sessionrestore_no_auto_restore', 11:27:02 INFO - 'tabpaint']}, 11:27:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['a11yr', 11:27:02 INFO - 'ts_paint', 11:27:02 INFO - 'tpaint', 11:27:02 INFO - 'sessionrestore', 11:27:02 INFO - 'sessionrestore_no_auto_restore', 11:27:02 INFO - 'tabpaint']}, 11:27:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['a11yr', 11:27:02 INFO - 'ts_paint', 11:27:02 INFO - 'tpaint', 11:27:02 INFO - 'sessionrestore', 11:27:02 INFO - 'sessionrestore_no_auto_restore', 11:27:02 INFO - 'tabpaint']}, 11:27:02 INFO - 'other_l64': {'tests': ['a11yr', 11:27:02 INFO - 'ts_paint', 11:27:02 INFO - 'tpaint', 11:27:02 INFO - 'sessionrestore', 11:27:02 INFO - 'sessionrestore_no_auto_restore', 11:27:02 INFO - 'tabpaint']}, 11:27:02 INFO - 'other_nol64': {'tests': ['a11yr', 11:27:02 INFO - 'ts_paint', 11:27:02 INFO - 'tpaint', 11:27:02 INFO - 'sessionrestore', 11:27:02 INFO - 'sessionrestore_no_auto_restore', 11:27:02 INFO - 'tabpaint']}, 11:27:02 INFO - 'svgr': {'tests': ['tsvgx', 11:27:02 INFO - 'tsvgr_opacity', 11:27:02 INFO - 'tart', 11:27:02 INFO - 'tscrollx', 11:27:02 INFO - 'cart']}, 11:27:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['tsvgx', 11:27:02 INFO - 'tsvgr_opacity', 11:27:02 INFO - 'tart', 11:27:02 INFO - 'tscrollx', 11:27:02 INFO - 'cart']}, 11:27:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'tests': ['tp5o']}, 11:27:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'talos_options': ['--e10s'], 11:27:02 INFO - 'tests': ['tp5o']}, 11:27:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'talos_options': ['--xperf_path', 11:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:02 INFO - 'tests': ['tp5n']}, 11:27:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:02 INFO - 'talos_options': ['--e10s', 11:27:02 INFO - '--xperf_path', 11:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:02 INFO - 'tests': ['tp5n']}}, 11:27:02 INFO - 'talos.zip': {'path': '', 11:27:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:27:02 INFO - Running post-action listener: _resource_record_post_action 11:27:02 INFO - ##### 11:27:02 INFO - ##### Running create-virtualenv step. 11:27:02 INFO - ##### 11:27:02 INFO - Running pre-action listener: _resource_record_pre_action 11:27:02 INFO - Running main action method: create_virtualenv 11:27:02 INFO - Creating virtualenv /builds/slave/test/build/venv 11:27:02 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 11:27:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:27:02 INFO - Using real prefix '/tools/python27' 11:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:27:02 INFO - Installing distribute.............................................................................................................................................................................................done. 11:27:05 INFO - Installing pip.................done. 11:27:05 INFO - Return code: 0 11:27:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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')]} 11:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27: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 11:27: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 11:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:05 INFO - 'HOME': '/Users/cltbld', 11:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:05 INFO - 'LOGNAME': 'cltbld', 11:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:05 INFO - 'MOZ_NO_REMOTE': '1', 11:27:05 INFO - 'NO_EM_RESTART': '1', 11:27:05 INFO - 'PAGER': '/bin/cat', 11:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:05 INFO - 'PWD': '/builds/slave/test', 11:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:05 INFO - 'SHELL': '/bin/bash', 11:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:05 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:05 INFO - 'USER': 'cltbld', 11:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:05 INFO - 'XPC_FLAGS': '0x0', 11:27:05 INFO - 'XPC_SERVICE_NAME': '0', 11:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:06 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 11:27:06 INFO - Cleaning up... 11:27:06 INFO - Return code: 0 11:27:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:27:06 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')]} 11:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:06 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')]} 11:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:06 INFO - 'HOME': '/Users/cltbld', 11:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:06 INFO - 'LOGNAME': 'cltbld', 11:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:06 INFO - 'MOZ_NO_REMOTE': '1', 11:27:06 INFO - 'NO_EM_RESTART': '1', 11:27:06 INFO - 'PAGER': '/bin/cat', 11:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:06 INFO - 'PWD': '/builds/slave/test', 11:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:06 INFO - 'SHELL': '/bin/bash', 11:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:06 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:06 INFO - 'USER': 'cltbld', 11:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:06 INFO - 'XPC_FLAGS': '0x0', 11:27:06 INFO - 'XPC_SERVICE_NAME': '0', 11:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:06 INFO - Downloading/unpacking psutil>=0.7.1 11:27:06 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 11:27:06 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 11:27:06 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 11:27:06 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 11:27:06 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 11:27:06 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 11:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:09 INFO - Installing collected packages: psutil 11:27:09 INFO - Running setup.py install for psutil 11:27:09 INFO - building 'psutil._psutil_osx' extension 11:27:09 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 11:27:09 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 11:27:09 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 11:27:10 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 11:27:10 INFO - building 'psutil._psutil_posix' extension 11:27:10 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 11:27:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:27:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:27:10 INFO - ^ 11:27:10 INFO - 1 warning generated. 11:27:10 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 11:27:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:10 INFO - Successfully installed psutil 11:27:10 INFO - Cleaning up... 11:27:10 INFO - Return code: 0 11:27:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:27:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:10 INFO - 'HOME': '/Users/cltbld', 11:27:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:10 INFO - 'LOGNAME': 'cltbld', 11:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:10 INFO - 'MOZ_NO_REMOTE': '1', 11:27:10 INFO - 'NO_EM_RESTART': '1', 11:27:10 INFO - 'PAGER': '/bin/cat', 11:27:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:10 INFO - 'PWD': '/builds/slave/test', 11:27:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:10 INFO - 'SHELL': '/bin/bash', 11:27:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:10 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:10 INFO - 'USER': 'cltbld', 11:27:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:10 INFO - 'XPC_FLAGS': '0x0', 11:27:10 INFO - 'XPC_SERVICE_NAME': '0', 11:27:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:27:10 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 11:27:10 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 11:27:10 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 11:27:10 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 11:27:10 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 11:27:10 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 11:27:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:27:13 INFO - Installing collected packages: mozsystemmonitor 11:27:13 INFO - Running setup.py install for mozsystemmonitor 11:27:13 INFO - Successfully installed mozsystemmonitor 11:27:13 INFO - Cleaning up... 11:27:13 INFO - Return code: 0 11:27:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:13 INFO - 'HOME': '/Users/cltbld', 11:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:13 INFO - 'LOGNAME': 'cltbld', 11:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:13 INFO - 'MOZ_NO_REMOTE': '1', 11:27:13 INFO - 'NO_EM_RESTART': '1', 11:27:13 INFO - 'PAGER': '/bin/cat', 11:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:13 INFO - 'PWD': '/builds/slave/test', 11:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:13 INFO - 'SHELL': '/bin/bash', 11:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:13 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:13 INFO - 'USER': 'cltbld', 11:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:13 INFO - 'XPC_FLAGS': '0x0', 11:27:13 INFO - 'XPC_SERVICE_NAME': '0', 11:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:13 INFO - Downloading/unpacking blobuploader==1.2.4 11:27:13 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 11:27:13 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 11:27:13 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 11:27:13 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 11:27:13 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 11:27:13 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 11:27:16 INFO - Downloading blobuploader-1.2.4.tar.gz 11:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:27:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:27:16 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 11:27:16 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 11:27:16 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 11:27:16 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 11:27:16 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 11:27:16 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 11:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:27:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:27:16 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 11:27:16 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 11:27:16 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 11:27:16 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 11:27:16 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 11:27:16 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 11:27:17 INFO - Downloading docopt-0.6.1.tar.gz 11:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:27:17 INFO - Installing collected packages: blobuploader, requests, docopt 11:27:17 INFO - Running setup.py install for blobuploader 11:27:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:27:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:27:17 INFO - Running setup.py install for requests 11:27:17 INFO - Running setup.py install for docopt 11:27:18 INFO - Successfully installed blobuploader requests docopt 11:27:18 INFO - Cleaning up... 11:27:18 INFO - Return code: 0 11:27:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:18 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 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27:18 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 11:27:18 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 11:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:18 INFO - 'HOME': '/Users/cltbld', 11:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:18 INFO - 'LOGNAME': 'cltbld', 11:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:18 INFO - 'MOZ_NO_REMOTE': '1', 11:27:18 INFO - 'NO_EM_RESTART': '1', 11:27:18 INFO - 'PAGER': '/bin/cat', 11:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:18 INFO - 'PWD': '/builds/slave/test', 11:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:18 INFO - 'SHELL': '/bin/bash', 11:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:18 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:18 INFO - 'USER': 'cltbld', 11:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:18 INFO - 'XPC_FLAGS': '0x0', 11:27:18 INFO - 'XPC_SERVICE_NAME': '0', 11:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-iCGb9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-eqOEMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-4wrVqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-g5FetW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-aTqMS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-mbMFDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-1JC_2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Wgn8Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-f0pyuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-1rCGvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xMjrfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-JTNicg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-nad7Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Xr_HZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-qQZDxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:20 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-B785m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:20 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-rWEU7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:27:20 INFO - Running setup.py install for manifestparser 11:27:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Running setup.py install for mozcrash 11:27:20 INFO - Running setup.py install for mozdebug 11:27:20 INFO - Running setup.py install for mozdevice 11:27:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:27:20 INFO - Running setup.py install for mozfile 11:27:20 INFO - Running setup.py install for mozhttpd 11:27:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for mozinfo 11:27:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for mozInstall 11:27:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for mozleak 11:27:21 INFO - Running setup.py install for mozlog 11:27:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for moznetwork 11:27:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:27:21 INFO - Running setup.py install for mozprocess 11:27:22 INFO - Running setup.py install for mozprofile 11:27:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:27:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:27:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:27:22 INFO - Running setup.py install for mozrunner 11:27:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:27:22 INFO - Running setup.py install for mozscreenshot 11:27:22 INFO - Running setup.py install for moztest 11:27:22 INFO - Running setup.py install for mozversion 11:27:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:27:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:22 INFO - Cleaning up... 11:27:22 INFO - Return code: 0 11:27:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:22 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')]} 11:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:22 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')]} 11:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:22 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 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27:22 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 11:27:22 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 11:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:22 INFO - 'HOME': '/Users/cltbld', 11:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:22 INFO - 'LOGNAME': 'cltbld', 11:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:22 INFO - 'MOZ_NO_REMOTE': '1', 11:27:22 INFO - 'NO_EM_RESTART': '1', 11:27:22 INFO - 'PAGER': '/bin/cat', 11:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:22 INFO - 'PWD': '/builds/slave/test', 11:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:22 INFO - 'SHELL': '/bin/bash', 11:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:22 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:22 INFO - 'USER': 'cltbld', 11:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:22 INFO - 'XPC_FLAGS': '0x0', 11:27:22 INFO - 'XPC_SERVICE_NAME': '0', 11:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-z7O6D9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ZCcMbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-uSJ6ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-XQ4YN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-413SzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-SkHdRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-EveoNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-oTvjGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:23 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-OqVjTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:23 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)) 11:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9Sxyjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ByQfVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-iFELse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-2EgZot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-QnOnc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-a_zdUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-lkviB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:24 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)) 11:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:24 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YlcKZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:24 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)) 11:27:24 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)) 11:27:24 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)) 11:27:24 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)) 11:27:24 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)) 11:27:24 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)) 11:27:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:27 INFO - Downloading blessings-1.6.tar.gz 11:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:27 INFO - Installing collected packages: blessings 11:27:27 INFO - Running setup.py install for blessings 11:27:27 INFO - Successfully installed blessings 11:27:27 INFO - Cleaning up... 11:27:27 INFO - Return code: 0 11:27:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:27 INFO - Reading from file tmpfile_stdout 11:27:27 INFO - Current package versions: 11:27:27 INFO - blessings == 1.6 11:27:27 INFO - blobuploader == 1.2.4 11:27:27 INFO - docopt == 0.6.1 11:27:27 INFO - manifestparser == 1.1 11:27:27 INFO - mozInstall == 1.12 11:27:27 INFO - mozcrash == 0.17 11:27:27 INFO - mozdebug == 0.1 11:27:27 INFO - mozdevice == 0.48 11:27:27 INFO - mozfile == 1.2 11:27:27 INFO - mozhttpd == 0.7 11:27:27 INFO - mozinfo == 0.9 11:27:27 INFO - mozleak == 0.1 11:27:27 INFO - mozlog == 3.1 11:27:27 INFO - moznetwork == 0.27 11:27:27 INFO - mozprocess == 0.22 11:27:27 INFO - mozprofile == 0.28 11:27:27 INFO - mozrunner == 6.11 11:27:27 INFO - mozscreenshot == 0.1 11:27:27 INFO - mozsystemmonitor == 0.0 11:27:27 INFO - moztest == 0.7 11:27:27 INFO - mozversion == 1.4 11:27:27 INFO - psutil == 3.1.1 11:27:27 INFO - requests == 1.2.3 11:27:27 INFO - wsgiref == 0.1.2 11:27:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27: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')]} 11:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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')]} 11:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27: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 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27: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 11:27: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 11:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:27 INFO - 'HOME': '/Users/cltbld', 11:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:27 INFO - 'LOGNAME': 'cltbld', 11:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:27 INFO - 'MOZ_NO_REMOTE': '1', 11:27:27 INFO - 'NO_EM_RESTART': '1', 11:27:27 INFO - 'PAGER': '/bin/cat', 11:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:27 INFO - 'PWD': '/builds/slave/test', 11:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:27 INFO - 'SHELL': '/bin/bash', 11:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:27 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:27 INFO - 'USER': 'cltbld', 11:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:27 INFO - 'XPC_FLAGS': '0x0', 11:27:27 INFO - 'XPC_SERVICE_NAME': '0', 11:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 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)) 11:27:28 INFO - Cleaning up... 11:27:28 INFO - Return code: 0 11:27:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:27:28 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')]} 11:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:28 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')]} 11:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:28 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 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27:28 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 11:27:28 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 11:27:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:28 INFO - 'HOME': '/Users/cltbld', 11:27:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:28 INFO - 'LOGNAME': 'cltbld', 11:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:28 INFO - 'MOZ_NO_REMOTE': '1', 11:27:28 INFO - 'NO_EM_RESTART': '1', 11:27:28 INFO - 'PAGER': '/bin/cat', 11:27:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:28 INFO - 'PWD': '/builds/slave/test', 11:27:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:28 INFO - 'SHELL': '/bin/bash', 11:27:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:28 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:28 INFO - 'USER': 'cltbld', 11:27:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:28 INFO - 'XPC_FLAGS': '0x0', 11:27:28 INFO - 'XPC_SERVICE_NAME': '0', 11:27:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:28 INFO - Downloading/unpacking jsonschema 11:27:28 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 11:27:28 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 11:27:28 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 11:27:28 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 11:27:28 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 11:27:28 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 11:27:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:27:30 INFO - Downloading/unpacking functools32 (from jsonschema) 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27:31 INFO - Downloading functools32-3.2.3-2.tar.gz 11:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:27:31 INFO - warning: no files found matching '*.txt' 11:27:31 INFO - no previously-included directories found matching 'build' 11:27:31 INFO - no previously-included directories found matching 'dist' 11:27:31 INFO - no previously-included directories found matching '.git*' 11:27:31 INFO - Installing collected packages: jsonschema, functools32 11:27:31 INFO - Running setup.py install for functools32 11:27:31 INFO - warning: no files found matching '*.txt' 11:27:31 INFO - no previously-included directories found matching 'build' 11:27:31 INFO - no previously-included directories found matching 'dist' 11:27:31 INFO - no previously-included directories found matching '.git*' 11:27:31 INFO - Successfully installed jsonschema functools32 11:27:31 INFO - Cleaning up... 11:27:31 INFO - Return code: 0 11:27:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10656ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1065734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc53ad56400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, '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.L78wPTJWfk/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.lF3hgMysMU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:31 INFO - 'HOME': '/Users/cltbld', 11:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:31 INFO - 'LOGNAME': 'cltbld', 11:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:31 INFO - 'MOZ_NO_REMOTE': '1', 11:27:31 INFO - 'NO_EM_RESTART': '1', 11:27:31 INFO - 'PAGER': '/bin/cat', 11:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:31 INFO - 'PWD': '/builds/slave/test', 11:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:31 INFO - 'SHELL': '/bin/bash', 11:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:27:31 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:31 INFO - 'USER': 'cltbld', 11:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:31 INFO - 'XPC_FLAGS': '0x0', 11:27:31 INFO - 'XPC_SERVICE_NAME': '0', 11:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:31 INFO - Downloading/unpacking flake8 11:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:27:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:27:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27: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 11:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:35 INFO - no previously-included directories found matching 'docs/_build' 11:27:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:27:35 INFO - Running setup.py install for pep8 11:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:35 INFO - no previously-included directories found matching 'docs/_build' 11:27:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:27:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:27:35 INFO - Cleaning up... 11:27:35 INFO - Return code: 0 11:27:35 INFO - Running post-action listener: _resource_record_post_action 11:27:35 INFO - Running post-action listener: _start_resource_monitoring 11:27:35 INFO - Starting resource monitoring. 11:27:35 INFO - ##### 11:27:35 INFO - ##### Running install step. 11:27:35 INFO - ##### 11:27:35 INFO - Running pre-action listener: _resource_record_pre_action 11:27:35 INFO - Running main action method: install 11:27:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:35 INFO - Reading from file tmpfile_stdout 11:27:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:36 INFO - Reading from file tmpfile_stdout 11:27:36 INFO - Output received: 11:27:36 INFO - Usage: mozinstall [options] installer 11:27:36 INFO - Options: 11:27:36 INFO - -h, --help show this help message and exit 11:27:36 INFO - -d DEST, --destination=DEST 11:27:36 INFO - Directory to install application into. [default: 11:27:36 INFO - "/builds/slave/test"] 11:27:36 INFO - --app=APP Application being installed. [default: firefox] 11:27:36 INFO - mkdir: /builds/slave/test/build/application 11:27:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:28:10 INFO - Reading from file tmpfile_stdout 11:28:10 INFO - Output received: 11:28:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:28:10 INFO - Running post-action listener: _resource_record_post_action 11:28:10 INFO - ##### 11:28:10 INFO - ##### Running run-tests step. 11:28:10 INFO - ##### 11:28:10 INFO - Running pre-action listener: _resource_record_pre_action 11:28:10 INFO - Running main action method: run_tests 11:28:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:28:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:28:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:28:10 INFO - 2016-03-15 11:28:10.209 screenresolution[1646:7412] starting screenresolution argv=screenresolution get 11:28:10 INFO - 2016-03-15 11:28:10.211 screenresolution[1646:7412] Display 0: 1600x1200x32@60 11:28:10 INFO - 2016-03-15 11:28:10.217 screenresolution[1647:7414] starting screenresolution argv=screenresolution list 11:28:10 INFO - Available Modes on Display 0 11:28:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:28:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:28:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:28:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:28:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:28:10 INFO - Intel Iris: 11:28:10 INFO - Chipset Model: Intel Iris 11:28:10 INFO - Type: GPU 11:28:10 INFO - Bus: Built-In 11:28:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:28:10 INFO - Vendor: Intel (0x8086) 11:28:10 INFO - Device ID: 0x0a2e 11:28:10 INFO - Revision ID: 0x0009 11:28:10 INFO - Displays: 11:28:10 INFO - Display: 11:28:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:28:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:28:10 INFO - Display Serial Number: 1600x1200 60 11:28:10 INFO - Main Display: Yes 11:28:10 INFO - Mirror: Off 11:28:10 INFO - Online: Yes 11:28:10 INFO - Rotation: Supported 11:28:10 INFO - Return code: 0 11:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:28:10 INFO - Python 2.7.3 11:28:10 INFO - Return code: 0 11:28:10 INFO - grabbing minidump binary from tooltool 11:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10640fd30>, '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 0x106233db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106406b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:28:10 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 11:28:10 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 11:28:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:28:10 INFO - Return code: 0 11:28:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:28:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:28:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:28:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:28:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:28:11 INFO - Return code: 0 11:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 11:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --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 11:28:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L78wPTJWfk/Render', 11:28:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:28:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:28:11 INFO - 'HOME': '/Users/cltbld', 11:28:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:28:11 INFO - 'LOGNAME': 'cltbld', 11:28:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:11 INFO - 'MOZ_NO_REMOTE': '1', 11:28:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:11 INFO - 'NO_EM_RESTART': '1', 11:28:11 INFO - 'PAGER': '/bin/cat', 11:28:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:11 INFO - 'PWD': '/builds/slave/test', 11:28:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:28:11 INFO - 'SHELL': '/bin/bash', 11:28:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lF3hgMysMU/Listeners', 11:28:11 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:28:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:28:11 INFO - 'USER': 'cltbld', 11:28:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:28:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:11 INFO - 'XPC_FLAGS': '0x0', 11:28:11 INFO - 'XPC_SERVICE_NAME': '0', 11:28:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:28:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 11:28:11 INFO - mozversion application_buildid: 20160315100924 11:28:11 INFO - mozversion application_changeset: 3cb1c3284e5fb5e737769a0d54c072709ffa822b 11:28:11 INFO - mozversion application_display_name: Nightly 11:28:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:28:11 INFO - mozversion application_name: Firefox 11:28:11 INFO - mozversion application_remotingname: firefox 11:28:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:28:11 INFO - mozversion application_vendor: Mozilla 11:28:11 INFO - mozversion application_version: 48.0a1 11:28:11 INFO - mozversion platform_buildid: 20160315100924 11:28:11 INFO - mozversion platform_changeset: 3cb1c3284e5fb5e737769a0d54c072709ffa822b 11:28:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:28:11 INFO - mozversion platform_version: 48.0a1 11:28:11 INFO - using testdate: 1458066491 11:28:11 INFO - actual date: 1458066491 11:28:11 INFO - starting webserver on 'localhost:49272' 11:28:11 INFO - SUITE-START | Running 2 tests 11:28:11 INFO - TEST-START | dromaeo_css 11:28:11 INFO - operating with platform_type : mac_ 11:28:11 INFO - Initialising browser for dromaeo_css test... 11:28:11 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpPLjrpc/profile http://localhost:49272/getInfo.html) 11:28:14 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 11:28:14 INFO - PROCESS | 1665 | colorDepth:24 11:28:14 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 11:28:14 INFO - PROCESS | 1665 | __metrics 11:28:14 INFO - PROCESS | 1665 | 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" 11:28:14 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:28:15 INFO - TEST-INFO | 1665: exit 0 11:28:15 INFO - Browser initialized. 11:28:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:28:15 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpPLjrpc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:26 INFO - PROCESS | 1668 | RSS: Main: 243269632 11:28:26 INFO - PROCESS | 1668 | 11:29:17 INFO - PROCESS | 1668 | 1458066557768 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] 11:31:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 11:31:30 INFO - PROCESS | 1668 | RSS: Main: 363171840 11:31:30 INFO - PROCESS | 1668 | 11:34:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 11:34:33 INFO - PROCESS | 1668 | RSS: Main: 377208832 11:34:33 INFO - PROCESS | 1668 | 11:37:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 11:37:36 INFO - PROCESS | 1668 | RSS: Main: 376406016 11:37:36 INFO - PROCESS | 1668 | 11:40:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 11:40:38 INFO - PROCESS | 1668 | RSS: Main: 338284544 11:40:38 INFO - PROCESS | 1668 | 11:43:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 11:43:42 INFO - PROCESS | 1668 | RSS: Main: 337264640 11:43:42 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 11:46:45 INFO - PROCESS | 1668 | RSS: Main: 391163904 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | __start_tp_report 11:46:45 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 11:46:45 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 11:46:45 INFO - PROCESS | 1668 | |i|pagename|runs| 11:46:45 INFO - PROCESS | 1668 | |0;dojo.html;2814.7185281471857;3458.861645534179;3516.9296614067703;3520.9119772005697;3567.1260541167417;5582.888342233163;5618.719064046797;5625.296837895263;5631.77472901084;5632.098864181732;5612.859678508039;5711.914321285184;5729.28383952006;5764.625299355539;5778.162166485857;4663.300504924255;5105.259737338084;5117.181250999841;5157.922631160535;5163.974180129113;5084.542391184793;5258;5280.656757310781;5287.788488460476;5306.071437498442;5062.696238225718;5145.794168233304;5189.922151167735;5203.1414816555225;5250.606204534656;5130.794768209267;5149.84550463483;5163.819266325698;5166.870828229286;5174.689518628857;5091.79632814687;5135.820246291362;5151.175811870083;5154.4072431670465;5157.58739300855;5500.477454641803;5507.5593952484105;5516.9448305516835;5528.778848846041;5533.363663178746;6104.359042300539;6107.249501910372;6118;6123.724432400508;6126.295476020226;6223.222097237845;6241.3446588108045;6281.152044473984;6281.371862813728;6293.779717709858;5004.624653151028;5458.4541545845495;5711.428857114297;5738.684372359477;5752.022156233408;6210.068489726577;6224.564280500412;6299.590526615755;6310.905336419957;6337.65142917144;6092.799872193021;6125.449118208436;6129.172561704202;6135.5398345124295;6140.3552626974415;6228.252609686867;6254.562180647402;6273.8745225095245;6277.089821975879;6281.654509001957;6039.7282122304605;6094.177286066413;6120.143179954721;6124.846878827976;6159.4456498915315;6105.490073363267;6107.46191531438;6141.486007784275;6141.877162456815;6195.256569211723;4795.640326975491;4814.807407703653;4823.445303790038;4835.008823191238;4858.6356023297685;4271.722338048017;4277.871663850089;4292.163028209532;4299.742015479082;4343.19650864591;5531.1426728857095;5659.122835960433;5675.517581005661;5678.063119585222;5798.507126894261;6225.937740622627;6243.8126856194385;6247;6259.280182778948;6271.749130034747;5699.715014249271;5706.914396284059;5711.029125048752;5719.48524632785;5751.1085781703905;5196.246544251062;5257.842264732064;5267.9736601316745;5305.336832895888;5319.547838433777;6236.563440559117;6282.183316168869;6292.590981586182;6302.212223472066;6305.936940630535;6180.598261113013;6264.404881536247;6280.152179455715;6304.117423560797;6311.431971122437;6227.314995350598;6227.595206311576;6247.6563788990225;6258.874822503615;6265.624062556261;4457.754823484739;6105.9694701526205;6115.449609535163;6122.877542449215;6141.815745527641;4846.927296090632;5726.627769194989;6107.0228763397645;6180.165677633462;6180.81457556274;5998.760049597967;6014.759409623566;6051.606645568024;6062.42406971337;6063.727132279147;5900.409959004065;6036.426539478743;6063.757449701962;6065.848353791191;6069.393060693896;5815.563832712479;5872.060470324727;5926.733297001559;5984;5993.550483713826;6071.817845464643;6080.361562035922;6082.391760823883;6092.45167934888;6105.755769769159;5751.539876809761;5880.117982302518;5909.2908850938165;5911.201987731602;5946.226990491208 11:46:45 INFO - PROCESS | 1668 | |1;ext.html;483.71460838105554;577.024828040611;583.4544700704841;633.2148136310974;635.3106879036244;27536.173914782565;38779.61220387795;39007.41488877662;39028;39128.41307380392;41499;42207.57792422075;42253.7887310563;42304.57695423045;42314.78842605783;8719.912800872005;9440.858387124199;9515.619375224982;9730.464824434654;9751.463669498175;9537.761555961088;9673.564689588986;9693.176080033205;9694.418334899894;9711.805763884719;9662.468564229;9717.368371055894;9867.40795552269;9874.259430542737;9875.703728888146;9780.853287200698;9854.704358869245;9855.605775768961;9866.210703143803;9873.506324683736;9588.041195880425;9713.708588742278;9740.366876153028;9740.512974351253;9742.318037737361;40618.390724139164;40834;40901.59098409008;40949.77150685484;41017.97455063617;3222.5005124205786;3287.474004159323;3360.327934413127;3744.4196149596855;3881.1655494068627;28469.029144069882;29157.271068223254;29680.109596712133;29973.70026299731;30223;2702.5675891857404;2730.194592595189;2782.6104345391664;2810.3676672748675;2857.2428306498796;488973;492646;493183;493380.9999999964;493851;63478.68260658667;64635.67682161559;64726.705465890416;64727.67636161789;64749.676251619385;67545;67642.66178669075;67768.66115669488;67845.98231026539;67947;17252.827471725373;17506.737398939025;17529.29882804699;17536.21087051086;17549.912250438665;13146.671333216746;13332.866671333357;13357;13358.933205333911;13410.195388276734;18367.238386290344;19881;20103.49741256451;20158;20181.798182017992;7460.664270107858;8793.296536277083;9077.364584479023;9092.318076144316;9108.67728729183;863.96976105836;975.9219262459128;999.6900960702205;1001.0290018681867;1079.6976846482996;28915;28956.710432895823;28978.565321520193;29716.55425168624;29743.25641858971;990.1633120013577;1116.4975760907623;1156.7917774800617;1193.1409385242612;1220.5544976083843;14744.55766327012;14860.479883204036;14885.479008234659;15111.4710985115;15132.773008404884;534152;536847;541821;542833;542882;60050;60091.09863352053;60093.699531502934;60250.79498410007;60476;1336.3184775764237;1460.145814698392;1462.144645382442;1498.2808252039083;1508.5775982724854;24790.628140577544;27667.98810703667;28462.003829865855;28465;29707;47252.29121563111;47376.289355659006;47834.76082619565;47902.56292311236;47956.5204347952;334043;335958;336341;336382;338244.6175538213;27840.164795056182;32553;33316.33367332688;33379;33425;40858.182836342516;41356;41386.379204312565;41776;42600.36099458449;33602.66397336093;34417.827910861284;34803.65196348004;35016.82491587526;35104.82447587746;33819.830900845336;34138.31723365469;34851;35076.64923350734;36114.4582831263;35813.28373432569;36034.4594831083;36498.8175059123;36778.080547985446;36796.080097996695;26398.736012640395;31193.532097019015;31319.903803367684;31608.841955790074;31616.683833162293;23184.4203894904;23637.172698955455;24007.159749408685;24152.51694966126;24455.38861528476 11:46:45 INFO - PROCESS | 1668 | |2;jquery.html;358.8564574170332;362.38213845393597;365.75859932444575;373.0226805768886;377.60163028005445;15666.686666266682;19971.900140499296;20649.483762905955;21104.57790844182;21139.894300528515;19825;20165.09257083431;20833.16667333305;20968.685469717966;20973.370798876058;4591.816327346911;5995.940040599604;6065.423784740443;6071.574989750719;6076.878462430749;4229.069604686979;4291;5957.9404205958035;6293.276273228568;6613.041109039186;6636.568623039487;6667.733290668368;6676.2989886062;6680.231773346054;6684.83287917801;6284.842878928041;6445.419912207901;6476.9676151619415;6484.6433446160445;6527.673616319189;3725.776453412777;5405.621606487547;5591.776328946838;5629.408912064216;5630.859228519279;23854;24273.393165170837;25548.744512554822;25755.613665795026;25816.8709156453;2037.9694304585444;2310.584094862924;2337.357226762637;2887.898923537666;2975.0777259049546;14329.856701432956;14455.927720361437;14635.560933172022;14977.251137443192;15180.240987950558;1696.5625171325871;1735.2711861018402;1755.9912200439044;1761.603639181174;1794.2822870851633;93409.59885601721;96626.51686741592;98508;101577.49211253897;101927;10416.479176041319;10664.41345725977;10789.83815242772;10791.082757965662;10968.451577421256;12013.099017573717;12153.210041347284;13073.169756234134;13167.736645267041;13191.15323854661;8573.914260857437;8611.526366049928;8627.741167764852;8677.219050285505;8744.606492707844;8905.821883562292;8914.643414263486;8930.598123084477;8982.32632552548;9071.319651026199;6216.222972128484;6250.6874656267;6274.403931626488;6283.7800676976085;6383.39357761012;1689.4509284482592;1735.8177391373977;1754.5350482122249;1790.7672002639574;1835.9128040979506;838.4047326398326;841.4152164245912;875.8948926128778;954.7660823098386;1009.4750729620556;19987.700184497244;20696.689549656767;20939.790602093784;21053.894730526557;21058.2629607963;942.8497233375272;967.6419724701765;990.5691024404407;1046.4303544682975;1097.4677281518457;10780.622678206382;11235.887641123483;11337.433128343715;11448.19862609626;11478.713032174095;607788.9610551919;608024;608923;617900;652866;96188.03811961791;96611;96745.51627241819;97102.02897971071;98009.78858065541;1038.0294424712918;1084.5282302198568;1092.3664274720643;1092.8032954068185;1093.0654290581597;14254.572362829133;15807.36770529166;16928;18159.27362905469;18605.162767675756;46256;46688;47206.29190562213;47218;47534.52465475301;52570;60537.48656283452;60633.48416289628;64468;64989;7519.624018799148;7528.774136775905;7562.903379010123;7646.464747467847;7846;9578.712638620853;12023.338716370683;12231.571894983634;12296.877031229573;12351.25892446456;10381.688549343531;10458.111060559937;10613.9469302653;10827.24209305341;10830.296030757976;10426.791464170523;10488.528016239135;10492;10672.30630009078;10713.517891694737;10661.680149595524;10777.676669699922;10842.080152671893;10892.276930767308;11003.394813285346;6388.872222555616;7442.627868606656;7443.627818608939;7533.2466753324225;7781.766547003599;10291.897081029094;10539.578416863545;10812.621558245424;10835.783284334428;10871.782564348827 11:46:45 INFO - PROCESS | 1668 | |3;mootools.html;1435.906666066705;1545.8376870428606;1577.471547031744;1862.4878158506408;2022.1405902491447;7991.640376183072;8583;8707.564621768917;8730.60712267948;8743.606537705795;8456.8731469028;8726.781830454242;8733.606987685553;8743.300535957123;8748.25639820616;2123.9150433982622;2200.7249093863265;2445.5842506773893;2494.401343677518;2526.4315529005917;2391.784739373456;2394.449276666368;2394.8802559872024;2397.424618091663;2400.1839374612714;2446.107170882624;2484.3168128764646;2507.849529028255;2512.057978258153;2513.899444022237;2477.8778738789165;2486.0304481252324;2502.962455563159;2514.7610976957158;2520.6093055576416;2480.7271200167966;2495.31378870812;2507.5361058204107;2516.7105782835024;2530.367408147963;8834;8913.108689131035;8917.46495210283;8920.464772113693;8933.017368089504;5346.5455436287575;5534.75093620788;5536.390996990368;5542;5549.805756798533;3536;3645.726570507196;3693.538307711536;3698.223373091654;3711.2577484502935;1036.75117971687;1052.831546952484;1056.271172890703;1067.5783065689009;1069.7218723132041;11758.647240582795;11763.411939388245;11764.823527647091;11778.764424711459;11793.233439826385;4832.9275060874115;4879.316895634614;4946.258061290835;4960.975195124073;4988.301637770715;10132.696019119438;10150.593976241016;10151.441670708035;10153.746156346151;10156.542955567018;5521.889562208733;5528.585356098309;5530.281063461724;5531.944680553223;5534.7786088556;4392.934105988413;4593.333966574828;4755.405574303212;4944.159492886218;4952.430470495867;3884.5726970033274;3970.2258059678084;3971.4439978403047;4010.6590939769862;4013.6989725770686;1310.1353106949557;1322.642886420661;1326.4959315460255;1335.1721932401972;1341.496938648007;1079.0935614084208;1184.3012622552735;1341.1081630715464;1363.9045266831424;1389.610908945497;8296.668133274723;8310.21052999964;8344.332453403713;8351.582420879053;8351.832963340821;534.6257619666171;537.4813305160538;1276.8212450256972;1333.9066265361332;1347.75066612675;5162.199859021857;6258.906116408258;6430.453411459985;6455;6481.125048118538;10389.324693894872;10469.267151299488;10697.144228461704;10712.089472394933;10714.571417143383;10413.791724165474;10433.113185379329;10453.372797632015;10500.212484063726;10517;8108.148644392254;8174.7956301092945;8319.916800832036;8351.958240208882;8364.749057528285;8237.176282371955;8241.340692744447;8251.174882511701;8268;8271.793205169919;9278.72163835086;9320.974692783653;9539.952300238454;9542.856857147288;9610.279229057709;8175.468594541336;9641.132298093205;9779.070988256104;9780.462074585967;9941.552630131517;6819.420349270367;7055.153381594037;7321.194668586345;7549.282818132268;7678.616069196406;8254.752357429286;8293.792655183668;8313.418060735932;8322.29260512839;8377.910871586655;7286.48994570375;7354.301341372561;7413.332800048021;7548.849023019399;7565.810854728676;7267.236940121211;7280.9271907280245;7303.926960730325;7325.597092159983;7368.300011498899;7693.769186924401;7740.380769538536;7787.182345853604;7803.297703206738;7818.960905195438;6999.825004374931;7014.5440546364325;7063.293670632896;7068.964655176691;7082.114735658043;7118.8932166018585;7145.678444469907;7175.533590316612;7179.317964793337;7180.676869540779 11:46:45 INFO - PROCESS | 1668 | |4;prototype.html;325.45811224311524;330.988829127017;334.09293767421445;337.21429070266277;339.2925749811644;6399.200099987502;6416.454601358884;6439.259485159208;6488.286288508266;6496.155499785022;6371.789360021593;6408.070829729698;6409.551331406792;6413.13422687937;6415.550911436201;3850.3646898261754;4548.613367863735;4648.465426475947;4763.785629646674;4835.468098509161;3838.42423636454;4781.90436191276;4790.7604619769045;4796.08874313881;4824.686395384307;4736.739479328636;4746.193147164973;4753.762311884409;4768.308595253686;4769.52304769522;4538.1377538267625;4632.60622847055;4642.025174713297;4653.6509761768;4661.394018777537;4065.1056767511395;4087.346024636044;4098.426220329156;4103.548609652966;4107.158032603309;6064.787732429344;6066.908996365058;6079.6960151992225;6107.26712794463;6113.847153821145;5286.894262114736;5621.437856214387;5639.68981706006;5651.4913657770585;5658.207850900877;6822.863542729117;6838.111045564095;6839.897401538981;6843.520953533254;6847.417969472601;4310.094880075188;4463.955360446386;4503.684742068057;4512;4512.887177820548;6964;7244.673989670478;7259.274072592699;7262.891056634155;7266.927330726678;4585.380973568593;4587.128445595326;4589.242774942164;4592.334111553872;4593.379893714306;4628.884277893012;4633.652476064309;4636.5131661175765;4636.930446043245;4639.512851150648;5464.371597266365;5481.945180548223;5496.587755918322;5499.432661691399;5521.806736764194;6449.709763060673;6625.933740662628;6877.931220687729;6884.65576721162;6893.517453778288;1583.3983086427315;1599.720048991422;1600.0719582642039;1611.8952268102537;1612.4598259583172;1021.2238698589126;1028.3572767020612;1036.0571879589538;1045.6810672744887;1050.3750268590177;5636;6094.390560943959;6231.470325022333;6430.967845160744;6540.2805691373915;7141.750038748619;7151.249118842551;7154.606496642735;7164.570125792469;7175.712971481083;6504.15445992018;6504.674766261668;6514.4462720668325;6515.51133664977;6519.934800651933;3726.571444283888;3767.416050512175;3772.830222639988;3780.0360907968293;3783.3000894834545;6080;7305.634718264066;7461.888071678929;7576.5832879191075;7597.810054748676;6700.698468568926;7336.193018767931;7406.703731850774;7407.8888816667795;7409.147947985943;7566.432517561095;7568.772936812014;7588.772336829904;7601.543907365576;7637;7133.3936615388275;7133.5719856808755;7138.286171382821;7139.643017849191;7157.856842863218;6789.626570538668;6977.895331569929;7036.366726994595;7036.788896333118;7050.471214659024;7464.626768661654;7516.549007059594;7528.548287102572;7529.322360987538;7534.849303014019;4118.784958437328;4479.977600111979;4558.475775285752;4561.771911404483;4567.497575266651;6562.507811914221;7013.509054366349;7019.824504387431;7056.15326160864;7066.893996590158;6627.602343859384;6795.626240556817;6809.625470599165;6906.585604863724;6939.6877140529805;6803.353681400259;6888.758893438706;6897.379235868796;6904.551204171713;6916.792496225121;6731.46148308144;6732.764353247613;6735.5621884579305;6742.426893713893;6752.291009444134;6851.109355783717;6902.344277293649;6914.274001229798;6917.827054323682;6929.480288978246;5825.79609713658;6257.9674353731125;6505.447037001719;6621.33786621334;6687.431568316748 11:46:45 INFO - PROCESS | 1668 | |5;yui.html;592.8081191950081;699.9440044796416;726.2592156000883;739.101991080837;769.9114601820793;14736.115833050011;15005.62485937852;15021.699566008674;15023.549293521184;15026.549203523899;13799.31003449826;15737.370505179808;16158.868879178463;16195.676086478294;16197.514074577752;717.3543810570476;727.1710250314645;916.0335845682802;921.0513171433435;936.6347124621403;909.5088652127876;918.6371383303591;919.9816003679922;922.9077092290751;924.6994726713845;977.7018009507098;980.0444566547594;980.4901451245383;982.2093214961989;990.7572644702058;776.5884081436848;788.1881661888265;790.7430085222268;972.6158167523823;986.2110311750607;713.4470785141505;716.1012928774406;716.3624374306871;717.9964100179466;720.0818955831305;15394.307256173499;15484.45804396852;15488.457903973307;15506;15510.379584816594;12289;12312.199707019015;12333.753324933452;12386.442610082568;12545.811812822814;9974.501274936296;9999.70182779564;10090.890002099763;10113.039261270167;10405.323653962469;3049.5120780674984;3410.6589341065696;3460.377132116218;3501.859925602973;3504.912377190565;84967.99999999939;84991.57504212439;86070.13929860684;86073.56963215144;86108.13891861064;9253.72238832836;9327.113924177193;9345.672901448417;9457.527123643791;9645.855312170323;21110.683339749918;21192.36422907315;21198.47003824917;21200;21235.362939111852;7196.244394338623;7288.744893928793;7307.707691692272;7361.852762944711;7479.513831600929;4072.775997320176;4119.361498967664;4124.030852749602;4126.8761937141935;4131.9173616528105;3541.1678255609913;3568.286342731464;3602.4776407420777;3606.098475381155;3612.096975756061;636.2142753699178;639.8304449320933;665.8501837086714;688.6281408039703;726.691156258588;534.8101423994426;580.2282963658324;594.9553783466257;601.2964831147568;606.3966353478318;6842.905135178347;7880.881786773203;7916.445848790529;8127.552984585905;8259.710910118118;508.36200568286563;596.8448203467043;600.3456232706371;605.6214865708932;626.0796628955428;3634.67287944081;3718.2749363873786;3790.2040571479747;3847.7498962567342;4033;95832.52083739676;95991;96762.51618741862;97002;98457.50771246241;72294.2770572298;72861.63569182226;77267.61366193245;77726;80424;68209.65895170493;68467;69566;70637.99999999897;71806.20484487824;7566.167721550735;7578.317951384402;7642.426817988784;7823.726169584037;8064.637091331021;48897.75551122364;48899.51100489092;49816;51051.2342314873;51847;67336;68146.65926670335;69218;71895;72697.54604907766;10160.644377446753;10206.897931020892;10377.273590848568;10592.099671528007;11181.776364472827;10742.409167495864;10931.125509959344;10962;11280.605178818701;11624.360660163773;8681.435706679045;10125.64560240388;10237.232207584311;10263.589456421958;10462.110720588835;10448.268621196443;10476.79046419052;10502.317349372266;10713.303635263683;10768.676939691823;10043.497825108861;10210.43842588635;10301.227407944285;10422;10429.53067111997;8744.213020828156;8858.15847494487;8940.910590894007;8975.192232698828;9026.413283136575;8514.361422893431;8531.23218910301;8649.962004559493;8777.913636656125;8783.736487905373 11:46:45 INFO - PROCESS | 1668 | __end_tp_report 11:46:45 INFO - PROCESS | 1668 | __start_cc_report 11:46:45 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1086 11:46:45 INFO - PROCESS | 1668 | __end_cc_report 11:46:45 INFO - PROCESS | 1668 | __startTimestamp1458067605612__endTimestamp 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | ------- Summary: start ------- 11:46:45 INFO - PROCESS | 1668 | Number of tests: 6 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5672.03 Median:5900.41 stddev:659.37 (11.2%) stddev-sans-first:622.13 11:46:45 INFO - PROCESS | 1668 | Values: 2814.7 3458.9 3516.9 3520.9 3567.1 5582.9 5618.7 5625.3 5631.8 5632.1 5612.9 5711.9 5729.3 5764.6 5778.2 4663.3 5105.3 5117.2 5157.9 5164.0 5084.5 5258.0 5280.7 5287.8 5306.1 5062.7 5145.8 5189.9 5203.1 5250.6 5130.8 5149.8 5163.8 5166.9 5174.7 5091.8 5135.8 5151.2 5154.4 5157.6 5500.5 5507.6 5516.9 5528.8 5533.4 6104.4 6107.2 6118.0 6123.7 6126.3 6223.2 6241.3 6281.2 6281.4 6293.8 5004.6 5458.5 5711.4 5738.7 5752.0 6210.1 6224.6 6299.6 6310.9 6337.7 6092.8 6125.4 6129.2 6135.5 6140.4 6228.3 6254.6 6273.9 6277.1 6281.7 6039.7 6094.2 6120.1 6124.8 6159.4 6105.5 6107.5 6141.5 6141.9 6195.3 4795.6 4814.8 4823.4 4835.0 4858.6 4271.7 4277.9 4292.2 4299.7 4343.2 5531.1 5659.1 5675.5 5678.1 5798.5 6225.9 6243.8 6247.0 6259.3 6271.7 5699.7 5706.9 5711.0 5719.5 5751.1 5196.2 5257.8 5268.0 5305.3 5319.5 6236.6 6282.2 6292.6 6302.2 6305.9 6180.6 6264.4 6280.2 6304.1 6311.4 6227.3 6227.6 6247.7 6258.9 6265.6 4457.8 6106.0 6115.4 6122.9 6141.8 4846.9 5726.6 6107.0 6180.2 6180.8 5998.8 6014.8 6051.6 6062.4 6063.7 5900.4 6036.4 6063.8 6065.8 6069.4 5815.6 5872.1 5926.7 5984.0 5993.6 6071.8 6080.4 6082.4 6092.5 6105.8 5751.5 5880.1 5909.3 5911.2 5946.2 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:60596.80 Median:21262.02 stddev:123521.73 (581.0%) stddev-sans-first:123785.78 11:46:45 INFO - PROCESS | 1668 | Values: 483.7 577.0 583.5 633.2 635.3 27536.2 38779.6 39007.4 39028.0 39128.4 41499.0 42207.6 42253.8 42304.6 42314.8 8719.9 9440.9 9515.6 9730.5 9751.5 9537.8 9673.6 9693.2 9694.4 9711.8 9662.5 9717.4 9867.4 9874.3 9875.7 9780.9 9854.7 9855.6 9866.2 9873.5 9588.0 9713.7 9740.4 9740.5 9742.3 40618.4 40834.0 40901.6 40949.8 41018.0 3222.5 3287.5 3360.3 3744.4 3881.2 28469.0 29157.3 29680.1 29973.7 30223.0 2702.6 2730.2 2782.6 2810.4 2857.2 488973.0 492646.0 493183.0 493381.0 493851.0 63478.7 64635.7 64726.7 64727.7 64749.7 67545.0 67642.7 67768.7 67846.0 67947.0 17252.8 17506.7 17529.3 17536.2 17549.9 13146.7 13332.9 13357.0 13358.9 13410.2 18367.2 19881.0 20103.5 20158.0 20181.8 7460.7 8793.3 9077.4 9092.3 9108.7 864.0 975.9 999.7 1001.0 1079.7 28915.0 28956.7 28978.6 29716.6 29743.3 990.2 1116.5 1156.8 1193.1 1220.6 14744.6 14860.5 14885.5 15111.5 15132.8 534152.0 536847.0 541821.0 542833.0 542882.0 60050.0 60091.1 60093.7 60250.8 60476.0 1336.3 1460.1 1462.1 1498.3 1508.6 24790.6 27668.0 28462.0 28465.0 29707.0 47252.3 47376.3 47834.8 47902.6 47956.5 334043.0 335958.0 336341.0 336382.0 338244.6 27840.2 32553.0 33316.3 33379.0 33425.0 40858.2 41356.0 41386.4 41776.0 42600.4 33602.7 34417.8 34803.7 35016.8 35104.8 33819.8 34138.3 34851.0 35076.6 36114.5 35813.3 36034.5 36498.8 36778.1 36796.1 26398.7 31193.5 31319.9 31608.8 31616.7 23184.4 23637.2 24007.2 24152.5 24455.4 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:33511.82 Median:25786.24 stddev:101939.49 (395.3%) stddev-sans-first:102195.07 11:46:45 INFO - PROCESS | 1668 | Values: 358.9 362.4 365.8 373.0 377.6 15666.7 19971.9 20649.5 21104.6 21139.9 19825.0 20165.1 20833.2 20968.7 20973.4 4591.8 5995.9 6065.4 6071.6 6076.9 4229.1 4291.0 5957.9 6293.3 6613.0 6636.6 6667.7 6676.3 6680.2 6684.8 6284.8 6445.4 6477.0 6484.6 6527.7 3725.8 5405.6 5591.8 5629.4 5630.9 23854.0 24273.4 25548.7 25755.6 25816.9 2038.0 2310.6 2337.4 2887.9 2975.1 14329.9 14455.9 14635.6 14977.3 15180.2 1696.6 1735.3 1756.0 1761.6 1794.3 93409.6 96626.5 98508.0 101577.5 101927.0 10416.5 10664.4 10789.8 10791.1 10968.5 12013.1 12153.2 13073.2 13167.7 13191.2 8573.9 8611.5 8627.7 8677.2 8744.6 8905.8 8914.6 8930.6 8982.3 9071.3 6216.2 6250.7 6274.4 6283.8 6383.4 1689.5 1735.8 1754.5 1790.8 1835.9 838.4 841.4 875.9 954.8 1009.5 19987.7 20696.7 20939.8 21053.9 21058.3 942.8 967.6 990.6 1046.4 1097.5 10780.6 11235.9 11337.4 11448.2 11478.7 607789.0 608024.0 608923.0 617900.0 652866.0 96188.0 96611.0 96745.5 97102.0 98009.8 1038.0 1084.5 1092.4 1092.8 1093.1 14254.6 15807.4 16928.0 18159.3 18605.2 46256.0 46688.0 47206.3 47218.0 47534.5 52570.0 60537.5 60633.5 64468.0 64989.0 7519.6 7528.8 7562.9 7646.5 7846.0 9578.7 12023.3 12231.6 12296.9 12351.3 10381.7 10458.1 10613.9 10827.2 10830.3 10426.8 10488.5 10492.0 10672.3 10713.5 10661.7 10777.7 10842.1 10892.3 11003.4 6388.9 7442.6 7443.6 7533.2 7781.8 10291.9 10539.6 10812.6 10835.8 10871.8 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6063.10 Median:2942.01 stddev:3165.75 (107.6%) stddev-sans-first:3155.53 11:46:45 INFO - PROCESS | 1668 | Values: 1435.9 1545.8 1577.5 1862.5 2022.1 7991.6 8583.0 8707.6 8730.6 8743.6 8456.9 8726.8 8733.6 8743.3 8748.3 2123.9 2200.7 2445.6 2494.4 2526.4 2391.8 2394.4 2394.9 2397.4 2400.2 2446.1 2484.3 2507.8 2512.1 2513.9 2477.9 2486.0 2503.0 2514.8 2520.6 2480.7 2495.3 2507.5 2516.7 2530.4 8834.0 8913.1 8917.5 8920.5 8933.0 5346.5 5534.8 5536.4 5542.0 5549.8 3536.0 3645.7 3693.5 3698.2 3711.3 1036.8 1052.8 1056.3 1067.6 1069.7 11758.6 11763.4 11764.8 11778.8 11793.2 4832.9 4879.3 4946.3 4961.0 4988.3 10132.7 10150.6 10151.4 10153.7 10156.5 5521.9 5528.6 5530.3 5531.9 5534.8 4392.9 4593.3 4755.4 4944.2 4952.4 3884.6 3970.2 3971.4 4010.7 4013.7 1310.1 1322.6 1326.5 1335.2 1341.5 1079.1 1184.3 1341.1 1363.9 1389.6 8296.7 8310.2 8344.3 8351.6 8351.8 534.6 537.5 1276.8 1333.9 1347.8 5162.2 6258.9 6430.5 6455.0 6481.1 10389.3 10469.3 10697.1 10712.1 10714.6 10413.8 10433.1 10453.4 10500.2 10517.0 8108.1 8174.8 8319.9 8352.0 8364.7 8237.2 8241.3 8251.2 8268.0 8271.8 9278.7 9321.0 9540.0 9542.9 9610.3 8175.5 9641.1 9779.1 9780.5 9941.6 6819.4 7055.2 7321.2 7549.3 7678.6 8254.8 8293.8 8313.4 8322.3 8377.9 7286.5 7354.3 7413.3 7548.8 7565.8 7267.2 7280.9 7303.9 7325.6 7368.3 7693.8 7740.4 7787.2 7803.3 7819.0 6999.8 7014.5 7063.3 7069.0 7082.1 7118.9 7145.7 7175.5 7179.3 7180.7 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5624.35 Median:6414.34 stddev:1799.51 (28.1%) stddev-sans-first:1760.06 11:46:45 INFO - PROCESS | 1668 | Values: 325.5 331.0 334.1 337.2 339.3 6399.2 6416.5 6439.3 6488.3 6496.2 6371.8 6408.1 6409.6 6413.1 6415.6 3850.4 4548.6 4648.5 4763.8 4835.5 3838.4 4781.9 4790.8 4796.1 4824.7 4736.7 4746.2 4753.8 4768.3 4769.5 4538.1 4632.6 4642.0 4653.7 4661.4 4065.1 4087.3 4098.4 4103.5 4107.2 6064.8 6066.9 6079.7 6107.3 6113.8 5286.9 5621.4 5639.7 5651.5 5658.2 6822.9 6838.1 6839.9 6843.5 6847.4 4310.1 4464.0 4503.7 4512.0 4512.9 6964.0 7244.7 7259.3 7262.9 7266.9 4585.4 4587.1 4589.2 4592.3 4593.4 4628.9 4633.7 4636.5 4636.9 4639.5 5464.4 5481.9 5496.6 5499.4 5521.8 6449.7 6625.9 6877.9 6884.7 6893.5 1583.4 1599.7 1600.1 1611.9 1612.5 1021.2 1028.4 1036.1 1045.7 1050.4 5636.0 6094.4 6231.5 6431.0 6540.3 7141.8 7151.2 7154.6 7164.6 7175.7 6504.2 6504.7 6514.4 6515.5 6519.9 3726.6 3767.4 3772.8 3780.0 3783.3 6080.0 7305.6 7461.9 7576.6 7597.8 6700.7 7336.2 7406.7 7407.9 7409.1 7566.4 7568.8 7588.8 7601.5 7637.0 7133.4 7133.6 7138.3 7139.6 7157.9 6789.6 6977.9 7036.4 7036.8 7050.5 7464.6 7516.5 7528.5 7529.3 7534.8 4118.8 4480.0 4558.5 4561.8 4567.5 6562.5 7013.5 7019.8 7056.2 7066.9 6627.6 6795.6 6809.6 6906.6 6939.7 6803.4 6888.8 6897.4 6904.6 6916.8 6731.5 6732.8 6735.6 6742.4 6752.3 6851.1 6902.3 6914.3 6917.8 6929.5 5825.8 6258.0 6505.4 6621.3 6687.4 11:46:45 INFO - PROCESS | 1668 | 11:46:45 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18389.61 Median:34000.93 stddev:26447.03 (77.8%) stddev-sans-first:26487.46 11:46:45 INFO - PROCESS | 1668 | Values: 592.8 699.9 726.3 739.1 769.9 14736.1 15005.6 15021.7 15023.5 15026.5 13799.3 15737.4 16158.9 16195.7 16197.5 717.4 727.2 916.0 921.1 936.6 909.5 918.6 920.0 922.9 924.7 977.7 980.0 980.5 982.2 990.8 776.6 788.2 790.7 972.6 986.2 713.4 716.1 716.4 718.0 720.1 15394.3 15484.5 15488.5 15506.0 15510.4 12289.0 12312.2 12333.8 12386.4 12545.8 9974.5 9999.7 10090.9 10113.0 10405.3 3049.5 3410.7 3460.4 3501.9 3504.9 84968.0 84991.6 86070.1 86073.6 86108.1 9253.7 9327.1 9345.7 9457.5 9645.9 21110.7 21192.4 21198.5 21200.0 21235.4 7196.2 7288.7 7307.7 7361.9 7479.5 4072.8 4119.4 4124.0 4126.9 4131.9 3541.2 3568.3 3602.5 3606.1 3612.1 636.2 639.8 665.9 688.6 726.7 534.8 580.2 595.0 601.3 606.4 6842.9 7880.9 7916.4 8127.6 8259.7 508.4 596.8 600.3 605.6 626.1 3634.7 3718.3 3790.2 3847.7 4033.0 95832.5 95991.0 96762.5 97002.0 98457.5 72294.3 72861.6 77267.6 77726.0 80424.0 68209.7 68467.0 69566.0 70638.0 71806.2 7566.2 7578.3 7642.4 7823.7 8064.6 48897.8 48899.5 49816.0 51051.2 51847.0 67336.0 68146.7 69218.0 71895.0 72697.5 10160.6 10206.9 10377.3 10592.1 11181.8 10742.4 10931.1 10962.0 11280.6 11624.4 8681.4 10125.6 10237.2 10263.6 10462.1 10448.3 10476.8 10502.3 10713.3 10768.7 10043.5 10210.4 10301.2 10422.0 10429.5 8744.2 8858.2 8940.9 8975.2 9026.4 8514.4 8531.2 8650.0 8777.9 8783.7 11:46:45 INFO - PROCESS | 1668 | -------- Summary: end -------- 11:46:45 INFO - PROCESS | 1668 | 11:46:46 INFO - TEST-INFO | 1668: exit 0 11:46:46 INFO - TEST-OK | dromaeo_css | took 1114203ms 11:46:46 INFO - TEST-START | kraken 11:46:46 INFO - operating with platform_type : mac_ 11:46:46 INFO - Initialising browser for kraken test... 11:46:46 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpln1fln/profile http://localhost:49272/getInfo.html) 11:46:48 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 11:46:48 INFO - PROCESS | 1679 | colorDepth:24 11:46:48 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 11:46:48 INFO - PROCESS | 1679 | __metrics 11:46:48 INFO - PROCESS | 1679 | 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" 11:46:48 ERROR - PROCESS | 1679 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:46:49 INFO - TEST-INFO | 1679: exit 0 11:46:49 INFO - Browser initialized. 11:46:49 INFO - Running cycle 1/1 for kraken test... 11:46:49 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpln1fln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:01 INFO - PROCESS | 1681 | RSS: Main: 243400704 11:47:01 INFO - PROCESS | 1681 | 11:47:03 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 11:47:04 INFO - PROCESS | 1681 | RSS: Main: 290713600 11:47:04 INFO - PROCESS | 1681 | 11:47:07 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 11:47:07 INFO - PROCESS | 1681 | RSS: Main: 299487232 11:47:07 INFO - PROCESS | 1681 | 11:47:11 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 11:47:11 INFO - PROCESS | 1681 | RSS: Main: 287285248 11:47:11 INFO - PROCESS | 1681 | 11:47:13 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 11:47:14 INFO - PROCESS | 1681 | RSS: Main: 288198656 11:47:14 INFO - PROCESS | 1681 | 11:47:16 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:47:16 INFO - PROCESS | 1681 | RSS: Main: 289636352 11:47:16 INFO - PROCESS | 1681 | 11:47:19 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 11:47:20 INFO - PROCESS | 1681 | RSS: Main: 289263616 11:47:20 INFO - PROCESS | 1681 | 11:47:23 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 11:47:23 INFO - PROCESS | 1681 | RSS: Main: 289230848 11:47:23 INFO - PROCESS | 1681 | 11:47:26 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 11:47:26 INFO - PROCESS | 1681 | RSS: Main: 291471360 11:47:26 INFO - PROCESS | 1681 | 11:47:28 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:47:29 INFO - PROCESS | 1681 | RSS: Main: 323764224 11:47:29 INFO - PROCESS | 1681 | 11:47:30 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:47:31 INFO - PROCESS | 1681 | RSS: Main: 323379200 11:47:31 INFO - PROCESS | 1681 | 11:47:33 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:47:34 INFO - PROCESS | 1681 | RSS: Main: 329625600 11:47:34 INFO - PROCESS | 1681 | 11:47:36 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:47:37 INFO - PROCESS | 1681 | RSS: Main: 332107776 11:47:37 INFO - PROCESS | 1681 | 11:47:39 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:47:40 INFO - PROCESS | 1681 | RSS: Main: 332546048 11:47:40 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 11:47:42 INFO - PROCESS | 1681 | RSS: Main: 392347648 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | __start_tp_report 11:47:42 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 11:47:42 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 11:47:42 INFO - PROCESS | 1681 | |i|pagename|runs| 11:47:42 INFO - PROCESS | 1681 | |0;ai-astar;112;109;109;111;112;114;162;165;158;110 11:47:42 INFO - PROCESS | 1681 | |1;audio-beat-detection;174;154;139;160;121;141;138;119;150;120 11:47:42 INFO - PROCESS | 1681 | |2;audio-dft;185;184;185;183;188;186;184;183;183;182 11:47:42 INFO - PROCESS | 1681 | |3;audio-fft;83;94;113;105;57;56;58;78;77;56 11:47:42 INFO - PROCESS | 1681 | |4;audio-oscillator;93;97;132;79;80;77;115;77;80;115 11:47:42 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;88;85;88;85;89;124;89;86;86;84 11:47:42 INFO - PROCESS | 1681 | |6;imaging-darkroom;93;93;92;94;93;93;94;95;93;93 11:47:42 INFO - PROCESS | 1681 | |7;imaging-desaturate;85;85;85;86;88;85;86;87;85;84 11:47:42 INFO - PROCESS | 1681 | |8;json-parse-financial;56;54;54;51;54;54;55;64;56;53 11:47:42 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;73;68;67;75;70;66;67;67;66;76 11:47:42 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;83;83;81;81;83;83;82;82;82;82 11:47:42 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;131;120;133;132;118;121;133;130;131;119 11:47:42 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;141;128;137;138;138;129;137;140;137;137 11:47:42 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;66;68;70;67;67;68;69;84;95;98 11:47:42 INFO - PROCESS | 1681 | __end_tp_report 11:47:42 INFO - PROCESS | 1681 | __start_cc_report 11:47:42 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1234 11:47:42 INFO - PROCESS | 1681 | __end_cc_report 11:47:42 INFO - PROCESS | 1681 | __startTimestamp1458067662518__endTimestamp 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | ------- Summary: start ------- 11:47:42 INFO - PROCESS | 1681 | Number of tests: 14 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:126.20 Median:113.00 stddev:24.58 (21.7%) stddev-sans-first:25.52 11:47:42 INFO - PROCESS | 1681 | Values: 112.0 109.0 109.0 111.0 112.0 114.0 162.0 165.0 158.0 110.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:145.50 stddev:18.36 (12.6%) stddev-sans-first:15.28 11:47:42 INFO - PROCESS | 1681 | Values: 174.0 154.0 139.0 160.0 121.0 141.0 138.0 119.0 150.0 120.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:1.77 (1.0%) stddev-sans-first:1.86 11:47:42 INFO - PROCESS | 1681 | Values: 185.0 184.0 185.0 183.0 188.0 186.0 184.0 183.0 183.0 182.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:77.70 Median:67.50 stddev:21.20 (31.4%) stddev-sans-first:22.40 11:47:42 INFO - PROCESS | 1681 | Values: 83.0 94.0 113.0 105.0 57.0 56.0 58.0 78.0 77.0 56.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:79.50 stddev:19.80 (24.9%) stddev-sans-first:20.99 11:47:42 INFO - PROCESS | 1681 | Values: 93.0 97.0 132.0 79.0 80.0 77.0 115.0 77.0 80.0 115.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:87.00 stddev:11.94 (13.7%) stddev-sans-first:12.63 11:47:42 INFO - PROCESS | 1681 | Values: 88.0 85.0 88.0 85.0 89.0 124.0 89.0 86.0 86.0 84.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 11:47:42 INFO - PROCESS | 1681 | Values: 93.0 93.0 92.0 94.0 93.0 93.0 94.0 95.0 93.0 93.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:1.17 (1.4%) stddev-sans-first:1.22 11:47:42 INFO - PROCESS | 1681 | Values: 85.0 85.0 85.0 86.0 88.0 85.0 86.0 87.0 85.0 84.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:3.45 (6.3%) stddev-sans-first:3.64 11:47:42 INFO - PROCESS | 1681 | Values: 56.0 54.0 54.0 51.0 54.0 54.0 55.0 64.0 56.0 53.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:3.81 (5.5%) stddev-sans-first:3.82 11:47:42 INFO - PROCESS | 1681 | Values: 73.0 68.0 67.0 75.0 70.0 66.0 67.0 67.0 66.0 76.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:0.79 (1.0%) stddev-sans-first:0.78 11:47:42 INFO - PROCESS | 1681 | Values: 83.0 83.0 81.0 81.0 83.0 83.0 82.0 82.0 82.0 82.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:131.00 stddev:6.39 (4.9%) stddev-sans-first:6.60 11:47:42 INFO - PROCESS | 1681 | Values: 131.0 120.0 133.0 132.0 118.0 121.0 133.0 130.0 131.0 119.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:137.50 stddev:4.29 (3.1%) stddev-sans-first:4.18 11:47:42 INFO - PROCESS | 1681 | Values: 141.0 128.0 137.0 138.0 138.0 129.0 137.0 140.0 137.0 137.0 11:47:42 INFO - PROCESS | 1681 | 11:47:42 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:69.50 stddev:12.37 (17.8%) stddev-sans-first:12.67 11:47:42 INFO - PROCESS | 1681 | Values: 66.0 68.0 70.0 67.0 67.0 68.0 69.0 84.0 95.0 98.0 11:47:42 INFO - PROCESS | 1681 | -------- Summary: end -------- 11:47:42 INFO - PROCESS | 1681 | 11:47:43 INFO - TEST-INFO | 1681: exit 0 11:47:43 INFO - TEST-OK | kraken | took 57139ms 11:47:43 INFO - SUITE-END | took 1171s 11:47:43 INFO - Completed test suite (00:19:31) 11:47:43 INFO - javascript benchmark 11:47:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2814.7185281471857, 3458.861645534179, 3516.9296614067703, 3520.9119772005697, 3567.1260541167417, 5582.888342233163, 5618.719064046797, 5625.296837895263, 5631.77472901084, 5632.098864181732, 5612.859678508039, 5711.914321285184, 5729.28383952006, 5764.625299355539, 5778.162166485857, 4663.300504924255, 5105.259737338084, 5117.181250999841, 5157.922631160535, 5163.974180129113, 5084.542391184793, 5258.0, 5280.656757310781, 5287.788488460476, 5306.071437498442, 5062.696238225718, 5145.794168233304, 5189.922151167735, 5203.1414816555225, 5250.606204534656, 5130.794768209267, 5149.84550463483, 5163.819266325698, 5166.870828229286, 5174.689518628857, 5091.79632814687, 5135.820246291362, 5151.175811870083, 5154.4072431670465, 5157.58739300855, 5500.477454641803, 5507.5593952484105, 5516.9448305516835, 5528.778848846041, 5533.363663178746, 6104.359042300539, 6107.249501910372, 6118.0, 6123.724432400508, 6126.295476020226, 6223.222097237845, 6241.3446588108045, 6281.152044473984, 6281.371862813728, 6293.779717709858, 5004.624653151028, 5458.4541545845495, 5711.428857114297, 5738.684372359477, 5752.022156233408, 6210.068489726577, 6224.564280500412, 6299.590526615755, 6310.905336419957, 6337.65142917144, 6092.799872193021, 6125.449118208436, 6129.172561704202, 6135.5398345124295, 6140.3552626974415, 6228.252609686867, 6254.562180647402, 6273.8745225095245, 6277.089821975879, 6281.654509001957, 6039.7282122304605, 6094.177286066413, 6120.143179954721, 6124.846878827976, 6159.4456498915315, 6105.490073363267, 6107.46191531438, 6141.486007784275, 6141.877162456815, 6195.256569211723, 4795.640326975491, 4814.807407703653, 4823.445303790038, 4835.008823191238, 4858.6356023297685, 4271.722338048017, 4277.871663850089, 4292.163028209532, 4299.742015479082, 4343.19650864591, 5531.1426728857095, 5659.122835960433, 5675.517581005661, 5678.063119585222, 5798.507126894261, 6225.937740622627, 6243.8126856194385, 6247.0, 6259.280182778948, 6271.749130034747, 5699.715014249271, 5706.914396284059, 5711.029125048752, 5719.48524632785, 5751.1085781703905, 5196.246544251062, 5257.842264732064, 5267.9736601316745, 5305.336832895888, 5319.547838433777, 6236.563440559117, 6282.183316168869, 6292.590981586182, 6302.212223472066, 6305.936940630535, 6180.598261113013, 6264.404881536247, 6280.152179455715, 6304.117423560797, 6311.431971122437, 6227.314995350598, 6227.595206311576, 6247.6563788990225, 6258.874822503615, 6265.624062556261, 4457.754823484739, 6105.9694701526205, 6115.449609535163, 6122.877542449215, 6141.815745527641, 4846.927296090632, 5726.627769194989, 6107.0228763397645, 6180.165677633462, 6180.81457556274, 5998.760049597967, 6014.759409623566, 6051.606645568024, 6062.42406971337, 6063.727132279147, 5900.409959004065, 6036.426539478743, 6063.757449701962, 6065.848353791191, 6069.393060693896, 5815.563832712479, 5872.060470324727, 5926.733297001559, 5984.0, 5993.550483713826, 6071.817845464643, 6080.361562035922, 6082.391760823883, 6092.45167934888, 6105.755769769159, 5751.539876809761, 5880.117982302518, 5909.2908850938165, 5911.201987731602, 5946.226990491208], "unit": "score", "name": "dojo.html", "value": 5630.209678399793}, {"lowerIsBetter": false, "replicates": [483.71460838105554, 577.024828040611, 583.4544700704841, 633.2148136310974, 635.3106879036244, 27536.173914782565, 38779.61220387795, 39007.41488877662, 39028.0, 39128.41307380392, 41499.0, 42207.57792422075, 42253.7887310563, 42304.57695423045, 42314.78842605783, 8719.912800872005, 9440.858387124199, 9515.619375224982, 9730.464824434654, 9751.463669498175, 9537.761555961088, 9673.564689588986, 9693.176080033205, 9694.418334899894, 9711.805763884719, 9662.468564229, 9717.368371055894, 9867.40795552269, 9874.259430542737, 9875.703728888146, 9780.853287200698, 9854.704358869245, 9855.605775768961, 9866.210703143803, 9873.506324683736, 9588.041195880425, 9713.708588742278, 9740.366876153028, 9740.512974351253, 9742.318037737361, 40618.390724139164, 40834.0, 40901.59098409008, 40949.77150685484, 41017.97455063617, 3222.5005124205786, 3287.474004159323, 3360.327934413127, 3744.4196149596855, 3881.1655494068627, 28469.029144069882, 29157.271068223254, 29680.109596712133, 29973.70026299731, 30223.0, 2702.5675891857404, 2730.194592595189, 2782.6104345391664, 2810.3676672748675, 2857.2428306498796, 488973.0, 492646.0, 493183.0, 493380.9999999964, 493851.0, 63478.68260658667, 64635.67682161559, 64726.705465890416, 64727.67636161789, 64749.676251619385, 67545.0, 67642.66178669075, 67768.66115669488, 67845.98231026539, 67947.0, 17252.827471725373, 17506.737398939025, 17529.29882804699, 17536.21087051086, 17549.912250438665, 13146.671333216746, 13332.866671333357, 13357.0, 13358.933205333911, 13410.195388276734, 18367.238386290344, 19881.0, 20103.49741256451, 20158.0, 20181.798182017992, 7460.664270107858, 8793.296536277083, 9077.364584479023, 9092.318076144316, 9108.67728729183, 863.96976105836, 975.9219262459128, 999.6900960702205, 1001.0290018681867, 1079.6976846482996, 28915.0, 28956.710432895823, 28978.565321520193, 29716.55425168624, 29743.25641858971, 990.1633120013577, 1116.4975760907623, 1156.7917774800617, 1193.1409385242612, 1220.5544976083843, 14744.55766327012, 14860.479883204036, 14885.479008234659, 15111.4710985115, 15132.773008404884, 534152.0, 536847.0, 541821.0, 542833.0, 542882.0, 60050.0, 60091.09863352053, 60093.699531502934, 60250.79498410007, 60476.0, 1336.3184775764237, 1460.145814698392, 1462.144645382442, 1498.2808252039083, 1508.5775982724854, 24790.628140577544, 27667.98810703667, 28462.003829865855, 28465.0, 29707.0, 47252.29121563111, 47376.289355659006, 47834.76082619565, 47902.56292311236, 47956.5204347952, 334043.0, 335958.0, 336341.0, 336382.0, 338244.6175538213, 27840.164795056182, 32553.0, 33316.33367332688, 33379.0, 33425.0, 40858.182836342516, 41356.0, 41386.379204312565, 41776.0, 42600.36099458449, 33602.66397336093, 34417.827910861284, 34803.65196348004, 35016.82491587526, 35104.82447587746, 33819.830900845336, 34138.31723365469, 34851.0, 35076.64923350734, 36114.4582831263, 35813.28373432569, 36034.4594831083, 36498.8175059123, 36778.080547985446, 36796.080097996695, 26398.736012640395, 31193.532097019015, 31319.903803367684, 31608.841955790074, 31616.683833162293, 23184.4203894904, 23637.172698955455, 24007.159749408685, 24152.51694966126, 24455.38861528476], "unit": "score", "name": "ext.html", "value": 19612.73233826843}, {"lowerIsBetter": false, "replicates": [358.8564574170332, 362.38213845393597, 365.75859932444575, 373.0226805768886, 377.60163028005445, 15666.686666266682, 19971.900140499296, 20649.483762905955, 21104.57790844182, 21139.894300528515, 19825.0, 20165.09257083431, 20833.16667333305, 20968.685469717966, 20973.370798876058, 4591.816327346911, 5995.940040599604, 6065.423784740443, 6071.574989750719, 6076.878462430749, 4229.069604686979, 4291.0, 5957.9404205958035, 6293.276273228568, 6613.041109039186, 6636.568623039487, 6667.733290668368, 6676.2989886062, 6680.231773346054, 6684.83287917801, 6284.842878928041, 6445.419912207901, 6476.9676151619415, 6484.6433446160445, 6527.673616319189, 3725.776453412777, 5405.621606487547, 5591.776328946838, 5629.408912064216, 5630.859228519279, 23854.0, 24273.393165170837, 25548.744512554822, 25755.613665795026, 25816.8709156453, 2037.9694304585444, 2310.584094862924, 2337.357226762637, 2887.898923537666, 2975.0777259049546, 14329.856701432956, 14455.927720361437, 14635.560933172022, 14977.251137443192, 15180.240987950558, 1696.5625171325871, 1735.2711861018402, 1755.9912200439044, 1761.603639181174, 1794.2822870851633, 93409.59885601721, 96626.51686741592, 98508.0, 101577.49211253897, 101927.0, 10416.479176041319, 10664.41345725977, 10789.83815242772, 10791.082757965662, 10968.451577421256, 12013.099017573717, 12153.210041347284, 13073.169756234134, 13167.736645267041, 13191.15323854661, 8573.914260857437, 8611.526366049928, 8627.741167764852, 8677.219050285505, 8744.606492707844, 8905.821883562292, 8914.643414263486, 8930.598123084477, 8982.32632552548, 9071.319651026199, 6216.222972128484, 6250.6874656267, 6274.403931626488, 6283.7800676976085, 6383.39357761012, 1689.4509284482592, 1735.8177391373977, 1754.5350482122249, 1790.7672002639574, 1835.9128040979506, 838.4047326398326, 841.4152164245912, 875.8948926128778, 954.7660823098386, 1009.4750729620556, 19987.700184497244, 20696.689549656767, 20939.790602093784, 21053.894730526557, 21058.2629607963, 942.8497233375272, 967.6419724701765, 990.5691024404407, 1046.4303544682975, 1097.4677281518457, 10780.622678206382, 11235.887641123483, 11337.433128343715, 11448.19862609626, 11478.713032174095, 607788.9610551919, 608024.0, 608923.0, 617900.0, 652866.0, 96188.03811961791, 96611.0, 96745.51627241819, 97102.02897971071, 98009.78858065541, 1038.0294424712918, 1084.5282302198568, 1092.3664274720643, 1092.8032954068185, 1093.0654290581597, 14254.572362829133, 15807.36770529166, 16928.0, 18159.27362905469, 18605.162767675756, 46256.0, 46688.0, 47206.29190562213, 47218.0, 47534.52465475301, 52570.0, 60537.48656283452, 60633.48416289628, 64468.0, 64989.0, 7519.624018799148, 7528.774136775905, 7562.903379010123, 7646.464747467847, 7846.0, 9578.712638620853, 12023.338716370683, 12231.571894983634, 12296.877031229573, 12351.25892446456, 10381.688549343531, 10458.111060559937, 10613.9469302653, 10827.24209305341, 10830.296030757976, 10426.791464170523, 10488.528016239135, 10492.0, 10672.30630009078, 10713.517891694737, 10661.680149595524, 10777.676669699922, 10842.080152671893, 10892.276930767308, 11003.394813285346, 6388.872222555616, 7442.627868606656, 7443.627818608939, 7533.2466753324225, 7781.766547003599, 10291.897081029094, 10539.578416863545, 10812.621558245424, 10835.783284334428, 10871.782564348827], "unit": "score", "name": "jquery.html", "value": 9404.131850976997}, {"lowerIsBetter": false, "replicates": [1435.906666066705, 1545.8376870428606, 1577.471547031744, 1862.4878158506408, 2022.1405902491447, 7991.640376183072, 8583.0, 8707.564621768917, 8730.60712267948, 8743.606537705795, 8456.8731469028, 8726.781830454242, 8733.606987685553, 8743.300535957123, 8748.25639820616, 2123.9150433982622, 2200.7249093863265, 2445.5842506773893, 2494.401343677518, 2526.4315529005917, 2391.784739373456, 2394.449276666368, 2394.8802559872024, 2397.424618091663, 2400.1839374612714, 2446.107170882624, 2484.3168128764646, 2507.849529028255, 2512.057978258153, 2513.899444022237, 2477.8778738789165, 2486.0304481252324, 2502.962455563159, 2514.7610976957158, 2520.6093055576416, 2480.7271200167966, 2495.31378870812, 2507.5361058204107, 2516.7105782835024, 2530.367408147963, 8834.0, 8913.108689131035, 8917.46495210283, 8920.464772113693, 8933.017368089504, 5346.5455436287575, 5534.75093620788, 5536.390996990368, 5542.0, 5549.805756798533, 3536.0, 3645.726570507196, 3693.538307711536, 3698.223373091654, 3711.2577484502935, 1036.75117971687, 1052.831546952484, 1056.271172890703, 1067.5783065689009, 1069.7218723132041, 11758.647240582795, 11763.411939388245, 11764.823527647091, 11778.764424711459, 11793.233439826385, 4832.9275060874115, 4879.316895634614, 4946.258061290835, 4960.975195124073, 4988.301637770715, 10132.696019119438, 10150.593976241016, 10151.441670708035, 10153.746156346151, 10156.542955567018, 5521.889562208733, 5528.585356098309, 5530.281063461724, 5531.944680553223, 5534.7786088556, 4392.934105988413, 4593.333966574828, 4755.405574303212, 4944.159492886218, 4952.430470495867, 3884.5726970033274, 3970.2258059678084, 3971.4439978403047, 4010.6590939769862, 4013.6989725770686, 1310.1353106949557, 1322.642886420661, 1326.4959315460255, 1335.1721932401972, 1341.496938648007, 1079.0935614084208, 1184.3012622552735, 1341.1081630715464, 1363.9045266831424, 1389.610908945497, 8296.668133274723, 8310.21052999964, 8344.332453403713, 8351.582420879053, 8351.832963340821, 534.6257619666171, 537.4813305160538, 1276.8212450256972, 1333.9066265361332, 1347.75066612675, 5162.199859021857, 6258.906116408258, 6430.453411459985, 6455.0, 6481.125048118538, 10389.324693894872, 10469.267151299488, 10697.144228461704, 10712.089472394933, 10714.571417143383, 10413.791724165474, 10433.113185379329, 10453.372797632015, 10500.212484063726, 10517.0, 8108.148644392254, 8174.7956301092945, 8319.916800832036, 8351.958240208882, 8364.749057528285, 8237.176282371955, 8241.340692744447, 8251.174882511701, 8268.0, 8271.793205169919, 9278.72163835086, 9320.974692783653, 9539.952300238454, 9542.856857147288, 9610.279229057709, 8175.468594541336, 9641.132298093205, 9779.070988256104, 9780.462074585967, 9941.552630131517, 6819.420349270367, 7055.153381594037, 7321.194668586345, 7549.282818132268, 7678.616069196406, 8254.752357429286, 8293.792655183668, 8313.418060735932, 8322.29260512839, 8377.910871586655, 7286.48994570375, 7354.301341372561, 7413.332800048021, 7548.849023019399, 7565.810854728676, 7267.236940121211, 7280.9271907280245, 7303.926960730325, 7325.597092159983, 7368.300011498899, 7693.769186924401, 7740.380769538536, 7787.182345853604, 7803.297703206738, 7818.960905195438, 6999.825004374931, 7014.5440546364325, 7063.293670632896, 7068.964655176691, 7082.114735658043, 7118.8932166018585, 7145.678444469907, 7175.533590316612, 7179.317964793337, 7180.676869540779], "unit": "score", "name": "mootools.html", "value": 4944.585656164723}, {"lowerIsBetter": false, "replicates": [325.45811224311524, 330.988829127017, 334.09293767421445, 337.21429070266277, 339.2925749811644, 6399.200099987502, 6416.454601358884, 6439.259485159208, 6488.286288508266, 6496.155499785022, 6371.789360021593, 6408.070829729698, 6409.551331406792, 6413.13422687937, 6415.550911436201, 3850.3646898261754, 4548.613367863735, 4648.465426475947, 4763.785629646674, 4835.468098509161, 3838.42423636454, 4781.90436191276, 4790.7604619769045, 4796.08874313881, 4824.686395384307, 4736.739479328636, 4746.193147164973, 4753.762311884409, 4768.308595253686, 4769.52304769522, 4538.1377538267625, 4632.60622847055, 4642.025174713297, 4653.6509761768, 4661.394018777537, 4065.1056767511395, 4087.346024636044, 4098.426220329156, 4103.548609652966, 4107.158032603309, 6064.787732429344, 6066.908996365058, 6079.6960151992225, 6107.26712794463, 6113.847153821145, 5286.894262114736, 5621.437856214387, 5639.68981706006, 5651.4913657770585, 5658.207850900877, 6822.863542729117, 6838.111045564095, 6839.897401538981, 6843.520953533254, 6847.417969472601, 4310.094880075188, 4463.955360446386, 4503.684742068057, 4512.0, 4512.887177820548, 6964.0, 7244.673989670478, 7259.274072592699, 7262.891056634155, 7266.927330726678, 4585.380973568593, 4587.128445595326, 4589.242774942164, 4592.334111553872, 4593.379893714306, 4628.884277893012, 4633.652476064309, 4636.5131661175765, 4636.930446043245, 4639.512851150648, 5464.371597266365, 5481.945180548223, 5496.587755918322, 5499.432661691399, 5521.806736764194, 6449.709763060673, 6625.933740662628, 6877.931220687729, 6884.65576721162, 6893.517453778288, 1583.3983086427315, 1599.720048991422, 1600.0719582642039, 1611.8952268102537, 1612.4598259583172, 1021.2238698589126, 1028.3572767020612, 1036.0571879589538, 1045.6810672744887, 1050.3750268590177, 5636.0, 6094.390560943959, 6231.470325022333, 6430.967845160744, 6540.2805691373915, 7141.750038748619, 7151.249118842551, 7154.606496642735, 7164.570125792469, 7175.712971481083, 6504.15445992018, 6504.674766261668, 6514.4462720668325, 6515.51133664977, 6519.934800651933, 3726.571444283888, 3767.416050512175, 3772.830222639988, 3780.0360907968293, 3783.3000894834545, 6080.0, 7305.634718264066, 7461.888071678929, 7576.5832879191075, 7597.810054748676, 6700.698468568926, 7336.193018767931, 7406.703731850774, 7407.8888816667795, 7409.147947985943, 7566.432517561095, 7568.772936812014, 7588.772336829904, 7601.543907365576, 7637.0, 7133.3936615388275, 7133.5719856808755, 7138.286171382821, 7139.643017849191, 7157.856842863218, 6789.626570538668, 6977.895331569929, 7036.366726994595, 7036.788896333118, 7050.471214659024, 7464.626768661654, 7516.549007059594, 7528.548287102572, 7529.322360987538, 7534.849303014019, 4118.784958437328, 4479.977600111979, 4558.475775285752, 4561.771911404483, 4567.497575266651, 6562.507811914221, 7013.509054366349, 7019.824504387431, 7056.15326160864, 7066.893996590158, 6627.602343859384, 6795.626240556817, 6809.625470599165, 6906.585604863724, 6939.6877140529805, 6803.353681400259, 6888.758893438706, 6897.379235868796, 6904.551204171713, 6916.792496225121, 6731.46148308144, 6732.764353247613, 6735.5621884579305, 6742.426893713893, 6752.291009444134, 6851.109355783717, 6902.344277293649, 6914.274001229798, 6917.827054323682, 6929.480288978246, 5825.79609713658, 6257.9674353731125, 6505.447037001719, 6621.33786621334, 6687.431568316748], "unit": "score", "name": "prototype.html", "value": 5026.164667266715}, {"lowerIsBetter": false, "replicates": [592.8081191950081, 699.9440044796416, 726.2592156000883, 739.101991080837, 769.9114601820793, 14736.115833050011, 15005.62485937852, 15021.699566008674, 15023.549293521184, 15026.549203523899, 13799.31003449826, 15737.370505179808, 16158.868879178463, 16195.676086478294, 16197.514074577752, 717.3543810570476, 727.1710250314645, 916.0335845682802, 921.0513171433435, 936.6347124621403, 909.5088652127876, 918.6371383303591, 919.9816003679922, 922.9077092290751, 924.6994726713845, 977.7018009507098, 980.0444566547594, 980.4901451245383, 982.2093214961989, 990.7572644702058, 776.5884081436848, 788.1881661888265, 790.7430085222268, 972.6158167523823, 986.2110311750607, 713.4470785141505, 716.1012928774406, 716.3624374306871, 717.9964100179466, 720.0818955831305, 15394.307256173499, 15484.45804396852, 15488.457903973307, 15506.0, 15510.379584816594, 12289.0, 12312.199707019015, 12333.753324933452, 12386.442610082568, 12545.811812822814, 9974.501274936296, 9999.70182779564, 10090.890002099763, 10113.039261270167, 10405.323653962469, 3049.5120780674984, 3410.6589341065696, 3460.377132116218, 3501.859925602973, 3504.912377190565, 84967.99999999939, 84991.57504212439, 86070.13929860684, 86073.56963215144, 86108.13891861064, 9253.72238832836, 9327.113924177193, 9345.672901448417, 9457.527123643791, 9645.855312170323, 21110.683339749918, 21192.36422907315, 21198.47003824917, 21200.0, 21235.362939111852, 7196.244394338623, 7288.744893928793, 7307.707691692272, 7361.852762944711, 7479.513831600929, 4072.775997320176, 4119.361498967664, 4124.030852749602, 4126.8761937141935, 4131.9173616528105, 3541.1678255609913, 3568.286342731464, 3602.4776407420777, 3606.098475381155, 3612.096975756061, 636.2142753699178, 639.8304449320933, 665.8501837086714, 688.6281408039703, 726.691156258588, 534.8101423994426, 580.2282963658324, 594.9553783466257, 601.2964831147568, 606.3966353478318, 6842.905135178347, 7880.881786773203, 7916.445848790529, 8127.552984585905, 8259.710910118118, 508.36200568286563, 596.8448203467043, 600.3456232706371, 605.6214865708932, 626.0796628955428, 3634.67287944081, 3718.2749363873786, 3790.2040571479747, 3847.7498962567342, 4033.0, 95832.52083739676, 95991.0, 96762.51618741862, 97002.0, 98457.50771246241, 72294.2770572298, 72861.63569182226, 77267.61366193245, 77726.0, 80424.0, 68209.65895170493, 68467.0, 69566.0, 70637.99999999897, 71806.20484487824, 7566.167721550735, 7578.317951384402, 7642.426817988784, 7823.726169584037, 8064.637091331021, 48897.75551122364, 48899.51100489092, 49816.0, 51051.2342314873, 51847.0, 67336.0, 68146.65926670335, 69218.0, 71895.0, 72697.54604907766, 10160.644377446753, 10206.897931020892, 10377.273590848568, 10592.099671528007, 11181.776364472827, 10742.409167495864, 10931.125509959344, 10962.0, 11280.605178818701, 11624.360660163773, 8681.435706679045, 10125.64560240388, 10237.232207584311, 10263.589456421958, 10462.110720588835, 10448.268621196443, 10476.79046419052, 10502.317349372266, 10713.303635263683, 10768.676939691823, 10043.497825108861, 10210.43842588635, 10301.227407944285, 10422.0, 10429.53067111997, 8744.213020828156, 8858.15847494487, 8940.910590894007, 8975.192232698828, 9026.413283136575, 8514.361422893431, 8531.23218910301, 8649.962004559493, 8777.913636656125, 8783.736487905373], "unit": "score", "name": "yui.html", "value": 6788.588190730874}], "name": "dromaeo_css", "value": 7480.439771235412}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 109.0, 111.0, 112.0, 114.0, 162.0, 165.0, 158.0, 110.0], "unit": "score", "name": "ai-astar", "value": 126.2}, {"lowerIsBetter": true, "replicates": [174.0, 154.0, 139.0, 160.0, 121.0, 141.0, 138.0, 119.0, 150.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 185.0, 183.0, 188.0, 186.0, 184.0, 183.0, 183.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [83.0, 94.0, 113.0, 105.0, 57.0, 56.0, 58.0, 78.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 77.7}, {"lowerIsBetter": true, "replicates": [93.0, 97.0, 132.0, 79.0, 80.0, 77.0, 115.0, 77.0, 80.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 85.0, 89.0, 124.0, 89.0, 86.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 92.0, 94.0, 93.0, 93.0, 94.0, 95.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.3}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 86.0, 88.0, 85.0, 86.0, 87.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 54.0, 51.0, 54.0, 54.0, 55.0, 64.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 67.0, 75.0, 70.0, 66.0, 67.0, 67.0, 66.0, 76.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 81.0, 81.0, 83.0, 83.0, 82.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [131.0, 120.0, 133.0, 132.0, 118.0, 121.0, 133.0, 130.0, 131.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 137.0, 138.0, 138.0, 129.0, 137.0, 140.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 70.0, 67.0, 67.0, 68.0, 69.0, 84.0, 95.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.2}], "name": "kraken", "value": 1438.6000000000001}]} 11:47:43 INFO - Return code: 0 11:47:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:47:43 ERROR - # TBPL SUCCESS # 11:47:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:47:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:47:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:47:43 INFO - 2016-03-15 11:47:43.805 screenresolution[1685:9625] starting screenresolution argv=screenresolution get 11:47:43 INFO - 2016-03-15 11:47:43.807 screenresolution[1685:9625] Display 0: 1600x1200x32@60 11:47:43 INFO - 2016-03-15 11:47:43.813 screenresolution[1686:9628] starting screenresolution argv=screenresolution list 11:47:43 INFO - Available Modes on Display 0 11:47:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:47:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:47:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:47:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:47:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:47:44 INFO - Intel Iris: 11:47:44 INFO - Chipset Model: Intel Iris 11:47:44 INFO - Type: GPU 11:47:44 INFO - Bus: Built-In 11:47:44 INFO - VRAM (Dynamic, Max): 1536 MB 11:47:44 INFO - Vendor: Intel (0x8086) 11:47:44 INFO - Device ID: 0x0a2e 11:47:44 INFO - Revision ID: 0x0009 11:47:44 INFO - Displays: 11:47:44 INFO - Display: 11:47:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:47:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:47:44 INFO - Display Serial Number: 1600x1200 60 11:47:44 INFO - Main Display: Yes 11:47:44 INFO - Mirror: Off 11:47:44 INFO - Online: Yes 11:47:44 INFO - Rotation: Supported 11:47:44 INFO - Return code: 0 11:47:44 INFO - Running post-action listener: _resource_record_post_action 11:47:44 INFO - Running post-run listener: _resource_record_post_run 11:47:45 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 38729216; Write bytes: 703588864; Read time: 426; Write time: 2012 11:47:45 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391375360; Write bytes: 385033728; Read time: 29834; Write time: 733 11:47:45 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36902400; Write bytes: 299119616; Read time: 405; Write time: 1234 11:47:45 INFO - Running post-run listener: _upload_blobber_files 11:47:45 INFO - Blob upload gear active. 11:47:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:47:45 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 11:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:47:45 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:46 INFO - (blobuploader) - INFO - Done attempting. 11:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:47 INFO - (blobuploader) - INFO - Done attempting. 11:47:47 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:47 INFO - Return code: 0 11:47:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598961ef02cd449abb25f9e16678758344e9f29131aff49e13e062da09f22e772a9e6376d81c1bbba79ae1a70cfaece5be6cbda8cc218ba10025e2af6fe206e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9998fdeeb7fd39c916df94f3f470b78bad837f84fc98beb939daf1a9a27a1e2605b8497c169e32f85fff875f7900da3b3a0d8ab4bc42bfd1b692fe8259d11b0"} 11:47:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:47 INFO - Contents: 11:47:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598961ef02cd449abb25f9e16678758344e9f29131aff49e13e062da09f22e772a9e6376d81c1bbba79ae1a70cfaece5be6cbda8cc218ba10025e2af6fe206e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9998fdeeb7fd39c916df94f3f470b78bad837f84fc98beb939daf1a9a27a1e2605b8497c169e32f85fff875f7900da3b3a0d8ab4bc42bfd1b692fe8259d11b0"} 11:47:47 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:47 INFO - Copying logs to upload dir... 11:47:47 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.050115 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-15 11:47:47.563451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 11:47:47.567333) ========= 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.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598961ef02cd449abb25f9e16678758344e9f29131aff49e13e062da09f22e772a9e6376d81c1bbba79ae1a70cfaece5be6cbda8cc218ba10025e2af6fe206e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9998fdeeb7fd39c916df94f3f470b78bad837f84fc98beb939daf1a9a27a1e2605b8497c169e32f85fff875f7900da3b3a0d8ab4bc42bfd1b692fe8259d11b0"} build_url:https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/YX70UTJETY26nLIlVo6eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/598961ef02cd449abb25f9e16678758344e9f29131aff49e13e062da09f22e772a9e6376d81c1bbba79ae1a70cfaece5be6cbda8cc218ba10025e2af6fe206e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9998fdeeb7fd39c916df94f3f470b78bad837f84fc98beb939daf1a9a27a1e2605b8497c169e32f85fff875f7900da3b3a0d8ab4bc42bfd1b692fe8259d11b0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 11:47:47.605579) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:47:47.605906) ========= 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.L78wPTJWfk/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.lF3hgMysMU/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 11:47:47.658640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 11:47:47.658951) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 11:47:47.659300) ========= ========= Total master_lag: 4.84 =========