builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1464097789.19 results: success (0) buildid: 20160524052203 builduid: c4372d02bd8443a09e58551715c1dc5f revision: f6e1ee9ac46c73705320caa6a208e6a017f3bdd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.189817) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.190299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.190601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.207842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.208179) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 06:49:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.2M=0s 2016-05-24 06:49:50 (83.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.318352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.318638) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017555 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.369078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.369386) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6e1ee9ac46c73705320caa6a208e6a017f3bdd8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f6e1ee9ac46c73705320caa6a208e6a017f3bdd8 --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=97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 06:49:50,326 truncating revision to first 12 chars 2016-05-24 06:49:50,326 Setting DEBUG logging. 2016-05-24 06:49:50,326 attempt 1/10 2016-05-24 06:49:50,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6e1ee9ac46c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 06:49:50,603 unpacking tar archive at: mozilla-central-f6e1ee9ac46c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567475 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.950690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.951071) ========= script_repo_revision: f6e1ee9ac46c73705320caa6a208e6a017f3bdd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.951506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.951815) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 06:49:49.959957) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-24 06:49:49.960229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:51 INFO - MultiFileLogger online at 20160524 06:49:51 in /builds/slave/test 06:49:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:49:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:49:51 INFO - {'append_to_log': False, 06:49:51 INFO - 'base_work_dir': '/builds/slave/test', 06:49:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:49:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:49:51 INFO - 'branch': 'Firefox-Non-PGO', 06:49:51 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:51 INFO - 'config_files': ('talos/linux_config.py',), 06:49:51 INFO - 'default_actions': ('clobber', 06:49:51 INFO - 'read-buildbot-config', 06:49:51 INFO - 'download-and-extract', 06:49:51 INFO - 'populate-webroot', 06:49:51 INFO - 'create-virtualenv', 06:49:51 INFO - 'install', 06:49:51 INFO - 'run-tests'), 06:49:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:51 INFO - 'download_minidump_stackwalk': True, 06:49:51 INFO - 'download_symbols': 'ondemand', 06:49:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:51 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:51 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:51 INFO - 'installer_path': 'installer.exe', 06:49:51 INFO - 'log_level': 'info', 06:49:51 INFO - 'log_name': 'talos', 06:49:51 INFO - 'log_to_console': True, 06:49:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:51 INFO - 'opt_config_files': (), 06:49:51 INFO - 'pip_index': False, 06:49:51 INFO - 'sps_profile': False, 06:49:51 INFO - 'sps_profile_interval': 0, 06:49:51 INFO - 'suite': 'dromaeojs', 06:49:51 INFO - 'system_bits': '32', 06:49:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:51 INFO - 'title': 'talos-linux64-ix-068', 06:49:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:51 INFO - 'use_talos_json': True, 06:49:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:49:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:51 INFO - 'work_dir': 'build'} 06:49:51 INFO - ##### 06:49:51 INFO - ##### Running clobber step. 06:49:51 INFO - ##### 06:49:51 INFO - Running pre-action listener: _resource_record_pre_action 06:49:51 INFO - Running main action method: clobber 06:49:51 INFO - rmtree: /builds/slave/test/build 06:49:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:51 INFO - Running post-action listener: _resource_record_post_action 06:49:51 INFO - ##### 06:49:51 INFO - ##### Finished clobber step (success) 06:49:51 INFO - ##### 06:49:51 INFO - ##### 06:49:51 INFO - ##### Running read-buildbot-config step. 06:49:51 INFO - ##### 06:49:51 INFO - Running pre-action listener: _resource_record_pre_action 06:49:51 INFO - Running main action method: read_buildbot_config 06:49:51 INFO - Using buildbot properties: 06:49:51 INFO - { 06:49:51 INFO - "project": "", 06:49:51 INFO - "product": "firefox", 06:49:51 INFO - "script_repo_revision": "production", 06:49:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:49:51 INFO - "repository": "", 06:49:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:49:51 INFO - "buildid": "20160524052203", 06:49:51 INFO - "pgo_build": "False", 06:49:51 INFO - "basedir": "/builds/slave/test", 06:49:51 INFO - "buildnumber": 592, 06:49:51 INFO - "slavename": "talos-linux64-ix-068", 06:49:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:49:51 INFO - "platform": "ubuntu64_hw", 06:49:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:49:51 INFO - "branch": "mozilla-central", 06:49:51 INFO - "repo_path": "mozilla-central", 06:49:51 INFO - "revision": "f6e1ee9ac46c73705320caa6a208e6a017f3bdd8", 06:49:51 INFO - "stage_platform": "linux64", 06:49:51 INFO - "builduid": "c4372d02bd8443a09e58551715c1dc5f", 06:49:51 INFO - "slavebuilddir": "test" 06:49:51 INFO - } 06:49:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:49:51 INFO - Running post-action listener: _resource_record_post_action 06:49:51 INFO - ##### 06:49:51 INFO - ##### Finished read-buildbot-config step (success) 06:49:51 INFO - ##### 06:49:51 INFO - ##### 06:49:51 INFO - ##### Running download-and-extract step. 06:49:51 INFO - ##### 06:49:51 INFO - Running pre-action listener: _resource_record_pre_action 06:49:51 INFO - Running main action method: download_and_extract 06:49:51 INFO - mkdir: /builds/slave/test/build/tests 06:49:51 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')]} 06:49:51 INFO - https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:49:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:49:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:49:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:49:55 INFO - Downloaded 1361 bytes. 06:49:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:49:55 INFO - Using the following test package requirements: 06:49:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:49:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'jsshell-linux-x86_64.zip'], 06:49:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:49:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:49:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49: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')]} 06:49:55 INFO - https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:49:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:49:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:49:57 INFO - Downloaded 22814329 bytes. 06:49:57 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'] 06:49:57 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 06:49:59 INFO - Return code: 0 06:49:59 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 06:49:59 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')]} 06:49:59 INFO - https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:49:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:49:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:49:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:50:00 INFO - Downloaded 22814329 bytes. 06:50:00 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'] 06:50:00 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 06:50:01 INFO - Return code: 0 06:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:01 INFO - https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:50:02 INFO - Downloaded 10840359 bytes. 06:50:02 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'] 06:50:02 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 06:50:02 INFO - Return code: 0 06:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:02 INFO - https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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 06:50:04 INFO - Downloaded 54822326 bytes. 06:50:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:50:04 INFO - mkdir: /builds/slave/test/properties 06:50:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:50:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:50:04 INFO - Contents: 06:50:04 INFO - build_url:https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:50:05 INFO - Running post-action listener: _resource_record_post_action 06:50:05 INFO - Running post-action listener: set_extra_try_arguments 06:50:05 INFO - ##### 06:50:05 INFO - ##### Finished download-and-extract step (success) 06:50:05 INFO - ##### 06:50:05 INFO - ##### 06:50:05 INFO - ##### Running populate-webroot step. 06:50:05 INFO - ##### 06:50:05 INFO - Running pre-action listener: _resource_record_pre_action 06:50:05 INFO - Running main action method: populate_webroot 06:50:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:05 INFO - '--tppagecycles', 06:50:05 INFO - '7'], 06:50:05 INFO - 'tests': ['tsvgm']}}, 06:50:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:50:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:50:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:50:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['damp', 'tps']}, 06:50:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'tests': ['damp', 'tps']}, 06:50:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['dromaeo_dom']}, 06:50:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['a11yr', 06:50:05 INFO - 'ts_paint', 06:50:05 INFO - 'tpaint', 06:50:05 INFO - 'sessionrestore', 06:50:05 INFO - 'sessionrestore_no_auto_restore', 06:50:05 INFO - 'tabpaint']}, 06:50:05 INFO - 'other-e10s': {'tests': ['a11yr', 06:50:05 INFO - 'ts_paint', 06:50:05 INFO - 'tpaint', 06:50:05 INFO - 'sessionrestore', 06:50:05 INFO - 'sessionrestore_no_auto_restore', 06:50:05 INFO - 'tabpaint']}, 06:50:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:50:05 INFO - 'ts_paint', 06:50:05 INFO - 'tpaint', 06:50:05 INFO - 'sessionrestore', 06:50:05 INFO - 'sessionrestore_no_auto_restore', 06:50:05 INFO - 'tabpaint']}, 06:50:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:50:05 INFO - 'ts_paint', 06:50:05 INFO - 'tpaint', 06:50:05 INFO - 'sessionrestore', 06:50:05 INFO - 'sessionrestore_no_auto_restore', 06:50:05 INFO - 'tabpaint']}, 06:50:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['a11yr', 06:50:05 INFO - 'ts_paint', 06:50:05 INFO - 'tpaint', 06:50:05 INFO - 'sessionrestore', 06:50:05 INFO - 'sessionrestore_no_auto_restore', 06:50:05 INFO - 'tabpaint']}, 06:50:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['a11yr', 06:50:05 INFO - 'ts_paint', 06:50:05 INFO - 'tpaint', 06:50:05 INFO - 'sessionrestore', 06:50:05 INFO - 'sessionrestore_no_auto_restore', 06:50:05 INFO - 'tabpaint']}, 06:50:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['tsvgx', 06:50:05 INFO - 'tsvgr_opacity', 06:50:05 INFO - 'tart', 06:50:05 INFO - 'tscrollx', 06:50:05 INFO - 'cart']}, 06:50:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:50:05 INFO - 'tsvgr_opacity', 06:50:05 INFO - 'tart', 06:50:05 INFO - 'tscrollx', 06:50:05 INFO - 'cart']}, 06:50:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'talos_options': ['--disable-e10s'], 06:50:05 INFO - 'tests': ['tp5o']}, 06:50:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'tests': ['tp5o']}, 06:50:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'talos_options': ['--disable-e10s', 06:50:05 INFO - '--xperf_path', 06:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:05 INFO - 'tests': ['tp5n']}, 06:50:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:05 INFO - 'talos_options': ['--xperf_path', 06:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:05 INFO - 'tests': ['tp5n']}}, 06:50:05 INFO - 'talos.zip': {'path': '', 06:50:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:05 INFO - Running post-action listener: _resource_record_post_action 06:50:05 INFO - ##### 06:50:05 INFO - ##### Finished populate-webroot step (success) 06:50:05 INFO - ##### 06:50:05 INFO - ##### 06:50:05 INFO - ##### Running create-virtualenv step. 06:50:05 INFO - ##### 06:50:05 INFO - Running pre-action listener: _resource_record_pre_action 06:50:05 INFO - Running main action method: create_virtualenv 06:50:05 INFO - Creating virtualenv /builds/slave/test/build/venv 06:50:05 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 06:50:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:50:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:05 INFO - Using real prefix '/usr' 06:50:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:50:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:08 INFO - Installing pip.................done. 06:50:08 INFO - Return code: 0 06:50:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 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 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:08 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 06:50:08 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 06:50:08 INFO - Using env: {'DISPLAY': ':0', 06:50:08 INFO - 'HOME': '/home/cltbld', 06:50:08 INFO - 'LANG': 'en_US.UTF-8', 06:50:08 INFO - 'LANGUAGE': 'en_US:en', 06:50:08 INFO - 'LOGNAME': 'cltbld', 06:50:08 INFO - 'MAIL': '/var/mail/cltbld', 06:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:08 INFO - 'MOZ_NO_REMOTE': '1', 06:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:08 INFO - 'NO_EM_RESTART': '1', 06:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:08 INFO - 'PWD': '/builds/slave/test', 06:50:08 INFO - 'SHELL': '/bin/bash', 06:50:08 INFO - 'SHLVL': '1', 06:50:08 INFO - 'TERM': 'linux', 06:50:08 INFO - 'TMOUT': '86400', 06:50:08 INFO - 'USER': 'cltbld', 06:50:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:08 INFO - '_': '/tools/buildbot/bin/python'} 06:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:08 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 06:50:08 INFO - Cleaning up... 06:50:08 INFO - Return code: 0 06:50:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 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 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:08 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 06:50:08 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 06:50:08 INFO - Using env: {'DISPLAY': ':0', 06:50:08 INFO - 'HOME': '/home/cltbld', 06:50:08 INFO - 'LANG': 'en_US.UTF-8', 06:50:08 INFO - 'LANGUAGE': 'en_US:en', 06:50:08 INFO - 'LOGNAME': 'cltbld', 06:50:08 INFO - 'MAIL': '/var/mail/cltbld', 06:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:08 INFO - 'MOZ_NO_REMOTE': '1', 06:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:08 INFO - 'NO_EM_RESTART': '1', 06:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:08 INFO - 'PWD': '/builds/slave/test', 06:50:08 INFO - 'SHELL': '/bin/bash', 06:50:08 INFO - 'SHLVL': '1', 06:50:08 INFO - 'TERM': 'linux', 06:50:08 INFO - 'TMOUT': '86400', 06:50:08 INFO - 'USER': 'cltbld', 06:50:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:08 INFO - '_': '/tools/buildbot/bin/python'} 06:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:08 INFO - Downloading/unpacking psutil>=3.1.1 06:50:08 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 06:50:08 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 06:50:08 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 06:50:08 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 06:50:08 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 06:50:08 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 06:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:10 INFO - Installing collected packages: psutil 06:50:10 INFO - Running setup.py install for psutil 06:50:10 INFO - building 'psutil._psutil_linux' extension 06:50:10 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 06:50:10 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 06:50:10 INFO - building 'psutil._psutil_posix' extension 06:50:10 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 06:50:10 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 06:50:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:11 INFO - Successfully installed psutil 06:50:11 INFO - Cleaning up... 06:50:11 INFO - Return code: 0 06:50:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:50: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 mozsystemmonitor==0.3 06:50:11 INFO - Using env: {'DISPLAY': ':0', 06:50:11 INFO - 'HOME': '/home/cltbld', 06:50:11 INFO - 'LANG': 'en_US.UTF-8', 06:50:11 INFO - 'LANGUAGE': 'en_US:en', 06:50:11 INFO - 'LOGNAME': 'cltbld', 06:50:11 INFO - 'MAIL': '/var/mail/cltbld', 06:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:11 INFO - 'MOZ_NO_REMOTE': '1', 06:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:11 INFO - 'NO_EM_RESTART': '1', 06:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:11 INFO - 'PWD': '/builds/slave/test', 06:50:11 INFO - 'SHELL': '/bin/bash', 06:50:11 INFO - 'SHLVL': '1', 06:50:11 INFO - 'TERM': 'linux', 06:50:11 INFO - 'TMOUT': '86400', 06:50:11 INFO - 'USER': 'cltbld', 06:50:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:11 INFO - '_': '/tools/buildbot/bin/python'} 06:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:50:13 INFO - Installing collected packages: mozsystemmonitor 06:50:13 INFO - Running setup.py install for mozsystemmonitor 06:50:13 INFO - Successfully installed mozsystemmonitor 06:50:13 INFO - Cleaning up... 06:50:13 INFO - Return code: 0 06:50:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:50:13 INFO - Using env: {'DISPLAY': ':0', 06:50:13 INFO - 'HOME': '/home/cltbld', 06:50:13 INFO - 'LANG': 'en_US.UTF-8', 06:50:13 INFO - 'LANGUAGE': 'en_US:en', 06:50:13 INFO - 'LOGNAME': 'cltbld', 06:50:13 INFO - 'MAIL': '/var/mail/cltbld', 06:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:13 INFO - 'MOZ_NO_REMOTE': '1', 06:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:13 INFO - 'NO_EM_RESTART': '1', 06:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:13 INFO - 'PWD': '/builds/slave/test', 06:50:13 INFO - 'SHELL': '/bin/bash', 06:50:13 INFO - 'SHLVL': '1', 06:50:13 INFO - 'TERM': 'linux', 06:50:13 INFO - 'TMOUT': '86400', 06:50:13 INFO - 'USER': 'cltbld', 06:50:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:13 INFO - '_': '/tools/buildbot/bin/python'} 06:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:50:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:16 INFO - Downloading docopt-0.6.1.tar.gz 06:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:16 INFO - Running setup.py install for blobuploader 06:50:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:50:16 INFO - Running setup.py install for requests 06:50:16 INFO - Running setup.py install for docopt 06:50:16 INFO - Successfully installed blobuploader requests docopt 06:50:16 INFO - Cleaning up... 06:50:16 INFO - Return code: 0 06:50:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:50:16 INFO - Using env: {'DISPLAY': ':0', 06:50:16 INFO - 'HOME': '/home/cltbld', 06:50:16 INFO - 'LANG': 'en_US.UTF-8', 06:50:16 INFO - 'LANGUAGE': 'en_US:en', 06:50:16 INFO - 'LOGNAME': 'cltbld', 06:50:16 INFO - 'MAIL': '/var/mail/cltbld', 06:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:16 INFO - 'MOZ_NO_REMOTE': '1', 06:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:16 INFO - 'NO_EM_RESTART': '1', 06:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:16 INFO - 'PWD': '/builds/slave/test', 06:50:16 INFO - 'SHELL': '/bin/bash', 06:50:16 INFO - 'SHLVL': '1', 06:50:16 INFO - 'TERM': 'linux', 06:50:16 INFO - 'TMOUT': '86400', 06:50:16 INFO - 'USER': 'cltbld', 06:50:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:16 INFO - '_': '/tools/buildbot/bin/python'} 06:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:17 INFO - Running setup.py (path:/tmp/pip-d62xZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:17 INFO - Running setup.py (path:/tmp/pip-gBLdSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:17 INFO - Running setup.py (path:/tmp/pip-OXOiqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:17 INFO - Running setup.py (path:/tmp/pip-iuOKRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:17 INFO - Running setup.py (path:/tmp/pip-HYsJf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:17 INFO - Running setup.py (path:/tmp/pip-YdMtW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:17 INFO - Running setup.py (path:/tmp/pip-GN1W4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:17 INFO - Running setup.py (path:/tmp/pip-M4qMfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:17 INFO - Running setup.py (path:/tmp/pip-CCJrNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:17 INFO - Running setup.py (path:/tmp/pip-S5gxLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:17 INFO - Running setup.py (path:/tmp/pip-FCvf36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:17 INFO - Running setup.py (path:/tmp/pip-kDkVGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:17 INFO - Running setup.py (path:/tmp/pip-uVBh7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:18 INFO - Running setup.py (path:/tmp/pip-DKbVVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:18 INFO - Running setup.py (path:/tmp/pip-6CErzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:18 INFO - Running setup.py (path:/tmp/pip-bD457M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:18 INFO - Running setup.py (path:/tmp/pip-MYqGVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:18 INFO - Running setup.py install for manifestparser 06:50:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:50:18 INFO - Running setup.py install for mozcrash 06:50:18 INFO - Running setup.py install for mozdebug 06:50:18 INFO - Running setup.py install for mozdevice 06:50:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:50:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:50:18 INFO - Running setup.py install for mozfile 06:50:18 INFO - Running setup.py install for mozhttpd 06:50:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:50:18 INFO - Running setup.py install for mozinfo 06:50:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozInstall 06:50:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozleak 06:50:19 INFO - Running setup.py install for mozlog 06:50:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for moznetwork 06:50:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozprocess 06:50:19 INFO - Running setup.py install for mozprofile 06:50:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozrunner 06:50:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozscreenshot 06:50:19 INFO - Running setup.py install for moztest 06:50:19 INFO - Running setup.py install for mozversion 06:50:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:20 INFO - Cleaning up... 06:50:20 INFO - Return code: 0 06:50:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:20 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 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:20 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 06:50:20 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 06:50:20 INFO - Using env: {'DISPLAY': ':0', 06:50:20 INFO - 'HOME': '/home/cltbld', 06:50:20 INFO - 'LANG': 'en_US.UTF-8', 06:50:20 INFO - 'LANGUAGE': 'en_US:en', 06:50:20 INFO - 'LOGNAME': 'cltbld', 06:50:20 INFO - 'MAIL': '/var/mail/cltbld', 06:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:20 INFO - 'MOZ_NO_REMOTE': '1', 06:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:20 INFO - 'NO_EM_RESTART': '1', 06:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:20 INFO - 'PWD': '/builds/slave/test', 06:50:20 INFO - 'SHELL': '/bin/bash', 06:50:20 INFO - 'SHLVL': '1', 06:50:20 INFO - 'TERM': 'linux', 06:50:20 INFO - 'TMOUT': '86400', 06:50:20 INFO - 'USER': 'cltbld', 06:50:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:20 INFO - '_': '/tools/buildbot/bin/python'} 06:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:20 INFO - Running setup.py (path:/tmp/pip-FogmWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:20 INFO - Running setup.py (path:/tmp/pip-KGfR7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:20 INFO - Running setup.py (path:/tmp/pip-9xH3gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:20 INFO - Running setup.py (path:/tmp/pip-fnVAsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:20 INFO - Running setup.py (path:/tmp/pip-2BfjZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:20 INFO - Running setup.py (path:/tmp/pip-agW1hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:20 INFO - Running setup.py (path:/tmp/pip-XR4uOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:20 INFO - Running setup.py (path:/tmp/pip-uMODc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:20 INFO - Running setup.py (path:/tmp/pip-MpdAdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:20 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)) 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:20 INFO - Running setup.py (path:/tmp/pip-OgPDWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:21 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)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:21 INFO - Running setup.py (path:/tmp/pip-NbxDbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:21 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)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:21 INFO - Running setup.py (path:/tmp/pip-qW3tHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:21 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)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:21 INFO - Running setup.py (path:/tmp/pip-O9UWIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:21 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)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:21 INFO - Running setup.py (path:/tmp/pip-mxA3OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:21 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)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:21 INFO - Running setup.py (path:/tmp/pip-WzFLJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:21 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)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:21 INFO - Running setup.py (path:/tmp/pip-QbMPHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:21 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)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:21 INFO - Running setup.py (path:/tmp/pip-qKzPzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:21 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)) 06:50:21 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)) 06:50:21 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)) 06:50:21 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)) 06:50:21 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)) 06:50:21 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)) 06:50:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:21 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 06:50:21 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 06:50:21 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 06:50:21 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 06:50:21 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 06:50:21 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 06:50:23 INFO - Downloading blessings-1.6.tar.gz 06:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:23 INFO - Installing collected packages: blessings 06:50:23 INFO - Running setup.py install for blessings 06:50:23 INFO - Successfully installed blessings 06:50:23 INFO - Cleaning up... 06:50:23 INFO - Return code: 0 06:50:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:50:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:23 INFO - Reading from file tmpfile_stdout 06:50:23 INFO - Current package versions: 06:50:23 INFO - argparse == 1.2.1 06:50:23 INFO - blessings == 1.6 06:50:23 INFO - blobuploader == 1.2.4 06:50:23 INFO - docopt == 0.6.1 06:50:23 INFO - manifestparser == 1.1 06:50:23 INFO - mozInstall == 1.12 06:50:23 INFO - mozcrash == 0.17 06:50:23 INFO - mozdebug == 0.1 06:50:23 INFO - mozdevice == 0.48 06:50:23 INFO - mozfile == 1.2 06:50:23 INFO - mozhttpd == 0.7 06:50:23 INFO - mozinfo == 0.9 06:50:23 INFO - mozleak == 0.1 06:50:23 INFO - mozlog == 3.2 06:50:23 INFO - moznetwork == 0.27 06:50:23 INFO - mozprocess == 0.22 06:50:23 INFO - mozprofile == 0.28 06:50:23 INFO - mozrunner == 6.11 06:50:23 INFO - mozscreenshot == 0.1 06:50:23 INFO - mozsystemmonitor == 0.3 06:50:23 INFO - moztest == 0.7 06:50:23 INFO - mozversion == 1.4 06:50:23 INFO - psutil == 3.1.1 06:50:23 INFO - requests == 1.2.3 06:50:23 INFO - wsgiref == 0.1.2 06:50:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:23 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')]} 06:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:23 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')]} 06:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:23 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 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:23 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 06:50:23 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 06:50:23 INFO - Using env: {'DISPLAY': ':0', 06:50:23 INFO - 'HOME': '/home/cltbld', 06:50:23 INFO - 'LANG': 'en_US.UTF-8', 06:50:23 INFO - 'LANGUAGE': 'en_US:en', 06:50:23 INFO - 'LOGNAME': 'cltbld', 06:50:23 INFO - 'MAIL': '/var/mail/cltbld', 06:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:23 INFO - 'MOZ_NO_REMOTE': '1', 06:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:23 INFO - 'NO_EM_RESTART': '1', 06:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:23 INFO - 'PWD': '/builds/slave/test', 06:50:23 INFO - 'SHELL': '/bin/bash', 06:50:23 INFO - 'SHLVL': '1', 06:50:23 INFO - 'TERM': 'linux', 06:50:23 INFO - 'TMOUT': '86400', 06:50:23 INFO - 'USER': 'cltbld', 06:50:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:23 INFO - '_': '/tools/buildbot/bin/python'} 06:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 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)) 06:50:24 INFO - Cleaning up... 06:50:24 INFO - Return code: 0 06:50:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:50:24 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')]} 06:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:24 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')]} 06:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:24 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 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:24 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 06:50:24 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 06:50:24 INFO - Using env: {'DISPLAY': ':0', 06:50:24 INFO - 'HOME': '/home/cltbld', 06:50:24 INFO - 'LANG': 'en_US.UTF-8', 06:50:24 INFO - 'LANGUAGE': 'en_US:en', 06:50:24 INFO - 'LOGNAME': 'cltbld', 06:50:24 INFO - 'MAIL': '/var/mail/cltbld', 06:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:24 INFO - 'MOZ_NO_REMOTE': '1', 06:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:24 INFO - 'NO_EM_RESTART': '1', 06:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:24 INFO - 'PWD': '/builds/slave/test', 06:50:24 INFO - 'SHELL': '/bin/bash', 06:50:24 INFO - 'SHLVL': '1', 06:50:24 INFO - 'TERM': 'linux', 06:50:24 INFO - 'TMOUT': '86400', 06:50:24 INFO - 'USER': 'cltbld', 06:50:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:24 INFO - '_': '/tools/buildbot/bin/python'} 06:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:24 INFO - Downloading/unpacking jsonschema 06:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:26 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:26 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:26 INFO - warning: no files found matching '*.txt' 06:50:26 INFO - no previously-included directories found matching 'build' 06:50:26 INFO - no previously-included directories found matching 'dist' 06:50:26 INFO - no previously-included directories found matching '.git*' 06:50:26 INFO - Installing collected packages: jsonschema, functools32 06:50:26 INFO - Running setup.py install for functools32 06:50:26 INFO - warning: no files found matching '*.txt' 06:50:26 INFO - no previously-included directories found matching 'build' 06:50:26 INFO - no previously-included directories found matching 'dist' 06:50:26 INFO - no previously-included directories found matching '.git*' 06:50:26 INFO - Successfully installed jsonschema functools32 06:50:26 INFO - Cleaning up... 06:50:26 INFO - Return code: 0 06:50:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:50:26 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')]} 06:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:26 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')]} 06:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:26 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 0x7fc1df292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', '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 06:50:26 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 06:50:26 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 06:50:26 INFO - Using env: {'DISPLAY': ':0', 06:50:26 INFO - 'HOME': '/home/cltbld', 06:50:26 INFO - 'LANG': 'en_US.UTF-8', 06:50:26 INFO - 'LANGUAGE': 'en_US:en', 06:50:26 INFO - 'LOGNAME': 'cltbld', 06:50:26 INFO - 'MAIL': '/var/mail/cltbld', 06:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:26 INFO - 'MOZ_NO_REMOTE': '1', 06:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:26 INFO - 'NO_EM_RESTART': '1', 06:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:26 INFO - 'PWD': '/builds/slave/test', 06:50:26 INFO - 'SHELL': '/bin/bash', 06:50:26 INFO - 'SHLVL': '1', 06:50:26 INFO - 'TERM': 'linux', 06:50:26 INFO - 'TMOUT': '86400', 06:50:26 INFO - 'USER': 'cltbld', 06:50:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:26 INFO - '_': '/tools/buildbot/bin/python'} 06:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:26 INFO - Downloading/unpacking flake8 06:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:29 INFO - no previously-included directories found matching 'docs/_build' 06:50:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:29 INFO - Running setup.py install for pep8 06:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:29 INFO - no previously-included directories found matching 'docs/_build' 06:50:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:50:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:29 INFO - Cleaning up... 06:50:29 INFO - Return code: 0 06:50:29 INFO - Running post-action listener: _resource_record_post_action 06:50:29 INFO - Running post-action listener: _start_resource_monitoring 06:50:29 INFO - Starting resource monitoring. 06:50:29 INFO - ##### 06:50:29 INFO - ##### Finished create-virtualenv step (success) 06:50:29 INFO - ##### 06:50:29 INFO - ##### 06:50:29 INFO - ##### Running install step. 06:50:29 INFO - ##### 06:50:29 INFO - Running pre-action listener: _resource_record_pre_action 06:50:29 INFO - Running main action method: install 06:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:30 INFO - Reading from file tmpfile_stdout 06:50:30 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:50:30 INFO - Reading from file tmpfile_stdout 06:50:30 INFO - Output received: 06:50:30 INFO - Usage: mozinstall [options] installer 06:50:30 INFO - Options: 06:50:30 INFO - -h, --help show this help message and exit 06:50:30 INFO - -d DEST, --destination=DEST 06:50:30 INFO - Directory to install application into. [default: 06:50:30 INFO - "/builds/slave/test"] 06:50:30 INFO - --app=APP Application being installed. [default: firefox] 06:50:30 INFO - mkdir: /builds/slave/test/build/application 06:50:30 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'] 06:50:30 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 06:50:46 INFO - Reading from file tmpfile_stdout 06:50:46 INFO - Output received: 06:50:46 INFO - /builds/slave/test/build/application/firefox/firefox 06:50:46 INFO - Running post-action listener: _resource_record_post_action 06:50:46 INFO - ##### 06:50:46 INFO - ##### Finished install step (success) 06:50:46 INFO - ##### 06:50:46 INFO - ##### 06:50:46 INFO - ##### Running run-tests step. 06:50:46 INFO - ##### 06:50:46 INFO - Running pre-action listener: _resource_record_pre_action 06:50:46 INFO - Running main action method: run_tests 06:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:46 INFO - Python 2.7.3 06:50:46 INFO - Return code: 0 06:50:46 INFO - grabbing minidump binary from tooltool 06:50:46 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')]} 06:50:46 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 0x205b9c0>, '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 0x205c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:46 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 06:50:46 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 06:50:46 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 06:50:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:46 INFO - Return code: 0 06:50:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:50:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:50:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:50:47 INFO - Return code: 0 06:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 06:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 06:50:47 INFO - Using env: {'DISPLAY': ':0', 06:50:47 INFO - 'HOME': '/home/cltbld', 06:50:47 INFO - 'LANG': 'en_US.UTF-8', 06:50:47 INFO - 'LANGUAGE': 'en_US:en', 06:50:47 INFO - 'LOGNAME': 'cltbld', 06:50:47 INFO - 'MAIL': '/var/mail/cltbld', 06:50:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:47 INFO - 'MOZ_NO_REMOTE': '1', 06:50:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:47 INFO - 'NO_EM_RESTART': '1', 06:50:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:47 INFO - 'PWD': '/builds/slave/test', 06:50:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:47 INFO - 'SHELL': '/bin/bash', 06:50:47 INFO - 'SHLVL': '1', 06:50:47 INFO - 'TERM': 'linux', 06:50:47 INFO - 'TMOUT': '86400', 06:50:47 INFO - 'USER': 'cltbld', 06:50:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410', 06:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:47 INFO - '_': '/tools/buildbot/bin/python'} 06:50:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 06:50:47 INFO - mozversion application_buildid: 20160524052203 06:50:47 INFO - mozversion application_changeset: f6e1ee9ac46c73705320caa6a208e6a017f3bdd8 06:50:47 INFO - mozversion application_display_name: Nightly 06:50:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:47 INFO - mozversion application_name: Firefox 06:50:47 INFO - mozversion application_remotingname: firefox 06:50:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:50:47 INFO - mozversion application_vendor: Mozilla 06:50:47 INFO - mozversion application_version: 49.0a1 06:50:47 INFO - mozversion platform_buildid: 20160524052203 06:50:47 INFO - mozversion platform_changeset: f6e1ee9ac46c73705320caa6a208e6a017f3bdd8 06:50:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:50:47 INFO - mozversion platform_version: 49.0a1 06:50:47 INFO - using testdate: 1464097847 06:50:47 INFO - actual date: 1464097847 06:50:47 INFO - starting webserver on 'localhost:44159' 06:50:47 INFO - SUITE-START | Running 2 tests 06:50:47 INFO - TEST-START | dromaeo_css 06:50:47 INFO - operating with platform_type : linux_ 06:50:47 INFO - Initialising browser for dromaeo_css test... 06:50:47 INFO - TEST-INFO | started process 14114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpynDT4i/profile http://localhost:44159/getInfo.html) 06:50:51 INFO - PROCESS | 14114 | __metrics Screen width/height:1600/1200 06:50:51 INFO - PROCESS | 14114 | colorDepth:24 06:50:51 INFO - PROCESS | 14114 | Browser inner width/height: 1024/697 06:50:51 INFO - PROCESS | 14114 | __metrics 06:50:53 ERROR - PROCESS | 14114 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:50:53 INFO - TEST-INFO | 14114: exit 0 06:50:53 INFO - Browser initialized. 06:50:53 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:53 INFO - TEST-INFO | started process 14199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpynDT4i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:05 INFO - PROCESS | 14199 | RSS: Main: 154607616 06:51:05 INFO - PROCESS | 14199 | 06:51:57 INFO - PROCESS | 14199 | 1464097917604 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] 06:54:09 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:44159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44159/tests/dromaeo/cssquery-ext.html) 06:54:10 INFO - PROCESS | 14199 | RSS: Main: 268562432 06:54:10 INFO - PROCESS | 14199 | 06:57:12 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:44159/tests/dromaeo/cssquery-ext.html (next: http://localhost:44159/tests/dromaeo/cssquery-jquery.html) 06:57:13 INFO - PROCESS | 14199 | RSS: Main: 239161344 06:57:13 INFO - PROCESS | 14199 | 07:00:15 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:44159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44159/tests/dromaeo/cssquery-mootools.html) 07:00:16 INFO - PROCESS | 14199 | RSS: Main: 239624192 07:00:16 INFO - PROCESS | 14199 | 07:03:18 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:44159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44159/tests/dromaeo/cssquery-prototype.html) 07:03:18 INFO - PROCESS | 14199 | RSS: Main: 238022656 07:03:18 INFO - PROCESS | 14199 | 07:06:21 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:44159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44159/tests/dromaeo/cssquery-yui.html) 07:06:22 INFO - PROCESS | 14199 | RSS: Main: 213213184 07:06:22 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | Cycle 1(1): loaded http://localhost:44159/tests/dromaeo/cssquery-yui.html (next: http://localhost:44159/tests/dromaeo/cssquery-dojo.html) 07:09:25 INFO - PROCESS | 14199 | RSS: Main: 264404992 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | __start_tp_report 07:09:25 INFO - PROCESS | 14199 | _x_x_mozilla_page_load 07:09:25 INFO - PROCESS | 14199 | _x_x_mozilla_page_load_details 07:09:25 INFO - PROCESS | 14199 | |i|pagename|runs| 07:09:25 INFO - PROCESS | 14199 | |0;dojo.html;2682.088090049383;2682.302601323656;2711.2137480130764;2711.9728802711966;2725.1960671601873;4583.610393116581;4632.675712700112;4653.302004699292;4734.455537613171;4750.382450281463;4721.173794585951;4727.787249573769;4750.121227572901;4803.3995750531185;4810.783514741836;4169.520505141902;4291.699581029329;4366.039471316305;4399.934000989988;4545.159145558082;4467.41923549938;4506.77466126694;4524.977375113136;4534.1158474097565;4547.477040140377;4266.786660666954;4306.160298741715;4397.120575884804;4407.096545208225;4449.087936972913;4373.103513779667;4376.6498680105515;4380;4488.7531185784765;4515.954840451586;4414.028913638995;4418.867433976986;4423.933640995388;4448.710833795825;4458.420405347284;4555.544445555451;4593.954060459419;4668.929966050512;4766.165920963852;4776.211925032366;5070.29015937769;5113.488651134894;5134.974325128351;5207.531322181022;5228.581713462914;5184.377874655028;5212.113940630102;5217.634765566412;5236.188390799432;5243.2659427680155;4713.976430117896;4782.904341913142;4829.734364609945;4844.903101937942;4862.149123903303;5286.920696189561;5324.3078399808555;5375.946240537544;5377.220303056035;5378.704171270618;5090.083784918676;5095.5159259871;5130.615203859726;5140.614453915897;5146.819861304836;5033.144365457881;5035.924461133086;5077.8730531737;5156.871078223075;5163.380394352702;5035.144025515671;5053.9494605054215;5055.848324550269;5061.417936937226;5092.185250359925;5026.572741316956;5037.269595908573;5040.747962601855;5041.546260836542;5085.542301192911;4117.97941010293;4137.441445404892;4138.275801734684;4279.657627389802;4297.076128632359;3771.8114094295174;3776.5656949450618;3826.1391186982705;3848.037990502374;3860.8841734748003;4486.035502367007;4486.528914463935;4494.752788596658;4497.595216430472;4545;4984.526469985346;5132.127538318495;5202.167653175474;5225.451327610622;5265.236540701577;4438.423005009328;4455.108978204372;4474.463064432289;4516.751578663205;4521.299198624219;4612.700174488715;4623.237165867594;4627.884302892455;4631.073785242965;4668.439787225487;4728.787204575871;4831.4685384608365;4870.975645121752;4879.926801098058;4893.584045356042;5178.585713143015;5194.922076168785;5201.947980520146;5203.843884683465;5240.873212259383;4901.166801643801;4908.312836203006;4908.779104940358;4910.21436570147;4954.900901981868;4962.950370496394;4970.030843985388;4972.055309491185;4990.126727822544;5106.438291787826;4998.775055122455;5000.549950504472;5014.0974624567925;5025.120603894231;5065.924011139909;4875.902921842699;4885.731284779371;4891.657583969088;4897.90204195907;4945.208766597327;4845.903081938271;4904.435989861212;4909.386326709161;4946.925796113133;4961.231009193581;4831.492693267156;4861.854144375674;4928.260760885896;4935.506449355035;4941.876453088702;4876.390451193601;4971.254311853251;4991.425986011655;5030.798768049237;5039.496050394931;4743.193657078236;4777.8327758528285;4814.903701926012;4910.238912968495;4911.140550403737 07:09:25 INFO - PROCESS | 14199 | |1;ext.html;543.695684656503;582.0018667984407;589.9233099697042;590.8847774683938;598.9431004054615;39901.60098399015;41906.16187676248;42093.15813683724;42226.944326391815;45467.772661136645;39799.40300895489;40315.39526907091;40366.79816600913;40436.393454098215;40455.59544404555;7646.541207527553;7818.921810781876;7820.843583128334;7822.726204582841;7824.608769561528;7786.649600767979;7879.803004924894;7884.724034658788;7886.132525422199;7887.132415434297;7854.214578542157;7916.247956444128;7919.960400197991;7920.762377128695;7928.246816552418;7820.882686759704;7864.056313242448;7877.133515313311;7878.960605196995;7880.605969701492;7760.06879174497;7838.412119091091;7841.333486653642;7841.9215807841765;7847.882281765778;36320;36894.63105368939;36907.26185476276;36907.63092369069;36946.81526592377;3106.130283520618;3269.2807582331848;3317.154125697956;3358.7648864579487;3671.889843304705;27854;28152.718472815213;28180.295492612644;28614.570781438295;28815.279618009507;3442.6729460701195;3474.3572439098593;3542.3092496963104;3563.6080031196548;3644.7084233261276;165335.1733241326;165536;165753;166004;166288;51459.48540514547;52336.738316308176;52420;52428.21357679638;52448.73775631174;33599.66400336014;34686.13284667853;34749.82625086858;36620.63379366226;36635;12024.639260822189;12093.334866582247;12134.757304853854;12138.514459421702;12175.025997920146;8936.597853096626;8980.640774369083;9018.09819018093;9101.453912765255;9148.085191480799;18688.439346819618;18732.625347492973;18794.154263058193;19014;19072;7065.717371305193;7122.180949190806;7148.356647901714;7148.535345202546;7160.391366733782;853.8206976534873;912.3020889019905;935.0696057422907;947.4552132523827;1019.8674172357546;27770;28745.71254287472;28746;29194.41611167765;29315.560266596018;967.4533888353058;986.1716158426813;990.7721224118493;1080.6433876820631;1090.6069486389883;14735.263236838115;15135.167565783988;15171.244827757937;15232.466863659718;15355.92322038405;368155;369213;370835;371378;372596;50582.24126638103;51152;51199.74400127975;51244.74377628088;51252;1035.089121573011;1167.515481075361;1218.4760552962134;1223.3455101520465;1234.9012079033835;28629.713702862704;29097.85451072731;29526.557101643062;29982.700172998862;29999;43061.13877722491;43356.56643433651;43513.34729978989;43555.34666980061;43560.564394356916;258506;258720;259107;259898.30966058193;260835;22426.327210183066;24520;25605.231843044738;25742.742572574036;25816.741832581432;39914.2017159661;40103.59896400999;40997;41337.379939300336;41400;34834.303313934084;36759;38236.235275294894;38447.423288650134;41639.7918010408;36678.63321366752;36781.816090919376;38041.42937855879;38491.807540962116;38599;36694;36835.447468288534;36942.445863311536;37156.62843371532;37550.06124846901;31968;33640.49539256864;33882.66117338795;34245;34501.65498345085;25545.872270638527;25631;25933.6109958347;26124.34689132787;26339.209823705318 07:09:25 INFO - PROCESS | 14199 | |2;jquery.html;364.71552189292345;368.5890232390884;374.04804771855623;377.32835552716176;382.5982718145946;15605.531834044983;17087.74368384472;17158.656826863455;17471.3011479541;17639.11804409779;15658.451954181606;16759.413420530283;17085.743713844273;17106;17127.743083853722;5018.573421259188;5232.189010703347;5270.710110943896;5280.102382594968;5283.920741188866;3738.9439158412647;3966.0283230608543;5092.719900405476;5698.943010569883;6065.302490213616;6086.6043707159115;6104.908426373608;6112.51099912006;6118.60229085108;6122.602030868002;5859.707014649251;6033.668148251844;6048.243969503812;6081.847953801146;6098.847528811771;3415.2486452980306;4990.8253211137435;5286.682799032032;5305.522502974713;5312.335958005249;20073;20462.386128416172;20477;20485.180592776273;20598.897005515028;1981.0787983587556;2053.435305291042;2188.835837312192;2247.2022432036556;2352.800011998982;12723.936380318131;13195.802062969064;13306.467741290337;13738.793918091236;13767.655808604764;1798.6492633936389;1814.1926842555067;1816.1464111867401;1825.1695478557224;1840.6318736252804;67279.66360168217;68277;69030;70387.64806175936;70737.93893091557;9372.437653740797;9532.857007144898;9721.951390243144;9791.804641944715;10033.598656053677;13452.394642241123;13539.729205415837;13573.660658483617;13586.91304695622;13587.59237222885;6543.738250469928;6549;6586.769463068769;6664.833379165462;6727.654469106101;5941.049432090845;5953.493953013955;5963.79126730571;6101.84745381369;6114.724837382329;6069.874014882339;6180.6600636965395;6188.597741146811;6216.813495595139;6289.685515724287;1652.8264532224184;1694.3222710915732;1750.7899052113828;1785.3487570957377;1795.5959909020366;851.421033697092;952.9714108576753;1000.3347773730388;1008.495752123938;1024.6464969585481;16533;16932.15339233058;16940.83059169417;17162;17437;876.1238761238761;876.6668665907042;898.725888603969;902.2601466797163;942.6512190489562;9651.806963860683;10044.748881277881;10058.547365368577;10076.294659373774;10251.128654064489;403147;403376;410137;411654;427842;64865.67567162134;65705;66688;67310;68078;866.6100254885326;871.1419252036738;887.9600417981206;895.5253715530779;898.5327629632554;14852.811775058186;15233.771493427386;15361.231938403258;15432.382704691687;15544.689106217586;33358;33566.49650255199;33690.49464257989;33728.83135584307;33811.66188338085;40470.79764601158;42640.78679606582;44106;44706.77646611746;44918.3262251073;7214.89177662325;7248.528845625017;7260.782176534713;7387.519811212254;7496.475246732894;7462.47048310351;11263.66209013731;11297.830532542182;11414.201005929504;11456.599019034295;8826.073262307622;9341.346105772802;9555.140037396668;9889.752756181153;10135.189184865341;9490.715278541655;9815.607375704893;9984.500774961078;10050.798984020132;10151.796964060824;9779.168770654574;9843.901560984585;9937.205023598239;9964.402135871871;10107.39355638664;7575.659095340613;7687.730929417444;7742;7760.650770715219;7786.260305271217;9033.50315732641;10065.748356291151;10099.495025248854;10160.390376577428;10192.235582331503 07:09:25 INFO - PROCESS | 14199 | |3;mootools.html;1283.634164263185;1410.992945035275;1418.383003393524;1552.7748476470913;1743.8343357381052;6671.332866713326;7493.325600695936;7736.149023607406;7737.381009519239;7911.841763164748;7677.117131529876;7828.412869034831;7839.608019599012;7841.098273698526;7842.64708088136;2185.3443966809973;2211.7345918489805;2214.2914267434426;2216.6231740604135;2216.8226541876693;2127.6702111172717;2150.3871396651957;2165.675148727688;2166.37175219187;2167.5773224221284;2149.892505374725;2159.1147629471843;2175.41263858758;2180.5202855371795;2183.9298743615595;2109.177420805879;2115.090511080235;2119.9152033918626;2120.9045592948355;2122.3208573256566;2071.3785864240817;2093.340597711716;2112.7992840680113;2113.1019316790303;2117.502386939068;7629.8855517167285;7650.885236721454;7676.80807979805;7690.500117492401;7693.269139431745;4281.12236991416;4488.41650585425;4493.123840851035;4495.685302028859;4504.436945381827;2937.104183224116;2945.484540205477;2953.867075981586;3015.54766784984;3017.683143269947;883.6023789294778;883.9160279773412;911.2072496927715;911.5624500239855;912.8904531456201;10461.320014199053;10536.315139515908;10577.153827693843;10581;10587.047165755042;3967.206558688274;4025.81883815229;4060.8578699745367;4098.631123198927;4099.528554216304;8434.367422443342;8442.493450392996;8468.195521425454;8471.788205294793;8484.15158484159;4302.634276086505;4350.282203436397;4352.086061926968;4352.608265256142;4357.586029327209;3411.403004474207;3753.5495740511315;3815.809209539512;3858.961410385916;3894.065424298148;3398.9830050850082;3438.8452519636176;3482.3383557124066;3508.2808024354945;3510.947335789965;996.5515518016921;1011.1910471622673;1013.9138173255209;1014.705735336744;1015.7866847961863;697.2051860878502;737.3548145372799;801.4870482890955;842.1662554071426;848.5799529232946;4978.726170060681;5057.772400241998;5088.66923649969;5116.488351164854;5170.793168273302;404.76321352008813;405.76871183425163;405.8680928698185;416.46947468054776;568.2527476368645;3500.4749287606555;3708.981455092707;3727.8322475488667;3734.477173195755;3806.448065030555;9398.906010939803;9700.417974921527;9710.660126895526;9770.12068913787;9811.509424528746;9634.470104144199;9642.373245739145;9648.903510964801;9649.421034737798;9672.613095476103;6955.791326260221;7213.89179162313;7232.276772322725;7240.275972402823;7248.782536523807;5152.227165925141;5283.2075188722;5284.630075894651;5343.118385466354;5479.808206712746;8930.508822014592;8944.642214311614;8977.955110224668;9043.412178208395;9060.773480663036;8957.776055598402;9218.907810921804;9223.49270790113;9312.627494900127;9314.627414903329;6153.261608606996;6237.594556353823;6278.623282603058;6281.12064311006;6284.340144284784;7474.738384156529;7528.887066694114;7538.585377804274;7545.924540754522;7550.5469671819865;5108.489151084862;6427.260865000398;6437.098806167047;6635.6350400728425;6871.931280687129;6140.8771824564155;6152.138700581832;6318.968405158129;6344.492440604648;6363;5906.970465147819;5958.285005799332;5971.701414929149;5973.193618861398;5987.6108052976415;4216.894577635584;4306.655467562525;4389.385486031894;4500.369948207319;4525.004499010212;4544.295634176708;4552.998340365114;4629.60648344881;4664.580187783115;4665.183592871302 07:09:25 INFO - PROCESS | 14199 | |4;prototype.html;294.7008786082127;301.4769375134142;303.09979361296956;304.193886201566;304.99390012199757;4757.310190022445;4792.329073929653;4812.7246279735855;4825.252085926687;4843.53986371295;4702.90594188116;4712.410948631421;4725.510764773462;4726.338312636225;4760.9761951190285;3570.2859428114416;3668.651478109589;3732.6267373262726;3803.1442925341717;3824.4836947012213;3763.849446022156;3788.545374555057;3790.180713257624;3798.2403519296113;3802.756373739493;3718.6467285607823;3730.104774854029;3741.457488664142;3763.6424539668687;3768.924621507568;3585.2112535242336;3667.046567892354;3750.7374483786148;3757.3988161893967;3763.435484677293;3322.6178989416285;3345.280764635591;3349.9665003349896;3352.6312105668358;3354.228527438678;4556.2937744649635;4561.2245918193985;4565.840195593139;4567.7259364437905;4578.313253012042;4160.604742549453;4225.9788701056295;4268.722533035343;4292.699511034229;4305.5694430557005;4914.140025495524;4931.43288521821;4940.407151141886;4945.763559110223;4947.431045429749;3637.6358865425464;3642.4718415829557;3644.3804553226014;3647.2705458908326;3669.724770642186;4941.876453088666;5173.379194496684;5207.229541955715;5217.686938783685;5227.242049902781;3625.0756057205244;3633.800140992218;3638.3632864248652;3646.6171052039153;3655.5430571178604;3648.5621725392593;3654.7076233901225;3679.9080022999638;3681.6134305897494;3690.1143725505685;4190.706650534434;4190.916181676349;4200.600942910419;4227.619514243733;4239.834045637413;4766.380370551806;4945.752712364368;5007.273945277914;5015.14742493777;5016.398032236155;1268.0489632775418;1278.9168704034207;1284.1652925598248;1287.4850059975897;1287.7553264879643;814.6252723747143;826.7726375246855;831.9958400208081;928.2852203803034;940.2243149401771;4352.934705979413;4446.510883802779;4447.465624359591;4456.665750068758;4471.642268618502;5044.267242240716;5080.212567052113;5084.339035925306;5113.284140220372;5134.589232861362;4190.004147034885;4387.561243875651;4410.580994805488;4444.2444784386735;4471.418715566955;2696.7055813209768;2709.498742732601;2731.658542682165;2749.752522272965;2755.600437936488;4816.590589799906;4888.731119788375;4899.559039686445;4910.312556242129;4912.729799861042;4994.400671919393;5138.974305128525;5157.149070403417;5177.896442071137;5191.454897235812;4833.637477189295;4837.95162048382;4861.538153875376;4869.172240719086;4872.488388719134;5080.771365288497;5089.185730283137;5101.591872650253;5108.514691104339;5110.182370820651;4777.3311736356245;4991.301217829434;5024.949750502448;5029.5221953914315;5038.395392552917;4889.364382630378;4893.657443979029;4899.730514821719;4903.283850652243;4917.786995851952;3661.8352174151696;3682.3371793077504;3700.389435743072;3714.6285371462636;3718.4422336648636;5101.566366858859;5216.382921294259;5217.947820521898;5221.138512145605;5221.216817477409;5023.2418653470995;5040.798368065236;5041.6470847040355;5046.1926091825135;5055.115354812967;4978.27814966835;5008.3238762768015;5039.773210205476;5054.671446355975;5059;4750.738709370879;4911.803527858846;4988.351514303117;4992.326035985241;4996.3504744383;4817.373741413594;4901.485344038824;5021.171506701499;5031.899362012666;5055.51972562606;4911.631627628014;4945.851624451272;4955.8265460710145;4963.677360971526;4987.202047672355 07:09:25 INFO - PROCESS | 14199 | |5;yui.html;625.6746491824251;712.1098626716604;742.2317900972491;747.6710247491103;754.4718696912163;12319.938400308009;12352.691182720426;12478.500859965614;12919.612411627655;13149;13864.584062478141;13883.791743123837;13972.37124329405;14015.229162396065;14051;633.7560039384847;812.3825892321848;814.3973459639853;818.8976377952756;820.274057459147;785.242241237206;824.583585289431;824.6660102658433;825.4345773145415;825.5872063968015;850.107387243395;856.0070318430621;857.8112815180682;858.8196478739441;859.5745106172423;661.9371159739817;821.4906757810136;848.8259906719138;849.3120572336396;849.9915000849974;619.9938000620026;622.7882519943196;623.1245100633618;623.2147494157349;623.6133597169738;12600.243985360816;12707.364631768374;12711.411073615798;12714.237145771283;12742.044346674036;11246.66260012201;11735.7066073348;11782.469788859522;11828.763424731456;12213.328266945315;10988.835167472495;10999;11158.944205279004;11213.831792523037;11407.54369825206;4071.4096456013713;4105;4148.688848336386;4207.305794543897;4268.701190916637;51201.23198151994;51341.22988155181;51553;52019;52076;9720.125188733047;9756.658516951873;9969.252306077073;10054.899451005542;10405.84391234132;16921.576960576083;16943.89864658793;16983.320667173422;17036.2333694984;17040.914795425942;6359.777407790705;6499.09012738217;6519.152510173647;6570.080188773575;6656;3640.8179591020344;3698.7410881238593;3699.8890033299044;3704.1850792825535;3706.8887933362043;2714.429969706384;2763.991143232706;2798.860056997142;2810.297425643589;2811.479876222905;492.32797231778363;494.92823540586414;501.39081016565046;506.8352785344704;507.8197239979828;542.5361316074778;545.6753231827057;569.7977218087602;571.1718008887048;576.665533990293;7267.273272672691;7417.816512938651;7573.545587264782;7598;7630.38956883448;517.1776874769135;528.8651393894532;555.2199160179954;557.3521303071408;570.395380896243;3545.9290814183573;3569.9323717757125;3590.461430785403;3603.837827297778;3621.764585301947;58026.709866451245;61425.38574614286;61841.690791545756;62178.68910655418;62356.68821655953;53841;54334;54911.72544137254;55945.440545594836;56537.71731141318;42016.579834201264;43094.353584696255;46501.3024804635;46994;50417;8134.87797683047;8271.966004249469;8331.33349332064;8391.790205244673;8444;28124;29088.400137991768;29777.25556861096;31893.20266993344;32367.51448728224;41619.7919010403;41909.79045104755;41968;41993;42647.36028959506;10938.671839844817;11030.669079927615;11053.171012173958;11072.778544429228;11118.277311974696;11408.258463199865;11494.655160345203;11984.520619175135;12262.38688065611;12302.876971230173;10920.2901811382;10983;10997.34015959045;11393.544258229578;11652.126090543074;10860.891391085988;11023.724406889893;11385.829212561985;11769.529218831492;11916.821247681464;10260.384376937407;10621.840672390075;10669.093127084285;10680.519376628226;10918.290311129751;8971.327150463872;9418.858717119112;9682.612695492102;9891.901080989099;9914.30599858003;9283.535823208947;9514.619415223313;9695.806083878142;9788.608455661693;9935.751606209613 07:09:25 INFO - PROCESS | 14199 | __end_tp_report 07:09:25 INFO - PROCESS | 14199 | __start_cc_report 07:09:25 INFO - PROCESS | 14199 | _x_x_mozilla_cycle_collect,1042 07:09:25 INFO - PROCESS | 14199 | __end_cc_report 07:09:25 INFO - PROCESS | 14199 | __startTimestamp1464098965411__endTimestamp 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | ------- Summary: start ------- 07:09:25 INFO - PROCESS | 14199 | Number of tests: 6 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | [#0] dojo.html Cycles:165 Average:4728.68 Median:4862.15 stddev:494.87 (10.2%) stddev-sans-first:469.62 07:09:25 INFO - PROCESS | 14199 | Values: 2682.1 2682.3 2711.2 2712.0 2725.2 4583.6 4632.7 4653.3 4734.5 4750.4 4721.2 4727.8 4750.1 4803.4 4810.8 4169.5 4291.7 4366.0 4399.9 4545.2 4467.4 4506.8 4525.0 4534.1 4547.5 4266.8 4306.2 4397.1 4407.1 4449.1 4373.1 4376.6 4380.0 4488.8 4516.0 4414.0 4418.9 4423.9 4448.7 4458.4 4555.5 4594.0 4668.9 4766.2 4776.2 5070.3 5113.5 5135.0 5207.5 5228.6 5184.4 5212.1 5217.6 5236.2 5243.3 4714.0 4782.9 4829.7 4844.9 4862.1 5286.9 5324.3 5375.9 5377.2 5378.7 5090.1 5095.5 5130.6 5140.6 5146.8 5033.1 5035.9 5077.9 5156.9 5163.4 5035.1 5053.9 5055.8 5061.4 5092.2 5026.6 5037.3 5040.7 5041.5 5085.5 4118.0 4137.4 4138.3 4279.7 4297.1 3771.8 3776.6 3826.1 3848.0 3860.9 4486.0 4486.5 4494.8 4497.6 4545.0 4984.5 5132.1 5202.2 5225.5 5265.2 4438.4 4455.1 4474.5 4516.8 4521.3 4612.7 4623.2 4627.9 4631.1 4668.4 4728.8 4831.5 4871.0 4879.9 4893.6 5178.6 5194.9 5201.9 5203.8 5240.9 4901.2 4908.3 4908.8 4910.2 4954.9 4963.0 4970.0 4972.1 4990.1 5106.4 4998.8 5000.5 5014.1 5025.1 5065.9 4875.9 4885.7 4891.7 4897.9 4945.2 4845.9 4904.4 4909.4 4946.9 4961.2 4831.5 4861.9 4928.3 4935.5 4941.9 4876.4 4971.3 4991.4 5030.8 5039.5 4743.2 4777.8 4814.9 4910.2 4911.1 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | [#1] ext.html Cycles:180 Average:42597.17 Median:36944.63 stddev:73222.07 (198.2%) stddev-sans-first:73359.40 07:09:25 INFO - PROCESS | 14199 | Values: 543.7 582.0 589.9 590.9 598.9 39901.6 41906.2 42093.2 42226.9 45467.8 39799.4 40315.4 40366.8 40436.4 40455.6 7646.5 7818.9 7820.8 7822.7 7824.6 7786.6 7879.8 7884.7 7886.1 7887.1 7854.2 7916.2 7920.0 7920.8 7928.2 7820.9 7864.1 7877.1 7879.0 7880.6 7760.1 7838.4 7841.3 7841.9 7847.9 36320.0 36894.6 36907.3 36907.6 36946.8 3106.1 3269.3 3317.2 3358.8 3671.9 27854.0 28152.7 28180.3 28614.6 28815.3 3442.7 3474.4 3542.3 3563.6 3644.7 165335.2 165536.0 165753.0 166004.0 166288.0 51459.5 52336.7 52420.0 52428.2 52448.7 33599.7 34686.1 34749.8 36620.6 36635.0 12024.6 12093.3 12134.8 12138.5 12175.0 8936.6 8980.6 9018.1 9101.5 9148.1 18688.4 18732.6 18794.2 19014.0 19072.0 7065.7 7122.2 7148.4 7148.5 7160.4 853.8 912.3 935.1 947.5 1019.9 27770.0 28745.7 28746.0 29194.4 29315.6 967.5 986.2 990.8 1080.6 1090.6 14735.3 15135.2 15171.2 15232.5 15355.9 368155.0 369213.0 370835.0 371378.0 372596.0 50582.2 51152.0 51199.7 51244.7 51252.0 1035.1 1167.5 1218.5 1223.3 1234.9 28629.7 29097.9 29526.6 29982.7 29999.0 43061.1 43356.6 43513.3 43555.3 43560.6 258506.0 258720.0 259107.0 259898.3 260835.0 22426.3 24520.0 25605.2 25742.7 25816.7 39914.2 40103.6 40997.0 41337.4 41400.0 34834.3 36759.0 38236.2 38447.4 41639.8 36678.6 36781.8 38041.4 38491.8 38599.0 36694.0 36835.4 36942.4 37156.6 37550.1 31968.0 33640.5 33882.7 34245.0 34501.7 25545.9 25631.0 25933.6 26124.3 26339.2 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | [#2] jquery.html Cycles:180 Average:24350.91 Median:44406.39 stddev:67482.95 (152.0%) stddev-sans-first:67648.23 07:09:25 INFO - PROCESS | 14199 | Values: 364.7 368.6 374.0 377.3 382.6 15605.5 17087.7 17158.7 17471.3 17639.1 15658.5 16759.4 17085.7 17106.0 17127.7 5018.6 5232.2 5270.7 5280.1 5283.9 3738.9 3966.0 5092.7 5698.9 6065.3 6086.6 6104.9 6112.5 6118.6 6122.6 5859.7 6033.7 6048.2 6081.8 6098.8 3415.2 4990.8 5286.7 5305.5 5312.3 20073.0 20462.4 20477.0 20485.2 20598.9 1981.1 2053.4 2188.8 2247.2 2352.8 12723.9 13195.8 13306.5 13738.8 13767.7 1798.6 1814.2 1816.1 1825.2 1840.6 67279.7 68277.0 69030.0 70387.6 70737.9 9372.4 9532.9 9722.0 9791.8 10033.6 13452.4 13539.7 13573.7 13586.9 13587.6 6543.7 6549.0 6586.8 6664.8 6727.7 5941.0 5953.5 5963.8 6101.8 6114.7 6069.9 6180.7 6188.6 6216.8 6289.7 1652.8 1694.3 1750.8 1785.3 1795.6 851.4 953.0 1000.3 1008.5 1024.6 16533.0 16932.2 16940.8 17162.0 17437.0 876.1 876.7 898.7 902.3 942.7 9651.8 10044.7 10058.5 10076.3 10251.1 403147.0 403376.0 410137.0 411654.0 427842.0 64865.7 65705.0 66688.0 67310.0 68078.0 866.6 871.1 888.0 895.5 898.5 14852.8 15233.8 15361.2 15432.4 15544.7 33358.0 33566.5 33690.5 33728.8 33811.7 40470.8 42640.8 44106.0 44706.8 44918.3 7214.9 7248.5 7260.8 7387.5 7496.5 7462.5 11263.7 11297.8 11414.2 11456.6 8826.1 9341.3 9555.1 9889.8 10135.2 9490.7 9815.6 9984.5 10050.8 10151.8 9779.2 9843.9 9937.2 9964.4 10107.4 7575.7 7687.7 7742.0 7760.7 7786.3 9033.5 10065.7 10099.5 10160.4 10192.2 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | [#3] mootools.html Cycles:180 Average:5013.40 Median:5098.58 stddev:2870.87 (56.3%) stddev-sans-first:2865.24 07:09:25 INFO - PROCESS | 14199 | Values: 1283.6 1411.0 1418.4 1552.8 1743.8 6671.3 7493.3 7736.1 7737.4 7911.8 7677.1 7828.4 7839.6 7841.1 7842.6 2185.3 2211.7 2214.3 2216.6 2216.8 2127.7 2150.4 2165.7 2166.4 2167.6 2149.9 2159.1 2175.4 2180.5 2183.9 2109.2 2115.1 2119.9 2120.9 2122.3 2071.4 2093.3 2112.8 2113.1 2117.5 7629.9 7650.9 7676.8 7690.5 7693.3 4281.1 4488.4 4493.1 4495.7 4504.4 2937.1 2945.5 2953.9 3015.5 3017.7 883.6 883.9 911.2 911.6 912.9 10461.3 10536.3 10577.2 10581.0 10587.0 3967.2 4025.8 4060.9 4098.6 4099.5 8434.4 8442.5 8468.2 8471.8 8484.2 4302.6 4350.3 4352.1 4352.6 4357.6 3411.4 3753.5 3815.8 3859.0 3894.1 3399.0 3438.8 3482.3 3508.3 3510.9 996.6 1011.2 1013.9 1014.7 1015.8 697.2 737.4 801.5 842.2 848.6 4978.7 5057.8 5088.7 5116.5 5170.8 404.8 405.8 405.9 416.5 568.3 3500.5 3709.0 3727.8 3734.5 3806.4 9398.9 9700.4 9710.7 9770.1 9811.5 9634.5 9642.4 9648.9 9649.4 9672.6 6955.8 7213.9 7232.3 7240.3 7248.8 5152.2 5283.2 5284.6 5343.1 5479.8 8930.5 8944.6 8978.0 9043.4 9060.8 8957.8 9218.9 9223.5 9312.6 9314.6 6153.3 6237.6 6278.6 6281.1 6284.3 7474.7 7528.9 7538.6 7545.9 7550.5 5108.5 6427.3 6437.1 6635.6 6871.9 6140.9 6152.1 6319.0 6344.5 6363.0 5907.0 5958.3 5971.7 5973.2 5987.6 4216.9 4306.7 4389.4 4500.4 4525.0 4544.3 4553.0 4629.6 4664.6 4665.2 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | [#4] prototype.html Cycles:180 Average:4155.49 Median:4759.14 stddev:1195.24 (25.1%) stddev-sans-first:1162.94 07:09:25 INFO - PROCESS | 14199 | Values: 294.7 301.5 303.1 304.2 305.0 4757.3 4792.3 4812.7 4825.3 4843.5 4702.9 4712.4 4725.5 4726.3 4761.0 3570.3 3668.7 3732.6 3803.1 3824.5 3763.8 3788.5 3790.2 3798.2 3802.8 3718.6 3730.1 3741.5 3763.6 3768.9 3585.2 3667.0 3750.7 3757.4 3763.4 3322.6 3345.3 3350.0 3352.6 3354.2 4556.3 4561.2 4565.8 4567.7 4578.3 4160.6 4226.0 4268.7 4292.7 4305.6 4914.1 4931.4 4940.4 4945.8 4947.4 3637.6 3642.5 3644.4 3647.3 3669.7 4941.9 5173.4 5207.2 5217.7 5227.2 3625.1 3633.8 3638.4 3646.6 3655.5 3648.6 3654.7 3679.9 3681.6 3690.1 4190.7 4190.9 4200.6 4227.6 4239.8 4766.4 4945.8 5007.3 5015.1 5016.4 1268.0 1278.9 1284.2 1287.5 1287.8 814.6 826.8 832.0 928.3 940.2 4352.9 4446.5 4447.5 4456.7 4471.6 5044.3 5080.2 5084.3 5113.3 5134.6 4190.0 4387.6 4410.6 4444.2 4471.4 2696.7 2709.5 2731.7 2749.8 2755.6 4816.6 4888.7 4899.6 4910.3 4912.7 4994.4 5139.0 5157.1 5177.9 5191.5 4833.6 4838.0 4861.5 4869.2 4872.5 5080.8 5089.2 5101.6 5108.5 5110.2 4777.3 4991.3 5024.9 5029.5 5038.4 4889.4 4893.7 4899.7 4903.3 4917.8 3661.8 3682.3 3700.4 3714.6 3718.4 5101.6 5216.4 5217.9 5221.1 5221.2 5023.2 5040.8 5041.6 5046.2 5055.1 4978.3 5008.3 5039.8 5054.7 5059.0 4750.7 4911.8 4988.4 4992.3 4996.4 4817.4 4901.5 5021.2 5031.9 5055.5 4911.6 4945.9 4955.8 4963.7 4987.2 07:09:25 INFO - PROCESS | 14199 | 07:09:25 INFO - PROCESS | 14199 | [#5] yui.html Cycles:180 Average:13702.71 Median:23743.16 stddev:16450.48 (69.3%) stddev-sans-first:16467.31 07:09:25 INFO - PROCESS | 14199 | Values: 625.7 712.1 742.2 747.7 754.5 12319.9 12352.7 12478.5 12919.6 13149.0 13864.6 13883.8 13972.4 14015.2 14051.0 633.8 812.4 814.4 818.9 820.3 785.2 824.6 824.7 825.4 825.6 850.1 856.0 857.8 858.8 859.6 661.9 821.5 848.8 849.3 850.0 620.0 622.8 623.1 623.2 623.6 12600.2 12707.4 12711.4 12714.2 12742.0 11246.7 11735.7 11782.5 11828.8 12213.3 10988.8 10999.0 11158.9 11213.8 11407.5 4071.4 4105.0 4148.7 4207.3 4268.7 51201.2 51341.2 51553.0 52019.0 52076.0 9720.1 9756.7 9969.3 10054.9 10405.8 16921.6 16943.9 16983.3 17036.2 17040.9 6359.8 6499.1 6519.2 6570.1 6656.0 3640.8 3698.7 3699.9 3704.2 3706.9 2714.4 2764.0 2798.9 2810.3 2811.5 492.3 494.9 501.4 506.8 507.8 542.5 545.7 569.8 571.2 576.7 7267.3 7417.8 7573.5 7598.0 7630.4 517.2 528.9 555.2 557.4 570.4 3545.9 3569.9 3590.5 3603.8 3621.8 58026.7 61425.4 61841.7 62178.7 62356.7 53841.0 54334.0 54911.7 55945.4 56537.7 42016.6 43094.4 46501.3 46994.0 50417.0 8134.9 8272.0 8331.3 8391.8 8444.0 28124.0 29088.4 29777.3 31893.2 32367.5 41619.8 41909.8 41968.0 41993.0 42647.4 10938.7 11030.7 11053.2 11072.8 11118.3 11408.3 11494.7 11984.5 12262.4 12302.9 10920.3 10983.0 10997.3 11393.5 11652.1 10860.9 11023.7 11385.8 11769.5 11916.8 10260.4 10621.8 10669.1 10680.5 10918.3 8971.3 9418.9 9682.6 9891.9 9914.3 9283.5 9514.6 9695.8 9788.6 9935.8 07:09:25 INFO - PROCESS | 14199 | -------- Summary: end -------- 07:09:25 INFO - PROCESS | 14199 | 07:09:26 INFO - TEST-INFO | 14199: exit 0 07:09:26 INFO - TEST-OK | dromaeo_css | took 1118835ms 07:09:26 INFO - TEST-START | kraken 07:09:26 INFO - operating with platform_type : linux_ 07:09:26 INFO - Initialising browser for kraken test... 07:09:26 INFO - TEST-INFO | started process 14374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbKjmFV/profile http://localhost:44159/getInfo.html) 07:09:30 INFO - PROCESS | 14374 | __metrics Screen width/height:1600/1200 07:09:30 INFO - PROCESS | 14374 | colorDepth:24 07:09:30 INFO - PROCESS | 14374 | Browser inner width/height: 1024/697 07:09:30 INFO - PROCESS | 14374 | __metrics 07:09:31 ERROR - PROCESS | 14374 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:09:32 INFO - TEST-INFO | 14374: exit 0 07:09:32 INFO - Browser initialized. 07:09:32 INFO - Running cycle 1/1 for kraken test... 07:09:32 INFO - TEST-INFO | started process 14454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbKjmFV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:44 INFO - PROCESS | 14454 | RSS: Main: 154775552 07:09:44 INFO - PROCESS | 14454 | 07:09:47 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44159/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:48 INFO - PROCESS | 14454 | RSS: Main: 210149376 07:09:48 INFO - PROCESS | 14454 | 07:09:51 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44159/tests/kraken/driver.html?testName=audio-dft) 07:09:51 INFO - PROCESS | 14454 | RSS: Main: 198311936 07:09:51 INFO - PROCESS | 14454 | 07:09:55 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44159/tests/kraken/driver.html?testName=audio-fft) 07:09:55 INFO - PROCESS | 14454 | RSS: Main: 267436032 07:09:55 INFO - PROCESS | 14454 | 07:09:57 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44159/tests/kraken/driver.html?testName=audio-oscillator) 07:09:58 INFO - PROCESS | 14454 | RSS: Main: 176824320 07:09:58 INFO - PROCESS | 14454 | 07:10:00 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:01 INFO - PROCESS | 14454 | RSS: Main: 180420608 07:10:01 INFO - PROCESS | 14454 | 07:10:04 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44159/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:05 INFO - PROCESS | 14454 | RSS: Main: 215605248 07:10:05 INFO - PROCESS | 14454 | 07:10:09 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44159/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:09 INFO - PROCESS | 14454 | RSS: Main: 214876160 07:10:09 INFO - PROCESS | 14454 | 07:10:12 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44159/tests/kraken/driver.html?testName=json-parse-financial) 07:10:13 INFO - PROCESS | 14454 | RSS: Main: 215576576 07:10:13 INFO - PROCESS | 14454 | 07:10:15 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:15 INFO - PROCESS | 14454 | RSS: Main: 209051648 07:10:15 INFO - PROCESS | 14454 | 07:10:17 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:18 INFO - PROCESS | 14454 | RSS: Main: 211972096 07:10:18 INFO - PROCESS | 14454 | 07:10:20 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:21 INFO - PROCESS | 14454 | RSS: Main: 217882624 07:10:21 INFO - PROCESS | 14454 | 07:10:24 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:25 INFO - PROCESS | 14454 | RSS: Main: 220012544 07:10:25 INFO - PROCESS | 14454 | 07:10:28 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:28 INFO - PROCESS | 14454 | RSS: Main: 218169344 07:10:28 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | Cycle 1(1): loaded http://localhost:44159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44159/tests/kraken/driver.html?testName=ai-astar) 07:10:30 INFO - PROCESS | 14454 | RSS: Main: 264470528 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | __start_tp_report 07:10:30 INFO - PROCESS | 14454 | _x_x_mozilla_page_load 07:10:30 INFO - PROCESS | 14454 | _x_x_mozilla_page_load_details 07:10:30 INFO - PROCESS | 14454 | |i|pagename|runs| 07:10:30 INFO - PROCESS | 14454 | |0;ai-astar;114;108;117;116;114;114;115;113;114;114 07:10:30 INFO - PROCESS | 14454 | |1;audio-beat-detection;167;130;132;233;131;131;161;136;174;130 07:10:30 INFO - PROCESS | 14454 | |2;audio-dft;161;162;164;162;161;162;160;162;161;161 07:10:30 INFO - PROCESS | 14454 | |3;audio-fft;75;76;75;141;77;78;75;78;123;77 07:10:30 INFO - PROCESS | 14454 | |4;audio-oscillator;95;94;162;94;93;94;134;93;94;143 07:10:30 INFO - PROCESS | 14454 | |5;imaging-gaussian-blur;116;118;117;117;119;118;116;117;117;117 07:10:30 INFO - PROCESS | 14454 | |6;imaging-darkroom;146;146;145;146;145;145;145;146;145;146 07:10:30 INFO - PROCESS | 14454 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;94 07:10:30 INFO - PROCESS | 14454 | |8;json-parse-financial;66;66;65;65;65;67;68;67;65;65 07:10:30 INFO - PROCESS | 14454 | |9;json-stringify-tinderbox;64;65;64;64;64;64;64;65;64;65 07:10:30 INFO - PROCESS | 14454 | |10;stanford-crypto-aes;84;87;87;85;87;83;83;84;141;85 07:10:30 INFO - PROCESS | 14454 | |11;stanford-crypto-ccm;133;138;143;131;133;139;132;130;161;141 07:10:30 INFO - PROCESS | 14454 | |12;stanford-crypto-pbkdf2;173;172;174;173;177;179;174;175;177;171 07:10:30 INFO - PROCESS | 14454 | |13;stanford-crypto-sha256-iterative;67;67;70;68;67;72;67;67;69;66 07:10:30 INFO - PROCESS | 14454 | __end_tp_report 07:10:30 INFO - PROCESS | 14454 | __start_cc_report 07:10:30 INFO - PROCESS | 14454 | _x_x_mozilla_cycle_collect,2123 07:10:30 INFO - PROCESS | 14454 | __end_cc_report 07:10:30 INFO - PROCESS | 14454 | __startTimestamp1464099030787__endTimestamp 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | ------- Summary: start ------- 07:10:30 INFO - PROCESS | 14454 | Number of tests: 14 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:2.38 (2.1%) stddev-sans-first:2.52 07:10:30 INFO - PROCESS | 14454 | Values: 114.0 108.0 117.0 116.0 114.0 114.0 115.0 113.0 114.0 114.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:148.50 stddev:33.09 (22.3%) stddev-sans-first:34.68 07:10:30 INFO - PROCESS | 14454 | Values: 167.0 130.0 132.0 233.0 131.0 131.0 161.0 136.0 174.0 130.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 07:10:30 INFO - PROCESS | 14454 | Values: 161.0 162.0 164.0 162.0 161.0 162.0 160.0 162.0 161.0 161.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#3] audio-fft Cycles:10 Average:87.50 Median:76.50 stddev:23.86 (31.2%) stddev-sans-first:24.88 07:10:30 INFO - PROCESS | 14454 | Values: 75.0 76.0 75.0 141.0 77.0 78.0 75.0 78.0 123.0 77.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.00 stddev:26.23 (27.9%) stddev-sans-first:27.29 07:10:30 INFO - PROCESS | 14454 | Values: 95.0 94.0 162.0 94.0 93.0 94.0 134.0 93.0 94.0 143.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 07:10:30 INFO - PROCESS | 14454 | Values: 116.0 118.0 117.0 117.0 119.0 118.0 116.0 117.0 117.0 117.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:10:30 INFO - PROCESS | 14454 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:10:30 INFO - PROCESS | 14454 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 07:10:30 INFO - PROCESS | 14454 | Values: 66.0 66.0 65.0 65.0 65.0 67.0 68.0 67.0 65.0 65.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:10:30 INFO - PROCESS | 14454 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:85.00 stddev:17.78 (20.9%) stddev-sans-first:18.69 07:10:30 INFO - PROCESS | 14454 | Values: 84.0 87.0 87.0 85.0 87.0 83.0 83.0 84.0 141.0 85.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:138.50 stddev:9.21 (6.6%) stddev-sans-first:9.58 07:10:30 INFO - PROCESS | 14454 | Values: 133.0 138.0 143.0 131.0 133.0 139.0 132.0 130.0 161.0 141.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:174.50 stddev:2.51 (1.4%) stddev-sans-first:2.60 07:10:30 INFO - PROCESS | 14454 | Values: 173.0 172.0 174.0 173.0 177.0 179.0 174.0 175.0 177.0 171.0 07:10:30 INFO - PROCESS | 14454 | 07:10:30 INFO - PROCESS | 14454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:1.83 (2.7%) stddev-sans-first:1.90 07:10:30 INFO - PROCESS | 14454 | Values: 67.0 67.0 70.0 68.0 67.0 72.0 67.0 67.0 69.0 66.0 07:10:30 INFO - PROCESS | 14454 | -------- Summary: end -------- 07:10:30 INFO - PROCESS | 14454 | 07:10:31 INFO - TEST-INFO | 14454: exit 0 07:10:31 INFO - TEST-OK | kraken | took 65630ms 07:10:31 INFO - SUITE-END | took 1184s 07:10:31 INFO - Completed test suite (00:19:44) 07:10:31 INFO - javascript benchmark 07:10:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2682.088090049383, 2682.302601323656, 2711.2137480130764, 2711.9728802711966, 2725.1960671601873, 4583.610393116581, 4632.675712700112, 4653.302004699292, 4734.455537613171, 4750.382450281463, 4721.173794585951, 4727.787249573769, 4750.121227572901, 4803.3995750531185, 4810.783514741836, 4169.520505141902, 4291.699581029329, 4366.039471316305, 4399.934000989988, 4545.159145558082, 4467.41923549938, 4506.77466126694, 4524.977375113136, 4534.1158474097565, 4547.477040140377, 4266.786660666954, 4306.160298741715, 4397.120575884804, 4407.096545208225, 4449.087936972913, 4373.103513779667, 4376.6498680105515, 4380.0, 4488.7531185784765, 4515.954840451586, 4414.028913638995, 4418.867433976986, 4423.933640995388, 4448.710833795825, 4458.420405347284, 4555.544445555451, 4593.954060459419, 4668.929966050512, 4766.165920963852, 4776.211925032366, 5070.29015937769, 5113.488651134894, 5134.974325128351, 5207.531322181022, 5228.581713462914, 5184.377874655028, 5212.113940630102, 5217.634765566412, 5236.188390799432, 5243.2659427680155, 4713.976430117896, 4782.904341913142, 4829.734364609945, 4844.903101937942, 4862.149123903303, 5286.920696189561, 5324.3078399808555, 5375.946240537544, 5377.220303056035, 5378.704171270618, 5090.083784918676, 5095.5159259871, 5130.615203859726, 5140.614453915897, 5146.819861304836, 5033.144365457881, 5035.924461133086, 5077.8730531737, 5156.871078223075, 5163.380394352702, 5035.144025515671, 5053.9494605054215, 5055.848324550269, 5061.417936937226, 5092.185250359925, 5026.572741316956, 5037.269595908573, 5040.747962601855, 5041.546260836542, 5085.542301192911, 4117.97941010293, 4137.441445404892, 4138.275801734684, 4279.657627389802, 4297.076128632359, 3771.8114094295174, 3776.5656949450618, 3826.1391186982705, 3848.037990502374, 3860.8841734748003, 4486.035502367007, 4486.528914463935, 4494.752788596658, 4497.595216430472, 4545.0, 4984.526469985346, 5132.127538318495, 5202.167653175474, 5225.451327610622, 5265.236540701577, 4438.423005009328, 4455.108978204372, 4474.463064432289, 4516.751578663205, 4521.299198624219, 4612.700174488715, 4623.237165867594, 4627.884302892455, 4631.073785242965, 4668.439787225487, 4728.787204575871, 4831.4685384608365, 4870.975645121752, 4879.926801098058, 4893.584045356042, 5178.585713143015, 5194.922076168785, 5201.947980520146, 5203.843884683465, 5240.873212259383, 4901.166801643801, 4908.312836203006, 4908.779104940358, 4910.21436570147, 4954.900901981868, 4962.950370496394, 4970.030843985388, 4972.055309491185, 4990.126727822544, 5106.438291787826, 4998.775055122455, 5000.549950504472, 5014.0974624567925, 5025.120603894231, 5065.924011139909, 4875.902921842699, 4885.731284779371, 4891.657583969088, 4897.90204195907, 4945.208766597327, 4845.903081938271, 4904.435989861212, 4909.386326709161, 4946.925796113133, 4961.231009193581, 4831.492693267156, 4861.854144375674, 4928.260760885896, 4935.506449355035, 4941.876453088702, 4876.390451193601, 4971.254311853251, 4991.425986011655, 5030.798768049237, 5039.496050394931, 4743.193657078236, 4777.8327758528285, 4814.903701926012, 4910.238912968495, 4911.140550403737], "value": 4697.534438316413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.695684656503, 582.0018667984407, 589.9233099697042, 590.8847774683938, 598.9431004054615, 39901.60098399015, 41906.16187676248, 42093.15813683724, 42226.944326391815, 45467.772661136645, 39799.40300895489, 40315.39526907091, 40366.79816600913, 40436.393454098215, 40455.59544404555, 7646.541207527553, 7818.921810781876, 7820.843583128334, 7822.726204582841, 7824.608769561528, 7786.649600767979, 7879.803004924894, 7884.724034658788, 7886.132525422199, 7887.132415434297, 7854.214578542157, 7916.247956444128, 7919.960400197991, 7920.762377128695, 7928.246816552418, 7820.882686759704, 7864.056313242448, 7877.133515313311, 7878.960605196995, 7880.605969701492, 7760.06879174497, 7838.412119091091, 7841.333486653642, 7841.9215807841765, 7847.882281765778, 36320.0, 36894.63105368939, 36907.26185476276, 36907.63092369069, 36946.81526592377, 3106.130283520618, 3269.2807582331848, 3317.154125697956, 3358.7648864579487, 3671.889843304705, 27854.0, 28152.718472815213, 28180.295492612644, 28614.570781438295, 28815.279618009507, 3442.6729460701195, 3474.3572439098593, 3542.3092496963104, 3563.6080031196548, 3644.7084233261276, 165335.1733241326, 165536.0, 165753.0, 166004.0, 166288.0, 51459.48540514547, 52336.738316308176, 52420.0, 52428.21357679638, 52448.73775631174, 33599.66400336014, 34686.13284667853, 34749.82625086858, 36620.63379366226, 36635.0, 12024.639260822189, 12093.334866582247, 12134.757304853854, 12138.514459421702, 12175.025997920146, 8936.597853096626, 8980.640774369083, 9018.09819018093, 9101.453912765255, 9148.085191480799, 18688.439346819618, 18732.625347492973, 18794.154263058193, 19014.0, 19072.0, 7065.717371305193, 7122.180949190806, 7148.356647901714, 7148.535345202546, 7160.391366733782, 853.8206976534873, 912.3020889019905, 935.0696057422907, 947.4552132523827, 1019.8674172357546, 27770.0, 28745.71254287472, 28746.0, 29194.41611167765, 29315.560266596018, 967.4533888353058, 986.1716158426813, 990.7721224118493, 1080.6433876820631, 1090.6069486389883, 14735.263236838115, 15135.167565783988, 15171.244827757937, 15232.466863659718, 15355.92322038405, 368155.0, 369213.0, 370835.0, 371378.0, 372596.0, 50582.24126638103, 51152.0, 51199.74400127975, 51244.74377628088, 51252.0, 1035.089121573011, 1167.515481075361, 1218.4760552962134, 1223.3455101520465, 1234.9012079033835, 28629.713702862704, 29097.85451072731, 29526.557101643062, 29982.700172998862, 29999.0, 43061.13877722491, 43356.56643433651, 43513.34729978989, 43555.34666980061, 43560.564394356916, 258506.0, 258720.0, 259107.0, 259898.30966058193, 260835.0, 22426.327210183066, 24520.0, 25605.231843044738, 25742.742572574036, 25816.741832581432, 39914.2017159661, 40103.59896400999, 40997.0, 41337.379939300336, 41400.0, 34834.303313934084, 36759.0, 38236.235275294894, 38447.423288650134, 41639.7918010408, 36678.63321366752, 36781.816090919376, 38041.42937855879, 38491.807540962116, 38599.0, 36694.0, 36835.447468288534, 36942.445863311536, 37156.62843371532, 37550.06124846901, 31968.0, 33640.49539256864, 33882.66117338795, 34245.0, 34501.65498345085, 25545.872270638527, 25631.0, 25933.6109958347, 26124.34689132787, 26339.209823705318], "value": 17082.592618816278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.71552189292345, 368.5890232390884, 374.04804771855623, 377.32835552716176, 382.5982718145946, 15605.531834044983, 17087.74368384472, 17158.656826863455, 17471.3011479541, 17639.11804409779, 15658.451954181606, 16759.413420530283, 17085.743713844273, 17106.0, 17127.743083853722, 5018.573421259188, 5232.189010703347, 5270.710110943896, 5280.102382594968, 5283.920741188866, 3738.9439158412647, 3966.0283230608543, 5092.719900405476, 5698.943010569883, 6065.302490213616, 6086.6043707159115, 6104.908426373608, 6112.51099912006, 6118.60229085108, 6122.602030868002, 5859.707014649251, 6033.668148251844, 6048.243969503812, 6081.847953801146, 6098.847528811771, 3415.2486452980306, 4990.8253211137435, 5286.682799032032, 5305.522502974713, 5312.335958005249, 20073.0, 20462.386128416172, 20477.0, 20485.180592776273, 20598.897005515028, 1981.0787983587556, 2053.435305291042, 2188.835837312192, 2247.2022432036556, 2352.800011998982, 12723.936380318131, 13195.802062969064, 13306.467741290337, 13738.793918091236, 13767.655808604764, 1798.6492633936389, 1814.1926842555067, 1816.1464111867401, 1825.1695478557224, 1840.6318736252804, 67279.66360168217, 68277.0, 69030.0, 70387.64806175936, 70737.93893091557, 9372.437653740797, 9532.857007144898, 9721.951390243144, 9791.804641944715, 10033.598656053677, 13452.394642241123, 13539.729205415837, 13573.660658483617, 13586.91304695622, 13587.59237222885, 6543.738250469928, 6549.0, 6586.769463068769, 6664.833379165462, 6727.654469106101, 5941.049432090845, 5953.493953013955, 5963.79126730571, 6101.84745381369, 6114.724837382329, 6069.874014882339, 6180.6600636965395, 6188.597741146811, 6216.813495595139, 6289.685515724287, 1652.8264532224184, 1694.3222710915732, 1750.7899052113828, 1785.3487570957377, 1795.5959909020366, 851.421033697092, 952.9714108576753, 1000.3347773730388, 1008.495752123938, 1024.6464969585481, 16533.0, 16932.15339233058, 16940.83059169417, 17162.0, 17437.0, 876.1238761238761, 876.6668665907042, 898.725888603969, 902.2601466797163, 942.6512190489562, 9651.806963860683, 10044.748881277881, 10058.547365368577, 10076.294659373774, 10251.128654064489, 403147.0, 403376.0, 410137.0, 411654.0, 427842.0, 64865.67567162134, 65705.0, 66688.0, 67310.0, 68078.0, 866.6100254885326, 871.1419252036738, 887.9600417981206, 895.5253715530779, 898.5327629632554, 14852.811775058186, 15233.771493427386, 15361.231938403258, 15432.382704691687, 15544.689106217586, 33358.0, 33566.49650255199, 33690.49464257989, 33728.83135584307, 33811.66188338085, 40470.79764601158, 42640.78679606582, 44106.0, 44706.77646611746, 44918.3262251073, 7214.89177662325, 7248.528845625017, 7260.782176534713, 7387.519811212254, 7496.475246732894, 7462.47048310351, 11263.66209013731, 11297.830532542182, 11414.201005929504, 11456.599019034295, 8826.073262307622, 9341.346105772802, 9555.140037396668, 9889.752756181153, 10135.189184865341, 9490.715278541655, 9815.607375704893, 9984.500774961078, 10050.798984020132, 10151.796964060824, 9779.168770654574, 9843.901560984585, 9937.205023598239, 9964.402135871871, 10107.39355638664, 7575.659095340613, 7687.730929417444, 7742.0, 7760.650770715219, 7786.260305271217, 9033.50315732641, 10065.748356291151, 10099.495025248854, 10160.390376577428, 10192.235582331503], "value": 8231.377304502192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.634164263185, 1410.992945035275, 1418.383003393524, 1552.7748476470913, 1743.8343357381052, 6671.332866713326, 7493.325600695936, 7736.149023607406, 7737.381009519239, 7911.841763164748, 7677.117131529876, 7828.412869034831, 7839.608019599012, 7841.098273698526, 7842.64708088136, 2185.3443966809973, 2211.7345918489805, 2214.2914267434426, 2216.6231740604135, 2216.8226541876693, 2127.6702111172717, 2150.3871396651957, 2165.675148727688, 2166.37175219187, 2167.5773224221284, 2149.892505374725, 2159.1147629471843, 2175.41263858758, 2180.5202855371795, 2183.9298743615595, 2109.177420805879, 2115.090511080235, 2119.9152033918626, 2120.9045592948355, 2122.3208573256566, 2071.3785864240817, 2093.340597711716, 2112.7992840680113, 2113.1019316790303, 2117.502386939068, 7629.8855517167285, 7650.885236721454, 7676.80807979805, 7690.500117492401, 7693.269139431745, 4281.12236991416, 4488.41650585425, 4493.123840851035, 4495.685302028859, 4504.436945381827, 2937.104183224116, 2945.484540205477, 2953.867075981586, 3015.54766784984, 3017.683143269947, 883.6023789294778, 883.9160279773412, 911.2072496927715, 911.5624500239855, 912.8904531456201, 10461.320014199053, 10536.315139515908, 10577.153827693843, 10581.0, 10587.047165755042, 3967.206558688274, 4025.81883815229, 4060.8578699745367, 4098.631123198927, 4099.528554216304, 8434.367422443342, 8442.493450392996, 8468.195521425454, 8471.788205294793, 8484.15158484159, 4302.634276086505, 4350.282203436397, 4352.086061926968, 4352.608265256142, 4357.586029327209, 3411.403004474207, 3753.5495740511315, 3815.809209539512, 3858.961410385916, 3894.065424298148, 3398.9830050850082, 3438.8452519636176, 3482.3383557124066, 3508.2808024354945, 3510.947335789965, 996.5515518016921, 1011.1910471622673, 1013.9138173255209, 1014.705735336744, 1015.7866847961863, 697.2051860878502, 737.3548145372799, 801.4870482890955, 842.1662554071426, 848.5799529232946, 4978.726170060681, 5057.772400241998, 5088.66923649969, 5116.488351164854, 5170.793168273302, 404.76321352008813, 405.76871183425163, 405.8680928698185, 416.46947468054776, 568.2527476368645, 3500.4749287606555, 3708.981455092707, 3727.8322475488667, 3734.477173195755, 3806.448065030555, 9398.906010939803, 9700.417974921527, 9710.660126895526, 9770.12068913787, 9811.509424528746, 9634.470104144199, 9642.373245739145, 9648.903510964801, 9649.421034737798, 9672.613095476103, 6955.791326260221, 7213.89179162313, 7232.276772322725, 7240.275972402823, 7248.782536523807, 5152.227165925141, 5283.2075188722, 5284.630075894651, 5343.118385466354, 5479.808206712746, 8930.508822014592, 8944.642214311614, 8977.955110224668, 9043.412178208395, 9060.773480663036, 8957.776055598402, 9218.907810921804, 9223.49270790113, 9312.627494900127, 9314.627414903329, 6153.261608606996, 6237.594556353823, 6278.623282603058, 6281.12064311006, 6284.340144284784, 7474.738384156529, 7528.887066694114, 7538.585377804274, 7545.924540754522, 7550.5469671819865, 5108.489151084862, 6427.260865000398, 6437.098806167047, 6635.6350400728425, 6871.931280687129, 6140.8771824564155, 6152.138700581832, 6318.968405158129, 6344.492440604648, 6363.0, 5906.970465147819, 5958.285005799332, 5971.701414929149, 5973.193618861398, 5987.6108052976415, 4216.894577635584, 4306.655467562525, 4389.385486031894, 4500.369948207319, 4525.004499010212, 4544.295634176708, 4552.998340365114, 4629.60648344881, 4664.580187783115, 4665.183592871302], "value": 3958.151512583239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.7008786082127, 301.4769375134142, 303.09979361296956, 304.193886201566, 304.99390012199757, 4757.310190022445, 4792.329073929653, 4812.7246279735855, 4825.252085926687, 4843.53986371295, 4702.90594188116, 4712.410948631421, 4725.510764773462, 4726.338312636225, 4760.9761951190285, 3570.2859428114416, 3668.651478109589, 3732.6267373262726, 3803.1442925341717, 3824.4836947012213, 3763.849446022156, 3788.545374555057, 3790.180713257624, 3798.2403519296113, 3802.756373739493, 3718.6467285607823, 3730.104774854029, 3741.457488664142, 3763.6424539668687, 3768.924621507568, 3585.2112535242336, 3667.046567892354, 3750.7374483786148, 3757.3988161893967, 3763.435484677293, 3322.6178989416285, 3345.280764635591, 3349.9665003349896, 3352.6312105668358, 3354.228527438678, 4556.2937744649635, 4561.2245918193985, 4565.840195593139, 4567.7259364437905, 4578.313253012042, 4160.604742549453, 4225.9788701056295, 4268.722533035343, 4292.699511034229, 4305.5694430557005, 4914.140025495524, 4931.43288521821, 4940.407151141886, 4945.763559110223, 4947.431045429749, 3637.6358865425464, 3642.4718415829557, 3644.3804553226014, 3647.2705458908326, 3669.724770642186, 4941.876453088666, 5173.379194496684, 5207.229541955715, 5217.686938783685, 5227.242049902781, 3625.0756057205244, 3633.800140992218, 3638.3632864248652, 3646.6171052039153, 3655.5430571178604, 3648.5621725392593, 3654.7076233901225, 3679.9080022999638, 3681.6134305897494, 3690.1143725505685, 4190.706650534434, 4190.916181676349, 4200.600942910419, 4227.619514243733, 4239.834045637413, 4766.380370551806, 4945.752712364368, 5007.273945277914, 5015.14742493777, 5016.398032236155, 1268.0489632775418, 1278.9168704034207, 1284.1652925598248, 1287.4850059975897, 1287.7553264879643, 814.6252723747143, 826.7726375246855, 831.9958400208081, 928.2852203803034, 940.2243149401771, 4352.934705979413, 4446.510883802779, 4447.465624359591, 4456.665750068758, 4471.642268618502, 5044.267242240716, 5080.212567052113, 5084.339035925306, 5113.284140220372, 5134.589232861362, 4190.004147034885, 4387.561243875651, 4410.580994805488, 4444.2444784386735, 4471.418715566955, 2696.7055813209768, 2709.498742732601, 2731.658542682165, 2749.752522272965, 2755.600437936488, 4816.590589799906, 4888.731119788375, 4899.559039686445, 4910.312556242129, 4912.729799861042, 4994.400671919393, 5138.974305128525, 5157.149070403417, 5177.896442071137, 5191.454897235812, 4833.637477189295, 4837.95162048382, 4861.538153875376, 4869.172240719086, 4872.488388719134, 5080.771365288497, 5089.185730283137, 5101.591872650253, 5108.514691104339, 5110.182370820651, 4777.3311736356245, 4991.301217829434, 5024.949750502448, 5029.5221953914315, 5038.395392552917, 4889.364382630378, 4893.657443979029, 4899.730514821719, 4903.283850652243, 4917.786995851952, 3661.8352174151696, 3682.3371793077504, 3700.389435743072, 3714.6285371462636, 3718.4422336648636, 5101.566366858859, 5216.382921294259, 5217.947820521898, 5221.138512145605, 5221.216817477409, 5023.2418653470995, 5040.798368065236, 5041.6470847040355, 5046.1926091825135, 5055.115354812967, 4978.27814966835, 5008.3238762768015, 5039.773210205476, 5054.671446355975, 5059.0, 4750.738709370879, 4911.803527858846, 4988.351514303117, 4992.326035985241, 4996.3504744383, 4817.373741413594, 4901.485344038824, 5021.171506701499, 5031.899362012666, 5055.51972562606, 4911.631627628014, 4945.851624451272, 4955.8265460710145, 4963.677360971526, 4987.202047672355], "value": 3777.912196079894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.6746491824251, 712.1098626716604, 742.2317900972491, 747.6710247491103, 754.4718696912163, 12319.938400308009, 12352.691182720426, 12478.500859965614, 12919.612411627655, 13149.0, 13864.584062478141, 13883.791743123837, 13972.37124329405, 14015.229162396065, 14051.0, 633.7560039384847, 812.3825892321848, 814.3973459639853, 818.8976377952756, 820.274057459147, 785.242241237206, 824.583585289431, 824.6660102658433, 825.4345773145415, 825.5872063968015, 850.107387243395, 856.0070318430621, 857.8112815180682, 858.8196478739441, 859.5745106172423, 661.9371159739817, 821.4906757810136, 848.8259906719138, 849.3120572336396, 849.9915000849974, 619.9938000620026, 622.7882519943196, 623.1245100633618, 623.2147494157349, 623.6133597169738, 12600.243985360816, 12707.364631768374, 12711.411073615798, 12714.237145771283, 12742.044346674036, 11246.66260012201, 11735.7066073348, 11782.469788859522, 11828.763424731456, 12213.328266945315, 10988.835167472495, 10999.0, 11158.944205279004, 11213.831792523037, 11407.54369825206, 4071.4096456013713, 4105.0, 4148.688848336386, 4207.305794543897, 4268.701190916637, 51201.23198151994, 51341.22988155181, 51553.0, 52019.0, 52076.0, 9720.125188733047, 9756.658516951873, 9969.252306077073, 10054.899451005542, 10405.84391234132, 16921.576960576083, 16943.89864658793, 16983.320667173422, 17036.2333694984, 17040.914795425942, 6359.777407790705, 6499.09012738217, 6519.152510173647, 6570.080188773575, 6656.0, 3640.8179591020344, 3698.7410881238593, 3699.8890033299044, 3704.1850792825535, 3706.8887933362043, 2714.429969706384, 2763.991143232706, 2798.860056997142, 2810.297425643589, 2811.479876222905, 492.32797231778363, 494.92823540586414, 501.39081016565046, 506.8352785344704, 507.8197239979828, 542.5361316074778, 545.6753231827057, 569.7977218087602, 571.1718008887048, 576.665533990293, 7267.273272672691, 7417.816512938651, 7573.545587264782, 7598.0, 7630.38956883448, 517.1776874769135, 528.8651393894532, 555.2199160179954, 557.3521303071408, 570.395380896243, 3545.9290814183573, 3569.9323717757125, 3590.461430785403, 3603.837827297778, 3621.764585301947, 58026.709866451245, 61425.38574614286, 61841.690791545756, 62178.68910655418, 62356.68821655953, 53841.0, 54334.0, 54911.72544137254, 55945.440545594836, 56537.71731141318, 42016.579834201264, 43094.353584696255, 46501.3024804635, 46994.0, 50417.0, 8134.87797683047, 8271.966004249469, 8331.33349332064, 8391.790205244673, 8444.0, 28124.0, 29088.400137991768, 29777.25556861096, 31893.20266993344, 32367.51448728224, 41619.7919010403, 41909.79045104755, 41968.0, 41993.0, 42647.36028959506, 10938.671839844817, 11030.669079927615, 11053.171012173958, 11072.778544429228, 11118.277311974696, 11408.258463199865, 11494.655160345203, 11984.520619175135, 12262.38688065611, 12302.876971230173, 10920.2901811382, 10983.0, 10997.34015959045, 11393.544258229578, 11652.126090543074, 10860.891391085988, 11023.724406889893, 11385.829212561985, 11769.529218831492, 11916.821247681464, 10260.384376937407, 10621.840672390075, 10669.093127084285, 10680.519376628226, 10918.290311129751, 8971.327150463872, 9418.858717119112, 9682.612695492102, 9891.901080989099, 9914.30599858003, 9283.535823208947, 9514.619415223313, 9695.806083878142, 9788.608455661693, 9935.751606209613], "value": 6070.465904977603, "unit": "score"}], "name": "dromaeo_css", "value": 6256.318028201525, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 117.0, 116.0, 114.0, 114.0, 115.0, 113.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 130.0, 132.0, 233.0, 131.0, 131.0, 161.0, 136.0, 174.0, 130.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 162.0, 161.0, 162.0, 160.0, 162.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 141.0, 77.0, 78.0, 75.0, 78.0, 123.0, 77.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 162.0, 94.0, 93.0, 94.0, 134.0, 93.0, 94.0, 143.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 119.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 67.0, 68.0, 67.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 87.0, 85.0, 87.0, 83.0, 83.0, 84.0, 141.0, 85.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 138.0, 143.0, 131.0, 133.0, 139.0, 132.0, 130.0, 161.0, 141.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 174.0, 173.0, 177.0, 179.0, 174.0, 175.0, 177.0, 171.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 68.0, 67.0, 72.0, 67.0, 67.0, 69.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1583.9999999999998, "alertThreshold": 2.0}]} 07:10:31 INFO - Return code: 0 07:10:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:32 ERROR - # TBPL SUCCESS # 07:10:32 INFO - Running post-action listener: _resource_record_post_action 07:10:32 INFO - ##### 07:10:32 INFO - ##### Finished run-tests step (success) 07:10:32 INFO - ##### 07:10:32 INFO - Running post-run listener: _resource_record_post_run 07:10:32 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 547692544; Read time: 0; Write time: 578608 07:10:32 INFO - TinderboxPrint: CPU usage
13.1% 07:10:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:10:32 INFO - TinderboxPrint: I/O write bytes / time
547,692,544 / 578,608 07:10:32 INFO - TinderboxPrint: CPU idle
8,338.8 (86.9%) 07:10:32 INFO - TinderboxPrint: CPU user
1,210.6 (12.6%) 07:10:32 INFO - TinderboxPrint: Swap in / out
0 / 0 07:10:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236806144; Read time: 0; Write time: 340488 07:10:32 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293564416; Read time: 0; Write time: 229164 07:10:32 INFO - Running post-run listener: _upload_blobber_files 07:10:32 INFO - Blob upload gear active. 07:10:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:10:32 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 07:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:10:33 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:10:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:10:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:36 INFO - (blobuploader) - INFO - Done attempting. 07:10:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:10:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:10:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:37 INFO - (blobuploader) - INFO - Done attempting. 07:10:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:10:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:10:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:38 INFO - (blobuploader) - INFO - Done attempting. 07:10:38 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:38 INFO - Return code: 0 07:10:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94401cc244a637cfa4d42267a33a6e3ec067a692c64cb3b6d03cc9f7ac16926629d6cdb72795098136c6f5c6b27675fbb25171f3c5bf9eaee0646b407eac641d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0b4ba4180f2f46f8e710c56c1ebaef9bf1d3ce10511b0b2315073c12eea3fc26f6293fc4dd4b691eab3137679c7784b857bdc346030b879287e7a2081ed728e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a566551588c86b23f9ee47309ae70a983b8c62f5f9af96b97a37348a4fa14f6974e13e1fa5adc619222ac142b1f1666ef8dff27f30926d56816665e04a1eb65e"} 07:10:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:38 INFO - Contents: 07:10:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94401cc244a637cfa4d42267a33a6e3ec067a692c64cb3b6d03cc9f7ac16926629d6cdb72795098136c6f5c6b27675fbb25171f3c5bf9eaee0646b407eac641d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0b4ba4180f2f46f8e710c56c1ebaef9bf1d3ce10511b0b2315073c12eea3fc26f6293fc4dd4b691eab3137679c7784b857bdc346030b879287e7a2081ed728e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a566551588c86b23f9ee47309ae70a983b8c62f5f9af96b97a37348a4fa14f6974e13e1fa5adc619222ac142b1f1666ef8dff27f30926d56816665e04a1eb65e"} 07:10:38 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:38 INFO - Copying logs to upload dir... 07:10:38 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.567091 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-24 07:10:37.522978) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 07:10:37.526146) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94401cc244a637cfa4d42267a33a6e3ec067a692c64cb3b6d03cc9f7ac16926629d6cdb72795098136c6f5c6b27675fbb25171f3c5bf9eaee0646b407eac641d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0b4ba4180f2f46f8e710c56c1ebaef9bf1d3ce10511b0b2315073c12eea3fc26f6293fc4dd4b691eab3137679c7784b857bdc346030b879287e7a2081ed728e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a566551588c86b23f9ee47309ae70a983b8c62f5f9af96b97a37348a4fa14f6974e13e1fa5adc619222ac142b1f1666ef8dff27f30926d56816665e04a1eb65e"} build_url:https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/BHHJsM8-R6GknXz-jP7aGQ/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/Firefox-Non-PGO/sha512/94401cc244a637cfa4d42267a33a6e3ec067a692c64cb3b6d03cc9f7ac16926629d6cdb72795098136c6f5c6b27675fbb25171f3c5bf9eaee0646b407eac641d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0b4ba4180f2f46f8e710c56c1ebaef9bf1d3ce10511b0b2315073c12eea3fc26f6293fc4dd4b691eab3137679c7784b857bdc346030b879287e7a2081ed728e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a566551588c86b23f9ee47309ae70a983b8c62f5f9af96b97a37348a4fa14f6974e13e1fa5adc619222ac142b1f1666ef8dff27f30926d56816665e04a1eb65e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 07:10:37.551504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:10:37.551929) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1464092862.475226-605290410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:10:37.633692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 07:10:37.634014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 07:10:37.634305) ========= ========= Total master_lag: 0.15 =========