builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0078 starttime: 1455715222.81 results: success (0) buildid: 20160217033051 builduid: a7e49e78cc244c62b54f1532371d56ee revision: f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:20:22.807310) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 05:20:22.807677) ========= ========= Started set props: basedir (results: 0, elapsed: 6 secs) (at 2016-02-17 05:20:22.807983) ========= 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.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005468 basedir: '/builds/slave/test' ========= master_lag: 6.44 ========= ========= Finished set props: basedir (results: 0, elapsed: 6 secs) (at 2016-02-17 05:20:29.252804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 17 secs) (at 2016-02-17 05:20:29.253101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 17 secs) (at 2016-02-17 05:20:46.889030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 05:20:46.889278) ========= 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.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.006226 ========= master_lag: 1.93 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 05:20:48.829487) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:20:48.829749) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 05:20:48.830079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-17 05:20:48.830346) ========= 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.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-02-17 05:20:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2016-02-17 05:20:49 (14.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.498745 ========= master_lag: 2.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-17 05:20:51.526300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:20:51.526649) ========= 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.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.026814 ========= master_lag: 0.29 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:20:51.841828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-02-17 05:20:51.842145) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8 --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 f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-02-17 05:20:52,135 truncating revision to first 12 chars 2016-02-17 05:20:52,135 Setting DEBUG logging. 2016-02-17 05:20:52,135 attempt 1/10 2016-02-17 05:20:52,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9fc67134ca0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 05:20:52,786 unpacking tar archive at: fx-team-f9fc67134ca0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.905910 ========= master_lag: 11.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2016-02-17 05:21:03.835955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:21:03.836276) ========= echo f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8 program finished with exit code 0 elapsedTime=0.005765 script_repo_revision: 'f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8' ========= master_lag: 0.78 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 05:21:04.622137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-02-17 05:21:04.622405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-02-17 05:21:09.282080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-17 05:21:09.282349) ========= /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.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:21:09 INFO - MultiFileLogger online at 20160217 05:21:09 in /builds/slave/test 05:21:09 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 05:21:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:09 INFO - {'append_to_log': False, 05:21:09 INFO - 'base_work_dir': '/builds/slave/test', 05:21:09 INFO - 'blob_upload_branch': 'Fx-Team', 05:21:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:09 INFO - 'branch': 'Fx-Team', 05:21:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:09 INFO - 'config_files': ('talos/mac_config.py',), 05:21:09 INFO - 'default_actions': ('clobber', 05:21:09 INFO - 'read-buildbot-config', 05:21:09 INFO - 'download-and-extract', 05:21:09 INFO - 'populate-webroot', 05:21:09 INFO - 'create-virtualenv', 05:21:09 INFO - 'install', 05:21:09 INFO - 'run-tests'), 05:21:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:09 INFO - 'download_minidump_stackwalk': True, 05:21:09 INFO - 'download_symbols': 'ondemand', 05:21:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:09 INFO - 'installer_path': 'installer.exe', 05:21:09 INFO - 'log_level': 'info', 05:21:09 INFO - 'log_name': 'talos', 05:21:09 INFO - 'log_to_console': True, 05:21:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:21:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:21:09 INFO - 'opt_config_files': (), 05:21:09 INFO - 'pip_index': False, 05:21:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:09 INFO - 'cmd': ('bash', 05:21:09 INFO - '-c', 05:21:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:09 INFO - 'enabled': True, 05:21:09 INFO - 'halt_on_failure': False, 05:21:09 INFO - 'name': 'check_screen_resolution'},), 05:21:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:09 INFO - 'cmd': ('bash', 05:21:09 INFO - '-c', 05:21:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:09 INFO - 'enabled': True, 05:21:09 INFO - 'halt_on_failure': False, 05:21:09 INFO - 'name': 'check_screen_resolution'},), 05:21:09 INFO - 'run_cmd_checks_enabled': True, 05:21:09 INFO - 'sps_profile': False, 05:21:09 INFO - 'sps_profile_interval': 0, 05:21:09 INFO - 'suite': 'dromaeojs', 05:21:09 INFO - 'system_bits': '32', 05:21:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:09 INFO - 'title': 't-yosemite-r7-0078', 05:21:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:09 INFO - 'use_talos_json': True, 05:21:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:09 INFO - 'work_dir': 'build'} 05:21:09 INFO - ##### 05:21:09 INFO - ##### Running clobber step. 05:21:09 INFO - ##### 05:21:09 INFO - Running pre-action listener: _resource_record_pre_action 05:21:09 INFO - Running main action method: clobber 05:21:09 INFO - rmtree: /builds/slave/test/build 05:21:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:11 INFO - Running post-action listener: _resource_record_post_action 05:21:11 INFO - ##### 05:21:11 INFO - ##### Running read-buildbot-config step. 05:21:11 INFO - ##### 05:21:11 INFO - Running pre-action listener: _resource_record_pre_action 05:21:11 INFO - Running main action method: read_buildbot_config 05:21:11 INFO - Using buildbot properties: 05:21:11 INFO - { 05:21:11 INFO - "project": "", 05:21:11 INFO - "product": "firefox", 05:21:11 INFO - "script_repo_revision": "production", 05:21:11 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:21:11 INFO - "repository": "", 05:21:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:21:11 INFO - "buildid": "20160217033051", 05:21:11 INFO - "pgo_build": "False", 05:21:11 INFO - "basedir": "/builds/slave/test", 05:21:11 INFO - "buildnumber": 375, 05:21:11 INFO - "slavename": "t-yosemite-r7-0078", 05:21:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:21:11 INFO - "platform": "yosemite_r7", 05:21:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:21:11 INFO - "branch": "fx-team", 05:21:11 INFO - "repo_path": "integration/fx-team", 05:21:11 INFO - "revision": "f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8", 05:21:11 INFO - "stage_platform": "macosx64", 05:21:11 INFO - "builduid": "a7e49e78cc244c62b54f1532371d56ee", 05:21:11 INFO - "slavebuilddir": "test" 05:21:11 INFO - } 05:21:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:21:11 INFO - Running post-action listener: _resource_record_post_action 05:21:11 INFO - ##### 05:21:11 INFO - ##### Running download-and-extract step. 05:21:11 INFO - ##### 05:21:11 INFO - Running pre-action listener: _resource_record_pre_action 05:21:11 INFO - Running main action method: download_and_extract 05:21:11 INFO - mkdir: /builds/slave/test/build/tests 05:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:11 INFO - https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:21:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/test_packages.json 05:21:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/test_packages.json 05:21:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:21:17 INFO - Downloaded 1277 bytes. 05:21:17 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:21:17 INFO - Using the following test package requirements: 05:21:17 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:21:17 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:21:17 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:21:17 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'jsshell-mac.zip'], 05:21:17 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:21:17 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:21:17 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:21:17 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:21:17 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:21:17 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:21:17 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:21:17 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:21:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:17 INFO - https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:18 INFO - Downloaded 17806602 bytes. 05:21:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:22 INFO - Return code: 0 05:21:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:21: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')]} 05:21:22 INFO - https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:24 INFO - Downloaded 17806602 bytes. 05:21:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:27 INFO - Return code: 0 05:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:27 INFO - https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:21:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:21:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:21:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:21:29 INFO - Downloaded 10707071 bytes. 05:21:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:21:29 INFO - Return code: 0 05:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:29 INFO - https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 05:21:39 INFO - Downloaded 111231132 bytes. 05:21:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:21:39 INFO - mkdir: /builds/slave/test/properties 05:21:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:39 INFO - Contents: 05:21:39 INFO - build_url:https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:21:40 INFO - Running post-action listener: _resource_record_post_action 05:21:40 INFO - Running post-action listener: set_extra_try_arguments 05:21:40 INFO - ##### 05:21:40 INFO - ##### Running populate-webroot step. 05:21:40 INFO - ##### 05:21:40 INFO - Running pre-action listener: _resource_record_pre_action 05:21:40 INFO - Running main action method: populate_webroot 05:21:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:40 INFO - '--tppagecycles', 05:21:40 INFO - '7'], 05:21:40 INFO - 'tests': ['tsvgm']}}, 05:21:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:21:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:21:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'tests': ['damp', 'tps']}, 05:21:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['damp', 'tps']}, 05:21:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:21:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:40 INFO - 'other': {'tests': ['a11yr', 05:21:40 INFO - 'ts_paint', 05:21:40 INFO - 'tpaint', 05:21:40 INFO - 'sessionrestore', 05:21:40 INFO - 'sessionrestore_no_auto_restore']}, 05:21:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['a11yr', 05:21:40 INFO - 'ts_paint', 05:21:40 INFO - 'tpaint', 05:21:40 INFO - 'sessionrestore', 05:21:40 INFO - 'sessionrestore_no_auto_restore']}, 05:21:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['a11yr', 05:21:40 INFO - 'ts_paint', 05:21:40 INFO - 'tpaint', 05:21:40 INFO - 'sessionrestore', 05:21:40 INFO - 'sessionrestore_no_auto_restore']}, 05:21:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['a11yr', 05:21:40 INFO - 'ts_paint', 05:21:40 INFO - 'tpaint', 05:21:40 INFO - 'sessionrestore', 05:21:40 INFO - 'sessionrestore_no_auto_restore']}, 05:21:40 INFO - 'other_l64': {'tests': ['a11yr', 05:21:40 INFO - 'ts_paint', 05:21:40 INFO - 'tpaint', 05:21:40 INFO - 'sessionrestore', 05:21:40 INFO - 'sessionrestore_no_auto_restore']}, 05:21:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:21:40 INFO - 'ts_paint', 05:21:40 INFO - 'tpaint', 05:21:40 INFO - 'sessionrestore', 05:21:40 INFO - 'sessionrestore_no_auto_restore']}, 05:21:40 INFO - 'svgr': {'tests': ['tsvgx', 05:21:40 INFO - 'tsvgr_opacity', 05:21:40 INFO - 'tart', 05:21:40 INFO - 'tscrollx', 05:21:40 INFO - 'cart']}, 05:21:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['tsvgx', 05:21:40 INFO - 'tsvgr_opacity', 05:21:40 INFO - 'tart', 05:21:40 INFO - 'tscrollx', 05:21:40 INFO - 'cart']}, 05:21:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'tests': ['tp5o']}, 05:21:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'talos_options': ['--e10s'], 05:21:40 INFO - 'tests': ['tp5o']}, 05:21:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'talos_options': ['--xperf_path', 05:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:40 INFO - 'tests': ['tp5n']}, 05:21:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:40 INFO - 'talos_options': ['--e10s', 05:21:40 INFO - '--xperf_path', 05:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:40 INFO - 'tests': ['tp5n']}}, 05:21:40 INFO - 'talos.zip': {'path': '', 05:21:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:40 INFO - Running post-action listener: _resource_record_post_action 05:21:40 INFO - ##### 05:21:40 INFO - ##### Running create-virtualenv step. 05:21:40 INFO - ##### 05:21:40 INFO - Running pre-action listener: _resource_record_pre_action 05:21:40 INFO - Running main action method: create_virtualenv 05:21:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:21:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:40 INFO - Using real prefix '/tools/python27' 05:21:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:44 INFO - Installing pip.................done. 05:21:44 INFO - Return code: 0 05:21:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:44 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 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:44 INFO - 'HOME': '/Users/cltbld', 05:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:44 INFO - 'LOGNAME': 'cltbld', 05:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:44 INFO - 'MOZ_NO_REMOTE': '1', 05:21:44 INFO - 'NO_EM_RESTART': '1', 05:21:44 INFO - 'PAGER': '/bin/cat', 05:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:44 INFO - 'PWD': '/builds/slave/test', 05:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:44 INFO - 'SHELL': '/bin/bash', 05:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:21:44 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:44 INFO - 'USER': 'cltbld', 05:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:44 INFO - 'XPC_FLAGS': '0x0', 05:21:44 INFO - 'XPC_SERVICE_NAME': '0', 05:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:21:44 INFO - Cleaning up... 05:21:44 INFO - Return code: 0 05:21:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:44 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 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:44 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 05:21:44 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 05:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:44 INFO - 'HOME': '/Users/cltbld', 05:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:44 INFO - 'LOGNAME': 'cltbld', 05:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:44 INFO - 'MOZ_NO_REMOTE': '1', 05:21:44 INFO - 'NO_EM_RESTART': '1', 05:21:44 INFO - 'PAGER': '/bin/cat', 05:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:44 INFO - 'PWD': '/builds/slave/test', 05:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:44 INFO - 'SHELL': '/bin/bash', 05:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:21:44 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:44 INFO - 'USER': 'cltbld', 05:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:44 INFO - 'XPC_FLAGS': '0x0', 05:21:44 INFO - 'XPC_SERVICE_NAME': '0', 05:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:44 INFO - Downloading/unpacking psutil>=0.7.1 05:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:47 INFO - Installing collected packages: psutil 05:21:47 INFO - Running setup.py install for psutil 05:21:47 INFO - building 'psutil._psutil_osx' extension 05:21:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:21:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:21:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:21:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:21:48 INFO - building 'psutil._psutil_posix' extension 05:21:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:21:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:21:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:21:48 INFO - ^ 05:21:48 INFO - 1 warning generated. 05:21:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:21:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:49 INFO - Successfully installed psutil 05:21:49 INFO - Cleaning up... 05:21:49 INFO - Return code: 0 05:21:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:49 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 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:49 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 05:21:49 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 05:21:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:21:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:49 INFO - 'HOME': '/Users/cltbld', 05:21:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:49 INFO - 'LOGNAME': 'cltbld', 05:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:49 INFO - 'MOZ_NO_REMOTE': '1', 05:21:49 INFO - 'NO_EM_RESTART': '1', 05:21:49 INFO - 'PAGER': '/bin/cat', 05:21:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:49 INFO - 'PWD': '/builds/slave/test', 05:21:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:49 INFO - 'SHELL': '/bin/bash', 05:21:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:21:49 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:21:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:49 INFO - 'USER': 'cltbld', 05:21:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:49 INFO - 'XPC_FLAGS': '0x0', 05:21:49 INFO - 'XPC_SERVICE_NAME': '0', 05:21:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:21:51 INFO - Installing collected packages: mozsystemmonitor 05:21:51 INFO - Running setup.py install for mozsystemmonitor 05:21:51 INFO - Successfully installed mozsystemmonitor 05:21:51 INFO - Cleaning up... 05:21:52 INFO - Return code: 0 05:21:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:52 INFO - 'HOME': '/Users/cltbld', 05:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:52 INFO - 'LOGNAME': 'cltbld', 05:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:52 INFO - 'MOZ_NO_REMOTE': '1', 05:21:52 INFO - 'NO_EM_RESTART': '1', 05:21:52 INFO - 'PAGER': '/bin/cat', 05:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:52 INFO - 'PWD': '/builds/slave/test', 05:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:52 INFO - 'SHELL': '/bin/bash', 05:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:21:52 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:52 INFO - 'USER': 'cltbld', 05:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:52 INFO - 'XPC_FLAGS': '0x0', 05:21:52 INFO - 'XPC_SERVICE_NAME': '0', 05:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:55 INFO - Downloading docopt-0.6.1.tar.gz 05:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:55 INFO - Running setup.py install for blobuploader 05:21:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:55 INFO - Running setup.py install for requests 05:21:56 INFO - Running setup.py install for docopt 05:21:56 INFO - Successfully installed blobuploader requests docopt 05:21:56 INFO - Cleaning up... 05:21:56 INFO - Return code: 0 05:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:56 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 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:56 INFO - 'HOME': '/Users/cltbld', 05:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:56 INFO - 'LOGNAME': 'cltbld', 05:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:56 INFO - 'MOZ_NO_REMOTE': '1', 05:21:56 INFO - 'NO_EM_RESTART': '1', 05:21:56 INFO - 'PAGER': '/bin/cat', 05:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:56 INFO - 'PWD': '/builds/slave/test', 05:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:56 INFO - 'SHELL': '/bin/bash', 05:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:21:56 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:56 INFO - 'USER': 'cltbld', 05:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:56 INFO - 'XPC_FLAGS': '0x0', 05:21:56 INFO - 'XPC_SERVICE_NAME': '0', 05:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-JNGyzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-OW7O4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-F99zOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-m9vz7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-zDTt_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7FF8QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-nnkEjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-6TAsSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-5qngSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-cawpa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-hVB9Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-8ABXBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-KrNrRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-L_wV65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-NPv9Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-WFEhFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-5MHtVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:58 INFO - Running setup.py install for manifestparser 05:21:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:58 INFO - Running setup.py install for mozcrash 05:21:59 INFO - Running setup.py install for mozdebug 05:21:59 INFO - Running setup.py install for mozdevice 05:21:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Running setup.py install for mozfile 05:21:59 INFO - Running setup.py install for mozhttpd 05:21:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Running setup.py install for mozinfo 05:21:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Running setup.py install for mozInstall 05:21:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:59 INFO - Running setup.py install for mozleak 05:22:00 INFO - Running setup.py install for mozlog 05:22:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:00 INFO - Running setup.py install for moznetwork 05:22:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:00 INFO - Running setup.py install for mozprocess 05:22:00 INFO - Running setup.py install for mozprofile 05:22:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:00 INFO - Running setup.py install for mozrunner 05:22:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:00 INFO - Running setup.py install for mozscreenshot 05:22:00 INFO - Running setup.py install for moztest 05:22:01 INFO - Running setup.py install for mozversion 05:22:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:01 INFO - Cleaning up... 05:22:01 INFO - Return code: 0 05:22:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:22:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:22:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:01 INFO - 'HOME': '/Users/cltbld', 05:22:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:01 INFO - 'LOGNAME': 'cltbld', 05:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:01 INFO - 'MOZ_NO_REMOTE': '1', 05:22:01 INFO - 'NO_EM_RESTART': '1', 05:22:01 INFO - 'PAGER': '/bin/cat', 05:22:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:01 INFO - 'PWD': '/builds/slave/test', 05:22:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:01 INFO - 'SHELL': '/bin/bash', 05:22:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:22:01 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:22:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:01 INFO - 'USER': 'cltbld', 05:22:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:01 INFO - 'XPC_FLAGS': '0x0', 05:22:01 INFO - 'XPC_SERVICE_NAME': '0', 05:22:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-fW7AV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-x2t7qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-RDXn68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-6Hk22j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-21QCzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-WEAXZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-T0IGvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-sM6btL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-u7w9h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-i7Xk31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:02 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)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pw6cNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-wRM97W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-w2OfVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-UUZMsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-PAmfpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-5Tc2dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-WjxrEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:22:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:05 INFO - Downloading blessings-1.6.tar.gz 05:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:05 INFO - Installing collected packages: blessings 05:22:05 INFO - Running setup.py install for blessings 05:22:05 INFO - Successfully installed blessings 05:22:05 INFO - Cleaning up... 05:22:06 INFO - Return code: 0 05:22:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:06 INFO - Reading from file tmpfile_stdout 05:22:06 INFO - Current package versions: 05:22:06 INFO - blessings == 1.6 05:22:06 INFO - blobuploader == 1.2.4 05:22:06 INFO - docopt == 0.6.1 05:22:06 INFO - manifestparser == 1.1 05:22:06 INFO - mozInstall == 1.12 05:22:06 INFO - mozcrash == 0.16 05:22:06 INFO - mozdebug == 0.1 05:22:06 INFO - mozdevice == 0.48 05:22:06 INFO - mozfile == 1.2 05:22:06 INFO - mozhttpd == 0.7 05:22:06 INFO - mozinfo == 0.9 05:22:06 INFO - mozleak == 0.1 05:22:06 INFO - mozlog == 3.1 05:22:06 INFO - moznetwork == 0.27 05:22:06 INFO - mozprocess == 0.22 05:22:06 INFO - mozprofile == 0.28 05:22:06 INFO - mozrunner == 6.11 05:22:06 INFO - mozscreenshot == 0.1 05:22:06 INFO - mozsystemmonitor == 0.0 05:22:06 INFO - moztest == 0.7 05:22:06 INFO - mozversion == 1.4 05:22:06 INFO - psutil == 3.1.1 05:22:06 INFO - requests == 1.2.3 05:22:06 INFO - wsgiref == 0.1.2 05:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22: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')]} 05:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:06 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 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:06 INFO - 'HOME': '/Users/cltbld', 05:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:06 INFO - 'LOGNAME': 'cltbld', 05:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:06 INFO - 'MOZ_NO_REMOTE': '1', 05:22:06 INFO - 'NO_EM_RESTART': '1', 05:22:06 INFO - 'PAGER': '/bin/cat', 05:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:06 INFO - 'PWD': '/builds/slave/test', 05:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:06 INFO - 'SHELL': '/bin/bash', 05:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:22:06 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:06 INFO - 'USER': 'cltbld', 05:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:06 INFO - 'XPC_FLAGS': '0x0', 05:22:06 INFO - 'XPC_SERVICE_NAME': '0', 05:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:22:06 INFO - Cleaning up... 05:22:06 INFO - Return code: 0 05:22:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22: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')]} 05:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22: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', 'jsonschema'] in /builds/slave/test/build 05:22: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 jsonschema 05:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:06 INFO - 'HOME': '/Users/cltbld', 05:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:06 INFO - 'LOGNAME': 'cltbld', 05:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:06 INFO - 'MOZ_NO_REMOTE': '1', 05:22:06 INFO - 'NO_EM_RESTART': '1', 05:22:06 INFO - 'PAGER': '/bin/cat', 05:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:06 INFO - 'PWD': '/builds/slave/test', 05:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:06 INFO - 'SHELL': '/bin/bash', 05:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:22:06 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:06 INFO - 'USER': 'cltbld', 05:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:06 INFO - 'XPC_FLAGS': '0x0', 05:22:06 INFO - 'XPC_SERVICE_NAME': '0', 05:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:06 INFO - Downloading/unpacking jsonschema 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:09 INFO - warning: no files found matching '*.txt' 05:22:09 INFO - no previously-included directories found matching 'build' 05:22:09 INFO - no previously-included directories found matching 'dist' 05:22:09 INFO - no previously-included directories found matching '.git*' 05:22:09 INFO - Installing collected packages: jsonschema, functools32 05:22:09 INFO - Running setup.py install for functools32 05:22:10 INFO - warning: no files found matching '*.txt' 05:22:10 INFO - no previously-included directories found matching 'build' 05:22:10 INFO - no previously-included directories found matching 'dist' 05:22:10 INFO - no previously-included directories found matching '.git*' 05:22:10 INFO - Successfully installed jsonschema functools32 05:22:10 INFO - Cleaning up... 05:22:10 INFO - Return code: 0 05:22:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:22: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')]} 05:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101ec5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ecd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3a1d9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, '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.XmcAvWpj0J/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.OhnxdUshuh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:22: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', 'flake8'] in /builds/slave/test/build 05:22: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 flake8 05:22:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:22:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:10 INFO - 'HOME': '/Users/cltbld', 05:22:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:10 INFO - 'LOGNAME': 'cltbld', 05:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:10 INFO - 'MOZ_NO_REMOTE': '1', 05:22:10 INFO - 'NO_EM_RESTART': '1', 05:22:10 INFO - 'PAGER': '/bin/cat', 05:22:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:10 INFO - 'PWD': '/builds/slave/test', 05:22:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:10 INFO - 'SHELL': '/bin/bash', 05:22:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:22:10 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:22:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:10 INFO - 'USER': 'cltbld', 05:22:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:10 INFO - 'XPC_FLAGS': '0x0', 05:22:10 INFO - 'XPC_SERVICE_NAME': '0', 05:22:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:10 INFO - Downloading/unpacking flake8 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:22:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:22:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:13 INFO - no previously-included directories found matching 'docs/_build' 05:22:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:22:14 INFO - Running setup.py install for pep8 05:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:14 INFO - no previously-included directories found matching 'docs/_build' 05:22:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:22:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:22:14 INFO - Cleaning up... 05:22:14 INFO - Return code: 0 05:22:14 INFO - Running post-action listener: _resource_record_post_action 05:22:14 INFO - Running post-action listener: _start_resource_monitoring 05:22:14 INFO - Starting resource monitoring. 05:22:14 INFO - ##### 05:22:14 INFO - ##### Running install step. 05:22:14 INFO - ##### 05:22:14 INFO - Running pre-action listener: _resource_record_pre_action 05:22:14 INFO - Running main action method: install 05:22:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:14 INFO - Reading from file tmpfile_stdout 05:22:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:14 INFO - Reading from file tmpfile_stdout 05:22:14 INFO - Output received: 05:22:14 INFO - Usage: mozinstall [options] installer 05:22:14 INFO - Options: 05:22:14 INFO - -h, --help show this help message and exit 05:22:14 INFO - -d DEST, --destination=DEST 05:22:14 INFO - Directory to install application into. [default: 05:22:14 INFO - "/builds/slave/test"] 05:22:14 INFO - --app=APP Application being installed. [default: firefox] 05:22:14 INFO - mkdir: /builds/slave/test/build/application 05:22:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:22:48 INFO - Reading from file tmpfile_stdout 05:22:48 INFO - Output received: 05:22:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:22:48 INFO - Running post-action listener: _resource_record_post_action 05:22:48 INFO - ##### 05:22:48 INFO - ##### Running run-tests step. 05:22:48 INFO - ##### 05:22:48 INFO - Running pre-action listener: _resource_record_pre_action 05:22:48 INFO - Running main action method: run_tests 05:22:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:22:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:22:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:22:48 INFO - 2016-02-17 05:22:48.391 screenresolution[1659:8206] starting screenresolution argv=screenresolution get 05:22:48 INFO - 2016-02-17 05:22:48.394 screenresolution[1659:8206] Display 0: 1600x1200x32@60 05:22:48 INFO - 2016-02-17 05:22:48.400 screenresolution[1660:8208] starting screenresolution argv=screenresolution list 05:22:48 INFO - Available Modes on Display 0 05:22:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:22:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:22:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:22:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:22:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:22:48 INFO - Intel Iris: 05:22:48 INFO - Chipset Model: Intel Iris 05:22:48 INFO - Type: GPU 05:22:48 INFO - Bus: Built-In 05:22:48 INFO - VRAM (Dynamic, Max): 1536 MB 05:22:48 INFO - Vendor: Intel (0x8086) 05:22:48 INFO - Device ID: 0x0a2e 05:22:48 INFO - Revision ID: 0x0009 05:22:48 INFO - Displays: 05:22:48 INFO - Display: 05:22:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:22:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:22:48 INFO - Display Serial Number: 1600x1200 60 05:22:48 INFO - Main Display: Yes 05:22:48 INFO - Mirror: Off 05:22:48 INFO - Online: Yes 05:22:48 INFO - Rotation: Supported 05:22:48 INFO - Return code: 0 05:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:48 INFO - Python 2.7.3 05:22:48 INFO - Return code: 0 05:22:48 INFO - grabbing minidump binary from tooltool 05:22: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')]} 05:22:48 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 0x101d69d30>, '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 0x101b8ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d60b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:22:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:22:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:48 INFO - Return code: 0 05:22:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:22:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:22:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:49 INFO - Return code: 0 05:22:49 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/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:22:49 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/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XmcAvWpj0J/Render', 05:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:49 INFO - 'HOME': '/Users/cltbld', 05:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:49 INFO - 'LOGNAME': 'cltbld', 05:22:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:49 INFO - 'MOZ_NO_REMOTE': '1', 05:22:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:49 INFO - 'NO_EM_RESTART': '1', 05:22:49 INFO - 'PAGER': '/bin/cat', 05:22:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:49 INFO - 'PWD': '/builds/slave/test', 05:22:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:49 INFO - 'SHELL': '/bin/bash', 05:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OhnxdUshuh/Listeners', 05:22:49 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:49 INFO - 'USER': 'cltbld', 05:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:49 INFO - 'XPC_FLAGS': '0x0', 05:22:49 INFO - 'XPC_SERVICE_NAME': '0', 05:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:49 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/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:22:50 INFO - mozversion application_buildid: 20160217033051 05:22:50 INFO - mozversion application_changeset: f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8 05:22:50 INFO - mozversion application_display_name: Nightly 05:22:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:50 INFO - mozversion application_name: Firefox 05:22:50 INFO - mozversion application_remotingname: firefox 05:22:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:50 INFO - mozversion application_vendor: Mozilla 05:22:50 INFO - mozversion application_version: 47.0a1 05:22:50 INFO - mozversion platform_buildid: 20160217033051 05:22:50 INFO - mozversion platform_changeset: f9fc67134ca0407c7d7b4f8cf19acbee021bfbc8 05:22:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:50 INFO - mozversion platform_version: 47.0a1 05:22:50 INFO - using testdate: 1455715370 05:22:50 INFO - actual date: 1455715370 05:22:50 INFO - starting webserver on 'localhost:49291' 05:22:50 INFO - SUITE-START | Running 2 tests 05:22:50 INFO - TEST-START | dromaeo_css 05:22:50 INFO - operating with platform_type : mac_ 05:22:50 INFO - Initialising browser for dromaeo_css test... 05:22:50 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp1MRZN3/profile http://localhost:49291/getInfo.html) 05:22:52 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 05:22:52 INFO - PROCESS | 1678 | colorDepth:24 05:22:52 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 05:22:52 INFO - PROCESS | 1678 | __metrics 05:22:53 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:22:53 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:53 INFO - TEST-INFO | 1678: exit 0 05:22:53 INFO - Browser initialized. 05:22:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:53 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp1MRZN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:05 INFO - PROCESS | 1681 | RSS: Main: 244400128 05:23:05 INFO - PROCESS | 1681 | 05:23:56 INFO - PROCESS | 1681 | 1455715436355 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:26:06 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49291/tests/dromaeo/cssquery-ext.html) 05:26:08 INFO - PROCESS | 1681 | RSS: Main: 430080000 05:26:08 INFO - PROCESS | 1681 | 05:29:11 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-ext.html (next: http://localhost:49291/tests/dromaeo/cssquery-jquery.html) 05:29:11 INFO - PROCESS | 1681 | RSS: Main: 379875328 05:29:11 INFO - PROCESS | 1681 | 05:32:13 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49291/tests/dromaeo/cssquery-mootools.html) 05:32:14 INFO - PROCESS | 1681 | RSS: Main: 376406016 05:32:14 INFO - PROCESS | 1681 | 05:35:16 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49291/tests/dromaeo/cssquery-prototype.html) 05:35:17 INFO - PROCESS | 1681 | RSS: Main: 337551360 05:35:17 INFO - PROCESS | 1681 | 05:38:20 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49291/tests/dromaeo/cssquery-yui.html) 05:38:20 INFO - PROCESS | 1681 | RSS: Main: 337711104 05:38:20 INFO - PROCESS | 1681 | 05:41:23 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-yui.html (next: http://localhost:49291/tests/dromaeo/cssquery-dojo.html) 05:41:24 INFO - PROCESS | 1681 | RSS: Main: 379645952 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | __start_tp_report 05:41:24 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 05:41:24 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 05:41:24 INFO - PROCESS | 1681 | |i|pagename|runs| 05:41:24 INFO - PROCESS | 1681 | |0;dojo.html;3221.806691598504;3346.29727757171;3424.811635360056;3498.1429549760305;3504.56192975878;5565.165225216219;5647.576431767613;5652.63257888238;5655.095184770433;5670.71646417679;5681.715914204284;5688.943110568893;5721.113227449741;5801.4198580141965;5804.245448091753;5095.464976177504;5119.641625086236;5143.974280128594;5183.948160518385;5233.947660523384;4701.388819453467;5058.342415485981;5208.921866172011;5215.322008138936;5257.605679574028;5066.062778385974;5091.389033315989;5152.484751524855;5186.559142472895;5199.714015729133;5136.332276803992;5151.072806894757;5156;5175.844724658266;5178.585713142939;5065.898682026375;5147.742612869341;5149.9742501287255;5156.690598564098;5163.690178589297;4407.669424793121;5556.027695153372;5585.664860108406;5661.631993920423;5679.432056794329;4756.595689366373;6196.256449226076;6196.690165491753;6211.161493198406;6221.5333849961435;6212.751489940442;6249;6252.124702541648;6254.437100660963;6260.686965651699;4686.507916668769;5626.831195064155;5704.657720536781;5704.657720536781;5799.159121927297;6255.718492667841;6265.279492858289;6265.4361107500545;6274.403931626488;6286.528510361742;6025.969870150709;6030.849228769228;6073.119397687311;6077.058056001327;6083.878322433615;6101.459346768572;6112.816615501542;6163.630182189083;6181.134641150153;6188.845278868064;6143.020634992025;6159.938400616026;6172.444479996821;6178.598391104564;6180.8763824723255;6162.876742465126;6170.228721409824;6176.382361763787;6180.938190618036;6199.504039676815;4726.220173671306;4797;4839.806407743721;4885.218365061573;4919.90160196794;4292.5063617683745;4394.8242070317465;4424.823007079681;4427.889302767457;4440.666949978699;5608.635438696471;5628.493435590816;5632.4930756231315;5638.069718496402;5641.435856414408;6119.045604113885;6146.231721034871;6158.983767678373;6162.938370616236;6168.814935551941;5668.348139963874;5673.546116310686;5713;5719.513841323451;5729.427057294237;5315.4950279724135;5330.360356757214;5331.866703332447;5334.466553344634;5343.225232341289;6173.413525715139;6246.843828904313;6257.749690012349;6265.060240963892;6284.685765711696;6107.219158344477;6126.853582554517;6193.473554747897;6229.4393504584805;6251.843703907257;6245.843853903689;6261.467775239155;6267.561270711007;6269.843253918689;6282.654454005074;6038.728257228523;6152.876942461216;6159.922013647504;6170.259568851767;6177.81466556004;6021.578489505692;6122.9471041527795;6158.384161583985;6163.476104531165;6181.783637572664;6044.697765111815;6069.544784141119;6084.39156084388;6096.542759293159;6103.206583144163;5135.2553879687985;6010.639361638316;6043.54673399488;6050.334463208956;6057.454829065406;5740.454656807597;5783.566232532493;5836.9416305838095;5851.00532909415;5866.7066646668345;5923.940760592339;5968.552358573212;5980.790672326448;6003.8198854034445;6016.187814645142;5856.9121463178935;5864.794732184353;5868.2664666916635;5877.559183061373;5880.235569375954 05:41:24 INFO - PROCESS | 1681 | |1;ext.html;517.8990096931095;521.6765605324695;521.7417378397691;555.9054960656688;563.9295088113985;25294.62058069128;27186.59220111695;29950.400991980147;29980.700192998065;39270.60729392705;40762.796186019026;40967.79516102415;41176.58823411765;41223.969400764996;41266.58733412665;9419.670311539097;9664.95167524165;9675.467849268287;9677.080677335642;9678.951605241964;9503.80992380152;9650.951745241264;9651.80696386072;9663.178629816473;9674.661386851461;9797.706068817912;9859.950700246489;9879.654212102578;9889.802203955953;9896.109350158484;9754.219662426989;9840.16358609512;9841.45871977041;9841.753956151118;9848;9549.856752148724;9698.563564639608;9704.466254356008;9705.757356066084;9705.90294097057;39055.60944390548;39381.81854544368;39405;39423.40864887029;39441.80279098615;3085.444619968405;3101.5657807906687;3102.953455698166;3105.549695294192;3237.1097948064235;27882.860585697144;27977.580336294974;28729.425411491862;28918.71081289181;29643.110706678835;2787.2613757354316;2850.344470550748;2852.957205641917;2877.683454819968;2978.940421191564;461861.69069154776;462633;463267;464255;466276.9999999966;44490.555094449286;56502.43497565054;57497.13754293689;64774.676126619066;65307;43589.69230923078;43848;43952;43969;43990.56009439864;15294;15435.459758908384;15439;15448.304826282843;15454.768178477332;11365.204435689588;11569.595064172881;12544.560940367044;12550;12702.618921432371;14190.361433735507;14190.361433735507;14192.148471091561;14199.716005680035;14269;6067.7269522871575;6138.693065346715;6166.568340216231;6205.193324867829;6225.346338634468;899.0380293086334;915.4415806358116;967.908048735369;1001.2240513602017;1116.4808364110727;28913.855430722713;29313;29436;29447;29634;1056.3820165203442;1074.0280046557878;1107.3189988157226;1170.052257671289;1177.3230392524333;14794.038387504777;14798.260086995608;14801.481948131765;15115.093094414371;15216.391344346102;537655;542361;543879;544094.2795285998;544155;57154.7142264286;57536.136957945666;57630.7118464405;57680;57917.710411447675;1406.4093080906043;1419.1839692177039;1443.328852083744;1443.8989270751156;1450.1299220467845;23664.88167559151;29325.1789148143;30643.693563064084;31978.36043279168;32350.83824580862;54497;55150.724246380116;55326;55411.722941386644;55411.89176216372;501787;506743;507142.9285707096;507199;507215;35069.298614027066;42493.787531062146;42554.57445425506;43695;43760;41646;41695.791521043415;41776.37335440032;41869.581304187785;42851.357229642206;27430.17709468719;34914.65085349216;36082.27835443224;36411.725589605296;37786.43320350142;29412.411751765274;35356;35628.82185589056;36917.077073073386;37972.240555189295;34839.65160348364;35299.47050794292;35536.822315888254;35672;35783.64216357803;25956.610650839873;31603.051908442783;31768.888088916778;31881;32814;21961.23135690243;22412.663810042537;23711.762882370957;23805.880970595037;24385.7079294293 05:41:24 INFO - PROCESS | 1681 | |2;jquery.html;294.4758330172293;366.62421018456087;368.57061523325325;368.5945459994007;374.85193348627274;15155.393784248645;15449.69100617987;19098.618027639455;19715.802841971577;20251.49371265717;17408.216630251638;17445.912770436164;17806.376776812813;18650.25398984039;19299.807001929978;5644.604877658555;5846.386129456409;5847.064469684851;5849.678267695275;5859.79490717825;4175.081482073939;4370.2133615949115;5732.283464566929;5786.623869448494;6127.387261273881;6234.625922444668;6260.311365749764;6332.208473940757;6333.20834895638;6346.2067241594805;5355.544778693777;6158.107074474198;6330.556861019708;6332.303446620868;6336.398042186008;5335.546478549328;5388.218708287315;5468.589855760833;5493.533049690781;5503.724813759296;21956.780432195632;22365.32904012882;23850;25096.49807003868;25534.74465255342;1865.9626807463774;1980.4157773456866;2157.924472643466;2168.967465488019;2229.4872179398667;14221.502247421291;14281.500147494891;14517.112775339137;14698.926505367512;15216.08703477795;1546.9458568950145;1727.265911987413;1776.3072401763322;1792.57874399516;1800.918958646851;100757.4962125192;100939.49530252375;101950.49024754902;102183;103932.9213415735;10657.946710266398;11007.119430445546;11009.779804403866;11014.118870490342;11128.777424451466;13007.544735934196;13145.934270328587;13176.077674562881;13190.670233244055;13211.471541138439;8325.417220794487;8330.500169989698;8360;8412.873806892901;8427.41008129425;6223.37766223374;7331.78004659861;8436.662533498715;8438.83122337562;8512.106228845882;3997.600239975979;4058.736182148151;4506.098780243964;4521.977390113028;4536.319552067216;1776.5913839816915;1809.7647305850155;1852.4039512650902;1853.2494339792406;1855.5453913790939;730.0582248898967;779.567340126224;825.2036784502983;906.1844340093836;960.1790469148917;15371;18689.81310186908;18740.344087957128;19030.33393831209;19157.521061973563;796.77690246731;952.1906379577304;973.4354074636693;1003.1523362758458;1006.1598565197995;8422.831543369099;10223.699667574736;10419.791604167875;10430.68707938763;10456.477176141163;714753;722102;751427;759816.2009189918;763915;69437.61124777477;69600.65199673969;98739.0252194952;101853;108086;1055.8996895294936;1111.822108462642;1126.4536699700802;1131.2025022359217;1135.920485566019;14346.928265358607;18036.729449058013;18579.535511612317;19090.427287181406;19562.21751129939;48582.5141748578;49397.01205975932;50742.74628626833;52643.73678131585;54295.18557221724;62168;70036;70675.64662176656;72804;73340.26659733547;6157.692115394123;7514.774556763306;7610.657520411484;7963.562004089599;7973.72091976778;9369.531523423939;9459.763505912408;12202.877971220174;12316.228848509014;12372.938135309267;10115.747106322106;10298.897011029794;10529.42088185157;10683.893161068601;10732.195085368472;10465.162786977176;10560.894391055992;10627.681169564925;10700.30448020876;10729.356238625707;10412.32319899204;10789.244752867224;10847.620333288298;11057.391843448688;11192.104631629612;7749.7675069748;7949.523028618301;7954.840903181788;7968.84062318762;7976.322012628992;9604.423734575948;10301.9484902575;10750;10926.836097458703;11043.447827608748 05:41:24 INFO - PROCESS | 1681 | |3;mootools.html;1315.9342032898353;1526.847315268473;1553.409704312361;1781.7594624725657;1829.3871553029726;6934;7840.294373506384;8637;8658.177473140056;8663.133686631334;8271.379646526504;8585.313174946004;8595.656173753057;8598.957005214981;8646.740597782062;2028.8072633099905;2170;2217.756046834847;2443.010580714809;2484.4534202475425;2493.6259561065804;2495.301315631617;2497.4880149569294;2497.8751062446804;2501.58723810571;1968.9367741419617;2160.8703477791305;2408.5303365843665;2468.90124395024;2477.331120597438;2439.0731522021606;2468.456939473313;2488.912888048928;2490.2902672738182;2493.114944194821;2445.5231229910173;2471.530409222242;2484.6521486991837;2492.9376765580823;2494.052260141153;8603.397762156652;8661.956690216572;8670;8672.349573781928;8685.392022558424;5350.0904846176245;5460.481254280837;5474.507294343528;5484.808031718871;5506.862328441781;3536.2927414516944;3576.8211589420425;3677.191017976041;3682.668559829628;3685.2261025184744;1023.2837014090167;1041.3075304922218;1053.631229069827;1076.1122074288744;1087.521490544158;11887.46506407205;11902.940485297604;11903.16677832552;11913.04695624348;11970.880291197063;4447.933281000787;4559.654901803976;4897.510248975074;4978.4025916890205;4987.301777751118;10146.949265253626;10158.187345012382;10164.796704066026;10169.491525423698;10170.796584068277;5504.532114770209;5506.504414602705;5514.95215908976;5519.199716041152;5532.474414930575;4955.554000140005;5022.221555658879;5023.698578085254;5026.045051440215;5031.496850315012;3862.671672907778;3888.902777430587;3893.9875632335797;3919.333713268751;3939.4287828265315;1125.9774804504027;1260.136806287696;1287.948482060707;1291.9354032298347;1294.5533790842144;1323.6426164935413;1331.7602831490424;1357.9864201358057;1360.3130419138272;1360.7414591227634;8007.719729809429;8161.795955101051;8177.386695997824;8213.055498617736;8221.712240071569;502.071168338578;503.4864438272941;511.749242870998;512.9461406552333;514.7503460821498;6172.938270617326;6188.226471691039;6218.253809542884;6229.3770622937345;6232.937670623326;10240.180785537288;10637.734056648645;10739.033486986209;10750.73123171927;10770.838437423445;9902.405855648683;10621.575136994588;10624.840627390595;10632.25574209798;10647.094996925192;7977.162397948248;8085;8175.018997720431;8187.426880118334;8188.26305632484;7899.763007109796;7919.564423956737;8009.679612815422;8026.678932842621;8038.155993620586;9429.387089839138;9514.666986655433;9534.475603841578;9594.232461402931;9650.324477286804;9374.718758437259;9722.416655000723;9901.108900199017;9910.058544438267;9930.453825039693;6829.180498340231;6997.650117494207;7212.098487689039;7403.777886663409;7408.629403560359;8182.7545173644885;8189.467684600482;8225.095239523767;8228.136045715113;8251.917480825356;6328.557001009885;7414.22150674193;7639.427042971688;7703.998480197539;7781.766547003599;7464.664090116066;7538.359239464707;7546.584937828472;7684.193159718149;7693.346065584488;7692.9615351922885;7749.845003100019;7753.534787912743;7756.92243077562;7763.340116089969;6877.4841886857685;7002.894956575554;7012.964935175495;7027.191872934473;7095.467839911924;7183.892241616275;7198.6400679964745;7209.747658831916;7220.097487814023;7232.240614735377 05:41:24 INFO - PROCESS | 1681 | |4;prototype.html;317.25128696276784;324.53753401403;329.12617001860053;329.3511781789876;332.92342761164946;6498.285188629247;6649.235337936133;6680.432163266129;6716.462682985361;6756.7635132770365;5783.797567085153;6184.81445556634;6465.70904309306;6598.835029124274;6606.669666516667;4849.733264670451;4886.438059623136;4891.339669144673;4892.706437613754;4905;4670.416197975253;4759.024399998009;4769.236922092466;4870.43989941156;4894.583960363373;4797.664163508556;4822.132016237076;4823.565879070883;4829.3480380148585;4849.175640141185;4799.544043315879;4806.182948898696;4820.301056346828;4825.758712064383;4847.491013443573;3384.3062172254627;4124.8143833527265;4129.504459464853;4132.834686612532;4140.875773726793;5139.691618502864;6165.475934545569;6322.810315690536;6437;6449.580777249464;5572.86067848303;5591.524720398771;5606.271184745998;5610.438956104398;5624.3813180550105;6650.301718319555;7024.54340467873;7041.3310735480045;7049.577025378494;7075.292470752935;4402.603765661074;4405.163019026407;4510.819567217307;4527.592516673482;4531.13908357411;5816.621919575214;7413.406927445845;7431.739889103909;7431.996680448125;7472.925270747277;4212.620864122244;4240.448741663564;4587.518310577408;4613.515580863961;4621.237495813153;4552.97723511387;4643.421236779511;4680.087382960358;4687.20317546018;4695.5304469552775;5586.301712285965;5587.804426845122;5588.357338905997;5615.859603509945;5651.886962260732;7033.8944915826305;7039.120109986252;7048.436125109979;7049.506534542533;7052.153741551047;1611.484325016007;1635.9182040897908;1639.1230691580186;1640.9425670101489;1642.4415698662274;1013.5591017907234;1045.8704599033026;1046.2048842879467;1047;1055.3931489393628;5001.874578219871;5473.877855039707;6482.546221764431;6572.11276477679;6603.141591593062;6626.237982631963;7266.600336981517;7280.526765760314;7287.344139027513;7301.050863387725;6342.809715708536;6551.836204094936;6559.311272316433;6565.507586930904;6573.079768832367;3816.6755825754567;3876.5348158221195;3878.4957955466175;3878.5733569307354;3883.0874744435037;7597.810054748676;7601.011868457065;7611.885821712679;7619.771406857803;7634.083909930844;5958.7914422995855;7285.453590980592;7487.7004919803685;7521.210272921265;7561.886571701429;7570;7578.204288549843;7583.924160758432;7592.962035189788;7594.5063570867715;5446.618736688394;7077.929220707727;7235.674394652148;7267.454940879349;7269.164046134762;6390.265119511129;7225.891611625725;7237.927620723936;7239.755675740537;7267;7748.031496062992;7762.650680719268;7773.494722843223;7775.494592851446;7775.688972441039;4483.349914262349;4644.907101858012;4673.976630116827;4676.602488788355;4677.2750223715375;7306.4520160989205;7313.195548489768;7318.96340518294;7329.486935914648;7337;6923.900659628782;7059.858802824017;7068.68190931399;7099;7099.609521476368;7055.3650171484815;7081.82295442618;7092.929070709433;7102.4673149512955;7127.216006239206;6939.410150137295;6972.477064220102;6974.37230649244;6975;6978.930210697828;6864.38220560152;7093.056381601577;7105.467089968376;7147.46394020461;7168.928310717035;6971.51199416036;7011.3339232772805;7014.754483593049;7020.368166865007;7040.190378106583 05:41:24 INFO - PROCESS | 1681 | |5;yui.html;684.5481981891951;697.2748341724607;710.7121615745623;720.484853329869;766.1878408886585;15144;15196.772048419283;15276.388944442237;15382.461613843503;15438.536843894688;13711.65720856979;13922.791158132635;13924.443022279122;13941.512047078355;13961.93019034906;703.7114782938996;721.4805340155079;741.7960060983219;764.9672941528919;864.7924498120469;870.0212261206143;876.5967654878764;880.3573391424264;880.8458519759049;881.9073997230295;926.4117285523707;928.8142371525722;929.5166513413021;930.1303281431883;931.12009151352;726.7056841978981;742.7920182348923;743.4201322968094;746.2686567164183;747.0139415970921;669.9631520266383;684.565301033847;685.8319711670623;686.080651926416;687.3435868745336;14933.477328293458;14990.477237849096;14994;15000.549983500403;15007.399704011827;12342.568010119603;12534.68663283416;12617.810732839014;12661.30362830044;12846.229226246454;9879.802403951953;10128.94935525325;10195.847062293997;10359.482025898675;10809.621663241749;3486.738494612914;3524.3303772283184;3525.189206482498;3525.788452692821;3532.364174448598;75974;76566.46867062683;76685;78159.6092019542;86679;9427.387219830689;9468.763280918032;9469.030518409158;9545.522723863918;9811.75470613226;20590.897045514677;20637.277695280893;20642.380728578166;20651.070701818455;20657.070431830605;7432.591207483641;7625.771226863203;7644.503107298008;7680.462367634212;7726.729564465217;4115.506139263308;4152.667786577066;4158.8933433890315;4195.4336164618;4201.075763332062;3361.310931259086;3396.286779776225;3399.2181798186557;3405.931881362359;3415.958132769529;647.1296106736432;654.6824789976857;668.7625892807984;671.2984930747381;676.5805200775551;515.7034705044539;545.4218528359872;565.5588640860136;594.4679511836882;612.3845535237058;8115.715949941724;8520.829583408296;8749.343799215085;8939.106089391138;9333.859992100124;486.3750081145781;525.8054519827688;545.4273013335982;549.4917201588514;552.9225908372831;3841.327767640652;4079.0414252650603;4087.4686290782006;4196.244675958357;4220.514640816284;97108;98488;100641.49679251557;100642;102283.46574801384;59872;80535.59732201301;83096.58451707824;85960;86948.130518694;74284;74831.25168748242;75470.62264688642;76214.61892690501;79330;8397.664093436195;8966.865497017681;9038.404286990071;9053.818923621622;9238.122378374044;51365.20221792369;51586;52259.43221703355;52631.47368526266;53024.73487632537;67180.32819671741;71849.6407517959;71957.6402118007;72909.90635140371;76765;11842.111841612086;11874.228175168586;11894.226875253082;11994.940025299818;12243.047911260415;11589.246698964878;11653.242539235262;12005.75988480208;12208.69478263015;12242.387880606113;9939.602415903571;11691.824622630496;11714.824277636013;11834;12421.627351179479;11390.228642089667;11452.770944581229;11478;11767.588134415255;12460;11462.369569673749;11571.710707232387;11598.47806848677;11852.170348075551;11877.990370818578;9450.858237126586;9599.124639411231;9740.512974351395;9781.364211326241;10072.848907266543;9932.453715045742;10022.247382953083;10025.949870250603;10094.242931780293;10095.151879908526 05:41:24 INFO - PROCESS | 1681 | __end_tp_report 05:41:24 INFO - PROCESS | 1681 | __start_cc_report 05:41:24 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1776 05:41:24 INFO - PROCESS | 1681 | __end_cc_report 05:41:24 INFO - PROCESS | 1681 | __startTimestamp1455716483999__endTimestamp 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | ------- Summary: start ------- 05:41:24 INFO - PROCESS | 1681 | Number of tests: 6 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5664.58 Median:5864.79 stddev:646.71 (11.0%) stddev-sans-first:619.65 05:41:24 INFO - PROCESS | 1681 | Values: 3221.8 3346.3 3424.8 3498.1 3504.6 5565.2 5647.6 5652.6 5655.1 5670.7 5681.7 5688.9 5721.1 5801.4 5804.2 5095.5 5119.6 5144.0 5183.9 5233.9 4701.4 5058.3 5208.9 5215.3 5257.6 5066.1 5091.4 5152.5 5186.6 5199.7 5136.3 5151.1 5156.0 5175.8 5178.6 5065.9 5147.7 5150.0 5156.7 5163.7 4407.7 5556.0 5585.7 5661.6 5679.4 4756.6 6196.3 6196.7 6211.2 6221.5 6212.8 6249.0 6252.1 6254.4 6260.7 4686.5 5626.8 5704.7 5704.7 5799.2 6255.7 6265.3 6265.4 6274.4 6286.5 6026.0 6030.8 6073.1 6077.1 6083.9 6101.5 6112.8 6163.6 6181.1 6188.8 6143.0 6159.9 6172.4 6178.6 6180.9 6162.9 6170.2 6176.4 6180.9 6199.5 4726.2 4797.0 4839.8 4885.2 4919.9 4292.5 4394.8 4424.8 4427.9 4440.7 5608.6 5628.5 5632.5 5638.1 5641.4 6119.0 6146.2 6159.0 6162.9 6168.8 5668.3 5673.5 5713.0 5719.5 5729.4 5315.5 5330.4 5331.9 5334.5 5343.2 6173.4 6246.8 6257.7 6265.1 6284.7 6107.2 6126.9 6193.5 6229.4 6251.8 6245.8 6261.5 6267.6 6269.8 6282.7 6038.7 6152.9 6159.9 6170.3 6177.8 6021.6 6122.9 6158.4 6163.5 6181.8 6044.7 6069.5 6084.4 6096.5 6103.2 5135.3 6010.6 6043.5 6050.3 6057.5 5740.5 5783.6 5836.9 5851.0 5866.7 5923.9 5968.6 5980.8 6003.8 6016.2 5856.9 5864.8 5868.3 5877.6 5880.2 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:63579.57 Median:39414.20 stddev:134559.24 (341.4%) stddev-sans-first:134853.41 05:41:24 INFO - PROCESS | 1681 | Values: 517.9 521.7 521.7 555.9 563.9 25294.6 27186.6 29950.4 29980.7 39270.6 40762.8 40967.8 41176.6 41224.0 41266.6 9419.7 9665.0 9675.5 9677.1 9679.0 9503.8 9651.0 9651.8 9663.2 9674.7 9797.7 9860.0 9879.7 9889.8 9896.1 9754.2 9840.2 9841.5 9841.8 9848.0 9549.9 9698.6 9704.5 9705.8 9705.9 39055.6 39381.8 39405.0 39423.4 39441.8 3085.4 3101.6 3103.0 3105.5 3237.1 27882.9 27977.6 28729.4 28918.7 29643.1 2787.3 2850.3 2853.0 2877.7 2978.9 461861.7 462633.0 463267.0 464255.0 466277.0 44490.6 56502.4 57497.1 64774.7 65307.0 43589.7 43848.0 43952.0 43969.0 43990.6 15294.0 15435.5 15439.0 15448.3 15454.8 11365.2 11569.6 12544.6 12550.0 12702.6 14190.4 14190.4 14192.1 14199.7 14269.0 6067.7 6138.7 6166.6 6205.2 6225.3 899.0 915.4 967.9 1001.2 1116.5 28913.9 29313.0 29436.0 29447.0 29634.0 1056.4 1074.0 1107.3 1170.1 1177.3 14794.0 14798.3 14801.5 15115.1 15216.4 537655.0 542361.0 543879.0 544094.3 544155.0 57154.7 57536.1 57630.7 57680.0 57917.7 1406.4 1419.2 1443.3 1443.9 1450.1 23664.9 29325.2 30643.7 31978.4 32350.8 54497.0 55150.7 55326.0 55411.7 55411.9 501787.0 506743.0 507142.9 507199.0 507215.0 35069.3 42493.8 42554.6 43695.0 43760.0 41646.0 41695.8 41776.4 41869.6 42851.4 27430.2 34914.7 36082.3 36411.7 37786.4 29412.4 35356.0 35628.8 36917.1 37972.2 34839.7 35299.5 35536.8 35672.0 35783.6 25956.6 31603.1 31768.9 31881.0 32814.0 21961.2 22412.7 23711.8 23805.9 24385.7 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:36853.03 Median:12297.41 stddev:121947.19 (991.6%) stddev-sans-first:122258.38 05:41:24 INFO - PROCESS | 1681 | Values: 294.5 366.6 368.6 368.6 374.9 15155.4 15449.7 19098.6 19715.8 20251.5 17408.2 17445.9 17806.4 18650.3 19299.8 5644.6 5846.4 5847.1 5849.7 5859.8 4175.1 4370.2 5732.3 5786.6 6127.4 6234.6 6260.3 6332.2 6333.2 6346.2 5355.5 6158.1 6330.6 6332.3 6336.4 5335.5 5388.2 5468.6 5493.5 5503.7 21956.8 22365.3 23850.0 25096.5 25534.7 1866.0 1980.4 2157.9 2169.0 2229.5 14221.5 14281.5 14517.1 14698.9 15216.1 1546.9 1727.3 1776.3 1792.6 1800.9 100757.5 100939.5 101950.5 102183.0 103932.9 10657.9 11007.1 11009.8 11014.1 11128.8 13007.5 13145.9 13176.1 13190.7 13211.5 8325.4 8330.5 8360.0 8412.9 8427.4 6223.4 7331.8 8436.7 8438.8 8512.1 3997.6 4058.7 4506.1 4522.0 4536.3 1776.6 1809.8 1852.4 1853.2 1855.5 730.1 779.6 825.2 906.2 960.2 15371.0 18689.8 18740.3 19030.3 19157.5 796.8 952.2 973.4 1003.2 1006.2 8422.8 10223.7 10419.8 10430.7 10456.5 714753.0 722102.0 751427.0 759816.2 763915.0 69437.6 69600.7 98739.0 101853.0 108086.0 1055.9 1111.8 1126.5 1131.2 1135.9 14346.9 18036.7 18579.5 19090.4 19562.2 48582.5 49397.0 50742.7 52643.7 54295.2 62168.0 70036.0 70675.6 72804.0 73340.3 6157.7 7514.8 7610.7 7963.6 7973.7 9369.5 9459.8 12202.9 12316.2 12372.9 10115.7 10298.9 10529.4 10683.9 10732.2 10465.2 10560.9 10627.7 10700.3 10729.4 10412.3 10789.2 10847.6 11057.4 11192.1 7749.8 7949.5 7954.8 7968.8 7976.3 9604.4 10301.9 10750.0 10926.8 11043.4 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:6019.06 Median:5467.49 stddev:3193.54 (58.4%) stddev-sans-first:3182.93 05:41:24 INFO - PROCESS | 1681 | Values: 1315.9 1526.8 1553.4 1781.8 1829.4 6934.0 7840.3 8637.0 8658.2 8663.1 8271.4 8585.3 8595.7 8599.0 8646.7 2028.8 2170.0 2217.8 2443.0 2484.5 2493.6 2495.3 2497.5 2497.9 2501.6 1968.9 2160.9 2408.5 2468.9 2477.3 2439.1 2468.5 2488.9 2490.3 2493.1 2445.5 2471.5 2484.7 2492.9 2494.1 8603.4 8662.0 8670.0 8672.3 8685.4 5350.1 5460.5 5474.5 5484.8 5506.9 3536.3 3576.8 3677.2 3682.7 3685.2 1023.3 1041.3 1053.6 1076.1 1087.5 11887.5 11902.9 11903.2 11913.0 11970.9 4447.9 4559.7 4897.5 4978.4 4987.3 10146.9 10158.2 10164.8 10169.5 10170.8 5504.5 5506.5 5515.0 5519.2 5532.5 4955.6 5022.2 5023.7 5026.0 5031.5 3862.7 3888.9 3894.0 3919.3 3939.4 1126.0 1260.1 1287.9 1291.9 1294.6 1323.6 1331.8 1358.0 1360.3 1360.7 8007.7 8161.8 8177.4 8213.1 8221.7 502.1 503.5 511.7 512.9 514.8 6172.9 6188.2 6218.3 6229.4 6232.9 10240.2 10637.7 10739.0 10750.7 10770.8 9902.4 10621.6 10624.8 10632.3 10647.1 7977.2 8085.0 8175.0 8187.4 8188.3 7899.8 7919.6 8009.7 8026.7 8038.2 9429.4 9514.7 9534.5 9594.2 9650.3 9374.7 9722.4 9901.1 9910.1 9930.5 6829.2 6997.7 7212.1 7403.8 7408.6 8182.8 8189.5 8225.1 8228.1 8251.9 6328.6 7414.2 7639.4 7704.0 7781.8 7464.7 7538.4 7546.6 7684.2 7693.3 7693.0 7749.8 7753.5 7756.9 7763.3 6877.5 7002.9 7013.0 7027.2 7095.5 7183.9 7198.6 7209.7 7220.1 7232.2 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:5724.61 Median:6490.42 stddev:1849.32 (28.5%) stddev-sans-first:1809.42 05:41:24 INFO - PROCESS | 1681 | Values: 317.3 324.5 329.1 329.4 332.9 6498.3 6649.2 6680.4 6716.5 6756.8 5783.8 6184.8 6465.7 6598.8 6606.7 4849.7 4886.4 4891.3 4892.7 4905.0 4670.4 4759.0 4769.2 4870.4 4894.6 4797.7 4822.1 4823.6 4829.3 4849.2 4799.5 4806.2 4820.3 4825.8 4847.5 3384.3 4124.8 4129.5 4132.8 4140.9 5139.7 6165.5 6322.8 6437.0 6449.6 5572.9 5591.5 5606.3 5610.4 5624.4 6650.3 7024.5 7041.3 7049.6 7075.3 4402.6 4405.2 4510.8 4527.6 4531.1 5816.6 7413.4 7431.7 7432.0 7472.9 4212.6 4240.4 4587.5 4613.5 4621.2 4553.0 4643.4 4680.1 4687.2 4695.5 5586.3 5587.8 5588.4 5615.9 5651.9 7033.9 7039.1 7048.4 7049.5 7052.2 1611.5 1635.9 1639.1 1640.9 1642.4 1013.6 1045.9 1046.2 1047.0 1055.4 5001.9 5473.9 6482.5 6572.1 6603.1 6626.2 7266.6 7280.5 7287.3 7301.1 6342.8 6551.8 6559.3 6565.5 6573.1 3816.7 3876.5 3878.5 3878.6 3883.1 7597.8 7601.0 7611.9 7619.8 7634.1 5958.8 7285.5 7487.7 7521.2 7561.9 7570.0 7578.2 7583.9 7593.0 7594.5 5446.6 7077.9 7235.7 7267.5 7269.2 6390.3 7225.9 7237.9 7239.8 7267.0 7748.0 7762.7 7773.5 7775.5 7775.7 4483.3 4644.9 4674.0 4676.6 4677.3 7306.5 7313.2 7319.0 7329.5 7337.0 6923.9 7059.9 7068.7 7099.0 7099.6 7055.4 7081.8 7092.9 7102.5 7127.2 6939.4 6972.5 6974.4 6975.0 6978.9 6864.4 7093.1 7105.5 7147.5 7168.9 6971.5 7011.3 7014.8 7020.4 7040.2 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:18916.15 Median:547.46 stddev:26957.94 (4924.2%) stddev-sans-first:26998.80 05:41:24 INFO - PROCESS | 1681 | Values: 684.5 697.3 710.7 720.5 766.2 15144.0 15196.8 15276.4 15382.5 15438.5 13711.7 13922.8 13924.4 13941.5 13961.9 703.7 721.5 741.8 765.0 864.8 870.0 876.6 880.4 880.8 881.9 926.4 928.8 929.5 930.1 931.1 726.7 742.8 743.4 746.3 747.0 670.0 684.6 685.8 686.1 687.3 14933.5 14990.5 14994.0 15000.5 15007.4 12342.6 12534.7 12617.8 12661.3 12846.2 9879.8 10128.9 10195.8 10359.5 10809.6 3486.7 3524.3 3525.2 3525.8 3532.4 75974.0 76566.5 76685.0 78159.6 86679.0 9427.4 9468.8 9469.0 9545.5 9811.8 20590.9 20637.3 20642.4 20651.1 20657.1 7432.6 7625.8 7644.5 7680.5 7726.7 4115.5 4152.7 4158.9 4195.4 4201.1 3361.3 3396.3 3399.2 3405.9 3416.0 647.1 654.7 668.8 671.3 676.6 515.7 545.4 565.6 594.5 612.4 8115.7 8520.8 8749.3 8939.1 9333.9 486.4 525.8 545.4 549.5 552.9 3841.3 4079.0 4087.5 4196.2 4220.5 97108.0 98488.0 100641.5 100642.0 102283.5 59872.0 80535.6 83096.6 85960.0 86948.1 74284.0 74831.3 75470.6 76214.6 79330.0 8397.7 8966.9 9038.4 9053.8 9238.1 51365.2 51586.0 52259.4 52631.5 53024.7 67180.3 71849.6 71957.6 72909.9 76765.0 11842.1 11874.2 11894.2 11994.9 12243.0 11589.2 11653.2 12005.8 12208.7 12242.4 9939.6 11691.8 11714.8 11834.0 12421.6 11390.2 11452.8 11478.0 11767.6 12460.0 11462.4 11571.7 11598.5 11852.2 11878.0 9450.9 9599.1 9740.5 9781.4 10072.8 9932.5 10022.2 10025.9 10094.2 10095.2 05:41:24 INFO - PROCESS | 1681 | -------- Summary: end -------- 05:41:24 INFO - PROCESS | 1681 | 05:41:24 INFO - TEST-INFO | 1681: exit 0 05:41:24 INFO - TEST-OK | dromaeo_css | took 1113863ms 05:41:24 INFO - TEST-START | kraken 05:41:24 INFO - operating with platform_type : mac_ 05:41:24 INFO - Initialising browser for kraken test... 05:41:24 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpD6sroP/profile http://localhost:49291/getInfo.html) 05:41:26 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 05:41:26 INFO - PROCESS | 1687 | colorDepth:24 05:41:26 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 05:41:26 INFO - PROCESS | 1687 | __metrics 05:41:26 INFO - PROCESS | 1687 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:41:26 INFO - PROCESS | 1687 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:27 INFO - TEST-INFO | 1687: exit 0 05:41:27 INFO - Browser initialized. 05:41:27 INFO - Running cycle 1/1 for kraken test... 05:41:27 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpD6sroP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:39 INFO - PROCESS | 1689 | RSS: Main: 244314112 05:41:39 INFO - PROCESS | 1689 | 05:41:41 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:42 INFO - PROCESS | 1689 | RSS: Main: 291479552 05:41:42 INFO - PROCESS | 1689 | 05:41:44 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-dft) 05:41:45 INFO - PROCESS | 1689 | RSS: Main: 301584384 05:41:45 INFO - PROCESS | 1689 | 05:41:48 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-fft) 05:41:49 INFO - PROCESS | 1689 | RSS: Main: 287174656 05:41:49 INFO - PROCESS | 1689 | 05:41:51 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-oscillator) 05:41:51 INFO - PROCESS | 1689 | RSS: Main: 288780288 05:41:51 INFO - PROCESS | 1689 | 05:41:53 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:54 INFO - PROCESS | 1689 | RSS: Main: 289910784 05:41:54 INFO - PROCESS | 1689 | 05:41:57 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:57 INFO - PROCESS | 1689 | RSS: Main: 288260096 05:41:57 INFO - PROCESS | 1689 | 05:42:00 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:01 INFO - PROCESS | 1689 | RSS: Main: 289046528 05:42:01 INFO - PROCESS | 1689 | 05:42:03 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49291/tests/kraken/driver.html?testName=json-parse-financial) 05:42:04 INFO - PROCESS | 1689 | RSS: Main: 291913728 05:42:04 INFO - PROCESS | 1689 | 05:42:06 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:06 INFO - PROCESS | 1689 | RSS: Main: 326176768 05:42:06 INFO - PROCESS | 1689 | 05:42:08 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:09 INFO - PROCESS | 1689 | RSS: Main: 324947968 05:42:09 INFO - PROCESS | 1689 | 05:42:11 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:11 INFO - PROCESS | 1689 | RSS: Main: 332730368 05:42:11 INFO - PROCESS | 1689 | 05:42:14 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:14 INFO - PROCESS | 1689 | RSS: Main: 333979648 05:42:14 INFO - PROCESS | 1689 | 05:42:17 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:18 INFO - PROCESS | 1689 | RSS: Main: 334163968 05:42:18 INFO - PROCESS | 1689 | 05:42:19 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49291/tests/kraken/driver.html?testName=ai-astar) 05:42:20 INFO - PROCESS | 1689 | RSS: Main: 394379264 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | __start_tp_report 05:42:20 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 05:42:20 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 05:42:20 INFO - PROCESS | 1689 | |i|pagename|runs| 05:42:20 INFO - PROCESS | 1689 | |0;ai-astar;109;109;113;108;110;112;116;110;111;110 05:42:20 INFO - PROCESS | 1689 | |1;audio-beat-detection;159;121;151;194;146;152;138;123;160;125 05:42:20 INFO - PROCESS | 1689 | |2;audio-dft;182;184;186;186;184;184;183;188;182;179 05:42:20 INFO - PROCESS | 1689 | |3;audio-fft;73;76;85;79;56;56;59;78;75;57 05:42:20 INFO - PROCESS | 1689 | |4;audio-oscillator;94;93;123;79;81;89;109;75;77;107 05:42:20 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;83;89;83;90;83;89;83;89;84;89 05:42:20 INFO - PROCESS | 1689 | |6;imaging-darkroom;94;94;94;95;93;103;144;93;94;93 05:42:20 INFO - PROCESS | 1689 | |7;imaging-desaturate;86;85;85;85;86;83;85;85;85;85 05:42:20 INFO - PROCESS | 1689 | |8;json-parse-financial;56;57;53;54;54;53;54;64;53;53 05:42:20 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;63;69;78;72;70;67;67;67;67;66 05:42:20 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;85;81;85;82;82;83;82;80;84;84 05:42:20 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;126;125;132;124;120;125;125;124;127;108 05:42:20 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;139;131;137;168;174;135;137;138;139;135 05:42:20 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;61;66;67;58;58;96;58;76;92;93 05:42:20 INFO - PROCESS | 1689 | __end_tp_report 05:42:20 INFO - PROCESS | 1689 | __start_cc_report 05:42:20 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,1150 05:42:20 INFO - PROCESS | 1689 | __end_cc_report 05:42:20 INFO - PROCESS | 1689 | __startTimestamp1455716540063__endTimestamp 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | ------- Summary: start ------- 05:42:20 INFO - PROCESS | 1689 | Number of tests: 14 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.50 stddev:2.35 (2.1%) stddev-sans-first:2.40 05:42:20 INFO - PROCESS | 1689 | Values: 109.0 109.0 113.0 108.0 110.0 112.0 116.0 110.0 111.0 110.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:151.50 stddev:22.06 (14.6%) stddev-sans-first:22.96 05:42:20 INFO - PROCESS | 1689 | Values: 159.0 121.0 151.0 194.0 146.0 152.0 138.0 123.0 160.0 125.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:2.53 (1.4%) stddev-sans-first:2.60 05:42:20 INFO - PROCESS | 1689 | Values: 182.0 184.0 186.0 186.0 184.0 184.0 183.0 188.0 182.0 179.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:69.40 Median:75.50 stddev:11.15 (14.8%) stddev-sans-first:11.75 05:42:20 INFO - PROCESS | 1689 | Values: 73.0 76.0 85.0 79.0 56.0 56.0 59.0 78.0 75.0 57.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:80.00 stddev:15.94 (19.9%) stddev-sans-first:16.90 05:42:20 INFO - PROCESS | 1689 | Values: 94.0 93.0 123.0 79.0 81.0 89.0 109.0 75.0 77.0 107.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:89.00 stddev:3.19 (3.6%) stddev-sans-first:3.17 05:42:20 INFO - PROCESS | 1689 | Values: 83.0 89.0 83.0 90.0 83.0 89.0 83.0 89.0 84.0 89.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:94.00 stddev:15.85 (16.9%) stddev-sans-first:16.67 05:42:20 INFO - PROCESS | 1689 | Values: 94.0 94.0 94.0 95.0 93.0 103.0 144.0 93.0 94.0 93.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 05:42:20 INFO - PROCESS | 1689 | Values: 86.0 85.0 85.0 85.0 86.0 83.0 85.0 85.0 85.0 85.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:3.41 (6.3%) stddev-sans-first:3.61 05:42:20 INFO - PROCESS | 1689 | Values: 56.0 57.0 53.0 54.0 54.0 53.0 54.0 64.0 53.0 53.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:4.09 (6.0%) stddev-sans-first:3.80 05:42:20 INFO - PROCESS | 1689 | Values: 63.0 69.0 78.0 72.0 70.0 67.0 67.0 67.0 67.0 66.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:1.69 (2.0%) stddev-sans-first:1.59 05:42:20 INFO - PROCESS | 1689 | Values: 85.0 81.0 85.0 82.0 82.0 83.0 82.0 80.0 84.0 84.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:125.00 stddev:6.24 (5.0%) stddev-sans-first:6.56 05:42:20 INFO - PROCESS | 1689 | Values: 126.0 125.0 132.0 124.0 120.0 125.0 125.0 124.0 127.0 108.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:138.50 stddev:14.86 (10.7%) stddev-sans-first:15.67 05:42:20 INFO - PROCESS | 1689 | Values: 139.0 131.0 137.0 168.0 174.0 135.0 137.0 138.0 139.0 135.0 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:71.50 stddev:15.64 (21.9%) stddev-sans-first:16.02 05:42:20 INFO - PROCESS | 1689 | Values: 61.0 66.0 67.0 58.0 58.0 96.0 58.0 76.0 92.0 93.0 05:42:20 INFO - PROCESS | 1689 | -------- Summary: end -------- 05:42:20 INFO - PROCESS | 1689 | 05:42:20 INFO - TEST-INFO | 1689: exit 0 05:42:20 INFO - TEST-OK | kraken | took 56310ms 05:42:20 INFO - SUITE-END | took 1170s 05:42:21 INFO - Completed test suite (00:19:30) 05:42:21 INFO - Working with test: dromaeo_css 05:42:21 INFO - Generating results file: dromaeo_css 05:42:21 INFO - Working with test: kraken 05:42:21 INFO - Generating results file: kraken 05:42:21 INFO - javascript benchmark 05:42:21 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:42:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 05:42:21 INFO - process_Request line: dromaeo_css 7415.91 graph.html#tests=[[72,64,59]] 05:42:21 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:42:21 INFO - process_Request line: kraken 1420.40 graph.html#tests=[[232,64,59]] 05:42:21 INFO - RETURN: dromaeo_css: 7415.91 05:42:21 INFO - RETURN: kraken: 1420.40 05:42:21 INFO - javascript benchmark 05:42:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3221.806691598504, 3346.29727757171, 3424.811635360056, 3498.1429549760305, 3504.56192975878, 5565.165225216219, 5647.576431767613, 5652.63257888238, 5655.095184770433, 5670.71646417679, 5681.715914204284, 5688.943110568893, 5721.113227449741, 5801.4198580141965, 5804.245448091753, 5095.464976177504, 5119.641625086236, 5143.974280128594, 5183.948160518385, 5233.947660523384, 4701.388819453467, 5058.342415485981, 5208.921866172011, 5215.322008138936, 5257.605679574028, 5066.062778385974, 5091.389033315989, 5152.484751524855, 5186.559142472895, 5199.714015729133, 5136.332276803992, 5151.072806894757, 5156.0, 5175.844724658266, 5178.585713142939, 5065.898682026375, 5147.742612869341, 5149.9742501287255, 5156.690598564098, 5163.690178589297, 4407.669424793121, 5556.027695153372, 5585.664860108406, 5661.631993920423, 5679.432056794329, 4756.595689366373, 6196.256449226076, 6196.690165491753, 6211.161493198406, 6221.5333849961435, 6212.751489940442, 6249.0, 6252.124702541648, 6254.437100660963, 6260.686965651699, 4686.507916668769, 5626.831195064155, 5704.657720536781, 5704.657720536781, 5799.159121927297, 6255.718492667841, 6265.279492858289, 6265.4361107500545, 6274.403931626488, 6286.528510361742, 6025.969870150709, 6030.849228769228, 6073.119397687311, 6077.058056001327, 6083.878322433615, 6101.459346768572, 6112.816615501542, 6163.630182189083, 6181.134641150153, 6188.845278868064, 6143.020634992025, 6159.938400616026, 6172.444479996821, 6178.598391104564, 6180.8763824723255, 6162.876742465126, 6170.228721409824, 6176.382361763787, 6180.938190618036, 6199.504039676815, 4726.220173671306, 4797.0, 4839.806407743721, 4885.218365061573, 4919.90160196794, 4292.5063617683745, 4394.8242070317465, 4424.823007079681, 4427.889302767457, 4440.666949978699, 5608.635438696471, 5628.493435590816, 5632.4930756231315, 5638.069718496402, 5641.435856414408, 6119.045604113885, 6146.231721034871, 6158.983767678373, 6162.938370616236, 6168.814935551941, 5668.348139963874, 5673.546116310686, 5713.0, 5719.513841323451, 5729.427057294237, 5315.4950279724135, 5330.360356757214, 5331.866703332447, 5334.466553344634, 5343.225232341289, 6173.413525715139, 6246.843828904313, 6257.749690012349, 6265.060240963892, 6284.685765711696, 6107.219158344477, 6126.853582554517, 6193.473554747897, 6229.4393504584805, 6251.843703907257, 6245.843853903689, 6261.467775239155, 6267.561270711007, 6269.843253918689, 6282.654454005074, 6038.728257228523, 6152.876942461216, 6159.922013647504, 6170.259568851767, 6177.81466556004, 6021.578489505692, 6122.9471041527795, 6158.384161583985, 6163.476104531165, 6181.783637572664, 6044.697765111815, 6069.544784141119, 6084.39156084388, 6096.542759293159, 6103.206583144163, 5135.2553879687985, 6010.639361638316, 6043.54673399488, 6050.334463208956, 6057.454829065406, 5740.454656807597, 5783.566232532493, 5836.9416305838095, 5851.00532909415, 5866.7066646668345, 5923.940760592339, 5968.552358573212, 5980.790672326448, 6003.8198854034445, 6016.187814645142, 5856.9121463178935, 5864.794732184353, 5868.2664666916635, 5877.559183061373, 5880.235569375954], "unit": "score", "name": "dojo.html", "value": 5624.630132190246}, {"lowerIsBetter": false, "replicates": [517.8990096931095, 521.6765605324695, 521.7417378397691, 555.9054960656688, 563.9295088113985, 25294.62058069128, 27186.59220111695, 29950.400991980147, 29980.700192998065, 39270.60729392705, 40762.796186019026, 40967.79516102415, 41176.58823411765, 41223.969400764996, 41266.58733412665, 9419.670311539097, 9664.95167524165, 9675.467849268287, 9677.080677335642, 9678.951605241964, 9503.80992380152, 9650.951745241264, 9651.80696386072, 9663.178629816473, 9674.661386851461, 9797.706068817912, 9859.950700246489, 9879.654212102578, 9889.802203955953, 9896.109350158484, 9754.219662426989, 9840.16358609512, 9841.45871977041, 9841.753956151118, 9848.0, 9549.856752148724, 9698.563564639608, 9704.466254356008, 9705.757356066084, 9705.90294097057, 39055.60944390548, 39381.81854544368, 39405.0, 39423.40864887029, 39441.80279098615, 3085.444619968405, 3101.5657807906687, 3102.953455698166, 3105.549695294192, 3237.1097948064235, 27882.860585697144, 27977.580336294974, 28729.425411491862, 28918.71081289181, 29643.110706678835, 2787.2613757354316, 2850.344470550748, 2852.957205641917, 2877.683454819968, 2978.940421191564, 461861.69069154776, 462633.0, 463267.0, 464255.0, 466276.9999999966, 44490.555094449286, 56502.43497565054, 57497.13754293689, 64774.676126619066, 65307.0, 43589.69230923078, 43848.0, 43952.0, 43969.0, 43990.56009439864, 15294.0, 15435.459758908384, 15439.0, 15448.304826282843, 15454.768178477332, 11365.204435689588, 11569.595064172881, 12544.560940367044, 12550.0, 12702.618921432371, 14190.361433735507, 14190.361433735507, 14192.148471091561, 14199.716005680035, 14269.0, 6067.7269522871575, 6138.693065346715, 6166.568340216231, 6205.193324867829, 6225.346338634468, 899.0380293086334, 915.4415806358116, 967.908048735369, 1001.2240513602017, 1116.4808364110727, 28913.855430722713, 29313.0, 29436.0, 29447.0, 29634.0, 1056.3820165203442, 1074.0280046557878, 1107.3189988157226, 1170.052257671289, 1177.3230392524333, 14794.038387504777, 14798.260086995608, 14801.481948131765, 15115.093094414371, 15216.391344346102, 537655.0, 542361.0, 543879.0, 544094.2795285998, 544155.0, 57154.7142264286, 57536.136957945666, 57630.7118464405, 57680.0, 57917.710411447675, 1406.4093080906043, 1419.1839692177039, 1443.328852083744, 1443.8989270751156, 1450.1299220467845, 23664.88167559151, 29325.1789148143, 30643.693563064084, 31978.36043279168, 32350.83824580862, 54497.0, 55150.724246380116, 55326.0, 55411.722941386644, 55411.89176216372, 501787.0, 506743.0, 507142.9285707096, 507199.0, 507215.0, 35069.298614027066, 42493.787531062146, 42554.57445425506, 43695.0, 43760.0, 41646.0, 41695.791521043415, 41776.37335440032, 41869.581304187785, 42851.357229642206, 27430.17709468719, 34914.65085349216, 36082.27835443224, 36411.725589605296, 37786.43320350142, 29412.411751765274, 35356.0, 35628.82185589056, 36917.077073073386, 37972.240555189295, 34839.65160348364, 35299.47050794292, 35536.822315888254, 35672.0, 35783.64216357803, 25956.610650839873, 31603.051908442783, 31768.888088916778, 31881.0, 32814.0, 21961.23135690243, 22412.663810042537, 23711.762882370957, 23805.880970595037, 24385.7079294293], "unit": "score", "name": "ext.html", "value": 18996.4345491191}, {"lowerIsBetter": false, "replicates": [294.4758330172293, 366.62421018456087, 368.57061523325325, 368.5945459994007, 374.85193348627274, 15155.393784248645, 15449.69100617987, 19098.618027639455, 19715.802841971577, 20251.49371265717, 17408.216630251638, 17445.912770436164, 17806.376776812813, 18650.25398984039, 19299.807001929978, 5644.604877658555, 5846.386129456409, 5847.064469684851, 5849.678267695275, 5859.79490717825, 4175.081482073939, 4370.2133615949115, 5732.283464566929, 5786.623869448494, 6127.387261273881, 6234.625922444668, 6260.311365749764, 6332.208473940757, 6333.20834895638, 6346.2067241594805, 5355.544778693777, 6158.107074474198, 6330.556861019708, 6332.303446620868, 6336.398042186008, 5335.546478549328, 5388.218708287315, 5468.589855760833, 5493.533049690781, 5503.724813759296, 21956.780432195632, 22365.32904012882, 23850.0, 25096.49807003868, 25534.74465255342, 1865.9626807463774, 1980.4157773456866, 2157.924472643466, 2168.967465488019, 2229.4872179398667, 14221.502247421291, 14281.500147494891, 14517.112775339137, 14698.926505367512, 15216.08703477795, 1546.9458568950145, 1727.265911987413, 1776.3072401763322, 1792.57874399516, 1800.918958646851, 100757.4962125192, 100939.49530252375, 101950.49024754902, 102183.0, 103932.9213415735, 10657.946710266398, 11007.119430445546, 11009.779804403866, 11014.118870490342, 11128.777424451466, 13007.544735934196, 13145.934270328587, 13176.077674562881, 13190.670233244055, 13211.471541138439, 8325.417220794487, 8330.500169989698, 8360.0, 8412.873806892901, 8427.41008129425, 6223.37766223374, 7331.78004659861, 8436.662533498715, 8438.83122337562, 8512.106228845882, 3997.600239975979, 4058.736182148151, 4506.098780243964, 4521.977390113028, 4536.319552067216, 1776.5913839816915, 1809.7647305850155, 1852.4039512650902, 1853.2494339792406, 1855.5453913790939, 730.0582248898967, 779.567340126224, 825.2036784502983, 906.1844340093836, 960.1790469148917, 15371.0, 18689.81310186908, 18740.344087957128, 19030.33393831209, 19157.521061973563, 796.77690246731, 952.1906379577304, 973.4354074636693, 1003.1523362758458, 1006.1598565197995, 8422.831543369099, 10223.699667574736, 10419.791604167875, 10430.68707938763, 10456.477176141163, 714753.0, 722102.0, 751427.0, 759816.2009189918, 763915.0, 69437.61124777477, 69600.65199673969, 98739.0252194952, 101853.0, 108086.0, 1055.8996895294936, 1111.822108462642, 1126.4536699700802, 1131.2025022359217, 1135.920485566019, 14346.928265358607, 18036.729449058013, 18579.535511612317, 19090.427287181406, 19562.21751129939, 48582.5141748578, 49397.01205975932, 50742.74628626833, 52643.73678131585, 54295.18557221724, 62168.0, 70036.0, 70675.64662176656, 72804.0, 73340.26659733547, 6157.692115394123, 7514.774556763306, 7610.657520411484, 7963.562004089599, 7973.72091976778, 9369.531523423939, 9459.763505912408, 12202.877971220174, 12316.228848509014, 12372.938135309267, 10115.747106322106, 10298.897011029794, 10529.42088185157, 10683.893161068601, 10732.195085368472, 10465.162786977176, 10560.894391055992, 10627.681169564925, 10700.30448020876, 10729.356238625707, 10412.32319899204, 10789.244752867224, 10847.620333288298, 11057.391843448688, 11192.104631629612, 7749.7675069748, 7949.523028618301, 7954.840903181788, 7968.84062318762, 7976.322012628992, 9604.423734575948, 10301.9484902575, 10750.0, 10926.836097458703, 11043.447827608748], "unit": "score", "name": "jquery.html", "value": 9143.535241589112}, {"lowerIsBetter": false, "replicates": [1315.9342032898353, 1526.847315268473, 1553.409704312361, 1781.7594624725657, 1829.3871553029726, 6934.0, 7840.294373506384, 8637.0, 8658.177473140056, 8663.133686631334, 8271.379646526504, 8585.313174946004, 8595.656173753057, 8598.957005214981, 8646.740597782062, 2028.8072633099905, 2170.0, 2217.756046834847, 2443.010580714809, 2484.4534202475425, 2493.6259561065804, 2495.301315631617, 2497.4880149569294, 2497.8751062446804, 2501.58723810571, 1968.9367741419617, 2160.8703477791305, 2408.5303365843665, 2468.90124395024, 2477.331120597438, 2439.0731522021606, 2468.456939473313, 2488.912888048928, 2490.2902672738182, 2493.114944194821, 2445.5231229910173, 2471.530409222242, 2484.6521486991837, 2492.9376765580823, 2494.052260141153, 8603.397762156652, 8661.956690216572, 8670.0, 8672.349573781928, 8685.392022558424, 5350.0904846176245, 5460.481254280837, 5474.507294343528, 5484.808031718871, 5506.862328441781, 3536.2927414516944, 3576.8211589420425, 3677.191017976041, 3682.668559829628, 3685.2261025184744, 1023.2837014090167, 1041.3075304922218, 1053.631229069827, 1076.1122074288744, 1087.521490544158, 11887.46506407205, 11902.940485297604, 11903.16677832552, 11913.04695624348, 11970.880291197063, 4447.933281000787, 4559.654901803976, 4897.510248975074, 4978.4025916890205, 4987.301777751118, 10146.949265253626, 10158.187345012382, 10164.796704066026, 10169.491525423698, 10170.796584068277, 5504.532114770209, 5506.504414602705, 5514.95215908976, 5519.199716041152, 5532.474414930575, 4955.554000140005, 5022.221555658879, 5023.698578085254, 5026.045051440215, 5031.496850315012, 3862.671672907778, 3888.902777430587, 3893.9875632335797, 3919.333713268751, 3939.4287828265315, 1125.9774804504027, 1260.136806287696, 1287.948482060707, 1291.9354032298347, 1294.5533790842144, 1323.6426164935413, 1331.7602831490424, 1357.9864201358057, 1360.3130419138272, 1360.7414591227634, 8007.719729809429, 8161.795955101051, 8177.386695997824, 8213.055498617736, 8221.712240071569, 502.071168338578, 503.4864438272941, 511.749242870998, 512.9461406552333, 514.7503460821498, 6172.938270617326, 6188.226471691039, 6218.253809542884, 6229.3770622937345, 6232.937670623326, 10240.180785537288, 10637.734056648645, 10739.033486986209, 10750.73123171927, 10770.838437423445, 9902.405855648683, 10621.575136994588, 10624.840627390595, 10632.25574209798, 10647.094996925192, 7977.162397948248, 8085.0, 8175.018997720431, 8187.426880118334, 8188.26305632484, 7899.763007109796, 7919.564423956737, 8009.679612815422, 8026.678932842621, 8038.155993620586, 9429.387089839138, 9514.666986655433, 9534.475603841578, 9594.232461402931, 9650.324477286804, 9374.718758437259, 9722.416655000723, 9901.108900199017, 9910.058544438267, 9930.453825039693, 6829.180498340231, 6997.650117494207, 7212.098487689039, 7403.777886663409, 7408.629403560359, 8182.7545173644885, 8189.467684600482, 8225.095239523767, 8228.136045715113, 8251.917480825356, 6328.557001009885, 7414.22150674193, 7639.427042971688, 7703.998480197539, 7781.766547003599, 7464.664090116066, 7538.359239464707, 7546.584937828472, 7684.193159718149, 7693.346065584488, 7692.9615351922885, 7749.845003100019, 7753.534787912743, 7756.92243077562, 7763.340116089969, 6877.4841886857685, 7002.894956575554, 7012.964935175495, 7027.191872934473, 7095.467839911924, 7183.892241616275, 7198.6400679964745, 7209.747658831916, 7220.097487814023, 7232.240614735377], "unit": "score", "name": "mootools.html", "value": 4816.957156800818}, {"lowerIsBetter": false, "replicates": [317.25128696276784, 324.53753401403, 329.12617001860053, 329.3511781789876, 332.92342761164946, 6498.285188629247, 6649.235337936133, 6680.432163266129, 6716.462682985361, 6756.7635132770365, 5783.797567085153, 6184.81445556634, 6465.70904309306, 6598.835029124274, 6606.669666516667, 4849.733264670451, 4886.438059623136, 4891.339669144673, 4892.706437613754, 4905.0, 4670.416197975253, 4759.024399998009, 4769.236922092466, 4870.43989941156, 4894.583960363373, 4797.664163508556, 4822.132016237076, 4823.565879070883, 4829.3480380148585, 4849.175640141185, 4799.544043315879, 4806.182948898696, 4820.301056346828, 4825.758712064383, 4847.491013443573, 3384.3062172254627, 4124.8143833527265, 4129.504459464853, 4132.834686612532, 4140.875773726793, 5139.691618502864, 6165.475934545569, 6322.810315690536, 6437.0, 6449.580777249464, 5572.86067848303, 5591.524720398771, 5606.271184745998, 5610.438956104398, 5624.3813180550105, 6650.301718319555, 7024.54340467873, 7041.3310735480045, 7049.577025378494, 7075.292470752935, 4402.603765661074, 4405.163019026407, 4510.819567217307, 4527.592516673482, 4531.13908357411, 5816.621919575214, 7413.406927445845, 7431.739889103909, 7431.996680448125, 7472.925270747277, 4212.620864122244, 4240.448741663564, 4587.518310577408, 4613.515580863961, 4621.237495813153, 4552.97723511387, 4643.421236779511, 4680.087382960358, 4687.20317546018, 4695.5304469552775, 5586.301712285965, 5587.804426845122, 5588.357338905997, 5615.859603509945, 5651.886962260732, 7033.8944915826305, 7039.120109986252, 7048.436125109979, 7049.506534542533, 7052.153741551047, 1611.484325016007, 1635.9182040897908, 1639.1230691580186, 1640.9425670101489, 1642.4415698662274, 1013.5591017907234, 1045.8704599033026, 1046.2048842879467, 1047.0, 1055.3931489393628, 5001.874578219871, 5473.877855039707, 6482.546221764431, 6572.11276477679, 6603.141591593062, 6626.237982631963, 7266.600336981517, 7280.526765760314, 7287.344139027513, 7301.050863387725, 6342.809715708536, 6551.836204094936, 6559.311272316433, 6565.507586930904, 6573.079768832367, 3816.6755825754567, 3876.5348158221195, 3878.4957955466175, 3878.5733569307354, 3883.0874744435037, 7597.810054748676, 7601.011868457065, 7611.885821712679, 7619.771406857803, 7634.083909930844, 5958.7914422995855, 7285.453590980592, 7487.7004919803685, 7521.210272921265, 7561.886571701429, 7570.0, 7578.204288549843, 7583.924160758432, 7592.962035189788, 7594.5063570867715, 5446.618736688394, 7077.929220707727, 7235.674394652148, 7267.454940879349, 7269.164046134762, 6390.265119511129, 7225.891611625725, 7237.927620723936, 7239.755675740537, 7267.0, 7748.031496062992, 7762.650680719268, 7773.494722843223, 7775.494592851446, 7775.688972441039, 4483.349914262349, 4644.907101858012, 4673.976630116827, 4676.602488788355, 4677.2750223715375, 7306.4520160989205, 7313.195548489768, 7318.96340518294, 7329.486935914648, 7337.0, 6923.900659628782, 7059.858802824017, 7068.68190931399, 7099.0, 7099.609521476368, 7055.3650171484815, 7081.82295442618, 7092.929070709433, 7102.4673149512955, 7127.216006239206, 6939.410150137295, 6972.477064220102, 6974.37230649244, 6975.0, 6978.930210697828, 6864.38220560152, 7093.056381601577, 7105.467089968376, 7147.46394020461, 7168.928310717035, 6971.51199416036, 7011.3339232772805, 7014.754483593049, 7020.368166865007, 7040.190378106583], "unit": "score", "name": "prototype.html", "value": 5107.878450693191}, {"lowerIsBetter": false, "replicates": [684.5481981891951, 697.2748341724607, 710.7121615745623, 720.484853329869, 766.1878408886585, 15144.0, 15196.772048419283, 15276.388944442237, 15382.461613843503, 15438.536843894688, 13711.65720856979, 13922.791158132635, 13924.443022279122, 13941.512047078355, 13961.93019034906, 703.7114782938996, 721.4805340155079, 741.7960060983219, 764.9672941528919, 864.7924498120469, 870.0212261206143, 876.5967654878764, 880.3573391424264, 880.8458519759049, 881.9073997230295, 926.4117285523707, 928.8142371525722, 929.5166513413021, 930.1303281431883, 931.12009151352, 726.7056841978981, 742.7920182348923, 743.4201322968094, 746.2686567164183, 747.0139415970921, 669.9631520266383, 684.565301033847, 685.8319711670623, 686.080651926416, 687.3435868745336, 14933.477328293458, 14990.477237849096, 14994.0, 15000.549983500403, 15007.399704011827, 12342.568010119603, 12534.68663283416, 12617.810732839014, 12661.30362830044, 12846.229226246454, 9879.802403951953, 10128.94935525325, 10195.847062293997, 10359.482025898675, 10809.621663241749, 3486.738494612914, 3524.3303772283184, 3525.189206482498, 3525.788452692821, 3532.364174448598, 75974.0, 76566.46867062683, 76685.0, 78159.6092019542, 86679.0, 9427.387219830689, 9468.763280918032, 9469.030518409158, 9545.522723863918, 9811.75470613226, 20590.897045514677, 20637.277695280893, 20642.380728578166, 20651.070701818455, 20657.070431830605, 7432.591207483641, 7625.771226863203, 7644.503107298008, 7680.462367634212, 7726.729564465217, 4115.506139263308, 4152.667786577066, 4158.8933433890315, 4195.4336164618, 4201.075763332062, 3361.310931259086, 3396.286779776225, 3399.2181798186557, 3405.931881362359, 3415.958132769529, 647.1296106736432, 654.6824789976857, 668.7625892807984, 671.2984930747381, 676.5805200775551, 515.7034705044539, 545.4218528359872, 565.5588640860136, 594.4679511836882, 612.3845535237058, 8115.715949941724, 8520.829583408296, 8749.343799215085, 8939.106089391138, 9333.859992100124, 486.3750081145781, 525.8054519827688, 545.4273013335982, 549.4917201588514, 552.9225908372831, 3841.327767640652, 4079.0414252650603, 4087.4686290782006, 4196.244675958357, 4220.514640816284, 97108.0, 98488.0, 100641.49679251557, 100642.0, 102283.46574801384, 59872.0, 80535.59732201301, 83096.58451707824, 85960.0, 86948.130518694, 74284.0, 74831.25168748242, 75470.62264688642, 76214.61892690501, 79330.0, 8397.664093436195, 8966.865497017681, 9038.404286990071, 9053.818923621622, 9238.122378374044, 51365.20221792369, 51586.0, 52259.43221703355, 52631.47368526266, 53024.73487632537, 67180.32819671741, 71849.6407517959, 71957.6402118007, 72909.90635140371, 76765.0, 11842.111841612086, 11874.228175168586, 11894.226875253082, 11994.940025299818, 12243.047911260415, 11589.246698964878, 11653.242539235262, 12005.75988480208, 12208.69478263015, 12242.387880606113, 9939.602415903571, 11691.824622630496, 11714.824277636013, 11834.0, 12421.627351179479, 11390.228642089667, 11452.770944581229, 11478.0, 11767.588134415255, 12460.0, 11462.369569673749, 11571.710707232387, 11598.47806848677, 11852.170348075551, 11877.990370818578, 9450.858237126586, 9599.124639411231, 9740.512974351395, 9781.364211326241, 10072.848907266543, 9932.453715045742, 10022.247382953083, 10025.949870250603, 10094.242931780293, 10095.151879908526], "unit": "score", "name": "yui.html", "value": 6919.223586213085}], "name": "dromaeo_css", "value": 7415.905291152334}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 113.0, 108.0, 110.0, 112.0, 116.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [159.0, 121.0, 151.0, 194.0, 146.0, 152.0, 138.0, 123.0, 160.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [182.0, 184.0, 186.0, 186.0, 184.0, 184.0, 183.0, 188.0, 182.0, 179.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 85.0, 79.0, 56.0, 56.0, 59.0, 78.0, 75.0, 57.0], "unit": "score", "name": "audio-fft", "value": 69.4}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 123.0, 79.0, 81.0, 89.0, 109.0, 75.0, 77.0, 107.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [83.0, 89.0, 83.0, 90.0, 83.0, 89.0, 83.0, 89.0, 84.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 95.0, 93.0, 103.0, 144.0, 93.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 99.7}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 83.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 53.0, 54.0, 54.0, 53.0, 54.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [63.0, 69.0, 78.0, 72.0, 70.0, 67.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 81.0, 85.0, 82.0, 82.0, 83.0, 82.0, 80.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [126.0, 125.0, 132.0, 124.0, 120.0, 125.0, 125.0, 124.0, 127.0, 108.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [139.0, 131.0, 137.0, 168.0, 174.0, 135.0, 137.0, 138.0, 139.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [61.0, 66.0, 67.0, 58.0, 58.0, 96.0, 58.0, 76.0, 92.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.5}], "name": "kraken", "value": 1420.4}]} 05:42:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1420.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7415.91"}}} 05:42:21 INFO - Return code: 0 05:42:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:21 INFO - # TBPL SUCCESS # 05:42:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:42:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:42:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:42:21 INFO - 2016-02-17 05:42:21.437 screenresolution[1693:10414] starting screenresolution argv=screenresolution get 05:42:21 INFO - 2016-02-17 05:42:21.440 screenresolution[1693:10414] Display 0: 1600x1200x32@60 05:42:21 INFO - 2016-02-17 05:42:21.446 screenresolution[1694:10417] starting screenresolution argv=screenresolution list 05:42:21 INFO - Available Modes on Display 0 05:42:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:42:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:42:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:42:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:42:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:42:21 INFO - Intel Iris: 05:42:21 INFO - Chipset Model: Intel Iris 05:42:21 INFO - Type: GPU 05:42:21 INFO - Bus: Built-In 05:42:21 INFO - VRAM (Dynamic, Max): 1536 MB 05:42:21 INFO - Vendor: Intel (0x8086) 05:42:21 INFO - Device ID: 0x0a2e 05:42:21 INFO - Revision ID: 0x0009 05:42:21 INFO - Displays: 05:42:21 INFO - Display: 05:42:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:42:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:42:21 INFO - Display Serial Number: 1600x1200 60 05:42:21 INFO - Main Display: Yes 05:42:21 INFO - Mirror: Off 05:42:21 INFO - Online: Yes 05:42:21 INFO - Rotation: Supported 05:42:21 INFO - Return code: 0 05:42:21 INFO - Running post-action listener: _resource_record_post_action 05:42:21 INFO - Running post-run listener: _resource_record_post_run 05:42:22 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 33877504; Write bytes: 709462528; Read time: 354; Write time: 1931 05:42:22 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 405053952; Write bytes: 406620160; Read time: 30174; Write time: 764 05:42:22 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 31972864; Write bytes: 301994496; Read time: 333; Write time: 1165 05:42:22 INFO - Running post-run listener: _upload_blobber_files 05:42:22 INFO - Blob upload gear active. 05:42:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:42:22 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'] 05:42:22 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 05:42:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:23 INFO - (blobuploader) - INFO - Done attempting. 05:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:24 INFO - (blobuploader) - INFO - Done attempting. 05:42:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:24 INFO - Return code: 0 05:42:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f90729313b6c78b7f98180b2f81c1eabbfc18ace97feea9245ec9457b7770c83c5745bf2193f74d03db0ade4e1b256b5f0b1dee96aa813c2689215dbb091dd88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/809aba681e5a1e4dc890970bf06505a233a72f338213df46ecfa95312e709f8140481b749bb0c40dd317e7d1e84ddc925f808132c6cce4c2edcff77c9fe1d3f7"} 05:42:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:24 INFO - Contents: 05:42:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f90729313b6c78b7f98180b2f81c1eabbfc18ace97feea9245ec9457b7770c83c5745bf2193f74d03db0ade4e1b256b5f0b1dee96aa813c2689215dbb091dd88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/809aba681e5a1e4dc890970bf06505a233a72f338213df46ecfa95312e709f8140481b749bb0c40dd317e7d1e84ddc925f808132c6cce4c2edcff77c9fe1d3f7"} 05:42:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:24 INFO - Copying logs to upload dir... 05:42:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.734037 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-17 05:42:25.075250) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 05:42:25.078218) ========= 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.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/f90729313b6c78b7f98180b2f81c1eabbfc18ace97feea9245ec9457b7770c83c5745bf2193f74d03db0ade4e1b256b5f0b1dee96aa813c2689215dbb091dd88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/809aba681e5a1e4dc890970bf06505a233a72f338213df46ecfa95312e709f8140481b749bb0c40dd317e7d1e84ddc925f808132c6cce4c2edcff77c9fe1d3f7"} build_url:https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/OuxmVq18TESTrKJPI0lfnQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f90729313b6c78b7f98180b2f81c1eabbfc18ace97feea9245ec9457b7770c83c5745bf2193f74d03db0ade4e1b256b5f0b1dee96aa813c2689215dbb091dd88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/809aba681e5a1e4dc890970bf06505a233a72f338213df46ecfa95312e709f8140481b749bb0c40dd317e7d1e84ddc925f808132c6cce4c2edcff77c9fe1d3f7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 05:42:25.103586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:42:25.106877) ========= 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.XmcAvWpj0J/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.OhnxdUshuh/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005217 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 05:42:25.155248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 05:42:25.155520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 05:42:25.155854) ========= ========= Total master_lag: 22.84 =========