builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0091 starttime: 1459215824.3 results: success (0) buildid: 20160328162444 builduid: dec1db2d5ae6487396ecb81ef0e37605 revision: 5be27e14eef45f7e6e9517af427bbacb33d0b7da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 18:43:44.303200) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 18:43:44.303640) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-03-28 18:43:44.303924) ========= 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.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005788 basedir: '/builds/slave/test' ========= master_lag: 4.47 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-03-28 18:43:48.778661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-28 18:43:48.778966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-28 18:43:51.492936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-03-28 18:43:51.493183) ========= 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.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005310 ========= master_lag: 5.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-03-28 18:43:56.591953) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 18:43:56.592596) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 18:43:56.592965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-28 18:43:56.593251) ========= 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.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-28 18:43:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.71M=0.001s 2016-03-28 18:43:58 (8.71 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.763683 ========= master_lag: 3.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-28 18:44:01.110148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:44:01.110503) ========= 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.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.020460 ========= master_lag: 0.95 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 18:44:02.084564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-28 18:44:02.084884) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5be27e14eef45f7e6e9517af427bbacb33d0b7da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5be27e14eef45f7e6e9517af427bbacb33d0b7da --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-28 18:44:02,247 truncating revision to first 12 chars 2016-03-28 18:44:02,247 Setting DEBUG logging. 2016-03-28 18:44:02,248 attempt 1/10 2016-03-28 18:44:02,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5be27e14eef4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 18:44:03,895 unpacking tar archive at: mozilla-aurora-5be27e14eef4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.902415 ========= master_lag: 2.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-28 18:44:06.046588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-03-28 18:44:06.047048) ========= echo 5be27e14eef45f7e6e9517af427bbacb33d0b7da in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5be27e14eef45f7e6e9517af427bbacb33d0b7da'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 5be27e14eef45f7e6e9517af427bbacb33d0b7da program finished with exit code 0 elapsedTime=0.004793 script_repo_revision: '5be27e14eef45f7e6e9517af427bbacb33d0b7da' ========= master_lag: 5.50 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-03-28 18:44:11.547707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 17 secs) (at 2016-03-28 18:44:11.548031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 17 secs) (at 2016-03-28 18:44:29.503600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 21 secs) (at 2016-03-28 18:44:29.503877) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:44:30 INFO - MultiFileLogger online at 20160328 18:44:30 in /builds/slave/test 18:44:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:44:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:44:30 INFO - {'append_to_log': False, 18:44:30 INFO - 'base_work_dir': '/builds/slave/test', 18:44:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:44:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:44:30 INFO - 'branch': 'Mozilla-Aurora', 18:44:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:30 INFO - 'config_files': ('talos/mac_config.py',), 18:44:30 INFO - 'default_actions': ('clobber', 18:44:30 INFO - 'read-buildbot-config', 18:44:30 INFO - 'download-and-extract', 18:44:30 INFO - 'populate-webroot', 18:44:30 INFO - 'create-virtualenv', 18:44:30 INFO - 'install', 18:44:30 INFO - 'run-tests'), 18:44:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:30 INFO - 'download_minidump_stackwalk': True, 18:44:30 INFO - 'download_symbols': 'ondemand', 18:44:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:30 INFO - 'installer_path': 'installer.exe', 18:44:30 INFO - 'log_level': 'info', 18:44:30 INFO - 'log_name': 'talos', 18:44:30 INFO - 'log_to_console': True, 18:44:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:44:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:44:30 INFO - 'opt_config_files': (), 18:44:30 INFO - 'pip_index': False, 18:44:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:44:30 INFO - 'cmd': ('bash', 18:44:30 INFO - '-c', 18:44:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:44:30 INFO - 'enabled': True, 18:44:30 INFO - 'halt_on_failure': False, 18:44:30 INFO - 'name': 'check_screen_resolution'},), 18:44:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:44:30 INFO - 'cmd': ('bash', 18:44:30 INFO - '-c', 18:44:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:44:30 INFO - 'enabled': True, 18:44:30 INFO - 'halt_on_failure': False, 18:44:30 INFO - 'name': 'check_screen_resolution'},), 18:44:30 INFO - 'run_cmd_checks_enabled': True, 18:44:30 INFO - 'sps_profile': False, 18:44:30 INFO - 'sps_profile_interval': 0, 18:44:30 INFO - 'suite': 'dromaeojs-e10s', 18:44:30 INFO - 'system_bits': '32', 18:44:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:30 INFO - 'title': 't-yosemite-r7-0091', 18:44:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:30 INFO - 'use_talos_json': True, 18:44:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:44:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:30 INFO - 'work_dir': 'build'} 18:44:30 INFO - ##### 18:44:30 INFO - ##### Running clobber step. 18:44:30 INFO - ##### 18:44:30 INFO - Running pre-action listener: _resource_record_pre_action 18:44:30 INFO - Running main action method: clobber 18:44:30 INFO - rmtree: /builds/slave/test/build 18:44:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:44:31 INFO - Running post-action listener: _resource_record_post_action 18:44:31 INFO - ##### 18:44:31 INFO - ##### Running read-buildbot-config step. 18:44:31 INFO - ##### 18:44:31 INFO - Running pre-action listener: _resource_record_pre_action 18:44:31 INFO - Running main action method: read_buildbot_config 18:44:31 INFO - Using buildbot properties: 18:44:31 INFO - { 18:44:31 INFO - "project": "", 18:44:31 INFO - "product": "firefox", 18:44:31 INFO - "script_repo_revision": "production", 18:44:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:44:31 INFO - "repository": "", 18:44:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:44:31 INFO - "buildid": "20160328162444", 18:44:31 INFO - "pgo_build": "False", 18:44:31 INFO - "basedir": "/builds/slave/test", 18:44:31 INFO - "buildnumber": 228, 18:44:31 INFO - "slavename": "t-yosemite-r7-0091", 18:44:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:44:31 INFO - "platform": "yosemite_r7", 18:44:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:44:31 INFO - "branch": "mozilla-aurora", 18:44:31 INFO - "repo_path": "releases/mozilla-aurora", 18:44:31 INFO - "revision": "5be27e14eef45f7e6e9517af427bbacb33d0b7da", 18:44:31 INFO - "stage_platform": "macosx64", 18:44:31 INFO - "builduid": "dec1db2d5ae6487396ecb81ef0e37605", 18:44:31 INFO - "slavebuilddir": "test" 18:44:31 INFO - } 18:44:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 18:44:31 INFO - Running post-action listener: _resource_record_post_action 18:44:31 INFO - ##### 18:44:31 INFO - ##### Running download-and-extract step. 18:44:31 INFO - ##### 18:44:31 INFO - Running pre-action listener: _resource_record_pre_action 18:44:31 INFO - Running main action method: download_and_extract 18:44:31 INFO - mkdir: /builds/slave/test/build/tests 18:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:31 INFO - https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:44:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 18:44:33 INFO - Downloaded 1277 bytes. 18:44:33 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 18:44:33 INFO - Using the following test package requirements: 18:44:33 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:44:33 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 18:44:33 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 18:44:33 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'jsshell-mac.zip'], 18:44:33 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 18:44:33 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:44:33 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 18:44:33 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 18:44:33 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 18:44:33 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 18:44:33 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 18:44:33 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 18:44:33 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:44:33 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')]} 18:44:33 INFO - https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:44:45 INFO - Downloaded 17903145 bytes. 18:44:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:44:48 INFO - Return code: 0 18:44:48 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:44: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')]} 18:44:48 INFO - https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 18:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:44:59 INFO - Downloaded 17903145 bytes. 18:44:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:45:02 INFO - Return code: 0 18:45:02 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')]} 18:45:02 INFO - https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 18:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:45:11 INFO - Downloaded 10845161 bytes. 18:45:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:45:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:45:12 INFO - Return code: 0 18:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:12 INFO - https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 18:45:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:45:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:45:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 18:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 18:45:39 INFO - Downloaded 115005184 bytes. 18:45:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:45:39 INFO - mkdir: /builds/slave/test/properties 18:45:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:45:39 INFO - Writing to file /builds/slave/test/properties/build_url 18:45:39 INFO - Contents: 18:45:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 18:45:43 INFO - Running post-action listener: _resource_record_post_action 18:45:43 INFO - Running post-action listener: set_extra_try_arguments 18:45:43 INFO - ##### 18:45:43 INFO - ##### Running populate-webroot step. 18:45:43 INFO - ##### 18:45:43 INFO - Running pre-action listener: _resource_record_pre_action 18:45:43 INFO - Running main action method: populate_webroot 18:45:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:45:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:45:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:45:43 INFO - '--tppagecycles', 18:45:43 INFO - '7'], 18:45:43 INFO - 'tests': ['tsvgm']}}, 18:45:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:45:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:45:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:45:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:45:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:45:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'tests': ['damp', 'tps']}, 18:45:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['damp', 'tps']}, 18:45:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:45:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:45:43 INFO - 'other': {'tests': ['a11yr', 18:45:43 INFO - 'ts_paint', 18:45:43 INFO - 'tpaint', 18:45:43 INFO - 'sessionrestore', 18:45:43 INFO - 'sessionrestore_no_auto_restore', 18:45:43 INFO - 'tabpaint']}, 18:45:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['a11yr', 18:45:43 INFO - 'ts_paint', 18:45:43 INFO - 'tpaint', 18:45:43 INFO - 'sessionrestore', 18:45:43 INFO - 'sessionrestore_no_auto_restore', 18:45:43 INFO - 'tabpaint']}, 18:45:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['a11yr', 18:45:43 INFO - 'ts_paint', 18:45:43 INFO - 'tpaint', 18:45:43 INFO - 'sessionrestore', 18:45:43 INFO - 'sessionrestore_no_auto_restore', 18:45:43 INFO - 'tabpaint']}, 18:45:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['a11yr', 18:45:43 INFO - 'ts_paint', 18:45:43 INFO - 'tpaint', 18:45:43 INFO - 'sessionrestore', 18:45:43 INFO - 'sessionrestore_no_auto_restore', 18:45:43 INFO - 'tabpaint']}, 18:45:43 INFO - 'other_l64': {'tests': ['a11yr', 18:45:43 INFO - 'ts_paint', 18:45:43 INFO - 'tpaint', 18:45:43 INFO - 'sessionrestore', 18:45:43 INFO - 'sessionrestore_no_auto_restore', 18:45:43 INFO - 'tabpaint']}, 18:45:43 INFO - 'other_nol64': {'tests': ['a11yr', 18:45:43 INFO - 'ts_paint', 18:45:43 INFO - 'tpaint', 18:45:43 INFO - 'sessionrestore', 18:45:43 INFO - 'sessionrestore_no_auto_restore', 18:45:43 INFO - 'tabpaint']}, 18:45:43 INFO - 'svgr': {'tests': ['tsvgx', 18:45:43 INFO - 'tsvgr_opacity', 18:45:43 INFO - 'tart', 18:45:43 INFO - 'tscrollx', 18:45:43 INFO - 'cart']}, 18:45:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['tsvgx', 18:45:43 INFO - 'tsvgr_opacity', 18:45:43 INFO - 'tart', 18:45:43 INFO - 'tscrollx', 18:45:43 INFO - 'cart']}, 18:45:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'tests': ['tp5o']}, 18:45:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'talos_options': ['--e10s'], 18:45:43 INFO - 'tests': ['tp5o']}, 18:45:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'talos_options': ['--xperf_path', 18:45:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:43 INFO - 'tests': ['tp5n']}, 18:45:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:45:43 INFO - 'talos_options': ['--e10s', 18:45:43 INFO - '--xperf_path', 18:45:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:45:43 INFO - 'tests': ['tp5n']}}, 18:45:43 INFO - 'talos.zip': {'path': '', 18:45:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:45:43 INFO - Running post-action listener: _resource_record_post_action 18:45:43 INFO - ##### 18:45:43 INFO - ##### Running create-virtualenv step. 18:45:43 INFO - ##### 18:45:43 INFO - Running pre-action listener: _resource_record_pre_action 18:45:43 INFO - Running main action method: create_virtualenv 18:45:43 INFO - Creating virtualenv /builds/slave/test/build/venv 18:45:43 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 18:45:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:45:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:45:43 INFO - Using real prefix '/tools/python27' 18:45:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:45:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:45:47 INFO - Installing pip.................done. 18:45:47 INFO - Return code: 0 18:45:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 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 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:45:47 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 18:45:47 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 18:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:47 INFO - 'HOME': '/Users/cltbld', 18:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:47 INFO - 'LOGNAME': 'cltbld', 18:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:47 INFO - 'MOZ_NO_REMOTE': '1', 18:45:47 INFO - 'NO_EM_RESTART': '1', 18:45:47 INFO - 'PAGER': '/bin/cat', 18:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:47 INFO - 'PWD': '/builds/slave/test', 18:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:47 INFO - 'SHELL': '/bin/bash', 18:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:45:47 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:47 INFO - 'USER': 'cltbld', 18:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:47 INFO - 'XPC_FLAGS': '0x0', 18:45:47 INFO - 'XPC_SERVICE_NAME': '0', 18:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:47 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 18:45:47 INFO - Cleaning up... 18:45:47 INFO - Return code: 0 18:45:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:47 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 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:45:47 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 18:45:47 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 18:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:47 INFO - 'HOME': '/Users/cltbld', 18:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:47 INFO - 'LOGNAME': 'cltbld', 18:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:47 INFO - 'MOZ_NO_REMOTE': '1', 18:45:47 INFO - 'NO_EM_RESTART': '1', 18:45:47 INFO - 'PAGER': '/bin/cat', 18:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:47 INFO - 'PWD': '/builds/slave/test', 18:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:47 INFO - 'SHELL': '/bin/bash', 18:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:45:47 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:47 INFO - 'USER': 'cltbld', 18:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:47 INFO - 'XPC_FLAGS': '0x0', 18:45:47 INFO - 'XPC_SERVICE_NAME': '0', 18:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:47 INFO - Downloading/unpacking psutil>=0.7.1 18:45:47 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 18:45:47 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 18:45:47 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 18:45:47 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 18:45:47 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 18:45:47 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 18:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:55 INFO - Installing collected packages: psutil 18:45:55 INFO - Running setup.py install for psutil 18:45:55 INFO - building 'psutil._psutil_osx' extension 18:45:55 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 18:45:56 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 18:45:56 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 18:45:56 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 18:45:56 INFO - building 'psutil._psutil_posix' extension 18:45:56 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 18:45:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:45:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:45:56 INFO - ^ 18:45:56 INFO - 1 warning generated. 18:45:56 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 18:45:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:45:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:45:56 INFO - Successfully installed psutil 18:45:56 INFO - Cleaning up... 18:45:56 INFO - Return code: 0 18:45:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:56 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 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:45:56 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 18:45:56 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 18:45:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:45:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:56 INFO - 'HOME': '/Users/cltbld', 18:45:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:56 INFO - 'LOGNAME': 'cltbld', 18:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:56 INFO - 'MOZ_NO_REMOTE': '1', 18:45:56 INFO - 'NO_EM_RESTART': '1', 18:45:56 INFO - 'PAGER': '/bin/cat', 18:45:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:56 INFO - 'PWD': '/builds/slave/test', 18:45:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:56 INFO - 'SHELL': '/bin/bash', 18:45:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:45:56 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:45:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:56 INFO - 'USER': 'cltbld', 18:45:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:56 INFO - 'XPC_FLAGS': '0x0', 18:45:56 INFO - 'XPC_SERVICE_NAME': '0', 18:45:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:45:56 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 18:45:56 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 18:45:56 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 18:45:56 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 18:45:56 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 18:45:56 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 18:46:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:46:01 INFO - Installing collected packages: mozsystemmonitor 18:46:01 INFO - Running setup.py install for mozsystemmonitor 18:46:01 INFO - Successfully installed mozsystemmonitor 18:46:01 INFO - Cleaning up... 18:46:01 INFO - Return code: 0 18:46:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:46: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')]} 18:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:01 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 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:46:01 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 18:46:01 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 18:46:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:46:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:01 INFO - 'HOME': '/Users/cltbld', 18:46:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:01 INFO - 'LOGNAME': 'cltbld', 18:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:01 INFO - 'MOZ_NO_REMOTE': '1', 18:46:01 INFO - 'NO_EM_RESTART': '1', 18:46:01 INFO - 'PAGER': '/bin/cat', 18:46:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:01 INFO - 'PWD': '/builds/slave/test', 18:46:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:01 INFO - 'SHELL': '/bin/bash', 18:46:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:46:01 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:46:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:01 INFO - 'USER': 'cltbld', 18:46:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:01 INFO - 'XPC_FLAGS': '0x0', 18:46:01 INFO - 'XPC_SERVICE_NAME': '0', 18:46:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:02 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:02 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 18:46:02 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 18:46:02 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 18:46:02 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 18:46:02 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 18:46:02 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 18:46:06 INFO - Downloading blobuploader-1.2.4.tar.gz 18:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:46:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:46: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 18:46: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 18:46: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 18:46: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 18:46: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 18:46: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 18:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:46:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:46:07 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 18:46:07 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 18:46:07 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 18:46:07 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 18:46:07 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 18:46:07 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 18:46:07 INFO - Downloading docopt-0.6.1.tar.gz 18:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:46:07 INFO - Installing collected packages: blobuploader, requests, docopt 18:46:07 INFO - Running setup.py install for blobuploader 18:46:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:46:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:46:07 INFO - Running setup.py install for requests 18:46:08 INFO - Running setup.py install for docopt 18:46:08 INFO - Successfully installed blobuploader requests docopt 18:46:08 INFO - Cleaning up... 18:46:08 INFO - Return code: 0 18:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:08 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')]} 18:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:08 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')]} 18:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:08 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 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:46:08 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 18:46:08 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 18:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:08 INFO - 'HOME': '/Users/cltbld', 18:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:08 INFO - 'LOGNAME': 'cltbld', 18:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:08 INFO - 'MOZ_NO_REMOTE': '1', 18:46:08 INFO - 'NO_EM_RESTART': '1', 18:46:08 INFO - 'PAGER': '/bin/cat', 18:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:08 INFO - 'PWD': '/builds/slave/test', 18:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:08 INFO - 'SHELL': '/bin/bash', 18:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:46:08 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:08 INFO - 'USER': 'cltbld', 18:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:08 INFO - 'XPC_FLAGS': '0x0', 18:46:08 INFO - 'XPC_SERVICE_NAME': '0', 18:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:08 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-btFXHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:08 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-6iCRan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-6uDS50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ElEoTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-GL46Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-kVxMuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Ya2gYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-BFR_ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-zwIbPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-5OdaIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Rp5Fmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:09 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-k46qjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:10 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ISqaTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:10 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-S1oEcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:10 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-FhxuO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:10 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ADMRKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:10 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-FNGW5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:46:10 INFO - Running setup.py install for manifestparser 18:46:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:46:10 INFO - Running setup.py install for mozcrash 18:46:10 INFO - Running setup.py install for mozdebug 18:46:11 INFO - Running setup.py install for mozdevice 18:46:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Running setup.py install for mozfile 18:46:11 INFO - Running setup.py install for mozhttpd 18:46:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Running setup.py install for mozinfo 18:46:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Running setup.py install for mozInstall 18:46:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:46:11 INFO - Running setup.py install for mozleak 18:46:11 INFO - Running setup.py install for mozlog 18:46:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:46:12 INFO - Running setup.py install for moznetwork 18:46:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:46:12 INFO - Running setup.py install for mozprocess 18:46:12 INFO - Running setup.py install for mozprofile 18:46:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:46:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:46:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:46:12 INFO - Running setup.py install for mozrunner 18:46:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:46:12 INFO - Running setup.py install for mozscreenshot 18:46:12 INFO - Running setup.py install for moztest 18:46:13 INFO - Running setup.py install for mozversion 18:46:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:46:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:46:13 INFO - Cleaning up... 18:46:13 INFO - Return code: 0 18:46:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:13 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 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:46:13 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 18:46:13 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 18:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:13 INFO - 'HOME': '/Users/cltbld', 18:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:13 INFO - 'LOGNAME': 'cltbld', 18:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:13 INFO - 'MOZ_NO_REMOTE': '1', 18:46:13 INFO - 'NO_EM_RESTART': '1', 18:46:13 INFO - 'PAGER': '/bin/cat', 18:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:13 INFO - 'PWD': '/builds/slave/test', 18:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:13 INFO - 'SHELL': '/bin/bash', 18:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:46:13 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:13 INFO - 'USER': 'cltbld', 18:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:13 INFO - 'XPC_FLAGS': '0x0', 18:46:13 INFO - 'XPC_SERVICE_NAME': '0', 18:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:13 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-8z1GEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:13 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)) 18:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:13 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-jP1Qth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:13 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-JSZgoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:13 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)) 18:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:13 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-BHupII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:13 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)) 18:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:13 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-_dkLDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-MCDuOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-UCs3Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-62SFBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-DTrEim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-LIVEmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-i6ZMlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-9YOvin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-fbb22H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-wCFScz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:14 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)) 18:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:14 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ubNIVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:15 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)) 18:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:15 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-T4WBd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:15 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)) 18:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:15 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-6QMz3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:15 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)) 18:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:46:15 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)) 18:46:15 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)) 18:46:15 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)) 18:46:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:19 INFO - Downloading blessings-1.6.tar.gz 18:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:46:19 INFO - Installing collected packages: blessings 18:46:19 INFO - Running setup.py install for blessings 18:46:19 INFO - Successfully installed blessings 18:46:19 INFO - Cleaning up... 18:46:19 INFO - Return code: 0 18:46:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:46:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:20 INFO - Reading from file tmpfile_stdout 18:46:20 INFO - Current package versions: 18:46:20 INFO - blessings == 1.6 18:46:20 INFO - blobuploader == 1.2.4 18:46:20 INFO - docopt == 0.6.1 18:46:20 INFO - manifestparser == 1.1 18:46:20 INFO - mozInstall == 1.12 18:46:20 INFO - mozcrash == 0.17 18:46:20 INFO - mozdebug == 0.1 18:46:20 INFO - mozdevice == 0.48 18:46:20 INFO - mozfile == 1.2 18:46:20 INFO - mozhttpd == 0.7 18:46:20 INFO - mozinfo == 0.9 18:46:20 INFO - mozleak == 0.1 18:46:20 INFO - mozlog == 3.1 18:46:20 INFO - moznetwork == 0.27 18:46:20 INFO - mozprocess == 0.22 18:46:20 INFO - mozprofile == 0.28 18:46:20 INFO - mozrunner == 6.11 18:46:20 INFO - mozscreenshot == 0.1 18:46:20 INFO - mozsystemmonitor == 0.0 18:46:20 INFO - moztest == 0.7 18:46:20 INFO - mozversion == 1.4 18:46:20 INFO - psutil == 3.1.1 18:46:20 INFO - requests == 1.2.3 18:46:20 INFO - wsgiref == 0.1.2 18:46:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:20 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 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:46:20 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 18:46:20 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 18:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:20 INFO - 'HOME': '/Users/cltbld', 18:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:20 INFO - 'LOGNAME': 'cltbld', 18:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:20 INFO - 'MOZ_NO_REMOTE': '1', 18:46:20 INFO - 'NO_EM_RESTART': '1', 18:46:20 INFO - 'PAGER': '/bin/cat', 18:46:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:20 INFO - 'PWD': '/builds/slave/test', 18:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:20 INFO - 'SHELL': '/bin/bash', 18:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:46:20 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:20 INFO - 'USER': 'cltbld', 18:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:20 INFO - 'XPC_FLAGS': '0x0', 18:46:20 INFO - 'XPC_SERVICE_NAME': '0', 18:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 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)) 18:46:20 INFO - Cleaning up... 18:46:20 INFO - Return code: 0 18:46:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:20 INFO - 'HOME': '/Users/cltbld', 18:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:20 INFO - 'LOGNAME': 'cltbld', 18:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:20 INFO - 'MOZ_NO_REMOTE': '1', 18:46:20 INFO - 'NO_EM_RESTART': '1', 18:46:20 INFO - 'PAGER': '/bin/cat', 18:46:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:20 INFO - 'PWD': '/builds/slave/test', 18:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:20 INFO - 'SHELL': '/bin/bash', 18:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:46:20 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:20 INFO - 'USER': 'cltbld', 18:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:20 INFO - 'XPC_FLAGS': '0x0', 18:46:20 INFO - 'XPC_SERVICE_NAME': '0', 18:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:20 INFO - Downloading/unpacking jsonschema 18:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:46:26 INFO - Downloading/unpacking functools32 (from jsonschema) 18:46:26 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 18:46:26 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 18:46:26 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 18:46:26 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 18:46:26 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 18:46:26 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 18:46:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:46:26 INFO - warning: no files found matching '*.txt' 18:46:26 INFO - no previously-included directories found matching 'build' 18:46:26 INFO - no previously-included directories found matching 'dist' 18:46:26 INFO - no previously-included directories found matching '.git*' 18:46:26 INFO - Installing collected packages: jsonschema, functools32 18:46:26 INFO - Running setup.py install for functools32 18:46:27 INFO - warning: no files found matching '*.txt' 18:46:27 INFO - no previously-included directories found matching 'build' 18:46:27 INFO - no previously-included directories found matching 'dist' 18:46:27 INFO - no previously-included directories found matching '.git*' 18:46:27 INFO - Successfully installed jsonschema functools32 18:46:27 INFO - Cleaning up... 18:46:27 INFO - Return code: 0 18:46:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:46: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')]} 18:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9e94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa5347b6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, '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.fGdnS1pzQi/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.JNV07gUzX1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 18:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:46:27 INFO - 'HOME': '/Users/cltbld', 18:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:46:27 INFO - 'LOGNAME': 'cltbld', 18:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:27 INFO - 'MOZ_NO_REMOTE': '1', 18:46:27 INFO - 'NO_EM_RESTART': '1', 18:46:27 INFO - 'PAGER': '/bin/cat', 18:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:27 INFO - 'PWD': '/builds/slave/test', 18:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:46:27 INFO - 'SHELL': '/bin/bash', 18:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:46:27 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:46:27 INFO - 'USER': 'cltbld', 18:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:27 INFO - 'XPC_FLAGS': '0x0', 18:46:27 INFO - 'XPC_SERVICE_NAME': '0', 18:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:27 INFO - Downloading/unpacking flake8 18:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:46:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:46:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:46:35 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 18:46:35 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 18:46:35 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 18:46:35 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 18:46:35 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 18:46:35 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 18:46:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:46:36 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 18:46:36 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 18:46:36 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 18:46:36 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 18:46:36 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 18:46:36 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 18:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:46:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:46:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:46:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:46:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:46:36 INFO - no previously-included directories found matching 'docs/_build' 18:46:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:46:37 INFO - Running setup.py install for pep8 18:46:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:46:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:46:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:46:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:46:37 INFO - no previously-included directories found matching 'docs/_build' 18:46:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:46:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:46:37 INFO - Cleaning up... 18:46:37 INFO - Return code: 0 18:46:37 INFO - Running post-action listener: _resource_record_post_action 18:46:37 INFO - Running post-action listener: _start_resource_monitoring 18:46:37 INFO - Starting resource monitoring. 18:46:37 INFO - ##### 18:46:37 INFO - ##### Running install step. 18:46:37 INFO - ##### 18:46:37 INFO - Running pre-action listener: _resource_record_pre_action 18:46:37 INFO - Running main action method: install 18:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:37 INFO - Reading from file tmpfile_stdout 18:46:37 INFO - Detecting whether we're running mozinstall >=1.0... 18:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:46:37 INFO - Reading from file tmpfile_stdout 18:46:37 INFO - Output received: 18:46:37 INFO - Usage: mozinstall [options] installer 18:46:37 INFO - Options: 18:46:37 INFO - -h, --help show this help message and exit 18:46:37 INFO - -d DEST, --destination=DEST 18:46:37 INFO - Directory to install application into. [default: 18:46:37 INFO - "/builds/slave/test"] 18:46:37 INFO - --app=APP Application being installed. [default: firefox] 18:46:37 INFO - mkdir: /builds/slave/test/build/application 18:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:47:09 INFO - Reading from file tmpfile_stdout 18:47:09 INFO - Output received: 18:47:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:47:09 INFO - Running post-action listener: _resource_record_post_action 18:47:09 INFO - ##### 18:47:09 INFO - ##### Running run-tests step. 18:47:09 INFO - ##### 18:47:09 INFO - Running pre-action listener: _resource_record_pre_action 18:47:09 INFO - Running main action method: run_tests 18:47:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:47:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:47:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:47:09 INFO - 2016-03-28 18:47:09.718 screenresolution[2256:30477] starting screenresolution argv=screenresolution get 18:47:09 INFO - 2016-03-28 18:47:09.721 screenresolution[2256:30477] Display 0: 1600x1200x32@60 18:47:09 INFO - 2016-03-28 18:47:09.727 screenresolution[2257:30479] starting screenresolution argv=screenresolution list 18:47:09 INFO - Available Modes on Display 0 18:47:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:47:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:47:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:47:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:47:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:47:09 INFO - Intel Iris: 18:47:09 INFO - Chipset Model: Intel Iris 18:47:09 INFO - Type: GPU 18:47:09 INFO - Bus: Built-In 18:47:09 INFO - VRAM (Dynamic, Max): 1536 MB 18:47:09 INFO - Vendor: Intel (0x8086) 18:47:09 INFO - Device ID: 0x0a2e 18:47:09 INFO - Revision ID: 0x0009 18:47:09 INFO - Displays: 18:47:09 INFO - Display: 18:47:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:47:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:47:09 INFO - Display Serial Number: 1600x1200 60 18:47:09 INFO - Main Display: Yes 18:47:09 INFO - Mirror: Off 18:47:09 INFO - Online: Yes 18:47:09 INFO - Rotation: Supported 18:47:09 INFO - Return code: 0 18:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:47:09 INFO - Python 2.7.3 18:47:09 INFO - Return code: 0 18:47:09 INFO - grabbing minidump binary from tooltool 18:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d886d30>, '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 0x10d6eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d87db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:47:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:47:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:47:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:10 INFO - Return code: 0 18:47:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:47:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:47:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:47:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:47:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:47:11 INFO - Return code: 0 18:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0091 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fGdnS1pzQi/Render', 18:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:47:11 INFO - 'HOME': '/Users/cltbld', 18:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:47:11 INFO - 'LOGNAME': 'cltbld', 18:47:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:47:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:11 INFO - 'MOZ_NO_REMOTE': '1', 18:47:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:47:11 INFO - 'NO_EM_RESTART': '1', 18:47:11 INFO - 'PAGER': '/bin/cat', 18:47:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:11 INFO - 'PWD': '/builds/slave/test', 18:47:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:47:11 INFO - 'SHELL': '/bin/bash', 18:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JNV07gUzX1/Listeners', 18:47:11 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 18:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:47:11 INFO - 'USER': 'cltbld', 18:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:11 INFO - 'XPC_FLAGS': '0x0', 18:47:11 INFO - 'XPC_SERVICE_NAME': '0', 18:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:47:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:47:11 INFO - mozversion application_buildid: 20160328162444 18:47:11 INFO - mozversion application_changeset: 5be27e14eef45f7e6e9517af427bbacb33d0b7da 18:47:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:47:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:11 INFO - mozversion application_name: Firefox 18:47:11 INFO - mozversion application_remotingname: firefox-dev 18:47:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:47:11 INFO - mozversion application_vendor: Mozilla 18:47:11 INFO - mozversion application_version: 47.0a2 18:47:11 INFO - mozversion platform_buildid: 20160328162444 18:47:11 INFO - mozversion platform_changeset: 5be27e14eef45f7e6e9517af427bbacb33d0b7da 18:47:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:47:11 INFO - mozversion platform_version: 47.0a2 18:47:11 INFO - using testdate: 1459216031 18:47:11 INFO - actual date: 1459216031 18:47:11 INFO - starting webserver on 'localhost:53889' 18:47:11 INFO - SUITE-START | Running 2 tests 18:47:11 INFO - TEST-START | dromaeo_css 18:47:11 INFO - operating with platform_type : mac_ 18:47:11 INFO - Initialising browser for dromaeo_css test... 18:47:11 INFO - TEST-INFO | started process 2275 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpXvkomf/profile http://localhost:53889/getInfo.html) 18:47:14 INFO - PROCESS | 2275 | __metrics Screen width/height:1600/1200 18:47:14 INFO - PROCESS | 2275 | colorDepth:24 18:47:14 INFO - PROCESS | 2275 | Browser inner width/height: 1024/689 18:47:14 INFO - PROCESS | 2275 | __metrics 18:47:14 ERROR - PROCESS | 2275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:47:14 INFO - TEST-INFO | 2275: exit 0 18:47:14 INFO - Browser initialized. 18:47:14 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:14 INFO - TEST-INFO | started process 2278 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpXvkomf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:27 INFO - PROCESS | 2278 | RSS: Main: 219877376 18:47:27 INFO - PROCESS | 2278 | 18:48:16 INFO - PROCESS | 2278 | 1459216096631 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] 18:50:28 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:53889/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53889/tests/dromaeo/cssquery-ext.html) 18:50:29 INFO - PROCESS | 2278 | RSS: Main: 231378944 18:50:29 INFO - PROCESS | 2278 | 18:53:31 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:53889/tests/dromaeo/cssquery-ext.html (next: http://localhost:53889/tests/dromaeo/cssquery-jquery.html) 18:53:32 INFO - PROCESS | 2278 | RSS: Main: 244224000 18:53:32 INFO - PROCESS | 2278 | 18:56:33 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:53889/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53889/tests/dromaeo/cssquery-mootools.html) 18:56:34 INFO - PROCESS | 2278 | RSS: Main: 244572160 18:56:34 INFO - PROCESS | 2278 | 18:59:35 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:53889/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53889/tests/dromaeo/cssquery-prototype.html) 18:59:36 INFO - PROCESS | 2278 | RSS: Main: 246583296 18:59:36 INFO - PROCESS | 2278 | 19:02:39 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:53889/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53889/tests/dromaeo/cssquery-yui.html) 19:02:39 INFO - PROCESS | 2278 | RSS: Main: 248938496 19:02:39 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | Cycle 1(1): loaded http://localhost:53889/tests/dromaeo/cssquery-yui.html (next: http://localhost:53889/tests/dromaeo/cssquery-dojo.html) 19:05:41 INFO - PROCESS | 2278 | RSS: Main: 251453440 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | __start_tp_report 19:05:41 INFO - PROCESS | 2278 | _x_x_mozilla_page_load 19:05:41 INFO - PROCESS | 2278 | _x_x_mozilla_page_load_details 19:05:41 INFO - PROCESS | 2278 | |i|pagename|runs| 19:05:41 INFO - PROCESS | 2278 | |0;dojo.html;2909.2872246299657;3580.946285805712;3597.6941959933406;3636.9090772730688;3651.65309295617;5403.78384864605;5453.291072160623;5908.970455147723;5928.258967629046;5933.317668468122;5948.7620495180245;5979.0134627786365;5980.923433781917;5988;6012.5791194616395;5330.99999999999;5378.677279363231;5426.077566813631;5450.5367043801325;5496.80761173359;5292;5401.054815407308;5410;5417.945820541783;5430.294061771984;5366.9463305366835;5433.4566543345745;5438.211459338394;5453.127499600065;5472.480114389146;5373.113436283009;5456.590755693339;5462.754176062087;5480.177973303997;5517.779288828442;5287.603429742746;5388.326459192601;5388.946110538884;5422.295101636762;5431.565474762049;5659.264295641581;5844.4739973402175;5855.4144585541535;5954.106883967396;5993.460588547052;5841.153032810219;6231.750729970796;6273.811785646438;6316.336784637593;6317.4946004319545;6324.71538780756;6327;6335.334789847092;6335.809925702236;6378.107065010902;5869.060950248026;6011;6050.45545900871;6066.605670631395;6067.423594758491;6360.681965901779;6461.160049193575;6470.773522926675;6479.546431749826;6480.25477070143;6283.214598175228;6305.054241863665;6314.336994615591;6328.7468501260355;6330.620162790247;6258.874822503524;6272.749090036347;6299.842503937438;6333.2716737575765;6337.176167098248;6273.466755325757;6287.685615719196;6314.463270621956;6323.20959880015;6330.39861213184;6223.875522489616;6275.3724627536885;6317.210348706411;6320.873582528324;6339.4611458025665;4914.0908931847725;4941.45643979162;4958.603311735053;5008.048470790538;5071.543561079447;4509.1658043262105;4512.887177820515;4521.186186486399;4521.892136426596;4532.1842068427995;5825.1844741736195;5848.561357898175;5865.442782935615;5868.67722275279;5871.3541510433815;5929.229200203946;6172.969135154295;6215.12988181655;6266.49868010558;6300.401461861115;5861.267341582302;5869.882602347929;5875.823725288248;5876.118582212703;5890.764369425261;5478.58910581708;5505.284313039359;5507.889842203133;5515.641483303572;5525.977694126599;6341.460975817107;6416.679166041773;6455.709493072729;6501.2523559791225;6508.576942498722;5272.973635131953;6340.904886426615;6383.680815959091;6384.329645387167;6391.2330520337855;6277.2781130170615;6554.606723596599;6565.343465653396;6582.670866456562;6592.110065141144;6123.969380153071;6191.349908259568;6271.3415091414745;6300.243970723543;6314.936850631435;5505.889882202254;6275.900541919053;6314.116023756769;6318.115463835159;6329.778457753957;5252.343457067866;6119.715820550834;6201.875962480815;6284.3087260402235;6293.905591416224;5702.830919661376;5948.791792287249;6222.782202622887;6289.433950944437;6304.369563043842;5913.46778789911;6036;6142.723577439116;6160.507159427325;6173.9073913892225;5123.6157288202785;6143.723532440961;6155;6209.410106039919;6297.244330680348;6193.566450348612;6205.751769929152;6208.130861679459;6214.689265536796;6238.532110091671 19:05:41 INFO - PROCESS | 2278 | |1;ext.html;501.0530098114562;570.9657420554767;591.4794980417232;678.7217240931218;679.6703598754605;38809.22381552367;39238.80380598093;39617.207655846905;39745.8012709936;39780.204395912064;41391.17217655645;41427.550035748754;41780;41880;42013;9452.291078169148;9638.867368105359;9651.613935442574;9686.07982241686;9716.31985760997;9527.285453590974;9717.174040206592;9777.804443911153;9799.41203527787;9812.313138080337;9712;9730.854037189412;9737.853932191023;9794.118529332358;9795.559199835989;9674.90325096747;9706.369086009387;9737.367071140354;9762.804743905153;9795.118439340493;9615.711528654152;9752.512374381253;9757.268204884662;9769.364991275615;9778.51107444632;40840;41045;41107.38338924918;41121.58878411238;41184.97037574085;3218.5494030835703;3387.5934887813373;3644.890653280406;3818.885433437001;3988.68090552758;27581.448371032668;27614.309642258904;27785.166445006682;28162.85918570394;30682;2732.7267273272714;2763.3644261819895;2835.1211124551455;2855.286178455386;2864.427114577072;137840;138385.30807346;139092;139275.91086133715;139546;53790;78184;79230.60384698155;79554.6022269885;80196.19803801888;54608;54692.72653636707;55039;55277.447225528034;55298.17052744212;17547.21037553313;17563.473095807145;17807.19867605961;17815.198316075806;17832.019238941983;12123.636290911287;13487.730245395038;13639.863601364057;13909.026368154335;14089.01376903607;16560.75158872618;16669.33322667104;16691.415800446925;16702.665946680998;16729.665406691798;7191.280871912872;7298.96350518244;7343.37581305595;7349.265073492715;7407.629618519052;961.927855410847;1010.1716592394166;1073.044989958937;1154.9786731152235;1204.5543149034913;23704.525909482058;30501.932432365204;30540;30960.845195773876;31669.52495712566;1093.8960798724108;1118.0999295567146;1148.362658724416;1201.5073819733868;1224.908131890094;12943.676408089685;13535.390907408993;14274.14355138695;15712.528624141294;15989.760153597705;514757;562738;563702;565438;565924;62026.75946481045;63615.363846360946;64229.678851605444;64361;64493.35506644967;1504.3230546254229;1538.061782312766;1542.383046781274;1552.1152942822482;1583.762435634641;30298.788048477814;30444.71664625206;30548.84725576358;30562.541561876144;30819.38361232718;54277;54424.45575544352;54667.45332546624;54713.72643136918;55060;522471;524100;525399;525804;525849;35492.46761298531;35956.8202158998;47520.52479475299;47537.286940696606;48740;44788.63827898614;44978;45188;45303.54696452993;45602.54397456116;29704.55443168311;36566;37171;38249.61750382461;38286;37152;37159.442608360354;37377;37432.81283593673;37714.43428348632;34774.47838282377;36691.44962825506;39111.6088839108;39679;40563.39154912738;31207.687923121386;33205.33589328152;33467.33065338728;33514.32971340511;33578.3284334307;25354.746452535976;25468.872655636602;25563;25808.351845843248;26046.609300860124 19:05:41 INFO - PROCESS | 2278 | |2;jquery.html;368.93912504436764;376.5895174260058;385.8283064036503;390.60939060939063;391.3816170450685;19916.4539799011;20903.163873445083;21179.47051323718;21420.357389278306;21615.243466478656;21231;21614;21654;21804.563908721815;21930.89034554825;5723.656580605177;5936.821895343136;6193.1639228704225;6198.194234749476;6201.534884883629;4134.793260336971;4871.780769865364;6158.291796443399;6167.105769663419;6168.96915515424;5985.221921150244;6095;6114.419130182626;6132.4480796728285;6142.785002524913;5969.194158788573;6051.213342265477;6056.242969628796;6086.908696369558;6098.512119030467;5692.316921969349;5700.087985922232;5800.245968024172;5810.3899090595305;5815.73829177688;13739.725205495834;13918.93040534801;13933.233672148028;13960.790588141186;14027.509037183752;1916.7316575679415;2180.4003898927763;2215.435064058671;2258.8644681319174;2410.1203060882826;8841.38110332277;10123.746906327327;10297.53661085253;11058.22592418531;13030.739385212337;1740.7388891666226;1794.9641007179914;1807.096451774113;1812.7009043507805;1823.717323814811;107002.99999999921;109093.45453272763;111799.44100279447;112155;113397.4330128344;10870.510827012804;11716.88283117175;11834.349110798816;11942.223755455867;12016.399180040962;14463.92768036153;14512.274386280644;14517.419303227964;14573.92713036428;14621.853781462049;7374.557526548317;7397.556146631219;8177.264046235868;9036.141566551167;9156.496392698333;9272.953635231781;9294.953525232466;9312.115349041831;9331.486768227813;9359.62561497546;4567.840125595588;4680.251159814414;4720.976395118071;4724.527547245248;4754.762261886961;1832.7446395701654;1890.858185636083;2018.3238615063824;2029.1578994717026;2033.3493282149866;825.5170725125748;942.9481378524247;967.0764419978904;1018.8573599696049;1038.444432228754;15637.452689155825;16662.58343541397;19786.60426791485;20168.495787605134;21022.054007569695;990.7374545745383;997.0926456924309;1010.1918465227789;1060.9204309676804;1119.082352470966;10934.726631834108;11128.05411540012;11128.610498632508;11136.38749868765;11248.493817778219;624925;648101;653659;655842;659431;125109;128181;129751;130136.69863301436;131739;1004.0612027754073;1021.371856308365;1022.437659287389;1037.526712068864;1038.4963292802834;18266.082061383364;18509.33415992567;18631.534211644816;18701.90649046746;19164.616707666046;54258.45741542534;55734.44265557292;56150;56367.590810230075;56442.43557564536;55302.72348638231;73224;74563;76708.61645691736;77262;7795.337396321376;8219.712310069119;8344.374171937008;8409.957950210455;8485.91514084876;7740.535567865946;12342.629721108382;12717.236965782082;13704.794428083387;14102.647433814236;10779.353238805697;11690.123240757148;11842.644720658394;11914.76170476603;11998.40007999579;10682.946585267024;11642.24325418845;11655.650330490098;11665.24175928562;12146.939265303618;11779.764404711686;12133.876571599758;12326.876731232931;12337.074719396262;12382.442790074288;8036.598170091589;8299.502029878227;8303.916960830315;8427.157284271523;8588.184122508352;11152.052075573667;11769;11788;11950.223235489666;12000.519979201083 19:05:41 INFO - PROCESS | 2278 | |3;mootools.html;1368.7809950407934;1659.3196789316382;1907.8092190780915;2040.183926429429;2047.6518991771397;8232.053313868906;8739.038705742363;8942.508162051085;9051.954740226298;9151.588178531974;8879.245264152554;8932.017478077407;9013.54932253388;9043.54782260886;9167.541622918845;2550.6684131062984;2567.6533667954773;2573.4081161332906;2573.6010918307693;2590.6502622146054;2304.331743794298;2523.570992931197;2577.7680008799202;2580.703219129796;2581.9483610327875;2551.693796744384;2558.4243545202276;2571.90998315059;2587.7282885297054;2588.120039186676;2561.3852675357875;2579.7291284415055;2582.7288134745863;2589.7928165746694;2602.050251658131;2556.1181392419585;2567.948641027169;2588.5081834451394;2596.0654164500766;2598.116640342274;9067.274618030608;9119.996800351955;9125.81748365029;9159.816803663889;9161.862572061424;4672.719636821767;5643.125315576092;5706.80026199081;5708.229389032469;5772.220750198711;3681.5398075240596;3692.132348898007;3715.5727091384565;3796.90507737306;3817.6373244542;946.2193690205607;977.1742877268767;1064.122099268107;1071.3678929431674;1100.1858624617805;10196.49017549127;11956.923876851126;12308.938455307667;12445.128840981044;12447.688807779787;4430.313301438282;5029.471905449948;5100.846974590768;5107.770150343244;5201.349831271091;10439.060484556427;10475.42385168823;10497.317674351143;10510.211734119972;10512;5642.802501912413;5646.887062258732;5650.576206784425;5664.858378540487;5674.347450043216;3976.5824588418377;4983.377077865267;5104.285400043997;5123.359580052494;5142.97428512855;4007.6793856491413;4068.450759147477;4073.574249012881;4103.138340948434;4137.91724165515;1366.5422083602105;1374.2785037855206;1381.530279704905;1382.7511048011454;1392.2273138408282;1365.2218235605808;1395.783653533704;1399.2863639543905;1428.6428392901776;1439.0717986898392;8313.584320783937;8446.197611226924;8479.364047696448;8483.363747718946;8527.019392769911;529.5313647422059;536.0779459329947;538.496505767109;541.7426722306873;543.8069485332729;6276.184096067482;6312.873742525124;6319.210098737658;6365.713542890581;6394.840128996812;10727.892721072845;11032.44837758109;11163.497642606102;11178.664640060812;11258.43707814606;10590.417527035934;10930.508127134299;10949.562017519369;10993.010629043265;11123.99884010443;8652.221300083023;8663.653453861774;8699.217070463688;8744;8744.994325652504;7898.68405263783;8039.356851451987;8042.437029407885;8098.987626546682;8191.139930307232;9564.521773911416;9878.802423951625;9979.550920208463;9985.500724963578;9998.750031249278;9988.700338989842;10190.541425636013;10263.897361026295;10299.433531155859;10314.174866010851;7124.679389427592;7567.31894129531;7576.204498527795;7642.617869106633;7680.6543705534505;8340.374471914509;8342.416030877781;8360.66557337724;8383.538905360263;8401.453905496122;7354.96322518384;7533.058367704037;7564.205758395289;7610.1628820828555;7640.197779233101;7374.078240219973;7387.852242955219;7434.59109748969;7517.736879209201;7525;7924.722634707758;7925.603719814101;7925.722599709213;7937.642806073625;7947.761567152995;7117.893231601426;7125.394341481032;7205.099362579677;7209.4592905533345;7222.422206223385;7278.09023872016;7286.817829554304;7293.635318234174;7339.155997060407;7355.2277010913085 19:05:41 INFO - PROCESS | 2278 | |4;prototype.html;330.2717507895091;339.1335138720569;339.8181972644634;341.67882190740715;350.18057744876984;6113.602615829968;6377.298497165308;6924.099867017287;6947.756828511003;6960.54756440831;5147;6709.899351509731;6787.389134977851;6892.207396149444;6897.137857767779;4323.854178642662;4659.860204193863;4840.394950631171;5017.974910125445;5093.134167191568;4024.396340548926;4063.4108054332105;4971.651984361096;5042.949570504285;5056.469070747574;5044.899102017957;5063.240513922904;5077.213031980049;5089.694618322894;5129.769160387791;5082.542571168613;5088.643794934356;5091.9236211456855;5096.235564665293;5108.438071812079;4331.935020974688;4342.522322544518;4345.109252603209;4349.630281426083;4358.7166834156;6227.470664993436;6528.281888992207;6641.070250164981;6660.866782664368;6720.932790672079;5863.648181109147;5873.647581145145;5904.97047514764;5905.320888097881;5917.497012753921;7305.598192099433;7314.378277846389;7318.707251709925;7338.376238019775;7369.6315184240575;4699.412573428322;4701.271302948048;4711.717296962159;4712.882177945545;4713.764311784432;7807.141214466405;7836.098848632423;7877.212278772135;7899.447038707292;7928.920710792876;4621.168189725881;4795.472498025214;4833.202521583969;4849.75751212438;4855.077535268288;4845.53967373099;4908.828191013297;4910.263460480956;4921.532454416824;4930.482299358516;5209.973950130225;5933.821985340447;5960.4635582797755;5967.791127310524;5978.133170690226;5961.463468287789;7005.92994070063;7481.513701609378;7490.325870671557;7530.43521735872;1465.604286842568;1667.3914021382109;1699.0994772770453;1700.2773821125973;1702.259517110061;916.9312301577409;1039.3192458939407;1081.810683130449;1081.8972197641212;1096.5613754498106;5464.535514481234;6616.768413105518;6723.327667233238;6725.092112564839;6738.191417029988;6701.329867013357;7631;7633.580153091633;7655.46411751172;7664;6747.190337159573;6858.6570671466225;6869.450443964471;6898.689558969859;6899.17209934811;4083.2037752637953;4117.855875044359;4125.50493940729;4136.276151673445;4138.565450627701;6188.009918413032;6546.541742078104;8001.079875814356;8168.550729709923;8169.387295952827;6326.829536535755;7807.68769249235;8004.959975200203;8089.433739638169;8111.269985701315;7937.761867143995;8104.1085480597085;8112.797180070545;8155.632996515171;8168.224018718212;7802.6488808004915;7806.102298235775;7815.179406162499;7832.569208693577;7859.960700196462;7635.923640763522;7644.617769111411;7681.577513236825;7690.0771907369235;7716.5755883426955;7715.884261735966;7733.38132949374;8141.592920354077;8150.959245203973;8172.509649421054;4769.785359658893;4819.879503012453;4828.975855120702;4833.178359678793;4876.829310974241;5953.898528772191;7733.304002639565;7750.418718596015;7785.338246248905;7799.142094369501;7439.986805343844;7448.180700123091;7452.776416707507;7488.663010164664;7507.887381689388;7218.566885986857;7461.477696561188;7466.925330746623;7469.178390377163;7472.701091956261;5829.912551311819;5863.742459153342;7003.264657211123;7261.128664560075;7305.1233851938105;7421.257874212535;7428.665710042953;7445.181030086578;7449.329560339595;7459.552426854189;5873;7084.509430386789;7287.708491660486;7296.4162866969455;7325.340719335072 19:05:41 INFO - PROCESS | 2278 | |5;yui.html;704.5596502186133;734.8567029429263;743.2530307041422;762.3596179209463;772.166060654493;15138.54584362468;15175.54473365798;15459.149746763924;15467.149306788122;15479.380824767024;16243.431479898207;16576.66846663066;16596.66806663869;16613.83386166138;16615.66768664626;785.3677789379548;949.7957939043122;960.4573416019962;966.6133546581389;967.1054274795786;974;974.8342781727088;975.5366201054478;976.023976023976;981.224832382417;1015.8222311095566;1026.0560284538205;1026.4508487958944;1028.2185538990345;1032.2774058159282;1010.1413798271484;1012.772126271583;1020.5305559442666;1020.8825985011707;1022.2741853284177;746.5371469688773;749.9550026998397;755.3013462547121;758.4084414156966;758.829263415727;15471.458498952596;15923.52229433119;15940.681186376207;15979.680406391923;15980.76028859568;12757.681057973625;12887.16233444823;12909.612711618667;12941.87058129416;13046.347682615831;10072.345297555708;11157.330560166334;11220.158488113424;11237.269577477438;11538.192326537146;2810.8313501189996;2819.760320372771;2820.1680504251294;2835.1211124551455;2845.8007939444246;80558.38883222362;80750;81499;82712;82868.9999999994;9488.762780930532;9524.571394287274;9567.569459374206;9632.133108020313;9659.661911833053;22040.779592204195;22068.33794986153;22085.895705214676;22135.889320553295;22192.223272185394;7588.886166707503;7606;7660.73187438437;7815.413843961725;7850.450468467153;4179.2059508693255;4213.915721685549;4223.957760422418;4244.490661120623;4271.487421509377;3294.275259442919;3720.069982504374;3737.9065523362133;3785.432185172191;3786.5266841644793;660.2242365220847;670.808819486444;676.7698982346026;688;700.6811900585221;526.108246522149;573.7446836157869;594.7680404642193;611.4222060153202;619.3218425823716;8205.917940820635;8367.456115352483;8444.57777111142;8485.872711909326;8670.089640587774;449.3439578215841;482.7610332885244;589.0810335876047;610.856448734547;619.4177473175291;2822.3931854650937;3827.483289755903;3939.8621048263744;3955.0903292242947;4103.938440923389;71913.64043179751;85061;86161;93349;94448.52775736214;83337.58331208305;83429.58285208656;86345;87915.80210494788;88578.55710721404;55814.44185558174;72843.90734138885;73892.15269618302;74898.62550687212;77408;7903.960480197562;7909.604519774103;7945.1260361361365;7964.084130325086;8095.595220239083;52391.73804130955;53067.46932530625;53632.73183634213;53708.31458426985;53973;71869;74197;75024;75385.62307188429;75794;10145.797084058426;10390.480475976323;10415.323004004715;10426.635067772591;10447.58209671635;11124.61063862761;11216.214864959375;11238;11325.943370283096;11991.700207494883;10390.220733445172;10433.426161561187;10482.68551943443;10529.684109476728;10744.086752626114;10474.109700675528;10521.736956576147;10642.41466719338;10690.57237710514;11378.31730096197;10630.627928022483;10876.456177191267;11397.886021139682;11518.539258429904;11601.18791684574;9190.724278271662;9444.197243234403;9549.09283618055;9552.331336806357;9571.138597526256;9374.906250937676;9487.66793162236;9501.952490237505;9616.807663846545;9829.705108846745 19:05:41 INFO - PROCESS | 2278 | __end_tp_report 19:05:41 INFO - PROCESS | 2278 | __start_cc_report 19:05:41 INFO - PROCESS | 2278 | _x_x_mozilla_cycle_collect,361 19:05:41 INFO - PROCESS | 2278 | __end_cc_report 19:05:41 INFO - PROCESS | 2278 | __startTimestamp1459217141932__endTimestamp 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | ------- Summary: start ------- 19:05:41 INFO - PROCESS | 2278 | Number of tests: 6 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | [#0] dojo.html Cycles:165 Average:5853.39 Median:6050.46 stddev:637.45 (10.5%) stddev-sans-first:596.10 19:05:41 INFO - PROCESS | 2278 | Values: 2909.3 3580.9 3597.7 3636.9 3651.7 5403.8 5453.3 5909.0 5928.3 5933.3 5948.8 5979.0 5980.9 5988.0 6012.6 5331.0 5378.7 5426.1 5450.5 5496.8 5292.0 5401.1 5410.0 5417.9 5430.3 5366.9 5433.5 5438.2 5453.1 5472.5 5373.1 5456.6 5462.8 5480.2 5517.8 5287.6 5388.3 5388.9 5422.3 5431.6 5659.3 5844.5 5855.4 5954.1 5993.5 5841.2 6231.8 6273.8 6316.3 6317.5 6324.7 6327.0 6335.3 6335.8 6378.1 5869.1 6011.0 6050.5 6066.6 6067.4 6360.7 6461.2 6470.8 6479.5 6480.3 6283.2 6305.1 6314.3 6328.7 6330.6 6258.9 6272.7 6299.8 6333.3 6337.2 6273.5 6287.7 6314.5 6323.2 6330.4 6223.9 6275.4 6317.2 6320.9 6339.5 4914.1 4941.5 4958.6 5008.0 5071.5 4509.2 4512.9 4521.2 4521.9 4532.2 5825.2 5848.6 5865.4 5868.7 5871.4 5929.2 6173.0 6215.1 6266.5 6300.4 5861.3 5869.9 5875.8 5876.1 5890.8 5478.6 5505.3 5507.9 5515.6 5526.0 6341.5 6416.7 6455.7 6501.3 6508.6 5273.0 6340.9 6383.7 6384.3 6391.2 6277.3 6554.6 6565.3 6582.7 6592.1 6124.0 6191.3 6271.3 6300.2 6314.9 5505.9 6275.9 6314.1 6318.1 6329.8 5252.3 6119.7 6201.9 6284.3 6293.9 5702.8 5948.8 6222.8 6289.4 6304.4 5913.5 6036.0 6142.7 6160.5 6173.9 5123.6 6143.7 6155.0 6209.4 6297.2 6193.6 6205.8 6208.1 6214.7 6238.5 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | [#1] ext.html Cycles:180 Average:57322.40 Median:39648.10 stddev:120387.35 (303.6%) stddev-sans-first:120649.48 19:05:41 INFO - PROCESS | 2278 | Values: 501.1 571.0 591.5 678.7 679.7 38809.2 39238.8 39617.2 39745.8 39780.2 41391.2 41427.6 41780.0 41880.0 42013.0 9452.3 9638.9 9651.6 9686.1 9716.3 9527.3 9717.2 9777.8 9799.4 9812.3 9712.0 9730.9 9737.9 9794.1 9795.6 9674.9 9706.4 9737.4 9762.8 9795.1 9615.7 9752.5 9757.3 9769.4 9778.5 40840.0 41045.0 41107.4 41121.6 41185.0 3218.5 3387.6 3644.9 3818.9 3988.7 27581.4 27614.3 27785.2 28162.9 30682.0 2732.7 2763.4 2835.1 2855.3 2864.4 137840.0 138385.3 139092.0 139275.9 139546.0 53790.0 78184.0 79230.6 79554.6 80196.2 54608.0 54692.7 55039.0 55277.4 55298.2 17547.2 17563.5 17807.2 17815.2 17832.0 12123.6 13487.7 13639.9 13909.0 14089.0 16560.8 16669.3 16691.4 16702.7 16729.7 7191.3 7299.0 7343.4 7349.3 7407.6 961.9 1010.2 1073.0 1155.0 1204.6 23704.5 30501.9 30540.0 30960.8 31669.5 1093.9 1118.1 1148.4 1201.5 1224.9 12943.7 13535.4 14274.1 15712.5 15989.8 514757.0 562738.0 563702.0 565438.0 565924.0 62026.8 63615.4 64229.7 64361.0 64493.4 1504.3 1538.1 1542.4 1552.1 1583.8 30298.8 30444.7 30548.8 30562.5 30819.4 54277.0 54424.5 54667.5 54713.7 55060.0 522471.0 524100.0 525399.0 525804.0 525849.0 35492.5 35956.8 47520.5 47537.3 48740.0 44788.6 44978.0 45188.0 45303.5 45602.5 29704.6 36566.0 37171.0 38249.6 38286.0 37152.0 37159.4 37377.0 37432.8 37714.4 34774.5 36691.4 39111.6 39679.0 40563.4 31207.7 33205.3 33467.3 33514.3 33578.3 25354.7 25468.9 25563.0 25808.4 26046.6 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | [#2] jquery.html Cycles:180 Average:35945.17 Median:21100.76 stddev:107645.23 (510.1%) stddev-sans-first:107914.06 19:05:41 INFO - PROCESS | 2278 | Values: 368.9 376.6 385.8 390.6 391.4 19916.5 20903.2 21179.5 21420.4 21615.2 21231.0 21614.0 21654.0 21804.6 21930.9 5723.7 5936.8 6193.2 6198.2 6201.5 4134.8 4871.8 6158.3 6167.1 6169.0 5985.2 6095.0 6114.4 6132.4 6142.8 5969.2 6051.2 6056.2 6086.9 6098.5 5692.3 5700.1 5800.2 5810.4 5815.7 13739.7 13918.9 13933.2 13960.8 14027.5 1916.7 2180.4 2215.4 2258.9 2410.1 8841.4 10123.7 10297.5 11058.2 13030.7 1740.7 1795.0 1807.1 1812.7 1823.7 107003.0 109093.5 111799.4 112155.0 113397.4 10870.5 11716.9 11834.3 11942.2 12016.4 14463.9 14512.3 14517.4 14573.9 14621.9 7374.6 7397.6 8177.3 9036.1 9156.5 9273.0 9295.0 9312.1 9331.5 9359.6 4567.8 4680.3 4721.0 4724.5 4754.8 1832.7 1890.9 2018.3 2029.2 2033.3 825.5 942.9 967.1 1018.9 1038.4 15637.5 16662.6 19786.6 20168.5 21022.1 990.7 997.1 1010.2 1060.9 1119.1 10934.7 11128.1 11128.6 11136.4 11248.5 624925.0 648101.0 653659.0 655842.0 659431.0 125109.0 128181.0 129751.0 130136.7 131739.0 1004.1 1021.4 1022.4 1037.5 1038.5 18266.1 18509.3 18631.5 18701.9 19164.6 54258.5 55734.4 56150.0 56367.6 56442.4 55302.7 73224.0 74563.0 76708.6 77262.0 7795.3 8219.7 8344.4 8410.0 8485.9 7740.5 12342.6 12717.2 13704.8 14102.6 10779.4 11690.1 11842.6 11914.8 11998.4 10682.9 11642.2 11655.7 11665.2 12146.9 11779.8 12133.9 12326.9 12337.1 12382.4 8036.6 8299.5 8303.9 8427.2 8588.2 11152.1 11769.0 11788.0 11950.2 12000.5 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | [#3] mootools.html Cycles:180 Average:6222.88 Median:540.12 stddev:3282.88 (607.8%) stddev-sans-first:3271.81 19:05:41 INFO - PROCESS | 2278 | Values: 1368.8 1659.3 1907.8 2040.2 2047.7 8232.1 8739.0 8942.5 9052.0 9151.6 8879.2 8932.0 9013.5 9043.5 9167.5 2550.7 2567.7 2573.4 2573.6 2590.7 2304.3 2523.6 2577.8 2580.7 2581.9 2551.7 2558.4 2571.9 2587.7 2588.1 2561.4 2579.7 2582.7 2589.8 2602.1 2556.1 2567.9 2588.5 2596.1 2598.1 9067.3 9120.0 9125.8 9159.8 9161.9 4672.7 5643.1 5706.8 5708.2 5772.2 3681.5 3692.1 3715.6 3796.9 3817.6 946.2 977.2 1064.1 1071.4 1100.2 10196.5 11956.9 12308.9 12445.1 12447.7 4430.3 5029.5 5100.8 5107.8 5201.3 10439.1 10475.4 10497.3 10510.2 10512.0 5642.8 5646.9 5650.6 5664.9 5674.3 3976.6 4983.4 5104.3 5123.4 5143.0 4007.7 4068.5 4073.6 4103.1 4137.9 1366.5 1374.3 1381.5 1382.8 1392.2 1365.2 1395.8 1399.3 1428.6 1439.1 8313.6 8446.2 8479.4 8483.4 8527.0 529.5 536.1 538.5 541.7 543.8 6276.2 6312.9 6319.2 6365.7 6394.8 10727.9 11032.4 11163.5 11178.7 11258.4 10590.4 10930.5 10949.6 10993.0 11124.0 8652.2 8663.7 8699.2 8744.0 8745.0 7898.7 8039.4 8042.4 8099.0 8191.1 9564.5 9878.8 9979.6 9985.5 9998.8 9988.7 10190.5 10263.9 10299.4 10314.2 7124.7 7567.3 7576.2 7642.6 7680.7 8340.4 8342.4 8360.7 8383.5 8401.5 7355.0 7533.1 7564.2 7610.2 7640.2 7374.1 7387.9 7434.6 7517.7 7525.0 7924.7 7925.6 7925.7 7937.6 7947.8 7117.9 7125.4 7205.1 7209.5 7222.4 7278.1 7286.8 7293.6 7339.2 7355.2 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | [#4] prototype.html Cycles:180 Average:5966.69 Median:6681.10 stddev:1950.60 (29.2%) stddev-sans-first:1909.65 19:05:41 INFO - PROCESS | 2278 | Values: 330.3 339.1 339.8 341.7 350.2 6113.6 6377.3 6924.1 6947.8 6960.5 5147.0 6709.9 6787.4 6892.2 6897.1 4323.9 4659.9 4840.4 5018.0 5093.1 4024.4 4063.4 4971.7 5042.9 5056.5 5044.9 5063.2 5077.2 5089.7 5129.8 5082.5 5088.6 5091.9 5096.2 5108.4 4331.9 4342.5 4345.1 4349.6 4358.7 6227.5 6528.3 6641.1 6660.9 6720.9 5863.6 5873.6 5905.0 5905.3 5917.5 7305.6 7314.4 7318.7 7338.4 7369.6 4699.4 4701.3 4711.7 4712.9 4713.8 7807.1 7836.1 7877.2 7899.4 7928.9 4621.2 4795.5 4833.2 4849.8 4855.1 4845.5 4908.8 4910.3 4921.5 4930.5 5210.0 5933.8 5960.5 5967.8 5978.1 5961.5 7005.9 7481.5 7490.3 7530.4 1465.6 1667.4 1699.1 1700.3 1702.3 916.9 1039.3 1081.8 1081.9 1096.6 5464.5 6616.8 6723.3 6725.1 6738.2 6701.3 7631.0 7633.6 7655.5 7664.0 6747.2 6858.7 6869.5 6898.7 6899.2 4083.2 4117.9 4125.5 4136.3 4138.6 6188.0 6546.5 8001.1 8168.6 8169.4 6326.8 7807.7 8005.0 8089.4 8111.3 7937.8 8104.1 8112.8 8155.6 8168.2 7802.6 7806.1 7815.2 7832.6 7860.0 7635.9 7644.6 7681.6 7690.1 7716.6 7715.9 7733.4 8141.6 8151.0 8172.5 4769.8 4819.9 4829.0 4833.2 4876.8 5953.9 7733.3 7750.4 7785.3 7799.1 7440.0 7448.2 7452.8 7488.7 7507.9 7218.6 7461.5 7466.9 7469.2 7472.7 5829.9 5863.7 7003.3 7261.1 7305.1 7421.3 7428.7 7445.2 7449.3 7459.6 5873.0 7084.5 7287.7 7296.4 7325.3 19:05:41 INFO - PROCESS | 2278 | 19:05:41 INFO - PROCESS | 2278 | [#5] yui.html Cycles:180 Average:18749.13 Median:53670.52 stddev:26446.56 (49.3%) stddev-sans-first:26486.04 19:05:41 INFO - PROCESS | 2278 | Values: 704.6 734.9 743.3 762.4 772.2 15138.5 15175.5 15459.1 15467.1 15479.4 16243.4 16576.7 16596.7 16613.8 16615.7 785.4 949.8 960.5 966.6 967.1 974.0 974.8 975.5 976.0 981.2 1015.8 1026.1 1026.5 1028.2 1032.3 1010.1 1012.8 1020.5 1020.9 1022.3 746.5 750.0 755.3 758.4 758.8 15471.5 15923.5 15940.7 15979.7 15980.8 12757.7 12887.2 12909.6 12941.9 13046.3 10072.3 11157.3 11220.2 11237.3 11538.2 2810.8 2819.8 2820.2 2835.1 2845.8 80558.4 80750.0 81499.0 82712.0 82869.0 9488.8 9524.6 9567.6 9632.1 9659.7 22040.8 22068.3 22085.9 22135.9 22192.2 7588.9 7606.0 7660.7 7815.4 7850.5 4179.2 4213.9 4224.0 4244.5 4271.5 3294.3 3720.1 3737.9 3785.4 3786.5 660.2 670.8 676.8 688.0 700.7 526.1 573.7 594.8 611.4 619.3 8205.9 8367.5 8444.6 8485.9 8670.1 449.3 482.8 589.1 610.9 619.4 2822.4 3827.5 3939.9 3955.1 4103.9 71913.6 85061.0 86161.0 93349.0 94448.5 83337.6 83429.6 86345.0 87915.8 88578.6 55814.4 72843.9 73892.2 74898.6 77408.0 7904.0 7909.6 7945.1 7964.1 8095.6 52391.7 53067.5 53632.7 53708.3 53973.0 71869.0 74197.0 75024.0 75385.6 75794.0 10145.8 10390.5 10415.3 10426.6 10447.6 11124.6 11216.2 11238.0 11325.9 11991.7 10390.2 10433.4 10482.7 10529.7 10744.1 10474.1 10521.7 10642.4 10690.6 11378.3 10630.6 10876.5 11397.9 11518.5 11601.2 9190.7 9444.2 9549.1 9552.3 9571.1 9374.9 9487.7 9502.0 9616.8 9829.7 19:05:41 INFO - PROCESS | 2278 | -------- Summary: end -------- 19:05:41 INFO - PROCESS | 2278 | 19:05:42 INFO - TEST-INFO | 2278: exit 0 19:05:42 INFO - TEST-OK | dromaeo_css | took 1111007ms 19:05:42 INFO - TEST-START | kraken 19:05:42 INFO - operating with platform_type : mac_ 19:05:42 INFO - Initialising browser for kraken test... 19:05:42 INFO - TEST-INFO | started process 2283 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpcda3Ps/profile http://localhost:53889/getInfo.html) 19:05:44 INFO - PROCESS | 2283 | __metrics Screen width/height:1600/1200 19:05:44 INFO - PROCESS | 2283 | colorDepth:24 19:05:44 INFO - PROCESS | 2283 | Browser inner width/height: 1024/689 19:05:44 INFO - PROCESS | 2283 | __metrics 19:05:45 ERROR - PROCESS | 2283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:05:45 INFO - TEST-INFO | 2283: exit 0 19:05:45 INFO - Browser initialized. 19:05:45 INFO - Running cycle 1/1 for kraken test... 19:05:45 INFO - TEST-INFO | started process 2286 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpcda3Ps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:57 INFO - PROCESS | 2286 | RSS: Main: 220438528 19:05:57 INFO - PROCESS | 2286 | 19:06:00 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53889/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:01 INFO - PROCESS | 2286 | RSS: Main: 231940096 19:06:01 INFO - PROCESS | 2286 | 19:06:03 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53889/tests/kraken/driver.html?testName=audio-dft) 19:06:04 INFO - PROCESS | 2286 | RSS: Main: 241709056 19:06:04 INFO - PROCESS | 2286 | 19:06:07 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53889/tests/kraken/driver.html?testName=audio-fft) 19:06:08 INFO - PROCESS | 2286 | RSS: Main: 244281344 19:06:08 INFO - PROCESS | 2286 | 19:06:10 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53889/tests/kraken/driver.html?testName=audio-oscillator) 19:06:11 INFO - PROCESS | 2286 | RSS: Main: 245858304 19:06:11 INFO - PROCESS | 2286 | 19:06:13 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53889/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:13 INFO - PROCESS | 2286 | RSS: Main: 246132736 19:06:13 INFO - PROCESS | 2286 | 19:06:16 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53889/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:17 INFO - PROCESS | 2286 | RSS: Main: 247541760 19:06:17 INFO - PROCESS | 2286 | 19:06:19 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53889/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:20 INFO - PROCESS | 2286 | RSS: Main: 247918592 19:06:20 INFO - PROCESS | 2286 | 19:06:23 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53889/tests/kraken/driver.html?testName=json-parse-financial) 19:06:24 INFO - PROCESS | 2286 | RSS: Main: 247910400 19:06:24 INFO - PROCESS | 2286 | 19:06:25 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53889/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:26 INFO - PROCESS | 2286 | RSS: Main: 246444032 19:06:26 INFO - PROCESS | 2286 | 19:06:28 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:28 INFO - PROCESS | 2286 | RSS: Main: 246599680 19:06:28 INFO - PROCESS | 2286 | 19:06:30 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:06:31 INFO - PROCESS | 2286 | RSS: Main: 246931456 19:06:31 INFO - PROCESS | 2286 | 19:06:33 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:06:34 INFO - PROCESS | 2286 | RSS: Main: 248672256 19:06:34 INFO - PROCESS | 2286 | 19:06:37 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:06:37 INFO - PROCESS | 2286 | RSS: Main: 247103488 19:06:37 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | Cycle 1(1): loaded http://localhost:53889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53889/tests/kraken/driver.html?testName=ai-astar) 19:06:39 INFO - PROCESS | 2286 | RSS: Main: 250171392 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | __start_tp_report 19:06:39 INFO - PROCESS | 2286 | _x_x_mozilla_page_load 19:06:39 INFO - PROCESS | 2286 | _x_x_mozilla_page_load_details 19:06:39 INFO - PROCESS | 2286 | |i|pagename|runs| 19:06:39 INFO - PROCESS | 2286 | |0;ai-astar;116;111;116;131;170;184;117;114;150;166 19:06:39 INFO - PROCESS | 2286 | |1;audio-beat-detection;151;121;156;146;124;174;159;150;172;151 19:06:39 INFO - PROCESS | 2286 | |2;audio-dft;200;195;193;200;201;196;245;280;200;197 19:06:39 INFO - PROCESS | 2286 | |3;audio-fft;71;83;73;115;56;57;58;59;125;57 19:06:39 INFO - PROCESS | 2286 | |4;audio-oscillator;84;82;125;77;82;83;136;65;80;157 19:06:39 INFO - PROCESS | 2286 | |5;imaging-gaussian-blur;88;86;92;126;88;88;89;86;88;84 19:06:39 INFO - PROCESS | 2286 | |6;imaging-darkroom;94;96;95;95;95;95;96;95;119;119 19:06:39 INFO - PROCESS | 2286 | |7;imaging-desaturate;91;93;92;91;120;138;108;90;91;96 19:06:39 INFO - PROCESS | 2286 | |8;json-parse-financial;55;60;58;60;60;58;59;67;57;55 19:06:39 INFO - PROCESS | 2286 | |9;json-stringify-tinderbox;66;74;66;94;104;96;67;67;90;95 19:06:39 INFO - PROCESS | 2286 | |10;stanford-crypto-aes;84;80;81;83;81;80;81;85;81;87 19:06:39 INFO - PROCESS | 2286 | |11;stanford-crypto-ccm;120;142;143;121;127;122;127;130;157;114 19:06:39 INFO - PROCESS | 2286 | |12;stanford-crypto-pbkdf2;127;134;139;138;136;122;133;137;134;136 19:06:39 INFO - PROCESS | 2286 | |13;stanford-crypto-sha256-iterative;65;60;88;93;97;98;94;87;67;66 19:06:39 INFO - PROCESS | 2286 | __end_tp_report 19:06:39 INFO - PROCESS | 2286 | __start_cc_report 19:06:39 INFO - PROCESS | 2286 | _x_x_mozilla_cycle_collect,923 19:06:39 INFO - PROCESS | 2286 | __end_cc_report 19:06:39 INFO - PROCESS | 2286 | __startTimestamp1459217199715__endTimestamp 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | ------- Summary: start ------- 19:06:39 INFO - PROCESS | 2286 | Number of tests: 14 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#0] ai-astar Cycles:10 Average:137.50 Median:140.50 stddev:27.54 (19.6%) stddev-sans-first:28.10 19:06:39 INFO - PROCESS | 2286 | Values: 116.0 111.0 116.0 131.0 170.0 184.0 117.0 114.0 150.0 166.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:153.50 stddev:17.35 (11.3%) stddev-sans-first:18.41 19:06:39 INFO - PROCESS | 2286 | Values: 151.0 121.0 156.0 146.0 124.0 174.0 159.0 150.0 172.0 151.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#2] audio-dft Cycles:10 Average:210.70 Median:200.00 stddev:28.64 (14.3%) stddev-sans-first:30.11 19:06:39 INFO - PROCESS | 2286 | Values: 200.0 195.0 193.0 200.0 201.0 196.0 245.0 280.0 200.0 197.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#3] audio-fft Cycles:10 Average:75.40 Median:58.50 stddev:25.25 (43.2%) stddev-sans-first:26.73 19:06:39 INFO - PROCESS | 2286 | Values: 71.0 83.0 73.0 115.0 56.0 57.0 58.0 59.0 125.0 57.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:81.00 stddev:30.61 (37.8%) stddev-sans-first:32.10 19:06:39 INFO - PROCESS | 2286 | Values: 84.0 82.0 125.0 77.0 82.0 83.0 136.0 65.0 80.0 157.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:88.00 stddev:12.30 (14.0%) stddev-sans-first:12.99 19:06:39 INFO - PROCESS | 2286 | Values: 88.0 86.0 92.0 126.0 88.0 88.0 89.0 86.0 88.0 84.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:95.00 stddev:10.08 (10.6%) stddev-sans-first:10.47 19:06:39 INFO - PROCESS | 2286 | Values: 94.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 119.0 119.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#7] imaging-desaturate Cycles:10 Average:101.00 Median:91.00 stddev:16.23 (17.8%) stddev-sans-first:16.80 19:06:39 INFO - PROCESS | 2286 | Values: 91.0 93.0 92.0 91.0 120.0 138.0 108.0 90.0 91.0 96.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.50 stddev:3.41 (5.7%) stddev-sans-first:3.32 19:06:39 INFO - PROCESS | 2286 | Values: 55.0 60.0 58.0 60.0 60.0 58.0 59.0 67.0 57.0 55.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#9] json-stringify-tinderbox Cycles:10 Average:81.90 Median:82.00 stddev:15.21 (18.6%) stddev-sans-first:15.01 19:06:39 INFO - PROCESS | 2286 | Values: 66.0 74.0 66.0 94.0 104.0 96.0 67.0 67.0 90.0 95.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.36 (2.9%) stddev-sans-first:2.42 19:06:39 INFO - PROCESS | 2286 | Values: 84.0 80.0 81.0 83.0 81.0 80.0 81.0 85.0 81.0 87.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:128.50 stddev:13.17 (10.2%) stddev-sans-first:13.43 19:06:39 INFO - PROCESS | 2286 | Values: 120.0 142.0 143.0 121.0 127.0 122.0 127.0 130.0 157.0 114.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.60 Median:136.00 stddev:5.27 (3.9%) stddev-sans-first:5.02 19:06:39 INFO - PROCESS | 2286 | Values: 127.0 134.0 139.0 138.0 136.0 122.0 133.0 137.0 134.0 136.0 19:06:39 INFO - PROCESS | 2286 | 19:06:39 INFO - PROCESS | 2286 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.50 Median:90.50 stddev:15.12 (16.7%) stddev-sans-first:14.82 19:06:39 INFO - PROCESS | 2286 | Values: 65.0 60.0 88.0 93.0 97.0 98.0 94.0 87.0 67.0 66.0 19:06:39 INFO - PROCESS | 2286 | -------- Summary: end -------- 19:06:39 INFO - PROCESS | 2286 | 19:06:40 INFO - TEST-INFO | 2286: exit 0 19:06:40 INFO - TEST-OK | kraken | took 58005ms 19:06:40 INFO - SUITE-END | took 1169s 19:06:40 INFO - Completed test suite (00:19:29) 19:06:40 INFO - javascript benchmark 19:06:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2909.2872246299657, 3580.946285805712, 3597.6941959933406, 3636.9090772730688, 3651.65309295617, 5403.78384864605, 5453.291072160623, 5908.970455147723, 5928.258967629046, 5933.317668468122, 5948.7620495180245, 5979.0134627786365, 5980.923433781917, 5988.0, 6012.5791194616395, 5330.99999999999, 5378.677279363231, 5426.077566813631, 5450.5367043801325, 5496.80761173359, 5292.0, 5401.054815407308, 5410.0, 5417.945820541783, 5430.294061771984, 5366.9463305366835, 5433.4566543345745, 5438.211459338394, 5453.127499600065, 5472.480114389146, 5373.113436283009, 5456.590755693339, 5462.754176062087, 5480.177973303997, 5517.779288828442, 5287.603429742746, 5388.326459192601, 5388.946110538884, 5422.295101636762, 5431.565474762049, 5659.264295641581, 5844.4739973402175, 5855.4144585541535, 5954.106883967396, 5993.460588547052, 5841.153032810219, 6231.750729970796, 6273.811785646438, 6316.336784637593, 6317.4946004319545, 6324.71538780756, 6327.0, 6335.334789847092, 6335.809925702236, 6378.107065010902, 5869.060950248026, 6011.0, 6050.45545900871, 6066.605670631395, 6067.423594758491, 6360.681965901779, 6461.160049193575, 6470.773522926675, 6479.546431749826, 6480.25477070143, 6283.214598175228, 6305.054241863665, 6314.336994615591, 6328.7468501260355, 6330.620162790247, 6258.874822503524, 6272.749090036347, 6299.842503937438, 6333.2716737575765, 6337.176167098248, 6273.466755325757, 6287.685615719196, 6314.463270621956, 6323.20959880015, 6330.39861213184, 6223.875522489616, 6275.3724627536885, 6317.210348706411, 6320.873582528324, 6339.4611458025665, 4914.0908931847725, 4941.45643979162, 4958.603311735053, 5008.048470790538, 5071.543561079447, 4509.1658043262105, 4512.887177820515, 4521.186186486399, 4521.892136426596, 4532.1842068427995, 5825.1844741736195, 5848.561357898175, 5865.442782935615, 5868.67722275279, 5871.3541510433815, 5929.229200203946, 6172.969135154295, 6215.12988181655, 6266.49868010558, 6300.401461861115, 5861.267341582302, 5869.882602347929, 5875.823725288248, 5876.118582212703, 5890.764369425261, 5478.58910581708, 5505.284313039359, 5507.889842203133, 5515.641483303572, 5525.977694126599, 6341.460975817107, 6416.679166041773, 6455.709493072729, 6501.2523559791225, 6508.576942498722, 5272.973635131953, 6340.904886426615, 6383.680815959091, 6384.329645387167, 6391.2330520337855, 6277.2781130170615, 6554.606723596599, 6565.343465653396, 6582.670866456562, 6592.110065141144, 6123.969380153071, 6191.349908259568, 6271.3415091414745, 6300.243970723543, 6314.936850631435, 5505.889882202254, 6275.900541919053, 6314.116023756769, 6318.115463835159, 6329.778457753957, 5252.343457067866, 6119.715820550834, 6201.875962480815, 6284.3087260402235, 6293.905591416224, 5702.830919661376, 5948.791792287249, 6222.782202622887, 6289.433950944437, 6304.369563043842, 5913.46778789911, 6036.0, 6142.723577439116, 6160.507159427325, 6173.9073913892225, 5123.6157288202785, 6143.723532440961, 6155.0, 6209.410106039919, 6297.244330680348, 6193.566450348612, 6205.751769929152, 6208.130861679459, 6214.689265536796, 6238.532110091671], "unit": "score", "name": "dojo.html", "value": 5814.930055083722}, {"lowerIsBetter": false, "replicates": [501.0530098114562, 570.9657420554767, 591.4794980417232, 678.7217240931218, 679.6703598754605, 38809.22381552367, 39238.80380598093, 39617.207655846905, 39745.8012709936, 39780.204395912064, 41391.17217655645, 41427.550035748754, 41780.0, 41880.0, 42013.0, 9452.291078169148, 9638.867368105359, 9651.613935442574, 9686.07982241686, 9716.31985760997, 9527.285453590974, 9717.174040206592, 9777.804443911153, 9799.41203527787, 9812.313138080337, 9712.0, 9730.854037189412, 9737.853932191023, 9794.118529332358, 9795.559199835989, 9674.90325096747, 9706.369086009387, 9737.367071140354, 9762.804743905153, 9795.118439340493, 9615.711528654152, 9752.512374381253, 9757.268204884662, 9769.364991275615, 9778.51107444632, 40840.0, 41045.0, 41107.38338924918, 41121.58878411238, 41184.97037574085, 3218.5494030835703, 3387.5934887813373, 3644.890653280406, 3818.885433437001, 3988.68090552758, 27581.448371032668, 27614.309642258904, 27785.166445006682, 28162.85918570394, 30682.0, 2732.7267273272714, 2763.3644261819895, 2835.1211124551455, 2855.286178455386, 2864.427114577072, 137840.0, 138385.30807346, 139092.0, 139275.91086133715, 139546.0, 53790.0, 78184.0, 79230.60384698155, 79554.6022269885, 80196.19803801888, 54608.0, 54692.72653636707, 55039.0, 55277.447225528034, 55298.17052744212, 17547.21037553313, 17563.473095807145, 17807.19867605961, 17815.198316075806, 17832.019238941983, 12123.636290911287, 13487.730245395038, 13639.863601364057, 13909.026368154335, 14089.01376903607, 16560.75158872618, 16669.33322667104, 16691.415800446925, 16702.665946680998, 16729.665406691798, 7191.280871912872, 7298.96350518244, 7343.37581305595, 7349.265073492715, 7407.629618519052, 961.927855410847, 1010.1716592394166, 1073.044989958937, 1154.9786731152235, 1204.5543149034913, 23704.525909482058, 30501.932432365204, 30540.0, 30960.845195773876, 31669.52495712566, 1093.8960798724108, 1118.0999295567146, 1148.362658724416, 1201.5073819733868, 1224.908131890094, 12943.676408089685, 13535.390907408993, 14274.14355138695, 15712.528624141294, 15989.760153597705, 514757.0, 562738.0, 563702.0, 565438.0, 565924.0, 62026.75946481045, 63615.363846360946, 64229.678851605444, 64361.0, 64493.35506644967, 1504.3230546254229, 1538.061782312766, 1542.383046781274, 1552.1152942822482, 1583.762435634641, 30298.788048477814, 30444.71664625206, 30548.84725576358, 30562.541561876144, 30819.38361232718, 54277.0, 54424.45575544352, 54667.45332546624, 54713.72643136918, 55060.0, 522471.0, 524100.0, 525399.0, 525804.0, 525849.0, 35492.46761298531, 35956.8202158998, 47520.52479475299, 47537.286940696606, 48740.0, 44788.63827898614, 44978.0, 45188.0, 45303.54696452993, 45602.54397456116, 29704.55443168311, 36566.0, 37171.0, 38249.61750382461, 38286.0, 37152.0, 37159.442608360354, 37377.0, 37432.81283593673, 37714.43428348632, 34774.47838282377, 36691.44962825506, 39111.6088839108, 39679.0, 40563.39154912738, 31207.687923121386, 33205.33589328152, 33467.33065338728, 33514.32971340511, 33578.3284334307, 25354.746452535976, 25468.872655636602, 25563.0, 25808.351845843248, 26046.609300860124], "unit": "score", "name": "ext.html", "value": 19647.947823234495}, {"lowerIsBetter": false, "replicates": [368.93912504436764, 376.5895174260058, 385.8283064036503, 390.60939060939063, 391.3816170450685, 19916.4539799011, 20903.163873445083, 21179.47051323718, 21420.357389278306, 21615.243466478656, 21231.0, 21614.0, 21654.0, 21804.563908721815, 21930.89034554825, 5723.656580605177, 5936.821895343136, 6193.1639228704225, 6198.194234749476, 6201.534884883629, 4134.793260336971, 4871.780769865364, 6158.291796443399, 6167.105769663419, 6168.96915515424, 5985.221921150244, 6095.0, 6114.419130182626, 6132.4480796728285, 6142.785002524913, 5969.194158788573, 6051.213342265477, 6056.242969628796, 6086.908696369558, 6098.512119030467, 5692.316921969349, 5700.087985922232, 5800.245968024172, 5810.3899090595305, 5815.73829177688, 13739.725205495834, 13918.93040534801, 13933.233672148028, 13960.790588141186, 14027.509037183752, 1916.7316575679415, 2180.4003898927763, 2215.435064058671, 2258.8644681319174, 2410.1203060882826, 8841.38110332277, 10123.746906327327, 10297.53661085253, 11058.22592418531, 13030.739385212337, 1740.7388891666226, 1794.9641007179914, 1807.096451774113, 1812.7009043507805, 1823.717323814811, 107002.99999999921, 109093.45453272763, 111799.44100279447, 112155.0, 113397.4330128344, 10870.510827012804, 11716.88283117175, 11834.349110798816, 11942.223755455867, 12016.399180040962, 14463.92768036153, 14512.274386280644, 14517.419303227964, 14573.92713036428, 14621.853781462049, 7374.557526548317, 7397.556146631219, 8177.264046235868, 9036.141566551167, 9156.496392698333, 9272.953635231781, 9294.953525232466, 9312.115349041831, 9331.486768227813, 9359.62561497546, 4567.840125595588, 4680.251159814414, 4720.976395118071, 4724.527547245248, 4754.762261886961, 1832.7446395701654, 1890.858185636083, 2018.3238615063824, 2029.1578994717026, 2033.3493282149866, 825.5170725125748, 942.9481378524247, 967.0764419978904, 1018.8573599696049, 1038.444432228754, 15637.452689155825, 16662.58343541397, 19786.60426791485, 20168.495787605134, 21022.054007569695, 990.7374545745383, 997.0926456924309, 1010.1918465227789, 1060.9204309676804, 1119.082352470966, 10934.726631834108, 11128.05411540012, 11128.610498632508, 11136.38749868765, 11248.493817778219, 624925.0, 648101.0, 653659.0, 655842.0, 659431.0, 125109.0, 128181.0, 129751.0, 130136.69863301436, 131739.0, 1004.0612027754073, 1021.371856308365, 1022.437659287389, 1037.526712068864, 1038.4963292802834, 18266.082061383364, 18509.33415992567, 18631.534211644816, 18701.90649046746, 19164.616707666046, 54258.45741542534, 55734.44265557292, 56150.0, 56367.590810230075, 56442.43557564536, 55302.72348638231, 73224.0, 74563.0, 76708.61645691736, 77262.0, 7795.337396321376, 8219.712310069119, 8344.374171937008, 8409.957950210455, 8485.91514084876, 7740.535567865946, 12342.629721108382, 12717.236965782082, 13704.794428083387, 14102.647433814236, 10779.353238805697, 11690.123240757148, 11842.644720658394, 11914.76170476603, 11998.40007999579, 10682.946585267024, 11642.24325418845, 11655.650330490098, 11665.24175928562, 12146.939265303618, 11779.764404711686, 12133.876571599758, 12326.876731232931, 12337.074719396262, 12382.442790074288, 8036.598170091589, 8299.502029878227, 8303.916960830315, 8427.157284271523, 8588.184122508352, 11152.052075573667, 11769.0, 11788.0, 11950.223235489666, 12000.519979201083], "unit": "score", "name": "jquery.html", "value": 9565.474212991377}, {"lowerIsBetter": false, "replicates": [1368.7809950407934, 1659.3196789316382, 1907.8092190780915, 2040.183926429429, 2047.6518991771397, 8232.053313868906, 8739.038705742363, 8942.508162051085, 9051.954740226298, 9151.588178531974, 8879.245264152554, 8932.017478077407, 9013.54932253388, 9043.54782260886, 9167.541622918845, 2550.6684131062984, 2567.6533667954773, 2573.4081161332906, 2573.6010918307693, 2590.6502622146054, 2304.331743794298, 2523.570992931197, 2577.7680008799202, 2580.703219129796, 2581.9483610327875, 2551.693796744384, 2558.4243545202276, 2571.90998315059, 2587.7282885297054, 2588.120039186676, 2561.3852675357875, 2579.7291284415055, 2582.7288134745863, 2589.7928165746694, 2602.050251658131, 2556.1181392419585, 2567.948641027169, 2588.5081834451394, 2596.0654164500766, 2598.116640342274, 9067.274618030608, 9119.996800351955, 9125.81748365029, 9159.816803663889, 9161.862572061424, 4672.719636821767, 5643.125315576092, 5706.80026199081, 5708.229389032469, 5772.220750198711, 3681.5398075240596, 3692.132348898007, 3715.5727091384565, 3796.90507737306, 3817.6373244542, 946.2193690205607, 977.1742877268767, 1064.122099268107, 1071.3678929431674, 1100.1858624617805, 10196.49017549127, 11956.923876851126, 12308.938455307667, 12445.128840981044, 12447.688807779787, 4430.313301438282, 5029.471905449948, 5100.846974590768, 5107.770150343244, 5201.349831271091, 10439.060484556427, 10475.42385168823, 10497.317674351143, 10510.211734119972, 10512.0, 5642.802501912413, 5646.887062258732, 5650.576206784425, 5664.858378540487, 5674.347450043216, 3976.5824588418377, 4983.377077865267, 5104.285400043997, 5123.359580052494, 5142.97428512855, 4007.6793856491413, 4068.450759147477, 4073.574249012881, 4103.138340948434, 4137.91724165515, 1366.5422083602105, 1374.2785037855206, 1381.530279704905, 1382.7511048011454, 1392.2273138408282, 1365.2218235605808, 1395.783653533704, 1399.2863639543905, 1428.6428392901776, 1439.0717986898392, 8313.584320783937, 8446.197611226924, 8479.364047696448, 8483.363747718946, 8527.019392769911, 529.5313647422059, 536.0779459329947, 538.496505767109, 541.7426722306873, 543.8069485332729, 6276.184096067482, 6312.873742525124, 6319.210098737658, 6365.713542890581, 6394.840128996812, 10727.892721072845, 11032.44837758109, 11163.497642606102, 11178.664640060812, 11258.43707814606, 10590.417527035934, 10930.508127134299, 10949.562017519369, 10993.010629043265, 11123.99884010443, 8652.221300083023, 8663.653453861774, 8699.217070463688, 8744.0, 8744.994325652504, 7898.68405263783, 8039.356851451987, 8042.437029407885, 8098.987626546682, 8191.139930307232, 9564.521773911416, 9878.802423951625, 9979.550920208463, 9985.500724963578, 9998.750031249278, 9988.700338989842, 10190.541425636013, 10263.897361026295, 10299.433531155859, 10314.174866010851, 7124.679389427592, 7567.31894129531, 7576.204498527795, 7642.617869106633, 7680.6543705534505, 8340.374471914509, 8342.416030877781, 8360.66557337724, 8383.538905360263, 8401.453905496122, 7354.96322518384, 7533.058367704037, 7564.205758395289, 7610.1628820828555, 7640.197779233101, 7374.078240219973, 7387.852242955219, 7434.59109748969, 7517.736879209201, 7525.0, 7924.722634707758, 7925.603719814101, 7925.722599709213, 7937.642806073625, 7947.761567152995, 7117.893231601426, 7125.394341481032, 7205.099362579677, 7209.4592905533345, 7222.422206223385, 7278.09023872016, 7286.817829554304, 7293.635318234174, 7339.155997060407, 7355.2277010913085], "unit": "score", "name": "mootools.html", "value": 5004.786758860074}, {"lowerIsBetter": false, "replicates": [330.2717507895091, 339.1335138720569, 339.8181972644634, 341.67882190740715, 350.18057744876984, 6113.602615829968, 6377.298497165308, 6924.099867017287, 6947.756828511003, 6960.54756440831, 5147.0, 6709.899351509731, 6787.389134977851, 6892.207396149444, 6897.137857767779, 4323.854178642662, 4659.860204193863, 4840.394950631171, 5017.974910125445, 5093.134167191568, 4024.396340548926, 4063.4108054332105, 4971.651984361096, 5042.949570504285, 5056.469070747574, 5044.899102017957, 5063.240513922904, 5077.213031980049, 5089.694618322894, 5129.769160387791, 5082.542571168613, 5088.643794934356, 5091.9236211456855, 5096.235564665293, 5108.438071812079, 4331.935020974688, 4342.522322544518, 4345.109252603209, 4349.630281426083, 4358.7166834156, 6227.470664993436, 6528.281888992207, 6641.070250164981, 6660.866782664368, 6720.932790672079, 5863.648181109147, 5873.647581145145, 5904.97047514764, 5905.320888097881, 5917.497012753921, 7305.598192099433, 7314.378277846389, 7318.707251709925, 7338.376238019775, 7369.6315184240575, 4699.412573428322, 4701.271302948048, 4711.717296962159, 4712.882177945545, 4713.764311784432, 7807.141214466405, 7836.098848632423, 7877.212278772135, 7899.447038707292, 7928.920710792876, 4621.168189725881, 4795.472498025214, 4833.202521583969, 4849.75751212438, 4855.077535268288, 4845.53967373099, 4908.828191013297, 4910.263460480956, 4921.532454416824, 4930.482299358516, 5209.973950130225, 5933.821985340447, 5960.4635582797755, 5967.791127310524, 5978.133170690226, 5961.463468287789, 7005.92994070063, 7481.513701609378, 7490.325870671557, 7530.43521735872, 1465.604286842568, 1667.3914021382109, 1699.0994772770453, 1700.2773821125973, 1702.259517110061, 916.9312301577409, 1039.3192458939407, 1081.810683130449, 1081.8972197641212, 1096.5613754498106, 5464.535514481234, 6616.768413105518, 6723.327667233238, 6725.092112564839, 6738.191417029988, 6701.329867013357, 7631.0, 7633.580153091633, 7655.46411751172, 7664.0, 6747.190337159573, 6858.6570671466225, 6869.450443964471, 6898.689558969859, 6899.17209934811, 4083.2037752637953, 4117.855875044359, 4125.50493940729, 4136.276151673445, 4138.565450627701, 6188.009918413032, 6546.541742078104, 8001.079875814356, 8168.550729709923, 8169.387295952827, 6326.829536535755, 7807.68769249235, 8004.959975200203, 8089.433739638169, 8111.269985701315, 7937.761867143995, 8104.1085480597085, 8112.797180070545, 8155.632996515171, 8168.224018718212, 7802.6488808004915, 7806.102298235775, 7815.179406162499, 7832.569208693577, 7859.960700196462, 7635.923640763522, 7644.617769111411, 7681.577513236825, 7690.0771907369235, 7716.5755883426955, 7715.884261735966, 7733.38132949374, 8141.592920354077, 8150.959245203973, 8172.509649421054, 4769.785359658893, 4819.879503012453, 4828.975855120702, 4833.178359678793, 4876.829310974241, 5953.898528772191, 7733.304002639565, 7750.418718596015, 7785.338246248905, 7799.142094369501, 7439.986805343844, 7448.180700123091, 7452.776416707507, 7488.663010164664, 7507.887381689388, 7218.566885986857, 7461.477696561188, 7466.925330746623, 7469.178390377163, 7472.701091956261, 5829.912551311819, 5863.742459153342, 7003.264657211123, 7261.128664560075, 7305.1233851938105, 7421.257874212535, 7428.665710042953, 7445.181030086578, 7449.329560339595, 7459.552426854189, 5873.0, 7084.509430386789, 7287.708491660486, 7296.4162866969455, 7325.340719335072], "unit": "score", "name": "prototype.html", "value": 5315.309579329075}, {"lowerIsBetter": false, "replicates": [704.5596502186133, 734.8567029429263, 743.2530307041422, 762.3596179209463, 772.166060654493, 15138.54584362468, 15175.54473365798, 15459.149746763924, 15467.149306788122, 15479.380824767024, 16243.431479898207, 16576.66846663066, 16596.66806663869, 16613.83386166138, 16615.66768664626, 785.3677789379548, 949.7957939043122, 960.4573416019962, 966.6133546581389, 967.1054274795786, 974.0, 974.8342781727088, 975.5366201054478, 976.023976023976, 981.224832382417, 1015.8222311095566, 1026.0560284538205, 1026.4508487958944, 1028.2185538990345, 1032.2774058159282, 1010.1413798271484, 1012.772126271583, 1020.5305559442666, 1020.8825985011707, 1022.2741853284177, 746.5371469688773, 749.9550026998397, 755.3013462547121, 758.4084414156966, 758.829263415727, 15471.458498952596, 15923.52229433119, 15940.681186376207, 15979.680406391923, 15980.76028859568, 12757.681057973625, 12887.16233444823, 12909.612711618667, 12941.87058129416, 13046.347682615831, 10072.345297555708, 11157.330560166334, 11220.158488113424, 11237.269577477438, 11538.192326537146, 2810.8313501189996, 2819.760320372771, 2820.1680504251294, 2835.1211124551455, 2845.8007939444246, 80558.38883222362, 80750.0, 81499.0, 82712.0, 82868.9999999994, 9488.762780930532, 9524.571394287274, 9567.569459374206, 9632.133108020313, 9659.661911833053, 22040.779592204195, 22068.33794986153, 22085.895705214676, 22135.889320553295, 22192.223272185394, 7588.886166707503, 7606.0, 7660.73187438437, 7815.413843961725, 7850.450468467153, 4179.2059508693255, 4213.915721685549, 4223.957760422418, 4244.490661120623, 4271.487421509377, 3294.275259442919, 3720.069982504374, 3737.9065523362133, 3785.432185172191, 3786.5266841644793, 660.2242365220847, 670.808819486444, 676.7698982346026, 688.0, 700.6811900585221, 526.108246522149, 573.7446836157869, 594.7680404642193, 611.4222060153202, 619.3218425823716, 8205.917940820635, 8367.456115352483, 8444.57777111142, 8485.872711909326, 8670.089640587774, 449.3439578215841, 482.7610332885244, 589.0810335876047, 610.856448734547, 619.4177473175291, 2822.3931854650937, 3827.483289755903, 3939.8621048263744, 3955.0903292242947, 4103.938440923389, 71913.64043179751, 85061.0, 86161.0, 93349.0, 94448.52775736214, 83337.58331208305, 83429.58285208656, 86345.0, 87915.80210494788, 88578.55710721404, 55814.44185558174, 72843.90734138885, 73892.15269618302, 74898.62550687212, 77408.0, 7903.960480197562, 7909.604519774103, 7945.1260361361365, 7964.084130325086, 8095.595220239083, 52391.73804130955, 53067.46932530625, 53632.73183634213, 53708.31458426985, 53973.0, 71869.0, 74197.0, 75024.0, 75385.62307188429, 75794.0, 10145.797084058426, 10390.480475976323, 10415.323004004715, 10426.635067772591, 10447.58209671635, 11124.61063862761, 11216.214864959375, 11238.0, 11325.943370283096, 11991.700207494883, 10390.220733445172, 10433.426161561187, 10482.68551943443, 10529.684109476728, 10744.086752626114, 10474.109700675528, 10521.736956576147, 10642.41466719338, 10690.57237710514, 11378.31730096197, 10630.627928022483, 10876.456177191267, 11397.886021139682, 11518.539258429904, 11601.18791684574, 9190.724278271662, 9444.197243234403, 9549.09283618055, 9552.331336806357, 9571.138597526256, 9374.906250937676, 9487.66793162236, 9501.952490237505, 9616.807663846545, 9829.705108846745], "unit": "score", "name": "yui.html", "value": 7007.552432453404}], "name": "dromaeo_css", "value": 7670.91093505519}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 116.0, 131.0, 170.0, 184.0, 117.0, 114.0, 150.0, 166.0], "unit": "score", "name": "ai-astar", "value": 137.5}, {"lowerIsBetter": true, "replicates": [151.0, 121.0, 156.0, 146.0, 124.0, 174.0, 159.0, 150.0, 172.0, 151.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [200.0, 195.0, 193.0, 200.0, 201.0, 196.0, 245.0, 280.0, 200.0, 197.0], "unit": "score", "name": "audio-dft", "value": 210.7}, {"lowerIsBetter": true, "replicates": [71.0, 83.0, 73.0, 115.0, 56.0, 57.0, 58.0, 59.0, 125.0, 57.0], "unit": "score", "name": "audio-fft", "value": 75.4}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 125.0, 77.0, 82.0, 83.0, 136.0, 65.0, 80.0, 157.0], "unit": "score", "name": "audio-oscillator", "value": 97.1}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 92.0, 126.0, 88.0, 88.0, 89.0, 86.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.5}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 119.0, 119.0], "unit": "score", "name": "imaging-darkroom", "value": 99.9}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 92.0, 91.0, 120.0, 138.0, 108.0, 90.0, 91.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 101.0}, {"lowerIsBetter": true, "replicates": [55.0, 60.0, 58.0, 60.0, 60.0, 58.0, 59.0, 67.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [66.0, 74.0, 66.0, 94.0, 104.0, 96.0, 67.0, 67.0, 90.0, 95.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.9}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 81.0, 83.0, 81.0, 80.0, 81.0, 85.0, 81.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [120.0, 142.0, 143.0, 121.0, 127.0, 122.0, 127.0, 130.0, 157.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.3}, {"lowerIsBetter": true, "replicates": [127.0, 134.0, 139.0, 138.0, 136.0, 122.0, 133.0, 137.0, 134.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.6}, {"lowerIsBetter": true, "replicates": [65.0, 60.0, 88.0, 93.0, 97.0, 98.0, 94.0, 87.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.5}], "name": "kraken", "value": 1531.9999999999998}]} 19:06:40 INFO - Return code: 0 19:06:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:06:41 ERROR - # TBPL SUCCESS # 19:06:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:06:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:06:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:06:41 INFO - 2016-03-28 19:06:41.058 screenresolution[2291:32999] starting screenresolution argv=screenresolution get 19:06:41 INFO - 2016-03-28 19:06:41.060 screenresolution[2291:32999] Display 0: 1600x1200x32@60 19:06:41 INFO - 2016-03-28 19:06:41.066 screenresolution[2292:33002] starting screenresolution argv=screenresolution list 19:06:41 INFO - Available Modes on Display 0 19:06:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:06:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:06:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:06:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:06:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:06:41 INFO - Intel Iris: 19:06:41 INFO - Chipset Model: Intel Iris 19:06:41 INFO - Type: GPU 19:06:41 INFO - Bus: Built-In 19:06:41 INFO - VRAM (Dynamic, Max): 1536 MB 19:06:41 INFO - Vendor: Intel (0x8086) 19:06:41 INFO - Device ID: 0x0a2e 19:06:41 INFO - Revision ID: 0x0009 19:06:41 INFO - Displays: 19:06:41 INFO - Display: 19:06:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:06:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:06:41 INFO - Display Serial Number: 1600x1200 60 19:06:41 INFO - Main Display: Yes 19:06:41 INFO - Mirror: Off 19:06:41 INFO - Online: Yes 19:06:41 INFO - Rotation: Supported 19:06:41 INFO - Return code: 0 19:06:41 INFO - Running post-action listener: _resource_record_post_action 19:06:41 INFO - Running post-run listener: _resource_record_post_run 19:06:42 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 405504; Write bytes: 666103808; Read time: 5; Write time: 1981 19:06:42 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 357982720; Write bytes: 353064448; Read time: 28083; Write time: 639 19:06:42 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 405504; Write bytes: 301865472; Read time: 5; Write time: 1306 19:06:42 INFO - Running post-run listener: _upload_blobber_files 19:06:42 INFO - Blob upload gear active. 19:06:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:06:42 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 19:06:42 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:06:42 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:06:42 INFO - (blobuploader) - INFO - Open directory for files ... 19:06:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:06:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:44 INFO - (blobuploader) - INFO - Done attempting. 19:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:06:45 INFO - (blobuploader) - INFO - Done attempting. 19:06:45 INFO - (blobuploader) - INFO - Iteration through files over. 19:06:45 INFO - Return code: 0 19:06:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:06:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:06:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3302542f7f3f03c67b05ac68f7e5c2f02abce1c0430e09af0462c400b20f5996ce9f7ce0408d95a3f3c83f4f9673a9fbc0fe2e18b2334b0201eb72d9c83e1ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bcc00338d973452b93187c34719e456ba3fa42aee2679076f8d0236164726cedd5de8b996ecccb87653919682bf55881ed00112a24c7ac77334e74d7fc90"} 19:06:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:06:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:06:45 INFO - Contents: 19:06:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3302542f7f3f03c67b05ac68f7e5c2f02abce1c0430e09af0462c400b20f5996ce9f7ce0408d95a3f3c83f4f9673a9fbc0fe2e18b2334b0201eb72d9c83e1ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bcc00338d973452b93187c34719e456ba3fa42aee2679076f8d0236164726cedd5de8b996ecccb87653919682bf55881ed00112a24c7ac77334e74d7fc90"} 19:06:45 INFO - Running post-run listener: copy_logs_to_upload_dir 19:06:45 INFO - Copying logs to upload dir... 19:06:45 INFO - mkdir: /builds/slave/test/build/upload/logs 19:06:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1335.582388 ========= master_lag: 65.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 21 secs) (at 2016-03-28 19:07:50.739030) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-03-28 19:07:50.748581) ========= 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.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3302542f7f3f03c67b05ac68f7e5c2f02abce1c0430e09af0462c400b20f5996ce9f7ce0408d95a3f3c83f4f9673a9fbc0fe2e18b2334b0201eb72d9c83e1ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bcc00338d973452b93187c34719e456ba3fa42aee2679076f8d0236164726cedd5de8b996ecccb87653919682bf55881ed00112a24c7ac77334e74d7fc90"} build_url:https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/Ov71Fog7RYmh_Mw7Q2hGmg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3302542f7f3f03c67b05ac68f7e5c2f02abce1c0430e09af0462c400b20f5996ce9f7ce0408d95a3f3c83f4f9673a9fbc0fe2e18b2334b0201eb72d9c83e1ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5b6bcc00338d973452b93187c34719e456ba3fa42aee2679076f8d0236164726cedd5de8b996ecccb87653919682bf55881ed00112a24c7ac77334e74d7fc90"}' ========= master_lag: 7.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-03-28 19:07:58.151410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-03-28 19:07:58.151720) ========= 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.fGdnS1pzQi/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.JNV07gUzX1/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005142 ========= master_lag: 11.58 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-03-28 19:08:09.735495) ========= ========= Started reboot skipped (results: 3, elapsed: 9 secs) (at 2016-03-28 19:08:09.735768) ========= ========= Finished reboot skipped (results: 3, elapsed: 9 secs) (at 2016-03-28 19:08:19.203512) ========= ========= Total master_lag: 106.45 =========