builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1463510618.15 results: success (0) buildid: 20160517085406 builduid: c9d6cbc506de4be79cb468632ed1bb63 revision: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.154230) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.154801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.155130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.465906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.466351) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 11:43:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-05-17 11:43:38 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172236 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.662225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.662614) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014183 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.725772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:38.726173) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 11:43:38,952 truncating revision to first 12 chars 2016-05-17 11:43:38,952 Setting DEBUG logging. 2016-05-17 11:43:38,952 attempt 1/10 2016-05-17 11:43:38,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9f9aae87248d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 11:43:39,235 unpacking tar archive at: mozilla-inbound-9f9aae87248d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:39.341205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:39.341993) ========= script_repo_revision: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:39.342957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:39.343691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 11:43:39.354654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-17 11:43:39.355378) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:43:39 INFO - MultiFileLogger online at 20160517 11:43:39 in /builds/slave/test 11:43:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:43:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:43:39 INFO - {'append_to_log': False, 11:43:39 INFO - 'base_work_dir': '/builds/slave/test', 11:43:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:43:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:43:39 INFO - 'branch': 'Mozilla-Inbound', 11:43:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:43:39 INFO - 'config_files': ('talos/linux_config.py',), 11:43:39 INFO - 'default_actions': ('clobber', 11:43:39 INFO - 'read-buildbot-config', 11:43:39 INFO - 'download-and-extract', 11:43:39 INFO - 'populate-webroot', 11:43:39 INFO - 'create-virtualenv', 11:43:39 INFO - 'install', 11:43:39 INFO - 'run-tests'), 11:43:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:43:39 INFO - 'download_minidump_stackwalk': True, 11:43:39 INFO - 'download_symbols': 'ondemand', 11:43:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:43:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:43:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:43:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:43:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:43:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:43:39 INFO - 'installer_path': 'installer.exe', 11:43:39 INFO - 'log_level': 'info', 11:43:39 INFO - 'log_name': 'talos', 11:43:39 INFO - 'log_to_console': True, 11:43:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:43:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:43:39 INFO - 'opt_config_files': (), 11:43:39 INFO - 'pip_index': False, 11:43:39 INFO - 'sps_profile': False, 11:43:39 INFO - 'sps_profile_interval': 0, 11:43:39 INFO - 'suite': 'dromaeojs', 11:43:39 INFO - 'system_bits': '32', 11:43:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:43:39 INFO - 'title': 'talos-linux64-ix-007', 11:43:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:43:39 INFO - 'use_talos_json': True, 11:43:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:43:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:43:39 INFO - 'work_dir': 'build'} 11:43:39 INFO - ##### 11:43:39 INFO - ##### Running clobber step. 11:43:39 INFO - ##### 11:43:39 INFO - Running pre-action listener: _resource_record_pre_action 11:43:39 INFO - Running main action method: clobber 11:43:39 INFO - rmtree: /builds/slave/test/build 11:43:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:43:40 INFO - Running post-action listener: _resource_record_post_action 11:43:40 INFO - ##### 11:43:40 INFO - ##### Finished clobber step (success) 11:43:40 INFO - ##### 11:43:40 INFO - ##### 11:43:40 INFO - ##### Running read-buildbot-config step. 11:43:40 INFO - ##### 11:43:40 INFO - Running pre-action listener: _resource_record_pre_action 11:43:40 INFO - Running main action method: read_buildbot_config 11:43:40 INFO - Using buildbot properties: 11:43:40 INFO - { 11:43:40 INFO - "project": "", 11:43:40 INFO - "product": "firefox", 11:43:40 INFO - "script_repo_revision": "production", 11:43:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 11:43:40 INFO - "repository": "", 11:43:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 11:43:40 INFO - "buildid": "20160517085406", 11:43:40 INFO - "pgo_build": "True", 11:43:40 INFO - "basedir": "/builds/slave/test", 11:43:40 INFO - "buildnumber": 1824, 11:43:40 INFO - "slavename": "talos-linux64-ix-007", 11:43:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:43:40 INFO - "platform": "ubuntu64_hw", 11:43:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 11:43:40 INFO - "branch": "mozilla-inbound", 11:43:40 INFO - "repo_path": "integration/mozilla-inbound", 11:43:40 INFO - "revision": "9f9aae87248d444ff93d1a213b6de0a6ee39fb26", 11:43:40 INFO - "stage_platform": "linux64-pgo", 11:43:40 INFO - "builduid": "c9d6cbc506de4be79cb468632ed1bb63", 11:43:40 INFO - "slavebuilddir": "test" 11:43:40 INFO - } 11:43:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:43:40 INFO - Running post-action listener: _resource_record_post_action 11:43:40 INFO - ##### 11:43:40 INFO - ##### Finished read-buildbot-config step (success) 11:43:40 INFO - ##### 11:43:40 INFO - ##### 11:43:40 INFO - ##### Running download-and-extract step. 11:43:40 INFO - ##### 11:43:40 INFO - Running pre-action listener: _resource_record_pre_action 11:43:40 INFO - Running main action method: download_and_extract 11:43:40 INFO - mkdir: /builds/slave/test/build/tests 11:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:40 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:43:41 INFO - Downloaded 1361 bytes. 11:43:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:43:41 INFO - Using the following test package requirements: 11:43:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:43:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:43:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'jsshell-linux-x86_64.zip'], 11:43:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:43:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:43:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:43:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:43:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:43:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:43:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:43:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:41 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:42 INFO - Downloaded 24024596 bytes. 11:43:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:43:43 INFO - Return code: 0 11:43:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:43 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:43:46 INFO - Downloaded 24024596 bytes. 11:43:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:43:48 INFO - Return code: 0 11:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:48 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:43:48 INFO - Downloaded 10840194 bytes. 11:43:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:43:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:43:49 INFO - Return code: 0 11:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:49 INFO - https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:43:52 INFO - Downloaded 58417234 bytes. 11:43:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:52 INFO - mkdir: /builds/slave/test/properties 11:43:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:43:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:43:52 INFO - Contents: 11:43:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:43:53 INFO - Running post-action listener: _resource_record_post_action 11:43:53 INFO - Running post-action listener: set_extra_try_arguments 11:43:53 INFO - ##### 11:43:53 INFO - ##### Finished download-and-extract step (success) 11:43:53 INFO - ##### 11:43:53 INFO - ##### 11:43:53 INFO - ##### Running populate-webroot step. 11:43:53 INFO - ##### 11:43:53 INFO - Running pre-action listener: _resource_record_pre_action 11:43:53 INFO - Running main action method: populate_webroot 11:43:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:43:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:43:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:43:53 INFO - '--tppagecycles', 11:43:53 INFO - '7'], 11:43:53 INFO - 'tests': ['tsvgm']}}, 11:43:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:43:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:43:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:43:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:43:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:43:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['damp', 'tps']}, 11:43:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'tests': ['damp', 'tps']}, 11:43:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['dromaeo_dom']}, 11:43:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:43:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['a11yr', 11:43:53 INFO - 'ts_paint', 11:43:53 INFO - 'tpaint', 11:43:53 INFO - 'sessionrestore', 11:43:53 INFO - 'sessionrestore_no_auto_restore', 11:43:53 INFO - 'tabpaint']}, 11:43:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:43:53 INFO - 'ts_paint', 11:43:53 INFO - 'tpaint', 11:43:53 INFO - 'sessionrestore', 11:43:53 INFO - 'sessionrestore_no_auto_restore', 11:43:53 INFO - 'tabpaint']}, 11:43:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:43:53 INFO - 'ts_paint', 11:43:53 INFO - 'tpaint', 11:43:53 INFO - 'sessionrestore', 11:43:53 INFO - 'sessionrestore_no_auto_restore', 11:43:53 INFO - 'tabpaint']}, 11:43:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:43:53 INFO - 'ts_paint', 11:43:53 INFO - 'tpaint', 11:43:53 INFO - 'sessionrestore', 11:43:53 INFO - 'sessionrestore_no_auto_restore', 11:43:53 INFO - 'tabpaint']}, 11:43:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['a11yr', 11:43:53 INFO - 'ts_paint', 11:43:53 INFO - 'tpaint', 11:43:53 INFO - 'sessionrestore', 11:43:53 INFO - 'sessionrestore_no_auto_restore', 11:43:53 INFO - 'tabpaint']}, 11:43:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['a11yr', 11:43:53 INFO - 'ts_paint', 11:43:53 INFO - 'tpaint', 11:43:53 INFO - 'sessionrestore', 11:43:53 INFO - 'sessionrestore_no_auto_restore', 11:43:53 INFO - 'tabpaint']}, 11:43:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['tsvgx', 11:43:53 INFO - 'tsvgr_opacity', 11:43:53 INFO - 'tart', 11:43:53 INFO - 'tscrollx', 11:43:53 INFO - 'cart']}, 11:43:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:43:53 INFO - 'tsvgr_opacity', 11:43:53 INFO - 'tart', 11:43:53 INFO - 'tscrollx', 11:43:53 INFO - 'cart']}, 11:43:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'talos_options': ['--disable-e10s'], 11:43:53 INFO - 'tests': ['tp5o']}, 11:43:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'tests': ['tp5o']}, 11:43:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'talos_options': ['--disable-e10s', 11:43:53 INFO - '--xperf_path', 11:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:53 INFO - 'tests': ['tp5n']}, 11:43:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:43:53 INFO - 'talos_options': ['--xperf_path', 11:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:43:53 INFO - 'tests': ['tp5n']}}, 11:43:53 INFO - 'talos.zip': {'path': '', 11:43:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:43:53 INFO - Running post-action listener: _resource_record_post_action 11:43:53 INFO - ##### 11:43:53 INFO - ##### Finished populate-webroot step (success) 11:43:53 INFO - ##### 11:43:53 INFO - ##### 11:43:53 INFO - ##### Running create-virtualenv step. 11:43:53 INFO - ##### 11:43:53 INFO - Running pre-action listener: _resource_record_pre_action 11:43:53 INFO - Running main action method: create_virtualenv 11:43:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:43:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:43:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:43:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:43:53 INFO - Using real prefix '/usr' 11:43:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:43:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:43:55 INFO - Installing pip.................done. 11:43:55 INFO - Return code: 0 11:43:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:55 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 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:43:55 INFO - Using env: {'DISPLAY': ':0', 11:43:55 INFO - 'HOME': '/home/cltbld', 11:43:55 INFO - 'LANG': 'en_US.UTF-8', 11:43:55 INFO - 'LANGUAGE': 'en_US:en', 11:43:55 INFO - 'LOGNAME': 'cltbld', 11:43:55 INFO - 'MAIL': '/var/mail/cltbld', 11:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:55 INFO - 'MOZ_NO_REMOTE': '1', 11:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:55 INFO - 'NO_EM_RESTART': '1', 11:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:55 INFO - 'PWD': '/builds/slave/test', 11:43:55 INFO - 'SHELL': '/bin/bash', 11:43:55 INFO - 'SHLVL': '1', 11:43:55 INFO - 'TERM': 'linux', 11:43:55 INFO - 'TMOUT': '86400', 11:43:55 INFO - 'USER': 'cltbld', 11:43:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:55 INFO - '_': '/tools/buildbot/bin/python'} 11:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:43:55 INFO - Cleaning up... 11:43:55 INFO - Return code: 0 11:43:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:43:55 INFO - Using env: {'DISPLAY': ':0', 11:43:55 INFO - 'HOME': '/home/cltbld', 11:43:55 INFO - 'LANG': 'en_US.UTF-8', 11:43:55 INFO - 'LANGUAGE': 'en_US:en', 11:43:55 INFO - 'LOGNAME': 'cltbld', 11:43:55 INFO - 'MAIL': '/var/mail/cltbld', 11:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:55 INFO - 'MOZ_NO_REMOTE': '1', 11:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:55 INFO - 'NO_EM_RESTART': '1', 11:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:55 INFO - 'PWD': '/builds/slave/test', 11:43:55 INFO - 'SHELL': '/bin/bash', 11:43:55 INFO - 'SHLVL': '1', 11:43:55 INFO - 'TERM': 'linux', 11:43:55 INFO - 'TMOUT': '86400', 11:43:55 INFO - 'USER': 'cltbld', 11:43:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:55 INFO - '_': '/tools/buildbot/bin/python'} 11:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:56 INFO - Downloading/unpacking psutil>=3.1.1 11:43: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 11:43: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 11:43: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 11:43: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 11:43: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 11:43: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 11:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:58 INFO - Installing collected packages: psutil 11:43:58 INFO - Running setup.py install for psutil 11:43:58 INFO - building 'psutil._psutil_linux' extension 11:43:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:43:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:43:58 INFO - building 'psutil._psutil_posix' extension 11:43:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:43:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:43:58 INFO - Successfully installed psutil 11:43:58 INFO - Cleaning up... 11:43:58 INFO - Return code: 0 11:43:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:43:58 INFO - Using env: {'DISPLAY': ':0', 11:43:58 INFO - 'HOME': '/home/cltbld', 11:43:58 INFO - 'LANG': 'en_US.UTF-8', 11:43:58 INFO - 'LANGUAGE': 'en_US:en', 11:43:58 INFO - 'LOGNAME': 'cltbld', 11:43:58 INFO - 'MAIL': '/var/mail/cltbld', 11:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:58 INFO - 'MOZ_NO_REMOTE': '1', 11:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:58 INFO - 'NO_EM_RESTART': '1', 11:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:58 INFO - 'PWD': '/builds/slave/test', 11:43:58 INFO - 'SHELL': '/bin/bash', 11:43:58 INFO - 'SHLVL': '1', 11:43:58 INFO - 'TERM': 'linux', 11:43:58 INFO - 'TMOUT': '86400', 11:43:58 INFO - 'USER': 'cltbld', 11:43:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:58 INFO - '_': '/tools/buildbot/bin/python'} 11:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:43:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:44:00 INFO - Installing collected packages: mozsystemmonitor 11:44:00 INFO - Running setup.py install for mozsystemmonitor 11:44:00 INFO - Successfully installed mozsystemmonitor 11:44:00 INFO - Cleaning up... 11:44:00 INFO - Return code: 0 11:44:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:00 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 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:44:00 INFO - Using env: {'DISPLAY': ':0', 11:44:00 INFO - 'HOME': '/home/cltbld', 11:44:00 INFO - 'LANG': 'en_US.UTF-8', 11:44:00 INFO - 'LANGUAGE': 'en_US:en', 11:44:00 INFO - 'LOGNAME': 'cltbld', 11:44:00 INFO - 'MAIL': '/var/mail/cltbld', 11:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:00 INFO - 'MOZ_NO_REMOTE': '1', 11:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:00 INFO - 'NO_EM_RESTART': '1', 11:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:00 INFO - 'PWD': '/builds/slave/test', 11:44:00 INFO - 'SHELL': '/bin/bash', 11:44:00 INFO - 'SHLVL': '1', 11:44:00 INFO - 'TERM': 'linux', 11:44:00 INFO - 'TMOUT': '86400', 11:44:00 INFO - 'USER': 'cltbld', 11:44:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:00 INFO - '_': '/tools/buildbot/bin/python'} 11:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:03 INFO - Downloading docopt-0.6.1.tar.gz 11:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:03 INFO - Running setup.py install for blobuploader 11:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:03 INFO - Running setup.py install for requests 11:44:04 INFO - Running setup.py install for docopt 11:44:04 INFO - Successfully installed blobuploader requests docopt 11:44:04 INFO - Cleaning up... 11:44:04 INFO - Return code: 0 11:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:04 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 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:04 INFO - Using env: {'DISPLAY': ':0', 11:44:04 INFO - 'HOME': '/home/cltbld', 11:44:04 INFO - 'LANG': 'en_US.UTF-8', 11:44:04 INFO - 'LANGUAGE': 'en_US:en', 11:44:04 INFO - 'LOGNAME': 'cltbld', 11:44:04 INFO - 'MAIL': '/var/mail/cltbld', 11:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:04 INFO - 'MOZ_NO_REMOTE': '1', 11:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:04 INFO - 'NO_EM_RESTART': '1', 11:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:04 INFO - 'PWD': '/builds/slave/test', 11:44:04 INFO - 'SHELL': '/bin/bash', 11:44:04 INFO - 'SHLVL': '1', 11:44:04 INFO - 'TERM': 'linux', 11:44:04 INFO - 'TMOUT': '86400', 11:44:04 INFO - 'USER': 'cltbld', 11:44:04 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:04 INFO - '_': '/tools/buildbot/bin/python'} 11:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:04 INFO - Running setup.py (path:/tmp/pip-XqIPmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:04 INFO - Running setup.py (path:/tmp/pip-_topZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:04 INFO - Running setup.py (path:/tmp/pip-ud0Wn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:04 INFO - Running setup.py (path:/tmp/pip-1cMEEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:04 INFO - Running setup.py (path:/tmp/pip-1qizDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:05 INFO - Running setup.py (path:/tmp/pip-rc9Y6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:05 INFO - Running setup.py (path:/tmp/pip-kK5x17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:05 INFO - Running setup.py (path:/tmp/pip-nP8Y_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:05 INFO - Running setup.py (path:/tmp/pip-btcJBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:05 INFO - Running setup.py (path:/tmp/pip-K70EbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:05 INFO - Running setup.py (path:/tmp/pip-qDrz3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:05 INFO - Running setup.py (path:/tmp/pip-eQs7Ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:05 INFO - Running setup.py (path:/tmp/pip-NaMhc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:05 INFO - Running setup.py (path:/tmp/pip-fkDlWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:05 INFO - Running setup.py (path:/tmp/pip-pYQBhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:05 INFO - Running setup.py (path:/tmp/pip-8p8rIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:05 INFO - Running setup.py (path:/tmp/pip-ianGsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:05 INFO - Running setup.py install for manifestparser 11:44:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:05 INFO - Running setup.py install for mozcrash 11:44:06 INFO - Running setup.py install for mozdebug 11:44:06 INFO - Running setup.py install for mozdevice 11:44:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozfile 11:44:06 INFO - Running setup.py install for mozhttpd 11:44:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozinfo 11:44:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozInstall 11:44:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for mozleak 11:44:06 INFO - Running setup.py install for mozlog 11:44:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:06 INFO - Running setup.py install for moznetwork 11:44:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:07 INFO - Running setup.py install for mozprocess 11:44:07 INFO - Running setup.py install for mozprofile 11:44:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:07 INFO - Running setup.py install for mozrunner 11:44:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:07 INFO - Running setup.py install for mozscreenshot 11:44:07 INFO - Running setup.py install for moztest 11:44:07 INFO - Running setup.py install for mozversion 11:44:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:07 INFO - Cleaning up... 11:44:07 INFO - Return code: 0 11:44:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:07 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 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:07 INFO - Using env: {'DISPLAY': ':0', 11:44:07 INFO - 'HOME': '/home/cltbld', 11:44:07 INFO - 'LANG': 'en_US.UTF-8', 11:44:07 INFO - 'LANGUAGE': 'en_US:en', 11:44:07 INFO - 'LOGNAME': 'cltbld', 11:44:07 INFO - 'MAIL': '/var/mail/cltbld', 11:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:07 INFO - 'MOZ_NO_REMOTE': '1', 11:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:07 INFO - 'NO_EM_RESTART': '1', 11:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:07 INFO - 'PWD': '/builds/slave/test', 11:44:07 INFO - 'SHELL': '/bin/bash', 11:44:07 INFO - 'SHLVL': '1', 11:44:07 INFO - 'TERM': 'linux', 11:44:07 INFO - 'TMOUT': '86400', 11:44:07 INFO - 'USER': 'cltbld', 11:44:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:07 INFO - '_': '/tools/buildbot/bin/python'} 11:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:07 INFO - Running setup.py (path:/tmp/pip-lA1M7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:07 INFO - Running setup.py (path:/tmp/pip-5Umbt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:08 INFO - Running setup.py (path:/tmp/pip-jNXfiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:08 INFO - Running setup.py (path:/tmp/pip-yO2qOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:08 INFO - Running setup.py (path:/tmp/pip-peD3cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:08 INFO - Running setup.py (path:/tmp/pip-iE0_pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:08 INFO - Running setup.py (path:/tmp/pip-AtuOLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:08 INFO - Running setup.py (path:/tmp/pip-BGGYXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:08 INFO - Running setup.py (path:/tmp/pip-x5kxAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:08 INFO - Running setup.py (path:/tmp/pip-QnR173-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:08 INFO - Running setup.py (path:/tmp/pip-CsPcN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:08 INFO - Running setup.py (path:/tmp/pip-DuPQJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:08 INFO - Running setup.py (path:/tmp/pip-tmMyf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:08 INFO - Running setup.py (path:/tmp/pip-SkoFw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:08 INFO - Running setup.py (path:/tmp/pip-GSoE3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:08 INFO - Running setup.py (path:/tmp/pip-yEb4jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:09 INFO - Running setup.py (path:/tmp/pip-VjBxpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:44:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:10 INFO - Downloading blessings-1.6.tar.gz 11:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:11 INFO - Installing collected packages: blessings 11:44:11 INFO - Running setup.py install for blessings 11:44:11 INFO - Successfully installed blessings 11:44:11 INFO - Cleaning up... 11:44:11 INFO - Return code: 0 11:44:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:11 INFO - Reading from file tmpfile_stdout 11:44:11 INFO - Current package versions: 11:44:11 INFO - argparse == 1.2.1 11:44:11 INFO - blessings == 1.6 11:44:11 INFO - blobuploader == 1.2.4 11:44:11 INFO - docopt == 0.6.1 11:44:11 INFO - manifestparser == 1.1 11:44:11 INFO - mozInstall == 1.12 11:44:11 INFO - mozcrash == 0.17 11:44:11 INFO - mozdebug == 0.1 11:44:11 INFO - mozdevice == 0.48 11:44:11 INFO - mozfile == 1.2 11:44:11 INFO - mozhttpd == 0.7 11:44:11 INFO - mozinfo == 0.9 11:44:11 INFO - mozleak == 0.1 11:44:11 INFO - mozlog == 3.2 11:44:11 INFO - moznetwork == 0.27 11:44:11 INFO - mozprocess == 0.22 11:44:11 INFO - mozprofile == 0.28 11:44:11 INFO - mozrunner == 6.11 11:44:11 INFO - mozscreenshot == 0.1 11:44:11 INFO - mozsystemmonitor == 0.3 11:44:11 INFO - moztest == 0.7 11:44:11 INFO - mozversion == 1.4 11:44:11 INFO - psutil == 3.1.1 11:44:11 INFO - requests == 1.2.3 11:44:11 INFO - wsgiref == 0.1.2 11:44:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 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 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:44:11 INFO - Using env: {'DISPLAY': ':0', 11:44:11 INFO - 'HOME': '/home/cltbld', 11:44:11 INFO - 'LANG': 'en_US.UTF-8', 11:44:11 INFO - 'LANGUAGE': 'en_US:en', 11:44:11 INFO - 'LOGNAME': 'cltbld', 11:44:11 INFO - 'MAIL': '/var/mail/cltbld', 11:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:11 INFO - 'MOZ_NO_REMOTE': '1', 11:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:11 INFO - 'NO_EM_RESTART': '1', 11:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:11 INFO - 'PWD': '/builds/slave/test', 11:44:11 INFO - 'SHELL': '/bin/bash', 11:44:11 INFO - 'SHLVL': '1', 11:44:11 INFO - 'TERM': 'linux', 11:44:11 INFO - 'TMOUT': '86400', 11:44:11 INFO - 'USER': 'cltbld', 11:44:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:11 INFO - '_': '/tools/buildbot/bin/python'} 11:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:44:11 INFO - Cleaning up... 11:44:11 INFO - Return code: 0 11:44:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:11 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 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:44:11 INFO - Using env: {'DISPLAY': ':0', 11:44:11 INFO - 'HOME': '/home/cltbld', 11:44:11 INFO - 'LANG': 'en_US.UTF-8', 11:44:11 INFO - 'LANGUAGE': 'en_US:en', 11:44:11 INFO - 'LOGNAME': 'cltbld', 11:44:11 INFO - 'MAIL': '/var/mail/cltbld', 11:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:11 INFO - 'MOZ_NO_REMOTE': '1', 11:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:11 INFO - 'NO_EM_RESTART': '1', 11:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:11 INFO - 'PWD': '/builds/slave/test', 11:44:11 INFO - 'SHELL': '/bin/bash', 11:44:11 INFO - 'SHLVL': '1', 11:44:11 INFO - 'TERM': 'linux', 11:44:11 INFO - 'TMOUT': '86400', 11:44:11 INFO - 'USER': 'cltbld', 11:44:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:11 INFO - '_': '/tools/buildbot/bin/python'} 11:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:11 INFO - Downloading/unpacking jsonschema 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:13 INFO - Downloading/unpacking functools32 (from jsonschema) 11:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:13 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:14 INFO - warning: no files found matching '*.txt' 11:44:14 INFO - no previously-included directories found matching 'build' 11:44:14 INFO - no previously-included directories found matching 'dist' 11:44:14 INFO - no previously-included directories found matching '.git*' 11:44:14 INFO - Installing collected packages: jsonschema, functools32 11:44:14 INFO - Running setup.py install for functools32 11:44:14 INFO - warning: no files found matching '*.txt' 11:44:14 INFO - no previously-included directories found matching 'build' 11:44:14 INFO - no previously-included directories found matching 'dist' 11:44:14 INFO - no previously-included directories found matching '.git*' 11:44:14 INFO - Successfully installed jsonschema functools32 11:44:14 INFO - Cleaning up... 11:44:14 INFO - Return code: 0 11:44:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:14 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 0x7f5c7b0caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:44:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:44:14 INFO - Using env: {'DISPLAY': ':0', 11:44:14 INFO - 'HOME': '/home/cltbld', 11:44:14 INFO - 'LANG': 'en_US.UTF-8', 11:44:14 INFO - 'LANGUAGE': 'en_US:en', 11:44:14 INFO - 'LOGNAME': 'cltbld', 11:44:14 INFO - 'MAIL': '/var/mail/cltbld', 11:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:14 INFO - 'MOZ_NO_REMOTE': '1', 11:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:14 INFO - 'NO_EM_RESTART': '1', 11:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:14 INFO - 'PWD': '/builds/slave/test', 11:44:14 INFO - 'SHELL': '/bin/bash', 11:44:14 INFO - 'SHLVL': '1', 11:44:14 INFO - 'TERM': 'linux', 11:44:14 INFO - 'TMOUT': '86400', 11:44:14 INFO - 'USER': 'cltbld', 11:44:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:14 INFO - '_': '/tools/buildbot/bin/python'} 11:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:14 INFO - Downloading/unpacking flake8 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:44:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:44:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:17 INFO - no previously-included directories found matching 'docs/_build' 11:44:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:44:17 INFO - Running setup.py install for pep8 11:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:44:17 INFO - no previously-included directories found matching 'docs/_build' 11:44:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:44:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:44:17 INFO - Cleaning up... 11:44:17 INFO - Return code: 0 11:44:17 INFO - Running post-action listener: _resource_record_post_action 11:44:17 INFO - Running post-action listener: _start_resource_monitoring 11:44:17 INFO - Starting resource monitoring. 11:44:17 INFO - ##### 11:44:17 INFO - ##### Finished create-virtualenv step (success) 11:44:17 INFO - ##### 11:44:17 INFO - ##### 11:44:17 INFO - ##### Running install step. 11:44:17 INFO - ##### 11:44:17 INFO - Running pre-action listener: _resource_record_pre_action 11:44:17 INFO - Running main action method: install 11:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:17 INFO - Reading from file tmpfile_stdout 11:44:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:17 INFO - Reading from file tmpfile_stdout 11:44:17 INFO - Output received: 11:44:17 INFO - Usage: mozinstall [options] installer 11:44:17 INFO - Options: 11:44:17 INFO - -h, --help show this help message and exit 11:44:17 INFO - -d DEST, --destination=DEST 11:44:17 INFO - Directory to install application into. [default: 11:44:17 INFO - "/builds/slave/test"] 11:44:17 INFO - --app=APP Application being installed. [default: firefox] 11:44:17 INFO - mkdir: /builds/slave/test/build/application 11:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:44:34 INFO - Reading from file tmpfile_stdout 11:44:34 INFO - Output received: 11:44:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:44:34 INFO - Running post-action listener: _resource_record_post_action 11:44:34 INFO - ##### 11:44:34 INFO - ##### Finished install step (success) 11:44:34 INFO - ##### 11:44:34 INFO - ##### 11:44:34 INFO - ##### Running run-tests step. 11:44:34 INFO - ##### 11:44:34 INFO - Running pre-action listener: _resource_record_pre_action 11:44:34 INFO - Running main action method: run_tests 11:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:44:34 INFO - Python 2.7.3 11:44:34 INFO - Return code: 0 11:44:34 INFO - grabbing minidump binary from tooltool 11:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:34 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e699c0>, '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 0x1e6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:44:34 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:44:34 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/linux64/releng.manifest -o -c /builds/tooltool_cache 11:44:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:44:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:44:34 INFO - Return code: 0 11:44:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:44:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:44:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:44:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:44:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:44:35 INFO - Return code: 0 11:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:44:35 INFO - Using env: {'DISPLAY': ':0', 11:44:35 INFO - 'HOME': '/home/cltbld', 11:44:35 INFO - 'LANG': 'en_US.UTF-8', 11:44:35 INFO - 'LANGUAGE': 'en_US:en', 11:44:35 INFO - 'LOGNAME': 'cltbld', 11:44:35 INFO - 'MAIL': '/var/mail/cltbld', 11:44:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:35 INFO - 'MOZ_NO_REMOTE': '1', 11:44:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:35 INFO - 'NO_EM_RESTART': '1', 11:44:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:35 INFO - 'PWD': '/builds/slave/test', 11:44:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:35 INFO - 'SHELL': '/bin/bash', 11:44:35 INFO - 'SHLVL': '1', 11:44:35 INFO - 'TERM': 'linux', 11:44:35 INFO - 'TMOUT': '86400', 11:44:35 INFO - 'USER': 'cltbld', 11:44:35 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476', 11:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:35 INFO - '_': '/tools/buildbot/bin/python'} 11:44:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:44:35 INFO - mozversion application_buildid: 20160517085406 11:44:35 INFO - mozversion application_changeset: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 11:44:35 INFO - mozversion application_display_name: Nightly 11:44:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:44:35 INFO - mozversion application_name: Firefox 11:44:35 INFO - mozversion application_remotingname: firefox 11:44:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:44:35 INFO - mozversion application_vendor: Mozilla 11:44:35 INFO - mozversion application_version: 49.0a1 11:44:35 INFO - mozversion platform_buildid: 20160517085406 11:44:35 INFO - mozversion platform_changeset: 9f9aae87248d444ff93d1a213b6de0a6ee39fb26 11:44:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:44:35 INFO - mozversion platform_version: 49.0a1 11:44:35 INFO - using testdate: 1463510675 11:44:35 INFO - actual date: 1463510675 11:44:35 INFO - starting webserver on 'localhost:43778' 11:44:35 INFO - SUITE-START | Running 2 tests 11:44:35 INFO - TEST-START | dromaeo_css 11:44:35 INFO - operating with platform_type : linux_ 11:44:35 INFO - Initialising browser for dromaeo_css test... 11:44:35 INFO - TEST-INFO | started process 13187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqEhP1/profile http://localhost:43778/getInfo.html) 11:44:39 INFO - PROCESS | 13187 | __metrics Screen width/height:1600/1200 11:44:39 INFO - PROCESS | 13187 | colorDepth:24 11:44:39 INFO - PROCESS | 13187 | Browser inner width/height: 1024/697 11:44:39 INFO - PROCESS | 13187 | __metrics 11:44:40 ERROR - PROCESS | 13187 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:44:40 INFO - TEST-INFO | 13187: exit 0 11:44:40 INFO - Browser initialized. 11:44:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:44:40 INFO - TEST-INFO | started process 13271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYqEhP1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:52 INFO - PROCESS | 13271 | RSS: Main: 152563712 11:44:52 INFO - PROCESS | 13271 | 11:45:43 INFO - PROCESS | 13271 | 1463510743965 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:47:51 INFO - PROCESS | 13271 | Cycle 1(1): loaded http://localhost:43778/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43778/tests/dromaeo/cssquery-ext.html) 11:47:53 INFO - PROCESS | 13271 | RSS: Main: 287457280 11:47:53 INFO - PROCESS | 13271 | 11:50:55 INFO - PROCESS | 13271 | Cycle 1(1): loaded http://localhost:43778/tests/dromaeo/cssquery-ext.html (next: http://localhost:43778/tests/dromaeo/cssquery-jquery.html) 11:50:56 INFO - PROCESS | 13271 | RSS: Main: 236802048 11:50:56 INFO - PROCESS | 13271 | 11:53:58 INFO - PROCESS | 13271 | Cycle 1(1): loaded http://localhost:43778/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43778/tests/dromaeo/cssquery-mootools.html) 11:53:58 INFO - PROCESS | 13271 | RSS: Main: 245243904 11:53:58 INFO - PROCESS | 13271 | 11:57:00 INFO - PROCESS | 13271 | Cycle 1(1): loaded http://localhost:43778/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43778/tests/dromaeo/cssquery-prototype.html) 11:57:01 INFO - PROCESS | 13271 | RSS: Main: 233803776 11:57:01 INFO - PROCESS | 13271 | 12:00:04 INFO - PROCESS | 13271 | Cycle 1(1): loaded http://localhost:43778/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43778/tests/dromaeo/cssquery-yui.html) 12:00:04 INFO - PROCESS | 13271 | RSS: Main: 200302592 12:00:04 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | Cycle 1(1): loaded http://localhost:43778/tests/dromaeo/cssquery-yui.html (next: http://localhost:43778/tests/dromaeo/cssquery-dojo.html) 12:03:07 INFO - PROCESS | 13271 | RSS: Main: 273866752 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | __start_tp_report 12:03:07 INFO - PROCESS | 13271 | _x_x_mozilla_page_load 12:03:07 INFO - PROCESS | 13271 | _x_x_mozilla_page_load_details 12:03:07 INFO - PROCESS | 13271 | |i|pagename|runs| 12:03:07 INFO - PROCESS | 13271 | |0;dojo.html;3104.4722397192477;3126.2653276480023;3151.5115157150644;3159.5102759072324;3187.3465939482394;5271.499207575283;5304.946950530503;5313.840584782458;5396.3524377074755;5408.3509978802595;5377.085895397782;5395.757190926408;5405.648632838863;5446.591505637083;5473.2063850741615;4870.805167793284;4941.45643979162;4957.132501812186;4981.103401387749;5186.740662966856;5031.42138654054;5058.949410505903;5092.28707980883;5114.539691427771;5117.104506711329;4889.046635906;4914.11545921734;4925.162722337212;4970.229614409736;4990.176620857555;4926.605871530269;4937.679050861682;4946.455889852114;5001.799928002875;5051.419086805027;4937.136001199811;4952.801887924478;4955.529224723646;4977.178765503724;5023.372078490189;5185.688858668492;5349.465053494659;5354.571634269249;5390.0836857734275;5462.453754624546;5867.413258674141;5873.412658734135;5876.794312199096;5895.35151133375;5924;5699.2590963174525;5911.113333000041;5927.851803704899;5970.253718285215;5972.984592619222;5428;5479.178123281539;5511.559075274049;5562.972185139089;5563.693996830173;6005.549583781234;6076.5442591805795;6082.422169893853;6082.847928801727;6083.574149809471;5624.493795558419;5732.742026608813;5773.6824474654295;5783.942160578425;5786.363500014995;5816.360200377955;5895.380984996599;5946.226990491208;5947.910781338283;5958;5805.332386775491;5851.1515830205235;5857.970710146507;5862.589618726648;5863.970680146572;5643.858903527444;5825.03886858672;5871.911921321183;5878.647281163144;5900.793472228452;4358.869233922987;4374.518802931675;4395.978020109879;4404.7357158570585;4462.0183559616835;3930.3514920038447;3933;3943.3099207638547;3979.0450291930306;3979.6617287530885;5459.426760190202;5465.836024919259;5467.316585426822;5470.042742520043;5474.39781624021;5691.8292451226525;5792.391798861143;5859.560532959959;5883.852903677357;5887.20522729426;5514.338279406497;5523.475269849358;5530.5852061095575;5533.474319939599;5536.307961504812;4786.353842231254;4895.7062576244825;4897.853064408074;4898.21628539432;4947.60419166473;5972.283326000821;6018.909716354258;6028.246469191351;6069.666168360783;6078.513718902477;5881.441263080001;5887.941120588739;5888.646681199141;5889.734961926809;5896.734646940812;5889.94110058894;6007.81976540687;6010.098485227076;6063.333033366414;6068.666223357758;5788.623739456922;5846.6784326862435;5846.824595262149;5847.7368518417625;5895.115732640138;5900.055991041413;5916.083007133901;5923.378045305181;5930.644161350333;5952.166696662384;5553.72231388437;5676.943230567642;5685.0335442973965;5769.221155144001;5779.075347944308;5716.742746576498;5733.569982251264;5734.3692193857805;5744.655320680772;5782.710864456844;5648.5481161507805;5652.576056795675;5656.971715141398;5659.037963546125;5660.433956604471;5613.1860880171325;5703.344115426779;5722.513586345207;5739.971300143639;5780.768769249183;5479.095949168502;5523.944760552343;5599.216109744721;5608.85977850557;5628.324601047901 12:03:07 INFO - PROCESS | 13271 | |1;ext.html;575.9280089988752;617.9969100154499;632.8386261503316;641.942225199732;656.7143292667693;32258;44892.3266151008;44989.325160122586;45573.54426455743;45746.7712661437;42892.3566146508;46273.537264627346;46338.768306158425;46345.536544634626;46473.30290045644;7916.445848790587;8814;8869.201771840566;8951.060138685409;10293.794124117514;10141.44222067786;10241.795164096713;10499.42253176075;10547.947260263689;10578.100861426788;10598;10676.78646427071;10677.039066484014;10680.946595267053;10687.198460115484;10510.369377837316;10604.363738175656;10607.893921060768;10610.151187904949;10611.416372099531;10488.528016239288;10500.317479363817;10529.736756581071;10537.157027437786;10562.366258024544;42937;43280.56719432797;43374.78312608448;43389.56610433887;43418.56581434177;3455.6544345565494;3507.9298414031578;3509.4034014217646;3559.18138828071;3617.2946275476293;32557.18607034843;33002.339953200804;33103.50344744831;33194.170145746306;33494.83252583721;4252.893677658052;4274.358846173099;4287.571242875719;4324.675649326282;4328.5022222444195;319570;322558;323116;323196;323852;64396;64668.676656617354;64793.67603162048;64927.67536162289;64978.67510662511;66792.98673639295;66900;67474.66262668754;67551.66224168848;67618;15738.685226295638;16192.571114332708;16207.108609026616;16212;16213.675726485404;12482.687932801753;12535.686607834694;12536;12548;12554.435050422753;20097.497562560762;20560.691589626167;20628.381148565568;20733.481662958246;20739.792602073787;7500.812479687942;7573.734919277799;7640.044994375703;7758.262965018314;7766.5728384939375;880.9647614095364;946.4652471353663;989.9114761942784;1001.7095042437758;1015.6140666546665;28172.43655126927;29220.853895730386;29310.706892930797;29344;29432.705672942997;1020.4438580973388;1123.612353737959;1162.2793867802018;1179.6991767099507;1258.9604840159002;17065.317387304618;17414.216360263566;17427.128643567772;17434.564135896704;17561.56096097582;526094;527105;529749;531326;531672;60251;60762.39237607656;60866.69566652139;60909;61212;1242.5340497313507;1264.867188945166;1294.8769866862633;1353.0258214085843;1431.1127101197117;33120.337593248485;33858;34629.65370346365;34918.30163396667;35253.471197932566;51748;51754.48245517497;52327.47672523226;52365.21452178297;52408.47591524036;341154;342011;342350;343259;343765;38720.419193711554;46896.29655555101;47243;47546.52453475421;48267;48692.75653621709;49396.75301623469;50325.74837125791;50564;53996;42190;42224.78887605542;42277.5772242286;42717.57282427136;44147.77926110478;43022.35466468068;43213.56786432221;43328;43334.56665433305;43864.561354386045;35401.468977965866;36326.636733633386;36448.45327320039;36479;36494.8175259122;34805.47791783176;38071.619283807915;38500.614993849704;40656;41327.38008929808;28777.56833647539;29149.417011660073;29185;29199.7080029197;29414.55878161872 12:03:07 INFO - PROCESS | 13271 | |2;jquery.html;392.72705469698565;401.71478250442186;402.6356147686343;408.9550149483558;412.1653651356004;13218.870394707257;19127.904360478195;19612.509687257807;19699.60600787985;20860.374188774324;14426.278686065707;18929.242830286807;19015.714764278546;19806.603867922633;19892;5597.748101335439;5736.885262294752;5751.683657398841;5758.3090029196555;5777.248957635502;5653.321601407816;5735.713214339287;5740.655560666373;5741.770329186848;5742.971285143569;4158.688098392618;5795.4784069433745;6109.083637454373;6113.266408031042;6183.567150299458;6148;6148.231471066117;6160.1683772690785;6182.165407669952;6311.242650881878;5484.341878974548;5553.666779993173;5606.831795046155;5609.495145436889;5632.831015069554;23168.18911338112;23265.18571849977;23623.29130126099;23879.761202387926;23947.640785388234;2518.2571141513113;2564.781993530552;2597.6752905886765;2602.0762629266715;2629.2638061342664;13926.072934755644;14591.416343346253;14642.267886605627;15161.696766064617;15320;1911.3119277060248;1980.1881228696166;2002.779694233633;2066.5970135823522;2089.9968015352715;78314.21685783126;78978.21021789766;79196.20803791947;79653.60173199097;80379.5981020097;10366.688999330032;10809.243352965217;11059.889401106047;11072.833907491395;11115.277506962022;14650.926745366205;14873.479428220176;14877.851221487863;14881.702365952837;14900.105993640416;8097.352211823158;8140.837183256302;8173.509589424653;8289.792755181168;8369.3304535637;7783.416243781626;7908.090569584571;7995;7998.320142787812;8012.158723334082;6101.938980610226;6330.873382532415;6345.714442850082;6569.507286953498;6682.632455214913;1899.9715004274947;1981.3956743193464;1999.980030154448;2000.959980800376;2006.9197232110553;973.8490533967247;1075.3440401355167;1117.0058647803462;1133.484264659578;1148.3397046698183;18941.621167576846;19786.505337366394;19901.203951842053;19944.3019494317;20327.288544901152;1026.820306446369;1059.4490864750287;1079.5519859258477;1111.1388673777726;1155.6186458468853;11115.944420277847;11556.59551915679;11777.587784427504;11787.587434439753;11795.764084718257;470705;472556;477231;481726;484137;78442;79596;79772;79833.80249296149;80032.59983700044;1060.6022741471947;1067.5516283161091;1078.8813230544633;1085.685151306128;1090.6564432203832;17754.5561360967;17837.554061148057;17931.551711207325;18025.63948720992;18368;30158.246043849078;37137;38102.61897381102;39617.80191099026;39948;52082;52310.21534677059;53183.73408132935;53666.195007074144;54002;7723.227677232232;7829.491083079582;8708.433951793113;8772.21050105468;8962.462252264884;9621.18219951312;10584.89415105839;13478.393472293574;13623.863761362656;13895.305234738425;12074.577389791315;12077.758444830879;12213.328266945404;12248.938755306166;12569.811452828031;11209.047230985458;11503.597374091867;11782.764344713229;12036.217645852992;12134.179873019119;12070.637880863587;12274.693132671755;12419.565315213924;12624.926881214833;12746.10777245584;8215.507069575844;8224.465409748347;8342.83314333722;8348.499090054616;8676.869846952175;11329.830052549054;11679.591214307458;11774.705632359259;11868.82196767032;12046.819297710366 12:03:07 INFO - PROCESS | 13271 | |3;mootools.html;1337.6722702937782;1364.1678576068596;1464.5533112400717;1523.7181121492517;1835.109971663743;8400.075991640922;8654.26438752706;8686.609102590375;8893.91106088939;8924.509151996637;8606.784830379243;8808.603612837422;8812.295016398688;8812.91187088129;8839.425437346585;2104.3476522278143;2145.1205005947604;2160.114353115223;2162.059504115715;2173.239366221818;2349.6240601503764;2391.8325717199805;2393.3298676370555;2407.217654262363;2411.517696460715;2149.795769401904;2198.912043518257;2254.875981820999;2270.500489892221;2271.2164303315412;2099.3806826985924;2302.6200676888293;2368.336865677613;2403.3150552092743;2403.6995375578053;2383.213539531968;2414.155045733979;2414.2153800015067;2416.299273210767;2420.4674971506242;8932.285417166611;8986;8987.595558199897;8996.100389961017;9000.054994225577;5053.570446512051;5162.070827251093;5172.379314482248;5179.974100129475;5181.974090129563;3252.674732526752;3281.5569898063695;3422.9022734425384;3455.067131874405;3461.152017755641;1059.1473863539848;1085.4626959654943;1090.4711215060688;1091.7052395853075;1096.6984079378155;13081.476740930351;13127.737445251138;13141.605751827365;13157.473701051946;13195.73608527824;4615.815367385267;4763.904721905612;4782.426108866889;4817.614590832725;4820.68665536739;10795.352278863293;10836.512356943957;10861.619843305447;10863.076638485818;10893.183011274186;5404.108322126805;5407.891842163135;5414.40441551429;5422.8373148805595;5423.2136340230445;4251.553586873396;4781.42622885256;4814.759262036954;4909.2881532177635;5006.674566153189;4112.3420252759415;4220.599043090901;4228.217779710763;4244.278472659656;4283.507396649363;1316.8419789625307;1353.7563238616947;1365.8838998685223;1367.2958426410407;1369.6918193406404;857.4340934983006;963.7831487915163;1026.5431882812077;1037.5849660135855;1044.4203467075695;5884.941150588525;6179.721912513947;6248.5313601480075;6264.780732674426;6280.654563999024;421.83337581655076;438.49353996134516;439.69660933956106;456.04913754820905;458.67892475267445;4277.786110694453;4295.74225546462;4318;4342.131573685276;4352.912941741148;11094.944525277322;11278.830817537744;11338.716532086599;11381.772364552828;11441.313521188755;11017.228793984505;11182.217244792786;11202.887971120348;11257.774844503065;11315.094792416752;7941.404394670307;8192.34461243099;8281.54451505173;8326.45878017927;8512.276456501142;6233.2208473940755;6331.05034244867;6388.39310265524;6442.677866106769;6502.902456463252;10123.392596444237;10425.687229383131;10549.630762923261;10588.417637030037;10639.095676867553;10654.254202205771;10850.240483166419;10870.945645271722;10983.560657573607;11026.338419694845;7220.169680486812;7337.192908780136;7338.412926965723;8002.679892804223;8171.7548473545885;8055.113937466991;8582.141785821617;8888.955555222183;8901.910980890367;9028.548572571213;7821.882671760042;7838.294553490213;7855.7250496232355;7935.920640793749;8090.393220508367;7553.584552849646;7721.729739459317;7759.2240775921955;7815.140334563307;7957.363410926996;7094.680739366844;7123.679434425359;7239.167495738057;7273.781786546412;7305.050343455317;5186.481351864783;5296.761645725875;5307.6284660073425;5377.300950876361;5398.40617532079;5383.08487557124;5434.157705555645;5536.750846211849;5542;5578.972105139448 12:03:07 INFO - PROCESS | 13271 | |4;prototype.html;298.97010298970105;308.2663261437778;313.77721817509575;316.3404302030267;316.7291965369607;5358.2498450217;5373.785048598061;5388.380336261331;5444.156155795853;5458.645188062778;5330.534103121643;5352.732363381825;5362.8123015694455;5365.773204120295;5385.488378604036;4127.607877251657;4189.350650649139;4216.241076606209;4244;4251.787410629456;4108.506979162505;4171.228322760284;4173.853915112972;4205.85279515217;4207.453031105967;4089.672826173914;4120.278951183546;4141.730787498818;4174.582541745832;4185.012119243365;3862.9613703863165;3994.6804255659476;4139.317012692902;4168.478505345557;4178.707490475668;3613.277344531078;3628.1836586767768;3635.745497815154;3639.581448133472;3643.8178091095338;5115.795368185268;5134.5378915897745;5170.250313704491;5179.015986962465;5209.869753256161;4440.7335559866515;4519.570640789119;4706.317583950342;4744.715317080986;4744.810207591692;5520.972395138038;5598.608097433182;5606.35526914406;5611.260509242107;5619.6347237429845;3987.601239876018;4009.218202450523;4016.558178600381;4017.4576432181866;4018.3771515415156;5742.569307301927;5807.867465844162;5810.5932584719085;5812.941870581282;5834.5915785895;4070.5929407059057;4115.97942010288;4118.9588104119175;4134.421181034658;4138.317177665712;4163.146554956226;4183.728057676241;4184.8744537663915;4185.748855068706;4203.432536607519;4652.674312798139;4785.880352991203;4786.353842231324;4800.759962001886;4809.470958194595;5637.928793529216;5678.346990096192;5692.971535142381;5715.199872017921;5717.3996730342715;1414.7736362182002;1437.9209143496998;1438.7769895666188;1441.942322307117;1443;879.5916957066833;906.4833045164324;909.9353756105372;919.2829592917535;919.691903212418;4798.328234047236;4823.807047718122;4839.661223714376;4860.9513904861205;4892.706437613754;5124;5130.383929062334;5135.4094279157625;5153.819616313486;5164.328637277205;4505.400582793127;4867.5132486751045;4894.2658601210105;4939.975300123477;4945.67853089548;2765.3777899972347;2985.1641540368732;3031.8170916939766;3056.1595561220397;3083.9691603083684;5950.285965684059;5964.433378829004;5978.910316345258;5990.041593345044;5995.730192141364;5675.31896172462;5855.2973643163095;5874.676892770939;5919.881602367928;5929.229200203946;6021.6989150542295;6076.817695469054;6088.939110608837;6088.969555152285;6096.104350433508;5809.419058094157;5818;5833.270841144857;5839.328477225004;5851.327097383685;5550.5282051026115;5784.045632470596;5825.271841019872;5844.94155058444;5853.78527460228;6037.275526936795;6038.154658347747;6044.123602077586;6085.695715214133;6090.421409966046;3789.1853251551047;3999.8400063997115;4036.1524079943542;4042.69679774024;4070.4097905804083;5713.857153571194;5793.768249269982;5831.35855055952;5833.3958161505925;5880.117982302689;5643.492085712305;5667.951428985651;5699.202111704281;5740.13897915316;5764.625299355528;5465.590080744039;5631.662100273997;5675.432456754292;5678.375378708256;5706.229658995982;5563.248961390161;5572.192032155233;5584.636998595079;5588.842304098172;5594.944050559442;5445.83662490126;5692.829215123553;5700.657960522382;5743.10981797822;5757.424257574209;5525.530329922001;5532.114861622121;5533.889322213453;5551;5554.777808887599 12:03:07 INFO - PROCESS | 13271 | |5;yui.html;722.6567380494263;758.764782917296;777.2072486064213;789.1674283630767;789.5617932047714;14317.069390489636;14320.928395358022;14450.205238711867;14487.058341207841;14653.120812751242;12966.286854223014;12976.870231297708;12983.935080324609;13053;13073.150245234054;693.7918624412681;830.3938125168601;838.304207507767;860.0410542245414;861.6854847980474;846.5809424334932;850.5067061104576;851.595492141231;851.6082602003055;851.9020312664061;895.4850960697624;895.7760559860035;896.7713233125544;897.2642433204775;897.3897749530316;729.7810656802965;872.31959071924;884.3632584539122;887.7558671365362;892.6741739265186;649.5096202367182;652.1261509577189;652.1489456259579;652.3802387731674;652.781318258384;13568.1859088455;13573.524926627619;13574.59276221715;13584.117032392864;13672.31638418075;13625.931870340684;13794.65513362164;13919.860801392058;13957.092788968685;13979.720405591832;12533.310667913262;12541.372931353488;12713.491460341575;12754.170978886343;13112.803307950388;4423.380726698265;4459.977700111511;4462.419885414908;4465.732056076613;4481.775911204427;57079.42920570783;57978.13032804511;60257.397426025615;60394.79210415811;60501.09248361278;10553.366797992145;10677.89322106769;10821.106306396348;10889.673309800719;10978.286411383235;17164.39924602658;18267.360642377454;18328.266869325344;18386.44840654756;18607.813921860878;8074.3540516759695;8102.635381407733;8198.672053117809;8231.382646301432;8455.196756308142;4662.976685116552;4773.71357718538;4781.713097214179;4784.162771514971;4807.302941073524;3302.1414432247307;3379.4254976653538;3388.6611338865914;3389.389909816257;3402.914927126792;584.0305093544696;624.4224092714221;626.6396821827376;630.5838146823074;658.2232965101131;678.5284227461965;710.4884483172108;718.3857801579678;778.3889646627371;790.7983464216588;9963.103320701171;10424.530896109542;10475.47622618866;10484.266101372983;10546.736331591617;701.8034950213948;704.5451143388885;708.8724029674709;723.706898706025;760.8630446519569;4935.629827762932;4998.9500104999215;5011.949880501221;5028.120078986163;5074.847754567369;77269.61365193251;77776.22223777803;78699.60650196712;78923;78953.60523197347;69086.65456672786;69437.65281173562;69527.65236173887;70162;71826.281737183;61639.38360616336;61857.072143917874;61916.380836191965;61923.071153932724;62648.373516265165;9283.936301020782;9516.24029031573;9524.238060955246;9544.522773861141;9582.089701478348;39789.2042159161;40262.1947561053;40269.39595906122;40398.39402408907;42719.786401067795;53799.73100134474;54434.18348724693;54616.726916365165;55463;55996.72001639966;12789.424475898793;12928.482860685468;13154.276514791778;13246.337683115613;13679.110857794212;13352.866471335163;13705.725885482036;13820.930895345458;13871.653208669864;14863.272158229729;12295;12657.050721196132;13550.525731599346;13726.794098088338;14267.857321427067;13016.609501714964;13038;13484.393202306115;14070.296485175495;14078.859211407755;12655.177413468464;12966.222026678051;13349.466021359036;13425.664358390728;13435.664108397368;10467.267291289536;10660.946695266784;10877.238593298393;11143.665690029313;11153.553857845594;10239.7440063999;11283.401211880271;11475.540978360772;11488.712782180512;11686.123540734648 12:03:07 INFO - PROCESS | 13271 | __end_tp_report 12:03:07 INFO - PROCESS | 13271 | __start_cc_report 12:03:07 INFO - PROCESS | 13271 | _x_x_mozilla_cycle_collect,1120 12:03:07 INFO - PROCESS | 13271 | __end_cc_report 12:03:07 INFO - PROCESS | 13271 | __startTimestamp1463511787736__endTimestamp 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | ------- Summary: start ------- 12:03:07 INFO - PROCESS | 13271 | Number of tests: 6 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | [#0] dojo.html Cycles:165 Average:5424.64 Median:5628.32 stddev:633.11 (11.2%) stddev-sans-first:608.32 12:03:07 INFO - PROCESS | 13271 | Values: 3104.5 3126.3 3151.5 3159.5 3187.3 5271.5 5304.9 5313.8 5396.4 5408.4 5377.1 5395.8 5405.6 5446.6 5473.2 4870.8 4941.5 4957.1 4981.1 5186.7 5031.4 5058.9 5092.3 5114.5 5117.1 4889.0 4914.1 4925.2 4970.2 4990.2 4926.6 4937.7 4946.5 5001.8 5051.4 4937.1 4952.8 4955.5 4977.2 5023.4 5185.7 5349.5 5354.6 5390.1 5462.5 5867.4 5873.4 5876.8 5895.4 5924.0 5699.3 5911.1 5927.9 5970.3 5973.0 5428.0 5479.2 5511.6 5563.0 5563.7 6005.5 6076.5 6082.4 6082.8 6083.6 5624.5 5732.7 5773.7 5783.9 5786.4 5816.4 5895.4 5946.2 5947.9 5958.0 5805.3 5851.2 5858.0 5862.6 5864.0 5643.9 5825.0 5871.9 5878.6 5900.8 4358.9 4374.5 4396.0 4404.7 4462.0 3930.4 3933.0 3943.3 3979.0 3979.7 5459.4 5465.8 5467.3 5470.0 5474.4 5691.8 5792.4 5859.6 5883.9 5887.2 5514.3 5523.5 5530.6 5533.5 5536.3 4786.4 4895.7 4897.9 4898.2 4947.6 5972.3 6018.9 6028.2 6069.7 6078.5 5881.4 5887.9 5888.6 5889.7 5896.7 5889.9 6007.8 6010.1 6063.3 6068.7 5788.6 5846.7 5846.8 5847.7 5895.1 5900.1 5916.1 5923.4 5930.6 5952.2 5553.7 5676.9 5685.0 5769.2 5779.1 5716.7 5733.6 5734.4 5744.7 5782.7 5648.5 5652.6 5657.0 5659.0 5660.4 5613.2 5703.3 5722.5 5740.0 5780.8 5479.1 5523.9 5599.2 5608.9 5628.3 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | [#1] ext.html Cycles:180 Average:58081.97 Median:19971.97 stddev:108023.47 (540.9%) stddev-sans-first:108240.22 12:03:07 INFO - PROCESS | 13271 | Values: 575.9 618.0 632.8 641.9 656.7 32258.0 44892.3 44989.3 45573.5 45746.8 42892.4 46273.5 46338.8 46345.5 46473.3 7916.4 8814.0 8869.2 8951.1 10293.8 10141.4 10241.8 10499.4 10547.9 10578.1 10598.0 10676.8 10677.0 10680.9 10687.2 10510.4 10604.4 10607.9 10610.2 10611.4 10488.5 10500.3 10529.7 10537.2 10562.4 42937.0 43280.6 43374.8 43389.6 43418.6 3455.7 3507.9 3509.4 3559.2 3617.3 32557.2 33002.3 33103.5 33194.2 33494.8 4252.9 4274.4 4287.6 4324.7 4328.5 319570.0 322558.0 323116.0 323196.0 323852.0 64396.0 64668.7 64793.7 64927.7 64978.7 66793.0 66900.0 67474.7 67551.7 67618.0 15738.7 16192.6 16207.1 16212.0 16213.7 12482.7 12535.7 12536.0 12548.0 12554.4 20097.5 20560.7 20628.4 20733.5 20739.8 7500.8 7573.7 7640.0 7758.3 7766.6 881.0 946.5 989.9 1001.7 1015.6 28172.4 29220.9 29310.7 29344.0 29432.7 1020.4 1123.6 1162.3 1179.7 1259.0 17065.3 17414.2 17427.1 17434.6 17561.6 526094.0 527105.0 529749.0 531326.0 531672.0 60251.0 60762.4 60866.7 60909.0 61212.0 1242.5 1264.9 1294.9 1353.0 1431.1 33120.3 33858.0 34629.7 34918.3 35253.5 51748.0 51754.5 52327.5 52365.2 52408.5 341154.0 342011.0 342350.0 343259.0 343765.0 38720.4 46896.3 47243.0 47546.5 48267.0 48692.8 49396.8 50325.7 50564.0 53996.0 42190.0 42224.8 42277.6 42717.6 44147.8 43022.4 43213.6 43328.0 43334.6 43864.6 35401.5 36326.6 36448.5 36479.0 36494.8 34805.5 38071.6 38500.6 40656.0 41327.4 28777.6 29149.4 29185.0 29199.7 29414.6 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | [#2] jquery.html Cycles:180 Average:28202.20 Median:23751.53 stddev:78370.00 (330.0%) stddev-sans-first:78562.03 12:03:07 INFO - PROCESS | 13271 | Values: 392.7 401.7 402.6 409.0 412.2 13218.9 19127.9 19612.5 19699.6 20860.4 14426.3 18929.2 19015.7 19806.6 19892.0 5597.7 5736.9 5751.7 5758.3 5777.2 5653.3 5735.7 5740.7 5741.8 5743.0 4158.7 5795.5 6109.1 6113.3 6183.6 6148.0 6148.2 6160.2 6182.2 6311.2 5484.3 5553.7 5606.8 5609.5 5632.8 23168.2 23265.2 23623.3 23879.8 23947.6 2518.3 2564.8 2597.7 2602.1 2629.3 13926.1 14591.4 14642.3 15161.7 15320.0 1911.3 1980.2 2002.8 2066.6 2090.0 78314.2 78978.2 79196.2 79653.6 80379.6 10366.7 10809.2 11059.9 11072.8 11115.3 14650.9 14873.5 14877.9 14881.7 14900.1 8097.4 8140.8 8173.5 8289.8 8369.3 7783.4 7908.1 7995.0 7998.3 8012.2 6101.9 6330.9 6345.7 6569.5 6682.6 1900.0 1981.4 2000.0 2001.0 2006.9 973.8 1075.3 1117.0 1133.5 1148.3 18941.6 19786.5 19901.2 19944.3 20327.3 1026.8 1059.4 1079.6 1111.1 1155.6 11115.9 11556.6 11777.6 11787.6 11795.8 470705.0 472556.0 477231.0 481726.0 484137.0 78442.0 79596.0 79772.0 79833.8 80032.6 1060.6 1067.6 1078.9 1085.7 1090.7 17754.6 17837.6 17931.6 18025.6 18368.0 30158.2 37137.0 38102.6 39617.8 39948.0 52082.0 52310.2 53183.7 53666.2 54002.0 7723.2 7829.5 8708.4 8772.2 8962.5 9621.2 10584.9 13478.4 13623.9 13895.3 12074.6 12077.8 12213.3 12248.9 12569.8 11209.0 11503.6 11782.8 12036.2 12134.2 12070.6 12274.7 12419.6 12624.9 12746.1 8215.5 8224.5 8342.8 8348.5 8676.9 11329.8 11679.6 11774.7 11868.8 12046.8 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | [#3] mootools.html Cycles:180 Average:5943.08 Median:439.10 stddev:3463.51 (788.8%) stddev-sans-first:3455.93 12:03:07 INFO - PROCESS | 13271 | Values: 1337.7 1364.2 1464.6 1523.7 1835.1 8400.1 8654.3 8686.6 8893.9 8924.5 8606.8 8808.6 8812.3 8812.9 8839.4 2104.3 2145.1 2160.1 2162.1 2173.2 2349.6 2391.8 2393.3 2407.2 2411.5 2149.8 2198.9 2254.9 2270.5 2271.2 2099.4 2302.6 2368.3 2403.3 2403.7 2383.2 2414.2 2414.2 2416.3 2420.5 8932.3 8986.0 8987.6 8996.1 9000.1 5053.6 5162.1 5172.4 5180.0 5182.0 3252.7 3281.6 3422.9 3455.1 3461.2 1059.1 1085.5 1090.5 1091.7 1096.7 13081.5 13127.7 13141.6 13157.5 13195.7 4615.8 4763.9 4782.4 4817.6 4820.7 10795.4 10836.5 10861.6 10863.1 10893.2 5404.1 5407.9 5414.4 5422.8 5423.2 4251.6 4781.4 4814.8 4909.3 5006.7 4112.3 4220.6 4228.2 4244.3 4283.5 1316.8 1353.8 1365.9 1367.3 1369.7 857.4 963.8 1026.5 1037.6 1044.4 5884.9 6179.7 6248.5 6264.8 6280.7 421.8 438.5 439.7 456.0 458.7 4277.8 4295.7 4318.0 4342.1 4352.9 11094.9 11278.8 11338.7 11381.8 11441.3 11017.2 11182.2 11202.9 11257.8 11315.1 7941.4 8192.3 8281.5 8326.5 8512.3 6233.2 6331.1 6388.4 6442.7 6502.9 10123.4 10425.7 10549.6 10588.4 10639.1 10654.3 10850.2 10870.9 10983.6 11026.3 7220.2 7337.2 7338.4 8002.7 8171.8 8055.1 8582.1 8889.0 8901.9 9028.5 7821.9 7838.3 7855.7 7935.9 8090.4 7553.6 7721.7 7759.2 7815.1 7957.4 7094.7 7123.7 7239.2 7273.8 7305.1 5186.5 5296.8 5307.6 5377.3 5398.4 5383.1 5434.2 5536.8 5542.0 5579.0 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | [#4] prototype.html Cycles:180 Average:4690.94 Median:5341.63 stddev:1402.02 (26.2%) stddev-sans-first:1366.65 12:03:07 INFO - PROCESS | 13271 | Values: 299.0 308.3 313.8 316.3 316.7 5358.2 5373.8 5388.4 5444.2 5458.6 5330.5 5352.7 5362.8 5365.8 5385.5 4127.6 4189.4 4216.2 4244.0 4251.8 4108.5 4171.2 4173.9 4205.9 4207.5 4089.7 4120.3 4141.7 4174.6 4185.0 3863.0 3994.7 4139.3 4168.5 4178.7 3613.3 3628.2 3635.7 3639.6 3643.8 5115.8 5134.5 5170.3 5179.0 5209.9 4440.7 4519.6 4706.3 4744.7 4744.8 5521.0 5598.6 5606.4 5611.3 5619.6 3987.6 4009.2 4016.6 4017.5 4018.4 5742.6 5807.9 5810.6 5812.9 5834.6 4070.6 4116.0 4119.0 4134.4 4138.3 4163.1 4183.7 4184.9 4185.7 4203.4 4652.7 4785.9 4786.4 4800.8 4809.5 5637.9 5678.3 5693.0 5715.2 5717.4 1414.8 1437.9 1438.8 1441.9 1443.0 879.6 906.5 909.9 919.3 919.7 4798.3 4823.8 4839.7 4861.0 4892.7 5124.0 5130.4 5135.4 5153.8 5164.3 4505.4 4867.5 4894.3 4940.0 4945.7 2765.4 2985.2 3031.8 3056.2 3084.0 5950.3 5964.4 5978.9 5990.0 5995.7 5675.3 5855.3 5874.7 5919.9 5929.2 6021.7 6076.8 6088.9 6089.0 6096.1 5809.4 5818.0 5833.3 5839.3 5851.3 5550.5 5784.0 5825.3 5844.9 5853.8 6037.3 6038.2 6044.1 6085.7 6090.4 3789.2 3999.8 4036.2 4042.7 4070.4 5713.9 5793.8 5831.4 5833.4 5880.1 5643.5 5668.0 5699.2 5740.1 5764.6 5465.6 5631.7 5675.4 5678.4 5706.2 5563.2 5572.2 5584.6 5588.8 5594.9 5445.8 5692.8 5700.7 5743.1 5757.4 5525.5 5532.1 5533.9 5551.0 5554.8 12:03:07 INFO - PROCESS | 13271 | 12:03:07 INFO - PROCESS | 13271 | [#5] yui.html Cycles:180 Average:16763.22 Median:4777.71 stddev:21009.67 (439.7%) stddev-sans-first:21034.08 12:03:07 INFO - PROCESS | 13271 | Values: 722.7 758.8 777.2 789.2 789.6 14317.1 14320.9 14450.2 14487.1 14653.1 12966.3 12976.9 12983.9 13053.0 13073.2 693.8 830.4 838.3 860.0 861.7 846.6 850.5 851.6 851.6 851.9 895.5 895.8 896.8 897.3 897.4 729.8 872.3 884.4 887.8 892.7 649.5 652.1 652.1 652.4 652.8 13568.2 13573.5 13574.6 13584.1 13672.3 13625.9 13794.7 13919.9 13957.1 13979.7 12533.3 12541.4 12713.5 12754.2 13112.8 4423.4 4460.0 4462.4 4465.7 4481.8 57079.4 57978.1 60257.4 60394.8 60501.1 10553.4 10677.9 10821.1 10889.7 10978.3 17164.4 18267.4 18328.3 18386.4 18607.8 8074.4 8102.6 8198.7 8231.4 8455.2 4663.0 4773.7 4781.7 4784.2 4807.3 3302.1 3379.4 3388.7 3389.4 3402.9 584.0 624.4 626.6 630.6 658.2 678.5 710.5 718.4 778.4 790.8 9963.1 10424.5 10475.5 10484.3 10546.7 701.8 704.5 708.9 723.7 760.9 4935.6 4999.0 5011.9 5028.1 5074.8 77269.6 77776.2 78699.6 78923.0 78953.6 69086.7 69437.7 69527.7 70162.0 71826.3 61639.4 61857.1 61916.4 61923.1 62648.4 9283.9 9516.2 9524.2 9544.5 9582.1 39789.2 40262.2 40269.4 40398.4 42719.8 53799.7 54434.2 54616.7 55463.0 55996.7 12789.4 12928.5 13154.3 13246.3 13679.1 13352.9 13705.7 13820.9 13871.7 14863.3 12295.0 12657.1 13550.5 13726.8 14267.9 13016.6 13038.0 13484.4 14070.3 14078.9 12655.2 12966.2 13349.5 13425.7 13435.7 10467.3 10660.9 10877.2 11143.7 11153.6 10239.7 11283.4 11475.5 11488.7 11686.1 12:03:07 INFO - PROCESS | 13271 | -------- Summary: end -------- 12:03:07 INFO - PROCESS | 13271 | 12:03:08 INFO - TEST-INFO | 13271: exit 0 12:03:08 INFO - TEST-OK | dromaeo_css | took 1112907ms 12:03:08 INFO - TEST-START | kraken 12:03:08 INFO - operating with platform_type : linux_ 12:03:08 INFO - Initialising browser for kraken test... 12:03:08 INFO - TEST-INFO | started process 13449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf89hXo/profile http://localhost:43778/getInfo.html) 12:03:12 INFO - PROCESS | 13449 | __metrics Screen width/height:1600/1200 12:03:12 INFO - PROCESS | 13449 | colorDepth:24 12:03:12 INFO - PROCESS | 13449 | Browser inner width/height: 1024/697 12:03:12 INFO - PROCESS | 13449 | __metrics 12:03:12 ERROR - PROCESS | 13449 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:03:13 INFO - TEST-INFO | 13449: exit 0 12:03:13 INFO - Browser initialized. 12:03:13 INFO - Running cycle 1/1 for kraken test... 12:03:13 INFO - TEST-INFO | started process 13531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf89hXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:25 INFO - PROCESS | 13531 | RSS: Main: 152858624 12:03:25 INFO - PROCESS | 13531 | 12:03:28 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43778/tests/kraken/driver.html?testName=audio-beat-detection) 12:03:28 INFO - PROCESS | 13531 | RSS: Main: 208531456 12:03:28 INFO - PROCESS | 13531 | 12:03:31 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43778/tests/kraken/driver.html?testName=audio-dft) 12:03:32 INFO - PROCESS | 13531 | RSS: Main: 197672960 12:03:32 INFO - PROCESS | 13531 | 12:03:35 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43778/tests/kraken/driver.html?testName=audio-fft) 12:03:36 INFO - PROCESS | 13531 | RSS: Main: 264871936 12:03:36 INFO - PROCESS | 13531 | 12:03:38 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43778/tests/kraken/driver.html?testName=audio-oscillator) 12:03:38 INFO - PROCESS | 13531 | RSS: Main: 174297088 12:03:38 INFO - PROCESS | 13531 | 12:03:41 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43778/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:03:41 INFO - PROCESS | 13531 | RSS: Main: 178786304 12:03:41 INFO - PROCESS | 13531 | 12:03:44 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43778/tests/kraken/driver.html?testName=imaging-darkroom) 12:03:45 INFO - PROCESS | 13531 | RSS: Main: 214757376 12:03:45 INFO - PROCESS | 13531 | 12:03:48 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43778/tests/kraken/driver.html?testName=imaging-desaturate) 12:03:49 INFO - PROCESS | 13531 | RSS: Main: 215498752 12:03:49 INFO - PROCESS | 13531 | 12:03:52 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43778/tests/kraken/driver.html?testName=json-parse-financial) 12:03:53 INFO - PROCESS | 13531 | RSS: Main: 215232512 12:03:53 INFO - PROCESS | 13531 | 12:03:54 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43778/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:03:55 INFO - PROCESS | 13531 | RSS: Main: 201887744 12:03:55 INFO - PROCESS | 13531 | 12:03:57 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:03:57 INFO - PROCESS | 13531 | RSS: Main: 206553088 12:03:57 INFO - PROCESS | 13531 | 12:03:59 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:00 INFO - PROCESS | 13531 | RSS: Main: 215629824 12:04:00 INFO - PROCESS | 13531 | 12:04:03 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:03 INFO - PROCESS | 13531 | RSS: Main: 223600640 12:04:03 INFO - PROCESS | 13531 | 12:04:06 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:07 INFO - PROCESS | 13531 | RSS: Main: 220446720 12:04:07 INFO - PROCESS | 13531 | 12:04:08 INFO - PROCESS | 13531 | Cycle 1(1): loaded http://localhost:43778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43778/tests/kraken/driver.html?testName=ai-astar) 12:04:09 INFO - PROCESS | 13531 | RSS: Main: 265822208 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | __start_tp_report 12:04:09 INFO - PROCESS | 13531 | _x_x_mozilla_page_load 12:04:09 INFO - PROCESS | 13531 | _x_x_mozilla_page_load_details 12:04:09 INFO - PROCESS | 13531 | |i|pagename|runs| 12:04:09 INFO - PROCESS | 13531 | |0;ai-astar;111;105;109;108;110;110;112;110;110;109 12:04:09 INFO - PROCESS | 13531 | |1;audio-beat-detection;155;123;156;212;124;151;152;126;184;125 12:04:09 INFO - PROCESS | 13531 | |2;audio-dft;165;161;161;159;159;161;163;161;162;160 12:04:09 INFO - PROCESS | 13531 | |3;audio-fft;75;74;77;149;75;75;75;75;130;74 12:04:09 INFO - PROCESS | 13531 | |4;audio-oscillator;92;92;145;94;92;91;140;91;90;127 12:04:09 INFO - PROCESS | 13531 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;116 12:04:09 INFO - PROCESS | 13531 | |6;imaging-darkroom;145;146;146;145;144;145;145;145;145;146 12:04:09 INFO - PROCESS | 13531 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;94 12:04:09 INFO - PROCESS | 13531 | |8;json-parse-financial;55;55;55;55;56;55;56;113;53;55 12:04:09 INFO - PROCESS | 13531 | |9;json-stringify-tinderbox;59;59;58;58;59;58;58;58;59;61 12:04:09 INFO - PROCESS | 13531 | |10;stanford-crypto-aes;78;78;78;78;81;79;84;81;79;79 12:04:09 INFO - PROCESS | 13531 | |11;stanford-crypto-ccm;129;126;123;117;117;120;126;139;202;128 12:04:09 INFO - PROCESS | 13531 | |12;stanford-crypto-pbkdf2;162;158;159;161;160;157;161;164;170;163 12:04:09 INFO - PROCESS | 13531 | |13;stanford-crypto-sha256-iterative;62;62;65;62;64;61;61;66;61;61 12:04:09 INFO - PROCESS | 13531 | __end_tp_report 12:04:09 INFO - PROCESS | 13531 | __start_cc_report 12:04:09 INFO - PROCESS | 13531 | _x_x_mozilla_cycle_collect,1864 12:04:09 INFO - PROCESS | 13531 | __end_cc_report 12:04:09 INFO - PROCESS | 13531 | __startTimestamp1463511849161__endTimestamp 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | ------- Summary: start ------- 12:04:09 INFO - PROCESS | 13531 | Number of tests: 14 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.90 (1.7%) stddev-sans-first:1.92 12:04:09 INFO - PROCESS | 13531 | Values: 111.0 105.0 109.0 108.0 110.0 110.0 112.0 110.0 110.0 109.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:153.50 stddev:29.18 (19.0%) stddev-sans-first:30.92 12:04:09 INFO - PROCESS | 13531 | Values: 155.0 123.0 156.0 212.0 124.0 151.0 152.0 126.0 184.0 125.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.81 (1.1%) stddev-sans-first:1.30 12:04:09 INFO - PROCESS | 13531 | Values: 165.0 161.0 161.0 159.0 159.0 161.0 163.0 161.0 162.0 160.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#3] audio-fft Cycles:10 Average:87.90 Median:75.00 stddev:27.57 (36.8%) stddev-sans-first:28.85 12:04:09 INFO - PROCESS | 13531 | Values: 75.0 74.0 77.0 149.0 75.0 75.0 75.0 75.0 130.0 74.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:91.50 stddev:22.49 (24.6%) stddev-sans-first:23.33 12:04:09 INFO - PROCESS | 13531 | Values: 92.0 92.0 145.0 94.0 92.0 91.0 140.0 91.0 90.0 127.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:04:09 INFO - PROCESS | 13531 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 12:04:09 INFO - PROCESS | 13531 | Values: 145.0 146.0 146.0 145.0 144.0 145.0 145.0 145.0 145.0 146.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:04:09 INFO - PROCESS | 13531 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:55.00 stddev:18.36 (33.4%) stddev-sans-first:19.35 12:04:09 INFO - PROCESS | 13531 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 56.0 113.0 53.0 55.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.95 (1.6%) stddev-sans-first:1.00 12:04:09 INFO - PROCESS | 13531 | Values: 59.0 59.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 61.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:1.96 (2.5%) stddev-sans-first:2.00 12:04:09 INFO - PROCESS | 13531 | Values: 78.0 78.0 78.0 78.0 81.0 79.0 84.0 81.0 79.0 79.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:127.00 stddev:25.20 (19.8%) stddev-sans-first:26.69 12:04:09 INFO - PROCESS | 13531 | Values: 129.0 126.0 123.0 117.0 117.0 120.0 126.0 139.0 202.0 128.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.50 stddev:3.69 (2.3%) stddev-sans-first:3.91 12:04:09 INFO - PROCESS | 13531 | Values: 162.0 158.0 159.0 161.0 160.0 157.0 161.0 164.0 170.0 163.0 12:04:09 INFO - PROCESS | 13531 | 12:04:09 INFO - PROCESS | 13531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.00 stddev:1.84 (3.0%) stddev-sans-first:1.94 12:04:09 INFO - PROCESS | 13531 | Values: 62.0 62.0 65.0 62.0 64.0 61.0 61.0 66.0 61.0 61.0 12:04:09 INFO - PROCESS | 13531 | -------- Summary: end -------- 12:04:09 INFO - PROCESS | 13531 | 12:04:10 INFO - TEST-INFO | 13531: exit 0 12:04:10 INFO - TEST-OK | kraken | took 61753ms 12:04:10 INFO - SUITE-END | took 1174s 12:04:10 INFO - Completed test suite (00:19:34) 12:04:10 INFO - javascript benchmark 12:04:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.4722397192477, 3126.2653276480023, 3151.5115157150644, 3159.5102759072324, 3187.3465939482394, 5271.499207575283, 5304.946950530503, 5313.840584782458, 5396.3524377074755, 5408.3509978802595, 5377.085895397782, 5395.757190926408, 5405.648632838863, 5446.591505637083, 5473.2063850741615, 4870.805167793284, 4941.45643979162, 4957.132501812186, 4981.103401387749, 5186.740662966856, 5031.42138654054, 5058.949410505903, 5092.28707980883, 5114.539691427771, 5117.104506711329, 4889.046635906, 4914.11545921734, 4925.162722337212, 4970.229614409736, 4990.176620857555, 4926.605871530269, 4937.679050861682, 4946.455889852114, 5001.799928002875, 5051.419086805027, 4937.136001199811, 4952.801887924478, 4955.529224723646, 4977.178765503724, 5023.372078490189, 5185.688858668492, 5349.465053494659, 5354.571634269249, 5390.0836857734275, 5462.453754624546, 5867.413258674141, 5873.412658734135, 5876.794312199096, 5895.35151133375, 5924.0, 5699.2590963174525, 5911.113333000041, 5927.851803704899, 5970.253718285215, 5972.984592619222, 5428.0, 5479.178123281539, 5511.559075274049, 5562.972185139089, 5563.693996830173, 6005.549583781234, 6076.5442591805795, 6082.422169893853, 6082.847928801727, 6083.574149809471, 5624.493795558419, 5732.742026608813, 5773.6824474654295, 5783.942160578425, 5786.363500014995, 5816.360200377955, 5895.380984996599, 5946.226990491208, 5947.910781338283, 5958.0, 5805.332386775491, 5851.1515830205235, 5857.970710146507, 5862.589618726648, 5863.970680146572, 5643.858903527444, 5825.03886858672, 5871.911921321183, 5878.647281163144, 5900.793472228452, 4358.869233922987, 4374.518802931675, 4395.978020109879, 4404.7357158570585, 4462.0183559616835, 3930.3514920038447, 3933.0, 3943.3099207638547, 3979.0450291930306, 3979.6617287530885, 5459.426760190202, 5465.836024919259, 5467.316585426822, 5470.042742520043, 5474.39781624021, 5691.8292451226525, 5792.391798861143, 5859.560532959959, 5883.852903677357, 5887.20522729426, 5514.338279406497, 5523.475269849358, 5530.5852061095575, 5533.474319939599, 5536.307961504812, 4786.353842231254, 4895.7062576244825, 4897.853064408074, 4898.21628539432, 4947.60419166473, 5972.283326000821, 6018.909716354258, 6028.246469191351, 6069.666168360783, 6078.513718902477, 5881.441263080001, 5887.941120588739, 5888.646681199141, 5889.734961926809, 5896.734646940812, 5889.94110058894, 6007.81976540687, 6010.098485227076, 6063.333033366414, 6068.666223357758, 5788.623739456922, 5846.6784326862435, 5846.824595262149, 5847.7368518417625, 5895.115732640138, 5900.055991041413, 5916.083007133901, 5923.378045305181, 5930.644161350333, 5952.166696662384, 5553.72231388437, 5676.943230567642, 5685.0335442973965, 5769.221155144001, 5779.075347944308, 5716.742746576498, 5733.569982251264, 5734.3692193857805, 5744.655320680772, 5782.710864456844, 5648.5481161507805, 5652.576056795675, 5656.971715141398, 5659.037963546125, 5660.433956604471, 5613.1860880171325, 5703.344115426779, 5722.513586345207, 5739.971300143639, 5780.768769249183, 5479.095949168502, 5523.944760552343, 5599.216109744721, 5608.85977850557, 5628.324601047901], "value": 5380.849139826649, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9280089988752, 617.9969100154499, 632.8386261503316, 641.942225199732, 656.7143292667693, 32258.0, 44892.3266151008, 44989.325160122586, 45573.54426455743, 45746.7712661437, 42892.3566146508, 46273.537264627346, 46338.768306158425, 46345.536544634626, 46473.30290045644, 7916.445848790587, 8814.0, 8869.201771840566, 8951.060138685409, 10293.794124117514, 10141.44222067786, 10241.795164096713, 10499.42253176075, 10547.947260263689, 10578.100861426788, 10598.0, 10676.78646427071, 10677.039066484014, 10680.946595267053, 10687.198460115484, 10510.369377837316, 10604.363738175656, 10607.893921060768, 10610.151187904949, 10611.416372099531, 10488.528016239288, 10500.317479363817, 10529.736756581071, 10537.157027437786, 10562.366258024544, 42937.0, 43280.56719432797, 43374.78312608448, 43389.56610433887, 43418.56581434177, 3455.6544345565494, 3507.9298414031578, 3509.4034014217646, 3559.18138828071, 3617.2946275476293, 32557.18607034843, 33002.339953200804, 33103.50344744831, 33194.170145746306, 33494.83252583721, 4252.893677658052, 4274.358846173099, 4287.571242875719, 4324.675649326282, 4328.5022222444195, 319570.0, 322558.0, 323116.0, 323196.0, 323852.0, 64396.0, 64668.676656617354, 64793.67603162048, 64927.67536162289, 64978.67510662511, 66792.98673639295, 66900.0, 67474.66262668754, 67551.66224168848, 67618.0, 15738.685226295638, 16192.571114332708, 16207.108609026616, 16212.0, 16213.675726485404, 12482.687932801753, 12535.686607834694, 12536.0, 12548.0, 12554.435050422753, 20097.497562560762, 20560.691589626167, 20628.381148565568, 20733.481662958246, 20739.792602073787, 7500.812479687942, 7573.734919277799, 7640.044994375703, 7758.262965018314, 7766.5728384939375, 880.9647614095364, 946.4652471353663, 989.9114761942784, 1001.7095042437758, 1015.6140666546665, 28172.43655126927, 29220.853895730386, 29310.706892930797, 29344.0, 29432.705672942997, 1020.4438580973388, 1123.612353737959, 1162.2793867802018, 1179.6991767099507, 1258.9604840159002, 17065.317387304618, 17414.216360263566, 17427.128643567772, 17434.564135896704, 17561.56096097582, 526094.0, 527105.0, 529749.0, 531326.0, 531672.0, 60251.0, 60762.39237607656, 60866.69566652139, 60909.0, 61212.0, 1242.5340497313507, 1264.867188945166, 1294.8769866862633, 1353.0258214085843, 1431.1127101197117, 33120.337593248485, 33858.0, 34629.65370346365, 34918.30163396667, 35253.471197932566, 51748.0, 51754.48245517497, 52327.47672523226, 52365.21452178297, 52408.47591524036, 341154.0, 342011.0, 342350.0, 343259.0, 343765.0, 38720.419193711554, 46896.29655555101, 47243.0, 47546.52453475421, 48267.0, 48692.75653621709, 49396.75301623469, 50325.74837125791, 50564.0, 53996.0, 42190.0, 42224.78887605542, 42277.5772242286, 42717.57282427136, 44147.77926110478, 43022.35466468068, 43213.56786432221, 43328.0, 43334.56665433305, 43864.561354386045, 35401.468977965866, 36326.636733633386, 36448.45327320039, 36479.0, 36494.8175259122, 34805.47791783176, 38071.619283807915, 38500.614993849704, 40656.0, 41327.38008929808, 28777.56833647539, 29149.417011660073, 29185.0, 29199.7080029197, 29414.55878161872], "value": 20900.15758934502, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.72705469698565, 401.71478250442186, 402.6356147686343, 408.9550149483558, 412.1653651356004, 13218.870394707257, 19127.904360478195, 19612.509687257807, 19699.60600787985, 20860.374188774324, 14426.278686065707, 18929.242830286807, 19015.714764278546, 19806.603867922633, 19892.0, 5597.748101335439, 5736.885262294752, 5751.683657398841, 5758.3090029196555, 5777.248957635502, 5653.321601407816, 5735.713214339287, 5740.655560666373, 5741.770329186848, 5742.971285143569, 4158.688098392618, 5795.4784069433745, 6109.083637454373, 6113.266408031042, 6183.567150299458, 6148.0, 6148.231471066117, 6160.1683772690785, 6182.165407669952, 6311.242650881878, 5484.341878974548, 5553.666779993173, 5606.831795046155, 5609.495145436889, 5632.831015069554, 23168.18911338112, 23265.18571849977, 23623.29130126099, 23879.761202387926, 23947.640785388234, 2518.2571141513113, 2564.781993530552, 2597.6752905886765, 2602.0762629266715, 2629.2638061342664, 13926.072934755644, 14591.416343346253, 14642.267886605627, 15161.696766064617, 15320.0, 1911.3119277060248, 1980.1881228696166, 2002.779694233633, 2066.5970135823522, 2089.9968015352715, 78314.21685783126, 78978.21021789766, 79196.20803791947, 79653.60173199097, 80379.5981020097, 10366.688999330032, 10809.243352965217, 11059.889401106047, 11072.833907491395, 11115.277506962022, 14650.926745366205, 14873.479428220176, 14877.851221487863, 14881.702365952837, 14900.105993640416, 8097.352211823158, 8140.837183256302, 8173.509589424653, 8289.792755181168, 8369.3304535637, 7783.416243781626, 7908.090569584571, 7995.0, 7998.320142787812, 8012.158723334082, 6101.938980610226, 6330.873382532415, 6345.714442850082, 6569.507286953498, 6682.632455214913, 1899.9715004274947, 1981.3956743193464, 1999.980030154448, 2000.959980800376, 2006.9197232110553, 973.8490533967247, 1075.3440401355167, 1117.0058647803462, 1133.484264659578, 1148.3397046698183, 18941.621167576846, 19786.505337366394, 19901.203951842053, 19944.3019494317, 20327.288544901152, 1026.820306446369, 1059.4490864750287, 1079.5519859258477, 1111.1388673777726, 1155.6186458468853, 11115.944420277847, 11556.59551915679, 11777.587784427504, 11787.587434439753, 11795.764084718257, 470705.0, 472556.0, 477231.0, 481726.0, 484137.0, 78442.0, 79596.0, 79772.0, 79833.80249296149, 80032.59983700044, 1060.6022741471947, 1067.5516283161091, 1078.8813230544633, 1085.685151306128, 1090.6564432203832, 17754.5561360967, 17837.554061148057, 17931.551711207325, 18025.63948720992, 18368.0, 30158.246043849078, 37137.0, 38102.61897381102, 39617.80191099026, 39948.0, 52082.0, 52310.21534677059, 53183.73408132935, 53666.195007074144, 54002.0, 7723.227677232232, 7829.491083079582, 8708.433951793113, 8772.21050105468, 8962.462252264884, 9621.18219951312, 10584.89415105839, 13478.393472293574, 13623.863761362656, 13895.305234738425, 12074.577389791315, 12077.758444830879, 12213.328266945404, 12248.938755306166, 12569.811452828031, 11209.047230985458, 11503.597374091867, 11782.764344713229, 12036.217645852992, 12134.179873019119, 12070.637880863587, 12274.693132671755, 12419.565315213924, 12624.926881214833, 12746.10777245584, 8215.507069575844, 8224.465409748347, 8342.83314333722, 8348.499090054616, 8676.869846952175, 11329.830052549054, 11679.591214307458, 11774.705632359259, 11868.82196767032, 12046.819297710366], "value": 9426.859978402346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.6722702937782, 1364.1678576068596, 1464.5533112400717, 1523.7181121492517, 1835.109971663743, 8400.075991640922, 8654.26438752706, 8686.609102590375, 8893.91106088939, 8924.509151996637, 8606.784830379243, 8808.603612837422, 8812.295016398688, 8812.91187088129, 8839.425437346585, 2104.3476522278143, 2145.1205005947604, 2160.114353115223, 2162.059504115715, 2173.239366221818, 2349.6240601503764, 2391.8325717199805, 2393.3298676370555, 2407.217654262363, 2411.517696460715, 2149.795769401904, 2198.912043518257, 2254.875981820999, 2270.500489892221, 2271.2164303315412, 2099.3806826985924, 2302.6200676888293, 2368.336865677613, 2403.3150552092743, 2403.6995375578053, 2383.213539531968, 2414.155045733979, 2414.2153800015067, 2416.299273210767, 2420.4674971506242, 8932.285417166611, 8986.0, 8987.595558199897, 8996.100389961017, 9000.054994225577, 5053.570446512051, 5162.070827251093, 5172.379314482248, 5179.974100129475, 5181.974090129563, 3252.674732526752, 3281.5569898063695, 3422.9022734425384, 3455.067131874405, 3461.152017755641, 1059.1473863539848, 1085.4626959654943, 1090.4711215060688, 1091.7052395853075, 1096.6984079378155, 13081.476740930351, 13127.737445251138, 13141.605751827365, 13157.473701051946, 13195.73608527824, 4615.815367385267, 4763.904721905612, 4782.426108866889, 4817.614590832725, 4820.68665536739, 10795.352278863293, 10836.512356943957, 10861.619843305447, 10863.076638485818, 10893.183011274186, 5404.108322126805, 5407.891842163135, 5414.40441551429, 5422.8373148805595, 5423.2136340230445, 4251.553586873396, 4781.42622885256, 4814.759262036954, 4909.2881532177635, 5006.674566153189, 4112.3420252759415, 4220.599043090901, 4228.217779710763, 4244.278472659656, 4283.507396649363, 1316.8419789625307, 1353.7563238616947, 1365.8838998685223, 1367.2958426410407, 1369.6918193406404, 857.4340934983006, 963.7831487915163, 1026.5431882812077, 1037.5849660135855, 1044.4203467075695, 5884.941150588525, 6179.721912513947, 6248.5313601480075, 6264.780732674426, 6280.654563999024, 421.83337581655076, 438.49353996134516, 439.69660933956106, 456.04913754820905, 458.67892475267445, 4277.786110694453, 4295.74225546462, 4318.0, 4342.131573685276, 4352.912941741148, 11094.944525277322, 11278.830817537744, 11338.716532086599, 11381.772364552828, 11441.313521188755, 11017.228793984505, 11182.217244792786, 11202.887971120348, 11257.774844503065, 11315.094792416752, 7941.404394670307, 8192.34461243099, 8281.54451505173, 8326.45878017927, 8512.276456501142, 6233.2208473940755, 6331.05034244867, 6388.39310265524, 6442.677866106769, 6502.902456463252, 10123.392596444237, 10425.687229383131, 10549.630762923261, 10588.417637030037, 10639.095676867553, 10654.254202205771, 10850.240483166419, 10870.945645271722, 10983.560657573607, 11026.338419694845, 7220.169680486812, 7337.192908780136, 7338.412926965723, 8002.679892804223, 8171.7548473545885, 8055.113937466991, 8582.141785821617, 8888.955555222183, 8901.910980890367, 9028.548572571213, 7821.882671760042, 7838.294553490213, 7855.7250496232355, 7935.920640793749, 8090.393220508367, 7553.584552849646, 7721.729739459317, 7759.2240775921955, 7815.140334563307, 7957.363410926996, 7094.680739366844, 7123.679434425359, 7239.167495738057, 7273.781786546412, 7305.050343455317, 5186.481351864783, 5296.761645725875, 5307.6284660073425, 5377.300950876361, 5398.40617532079, 5383.08487557124, 5434.157705555645, 5536.750846211849, 5542.0, 5578.972105139448], "value": 4633.716113589854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.97010298970105, 308.2663261437778, 313.77721817509575, 316.3404302030267, 316.7291965369607, 5358.2498450217, 5373.785048598061, 5388.380336261331, 5444.156155795853, 5458.645188062778, 5330.534103121643, 5352.732363381825, 5362.8123015694455, 5365.773204120295, 5385.488378604036, 4127.607877251657, 4189.350650649139, 4216.241076606209, 4244.0, 4251.787410629456, 4108.506979162505, 4171.228322760284, 4173.853915112972, 4205.85279515217, 4207.453031105967, 4089.672826173914, 4120.278951183546, 4141.730787498818, 4174.582541745832, 4185.012119243365, 3862.9613703863165, 3994.6804255659476, 4139.317012692902, 4168.478505345557, 4178.707490475668, 3613.277344531078, 3628.1836586767768, 3635.745497815154, 3639.581448133472, 3643.8178091095338, 5115.795368185268, 5134.5378915897745, 5170.250313704491, 5179.015986962465, 5209.869753256161, 4440.7335559866515, 4519.570640789119, 4706.317583950342, 4744.715317080986, 4744.810207591692, 5520.972395138038, 5598.608097433182, 5606.35526914406, 5611.260509242107, 5619.6347237429845, 3987.601239876018, 4009.218202450523, 4016.558178600381, 4017.4576432181866, 4018.3771515415156, 5742.569307301927, 5807.867465844162, 5810.5932584719085, 5812.941870581282, 5834.5915785895, 4070.5929407059057, 4115.97942010288, 4118.9588104119175, 4134.421181034658, 4138.317177665712, 4163.146554956226, 4183.728057676241, 4184.8744537663915, 4185.748855068706, 4203.432536607519, 4652.674312798139, 4785.880352991203, 4786.353842231324, 4800.759962001886, 4809.470958194595, 5637.928793529216, 5678.346990096192, 5692.971535142381, 5715.199872017921, 5717.3996730342715, 1414.7736362182002, 1437.9209143496998, 1438.7769895666188, 1441.942322307117, 1443.0, 879.5916957066833, 906.4833045164324, 909.9353756105372, 919.2829592917535, 919.691903212418, 4798.328234047236, 4823.807047718122, 4839.661223714376, 4860.9513904861205, 4892.706437613754, 5124.0, 5130.383929062334, 5135.4094279157625, 5153.819616313486, 5164.328637277205, 4505.400582793127, 4867.5132486751045, 4894.2658601210105, 4939.975300123477, 4945.67853089548, 2765.3777899972347, 2985.1641540368732, 3031.8170916939766, 3056.1595561220397, 3083.9691603083684, 5950.285965684059, 5964.433378829004, 5978.910316345258, 5990.041593345044, 5995.730192141364, 5675.31896172462, 5855.2973643163095, 5874.676892770939, 5919.881602367928, 5929.229200203946, 6021.6989150542295, 6076.817695469054, 6088.939110608837, 6088.969555152285, 6096.104350433508, 5809.419058094157, 5818.0, 5833.270841144857, 5839.328477225004, 5851.327097383685, 5550.5282051026115, 5784.045632470596, 5825.271841019872, 5844.94155058444, 5853.78527460228, 6037.275526936795, 6038.154658347747, 6044.123602077586, 6085.695715214133, 6090.421409966046, 3789.1853251551047, 3999.8400063997115, 4036.1524079943542, 4042.69679774024, 4070.4097905804083, 5713.857153571194, 5793.768249269982, 5831.35855055952, 5833.3958161505925, 5880.117982302689, 5643.492085712305, 5667.951428985651, 5699.202111704281, 5740.13897915316, 5764.625299355528, 5465.590080744039, 5631.662100273997, 5675.432456754292, 5678.375378708256, 5706.229658995982, 5563.248961390161, 5572.192032155233, 5584.636998595079, 5588.842304098172, 5594.944050559442, 5445.83662490126, 5692.829215123553, 5700.657960522382, 5743.10981797822, 5757.424257574209, 5525.530329922001, 5532.114861622121, 5533.889322213453, 5551.0, 5554.777808887599], "value": 4236.004221445071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.6567380494263, 758.764782917296, 777.2072486064213, 789.1674283630767, 789.5617932047714, 14317.069390489636, 14320.928395358022, 14450.205238711867, 14487.058341207841, 14653.120812751242, 12966.286854223014, 12976.870231297708, 12983.935080324609, 13053.0, 13073.150245234054, 693.7918624412681, 830.3938125168601, 838.304207507767, 860.0410542245414, 861.6854847980474, 846.5809424334932, 850.5067061104576, 851.595492141231, 851.6082602003055, 851.9020312664061, 895.4850960697624, 895.7760559860035, 896.7713233125544, 897.2642433204775, 897.3897749530316, 729.7810656802965, 872.31959071924, 884.3632584539122, 887.7558671365362, 892.6741739265186, 649.5096202367182, 652.1261509577189, 652.1489456259579, 652.3802387731674, 652.781318258384, 13568.1859088455, 13573.524926627619, 13574.59276221715, 13584.117032392864, 13672.31638418075, 13625.931870340684, 13794.65513362164, 13919.860801392058, 13957.092788968685, 13979.720405591832, 12533.310667913262, 12541.372931353488, 12713.491460341575, 12754.170978886343, 13112.803307950388, 4423.380726698265, 4459.977700111511, 4462.419885414908, 4465.732056076613, 4481.775911204427, 57079.42920570783, 57978.13032804511, 60257.397426025615, 60394.79210415811, 60501.09248361278, 10553.366797992145, 10677.89322106769, 10821.106306396348, 10889.673309800719, 10978.286411383235, 17164.39924602658, 18267.360642377454, 18328.266869325344, 18386.44840654756, 18607.813921860878, 8074.3540516759695, 8102.635381407733, 8198.672053117809, 8231.382646301432, 8455.196756308142, 4662.976685116552, 4773.71357718538, 4781.713097214179, 4784.162771514971, 4807.302941073524, 3302.1414432247307, 3379.4254976653538, 3388.6611338865914, 3389.389909816257, 3402.914927126792, 584.0305093544696, 624.4224092714221, 626.6396821827376, 630.5838146823074, 658.2232965101131, 678.5284227461965, 710.4884483172108, 718.3857801579678, 778.3889646627371, 790.7983464216588, 9963.103320701171, 10424.530896109542, 10475.47622618866, 10484.266101372983, 10546.736331591617, 701.8034950213948, 704.5451143388885, 708.8724029674709, 723.706898706025, 760.8630446519569, 4935.629827762932, 4998.9500104999215, 5011.949880501221, 5028.120078986163, 5074.847754567369, 77269.61365193251, 77776.22223777803, 78699.60650196712, 78923.0, 78953.60523197347, 69086.65456672786, 69437.65281173562, 69527.65236173887, 70162.0, 71826.281737183, 61639.38360616336, 61857.072143917874, 61916.380836191965, 61923.071153932724, 62648.373516265165, 9283.936301020782, 9516.24029031573, 9524.238060955246, 9544.522773861141, 9582.089701478348, 39789.2042159161, 40262.1947561053, 40269.39595906122, 40398.39402408907, 42719.786401067795, 53799.73100134474, 54434.18348724693, 54616.726916365165, 55463.0, 55996.72001639966, 12789.424475898793, 12928.482860685468, 13154.276514791778, 13246.337683115613, 13679.110857794212, 13352.866471335163, 13705.725885482036, 13820.930895345458, 13871.653208669864, 14863.272158229729, 12295.0, 12657.050721196132, 13550.525731599346, 13726.794098088338, 14267.857321427067, 13016.609501714964, 13038.0, 13484.393202306115, 14070.296485175495, 14078.859211407755, 12655.177413468464, 12966.222026678051, 13349.466021359036, 13425.664358390728, 13435.664108397368, 10467.267291289536, 10660.946695266784, 10877.238593298393, 11143.665690029313, 11153.553857845594, 10239.7440063999, 11283.401211880271, 11475.540978360772, 11488.712782180512, 11686.123540734648], "value": 7140.136030383198, "unit": "score"}], "name": "dromaeo_css", "value": 7277.815657602769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 108.0, 110.0, 110.0, 112.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 156.0, 212.0, 124.0, 151.0, 152.0, 126.0, 184.0, 125.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 161.0, 159.0, 159.0, 161.0, 163.0, 161.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 149.0, 75.0, 75.0, 75.0, 75.0, 130.0, 74.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 145.0, 94.0, 92.0, 91.0, 140.0, 91.0, 90.0, 127.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0, 113.0, 53.0, 55.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 61.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 81.0, 79.0, 84.0, 81.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 123.0, 117.0, 117.0, 120.0, 126.0, 139.0, 202.0, 128.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 159.0, 161.0, 160.0, 157.0, 161.0, 164.0, 170.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 62.0, 64.0, 61.0, 61.0, 66.0, 61.0, 61.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1527.1000000000001, "alertThreshold": 2.0}]} 12:04:10 INFO - Return code: 0 12:04:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:04:10 ERROR - # TBPL SUCCESS # 12:04:10 INFO - Running post-action listener: _resource_record_post_action 12:04:10 INFO - ##### 12:04:10 INFO - ##### Finished run-tests step (success) 12:04:10 INFO - ##### 12:04:10 INFO - Running post-run listener: _resource_record_post_run 12:04:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 545169408; Read time: 0; Write time: 413112 12:04:10 INFO - TinderboxPrint: CPU usage
13.1% 12:04:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:04:10 INFO - TinderboxPrint: I/O write bytes / time
545,169,408 / 413,112 12:04:10 INFO - TinderboxPrint: CPU idle
8,273.8 (86.9%) 12:04:10 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 12:04:10 INFO - TinderboxPrint: Swap in / out
0 / 0 12:04:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 184467456; Read time: 0; Write time: 197128 12:04:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 289828864; Read time: 0; Write time: 178996 12:04:11 INFO - Running post-run listener: _upload_blobber_files 12:04:11 INFO - Blob upload gear active. 12:04:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:11 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 12:04:11 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:11 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:11 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:04:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:12 INFO - (blobuploader) - INFO - Done attempting. 12:04:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:04:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:16 INFO - (blobuploader) - INFO - Done attempting. 12:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:04:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:17 INFO - (blobuploader) - INFO - Done attempting. 12:04:17 INFO - (blobuploader) - INFO - Iteration through files over. 12:04:17 INFO - Return code: 0 12:04:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:04:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:04:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d181412457b5436df1c59b0fd883eb1df34659b15ed796836d7762d0db25b09b0ed57a59815958802286dea01e4353e61c0cec1016bf762d0fb8163e826c11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d87295914b7311bad09a6e1eaada65d2822d1ac3f789ad96decedb11c0209eb0c677d87ca2de464c74f724952464cb0188b2ab8022e240a3fe932214817ef050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2737111bf40e6ad7cd3c377e2e3be4a1bef33ab79a3077db198d2d9a3aa6691f170781ee0ceaa46649996630552182547b091bdff1a91afec9500d882d03ca48"} 12:04:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:04:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:04:17 INFO - Contents: 12:04:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d181412457b5436df1c59b0fd883eb1df34659b15ed796836d7762d0db25b09b0ed57a59815958802286dea01e4353e61c0cec1016bf762d0fb8163e826c11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d87295914b7311bad09a6e1eaada65d2822d1ac3f789ad96decedb11c0209eb0c677d87ca2de464c74f724952464cb0188b2ab8022e240a3fe932214817ef050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2737111bf40e6ad7cd3c377e2e3be4a1bef33ab79a3077db198d2d9a3aa6691f170781ee0ceaa46649996630552182547b091bdff1a91afec9500d882d03ca48"} 12:04:17 INFO - Running post-run listener: copy_logs_to_upload_dir 12:04:17 INFO - Copying logs to upload dir... 12:04:17 INFO - mkdir: /builds/slave/test/build/upload/logs 12:04:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.944771 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-17 12:04:17.326885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 12:04:17.330131) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d181412457b5436df1c59b0fd883eb1df34659b15ed796836d7762d0db25b09b0ed57a59815958802286dea01e4353e61c0cec1016bf762d0fb8163e826c11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d87295914b7311bad09a6e1eaada65d2822d1ac3f789ad96decedb11c0209eb0c677d87ca2de464c74f724952464cb0188b2ab8022e240a3fe932214817ef050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2737111bf40e6ad7cd3c377e2e3be4a1bef33ab79a3077db198d2d9a3aa6691f170781ee0ceaa46649996630552182547b091bdff1a91afec9500d882d03ca48"} build_url:https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/Em0MLap5TUSta5K6rdiQsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d181412457b5436df1c59b0fd883eb1df34659b15ed796836d7762d0db25b09b0ed57a59815958802286dea01e4353e61c0cec1016bf762d0fb8163e826c11c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d87295914b7311bad09a6e1eaada65d2822d1ac3f789ad96decedb11c0209eb0c677d87ca2de464c74f724952464cb0188b2ab8022e240a3fe932214817ef050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2737111bf40e6ad7cd3c377e2e3be4a1bef33ab79a3077db198d2d9a3aa6691f170781ee0ceaa46649996630552182547b091bdff1a91afec9500d882d03ca48"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 12:04:17.354321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:04:17.354644) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1463510617.512959-1060334476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 12:04:17.440166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 12:04:17.440479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 12:04:17.440772) ========= ========= Total master_lag: 0.21 =========