builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1469838734.28 results: success (0) buildid: 20160729155724 builduid: c9204be43ff14b6e98e9574d1a0371d0 revision: ff43d3e4c4fc8732b460ded61155c586e9e32573 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.290337) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.290974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.291271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.306404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.306760) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 17:32:14-- 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% 88.1M=0s 2016-07-29 17:32:14 (88.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.424511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.424824) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023106 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:14.474714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 17:32:14.475065) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ff43d3e4c4fc8732b460ded61155c586e9e32573 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ff43d3e4c4fc8732b460ded61155c586e9e32573 --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=4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 17:32:14,618 truncating revision to first 12 chars 2016-07-29 17:32:14,619 Setting DEBUG logging. 2016-07-29 17:32:14,619 attempt 1/10 2016-07-29 17:32:14,619 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ff43d3e4c4fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 17:32:16,001 unpacking tar archive at: autoland-ff43d3e4c4fc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.798391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 17:32:16.287512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:16.287880) ========= script_repo_revision: ff43d3e4c4fc8732b460ded61155c586e9e32573 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:16.288325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:16.288599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 17:32:16.298291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-29 17:32:16.298654) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:32:16 INFO - MultiFileLogger online at 20160729 17:32:16 in /builds/slave/test 17:32:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 17:32:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:32:16 INFO - {'append_to_log': False, 17:32:16 INFO - 'base_work_dir': '/builds/slave/test', 17:32:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 17:32:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:32:16 INFO - 'branch': 'Autoland-Non-PGO', 17:32:16 INFO - 'buildbot_json_path': 'buildprops.json', 17:32:16 INFO - 'config_files': ('talos/linux_config.py',), 17:32:16 INFO - 'default_actions': ('clobber', 17:32:16 INFO - 'read-buildbot-config', 17:32:16 INFO - 'download-and-extract', 17:32:16 INFO - 'populate-webroot', 17:32:16 INFO - 'create-virtualenv', 17:32:16 INFO - 'install', 17:32:16 INFO - 'run-tests'), 17:32:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:32:16 INFO - 'download_minidump_stackwalk': True, 17:32:16 INFO - 'download_symbols': 'ondemand', 17:32:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:32:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:32:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:32:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:32:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:32:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:32:16 INFO - 'installer_path': 'installer.exe', 17:32:16 INFO - 'log_level': 'info', 17:32:16 INFO - 'log_name': 'talos', 17:32:16 INFO - 'log_to_console': True, 17:32:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:32:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:32:16 INFO - 'opt_config_files': (), 17:32:16 INFO - 'pip_index': False, 17:32:16 INFO - 'sps_profile': False, 17:32:16 INFO - 'sps_profile_interval': 0, 17:32:16 INFO - 'suite': 'dromaeojs-e10s', 17:32:16 INFO - 'system_bits': '32', 17:32:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:32:16 INFO - 'title': 'talos-linux64-ix-030', 17:32:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:32:16 INFO - 'use_talos_json': True, 17:32:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:32:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:32:16 INFO - 'work_dir': 'build'} 17:32:16 INFO - [mozharness: 2016-07-30 00:32:16.531140Z] Running clobber step. 17:32:16 INFO - Running pre-action listener: _resource_record_pre_action 17:32:16 INFO - Running main action method: clobber 17:32:16 INFO - rmtree: /builds/slave/test/build 17:32:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:32:17 INFO - Running post-action listener: _resource_record_post_action 17:32:17 INFO - [mozharness: 2016-07-30 00:32:17.002322Z] Finished clobber step (success) 17:32:17 INFO - [mozharness: 2016-07-30 00:32:17.002424Z] Running read-buildbot-config step. 17:32:17 INFO - Running pre-action listener: _resource_record_pre_action 17:32:17 INFO - Running main action method: read_buildbot_config 17:32:17 INFO - Using buildbot properties: 17:32:17 INFO - { 17:32:17 INFO - "project": "", 17:32:17 INFO - "product": "firefox", 17:32:17 INFO - "script_repo_revision": "production", 17:32:17 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 17:32:17 INFO - "repository": "", 17:32:17 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 17:32:17 INFO - "buildid": "20160729155724", 17:32:17 INFO - "pgo_build": "False", 17:32:17 INFO - "basedir": "/builds/slave/test", 17:32:17 INFO - "buildnumber": 188, 17:32:17 INFO - "slavename": "talos-linux64-ix-030", 17:32:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:32:17 INFO - "platform": "ubuntu64_hw", 17:32:17 INFO - "scheduler": "tests-autoland-linux64-talos", 17:32:17 INFO - "branch": "autoland", 17:32:17 INFO - "repo_path": "integration/autoland", 17:32:17 INFO - "revision": "ff43d3e4c4fc8732b460ded61155c586e9e32573", 17:32:17 INFO - "stage_platform": "linux64", 17:32:17 INFO - "builduid": "c9204be43ff14b6e98e9574d1a0371d0", 17:32:17 INFO - "slavebuilddir": "test" 17:32:17 INFO - } 17:32:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:32:17 INFO - Running post-action listener: _resource_record_post_action 17:32:17 INFO - [mozharness: 2016-07-30 00:32:17.004894Z] Finished read-buildbot-config step (success) 17:32:17 INFO - [mozharness: 2016-07-30 00:32:17.004983Z] Running download-and-extract step. 17:32:17 INFO - Running pre-action listener: _resource_record_pre_action 17:32:17 INFO - Running main action method: download_and_extract 17:32:17 INFO - mkdir: /builds/slave/test/build/tests 17:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:17 INFO - https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:32:17 INFO - Downloaded 1361 bytes. 17:32:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:17 INFO - Using the following test package requirements: 17:32:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:32:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:32:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'jsshell-linux-x86_64.zip'], 17:32:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:32:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:32:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:32:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:32:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:32:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:17 INFO - https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:32:18 INFO - Downloaded 22760926 bytes. 17:32:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:32:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:32:19 INFO - Return code: 0 17:32:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:32:19 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')]} 17:32:19 INFO - https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:32:20 INFO - Downloaded 22760926 bytes. 17:32:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:32:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:32:22 INFO - Return code: 0 17:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:22 INFO - https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:32:23 INFO - Downloaded 14413725 bytes. 17:32:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:32:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:32:23 INFO - Return code: 0 17:32: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')]} 17:32:23 INFO - https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:32:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:32:24 INFO - Downloaded 57170880 bytes. 17:32:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:24 INFO - mkdir: /builds/slave/test/properties 17:32:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:32:24 INFO - Writing to file /builds/slave/test/properties/build_url 17:32:24 INFO - Contents: 17:32:24 INFO - build_url:https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:25 INFO - Running post-action listener: _resource_record_post_action 17:32:25 INFO - Running post-action listener: set_extra_try_arguments 17:32:25 INFO - [mozharness: 2016-07-30 00:32:25.269326Z] Finished download-and-extract step (success) 17:32:25 INFO - [mozharness: 2016-07-30 00:32:25.269559Z] Running populate-webroot step. 17:32:25 INFO - Running pre-action listener: _resource_record_pre_action 17:32:25 INFO - Running main action method: populate_webroot 17:32:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:32:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:32:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:32:25 INFO - '--tppagecycles', 17:32:25 INFO - '7'], 17:32:25 INFO - 'tests': ['tsvgm']}}, 17:32:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:32:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:32:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:32:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:32:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['damp', 'tps']}, 17:32:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'tests': ['damp', 'tps']}, 17:32:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['dromaeo_dom']}, 17:32:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:32:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['basic_compositor_video']}, 17:32:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:32:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['a11yr', 17:32:25 INFO - 'ts_paint', 17:32:25 INFO - 'tpaint', 17:32:25 INFO - 'sessionrestore', 17:32:25 INFO - 'sessionrestore_no_auto_restore', 17:32:25 INFO - 'tabpaint']}, 17:32:25 INFO - 'other-e10s': {'tests': ['a11yr', 17:32:25 INFO - 'ts_paint', 17:32:25 INFO - 'tpaint', 17:32:25 INFO - 'sessionrestore', 17:32:25 INFO - 'sessionrestore_no_auto_restore', 17:32:25 INFO - 'tabpaint']}, 17:32:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:32:25 INFO - 'ts_paint', 17:32:25 INFO - 'tpaint', 17:32:25 INFO - 'sessionrestore', 17:32:25 INFO - 'sessionrestore_no_auto_restore', 17:32:25 INFO - 'tabpaint']}, 17:32:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:32:25 INFO - 'ts_paint', 17:32:25 INFO - 'tpaint', 17:32:25 INFO - 'sessionrestore', 17:32:25 INFO - 'sessionrestore_no_auto_restore', 17:32:25 INFO - 'tabpaint']}, 17:32:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['a11yr', 17:32:25 INFO - 'ts_paint', 17:32:25 INFO - 'tpaint', 17:32:25 INFO - 'sessionrestore', 17:32:25 INFO - 'sessionrestore_no_auto_restore', 17:32:25 INFO - 'tabpaint']}, 17:32:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['a11yr', 17:32:25 INFO - 'ts_paint', 17:32:25 INFO - 'tpaint', 17:32:25 INFO - 'sessionrestore', 17:32:25 INFO - 'sessionrestore_no_auto_restore', 17:32:25 INFO - 'tabpaint']}, 17:32:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['tsvgx', 17:32:25 INFO - 'tsvgr_opacity', 17:32:25 INFO - 'tart', 17:32:25 INFO - 'tscrollx', 17:32:25 INFO - 'cart']}, 17:32:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:32:25 INFO - 'tsvgr_opacity', 17:32:25 INFO - 'tart', 17:32:25 INFO - 'tscrollx', 17:32:25 INFO - 'cart']}, 17:32:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'talos_options': ['--disable-e10s'], 17:32:25 INFO - 'tests': ['tp5o']}, 17:32:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'tests': ['tp5o']}, 17:32:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'talos_options': ['--disable-e10s', 17:32:25 INFO - '--xperf_path', 17:32:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:25 INFO - 'tests': ['tp5n']}, 17:32:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:25 INFO - 'talos_options': ['--xperf_path', 17:32:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:25 INFO - 'tests': ['tp5n']}}, 17:32:25 INFO - 'talos.zip': {'path': '', 17:32:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:32:25 INFO - Running post-action listener: _resource_record_post_action 17:32:25 INFO - [mozharness: 2016-07-30 00:32:25.288242Z] Finished populate-webroot step (success) 17:32:25 INFO - [mozharness: 2016-07-30 00:32:25.288332Z] Running create-virtualenv step. 17:32:25 INFO - Running pre-action listener: _resource_record_pre_action 17:32:25 INFO - Running main action method: create_virtualenv 17:32:25 INFO - Creating virtualenv /builds/slave/test/build/venv 17:32:25 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 17:32:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:32:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:32:25 INFO - Using real prefix '/usr' 17:32:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:32:25 INFO - Installing distribute.............................................................................................................................................................................................done. 17:32:27 INFO - Installing pip.................done. 17:32:27 INFO - Return code: 0 17:32:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:32:27 INFO - Using env: {'DISPLAY': ':0', 17:32:27 INFO - 'HOME': '/home/cltbld', 17:32:27 INFO - 'LANG': 'en_US.UTF-8', 17:32:27 INFO - 'LANGUAGE': 'en_US:en', 17:32:27 INFO - 'LOGNAME': 'cltbld', 17:32:27 INFO - 'MAIL': '/var/mail/cltbld', 17:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:27 INFO - 'MOZ_NO_REMOTE': '1', 17:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:27 INFO - 'NO_EM_RESTART': '1', 17:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:27 INFO - 'PWD': '/builds/slave/test', 17:32:27 INFO - 'SHELL': '/bin/bash', 17:32:27 INFO - 'SHLVL': '1', 17:32:27 INFO - 'TERM': 'linux', 17:32:27 INFO - 'TMOUT': '86400', 17:32:27 INFO - 'USER': 'cltbld', 17:32:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:27 INFO - '_': '/tools/buildbot/bin/python'} 17:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:28 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 17:32:28 INFO - Cleaning up... 17:32:28 INFO - Return code: 0 17:32:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:32:28 INFO - Using env: {'DISPLAY': ':0', 17:32:28 INFO - 'HOME': '/home/cltbld', 17:32:28 INFO - 'LANG': 'en_US.UTF-8', 17:32:28 INFO - 'LANGUAGE': 'en_US:en', 17:32:28 INFO - 'LOGNAME': 'cltbld', 17:32:28 INFO - 'MAIL': '/var/mail/cltbld', 17:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:28 INFO - 'MOZ_NO_REMOTE': '1', 17:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:28 INFO - 'NO_EM_RESTART': '1', 17:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:28 INFO - 'PWD': '/builds/slave/test', 17:32:28 INFO - 'SHELL': '/bin/bash', 17:32:28 INFO - 'SHLVL': '1', 17:32:28 INFO - 'TERM': 'linux', 17:32:28 INFO - 'TMOUT': '86400', 17:32:28 INFO - 'USER': 'cltbld', 17:32:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:28 INFO - '_': '/tools/buildbot/bin/python'} 17:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:28 INFO - Downloading/unpacking psutil>=3.1.1 17:32: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 17:32: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 17:32: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 17:32: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 17:32: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 17:32: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 17:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:32:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:30 INFO - Installing collected packages: psutil 17:32:30 INFO - Running setup.py install for psutil 17:32:30 INFO - building 'psutil._psutil_linux' extension 17:32:30 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 17:32:30 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 17:32:30 INFO - building 'psutil._psutil_posix' extension 17:32:30 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 17:32:30 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 17:32:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:30 INFO - Successfully installed psutil 17:32:30 INFO - Cleaning up... 17:32:30 INFO - Return code: 0 17:32:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:32:30 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')]} 17:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:30 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')]} 17:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:30 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:30 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 17:32:30 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 17:32:30 INFO - Using env: {'DISPLAY': ':0', 17:32:30 INFO - 'HOME': '/home/cltbld', 17:32:30 INFO - 'LANG': 'en_US.UTF-8', 17:32:30 INFO - 'LANGUAGE': 'en_US:en', 17:32:30 INFO - 'LOGNAME': 'cltbld', 17:32:30 INFO - 'MAIL': '/var/mail/cltbld', 17:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:30 INFO - 'MOZ_NO_REMOTE': '1', 17:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:30 INFO - 'NO_EM_RESTART': '1', 17:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:30 INFO - 'PWD': '/builds/slave/test', 17:32:30 INFO - 'SHELL': '/bin/bash', 17:32:30 INFO - 'SHLVL': '1', 17:32:30 INFO - 'TERM': 'linux', 17:32:30 INFO - 'TMOUT': '86400', 17:32:30 INFO - 'USER': 'cltbld', 17:32:30 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:30 INFO - '_': '/tools/buildbot/bin/python'} 17:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:32:32 INFO - Installing collected packages: mozsystemmonitor 17:32:32 INFO - Running setup.py install for mozsystemmonitor 17:32:33 INFO - Successfully installed mozsystemmonitor 17:32:33 INFO - Cleaning up... 17:32:33 INFO - Return code: 0 17:32:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:33 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:33 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==2.5.1'] in /builds/slave/test/build 17:32:33 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==2.5.1 17:32:33 INFO - Using env: {'DISPLAY': ':0', 17:32:33 INFO - 'HOME': '/home/cltbld', 17:32:33 INFO - 'LANG': 'en_US.UTF-8', 17:32:33 INFO - 'LANGUAGE': 'en_US:en', 17:32:33 INFO - 'LOGNAME': 'cltbld', 17:32:33 INFO - 'MAIL': '/var/mail/cltbld', 17:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:33 INFO - 'MOZ_NO_REMOTE': '1', 17:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:33 INFO - 'NO_EM_RESTART': '1', 17:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:33 INFO - 'PWD': '/builds/slave/test', 17:32:33 INFO - 'SHELL': '/bin/bash', 17:32:33 INFO - 'SHLVL': '1', 17:32:33 INFO - 'TERM': 'linux', 17:32:33 INFO - 'TMOUT': '86400', 17:32:33 INFO - 'USER': 'cltbld', 17:32:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:33 INFO - '_': '/tools/buildbot/bin/python'} 17:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:33 INFO - Downloading/unpacking jsonschema==2.5.1 17:32:33 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 17:32:33 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 17:32:33 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 17:32:33 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 17:32:33 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 17:32:33 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 17:32:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:32:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:35 INFO - Downloading functools32-3.2.3-2.tar.gz 17:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:32:35 INFO - warning: no files found matching '*.txt' 17:32:35 INFO - no previously-included directories found matching 'build' 17:32:35 INFO - no previously-included directories found matching 'dist' 17:32:35 INFO - no previously-included directories found matching '.git*' 17:32:35 INFO - Installing collected packages: jsonschema, functools32 17:32:35 INFO - Running setup.py install for functools32 17:32:35 INFO - warning: no files found matching '*.txt' 17:32:35 INFO - no previously-included directories found matching 'build' 17:32:35 INFO - no previously-included directories found matching 'dist' 17:32:35 INFO - no previously-included directories found matching '.git*' 17:32:35 INFO - Successfully installed jsonschema functools32 17:32:35 INFO - Cleaning up... 17:32:35 INFO - Return code: 0 17:32:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:32:35 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')]} 17:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:35 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')]} 17:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:35 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:35 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:32:35 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 functools32==3.2.3-2 17:32:35 INFO - Using env: {'DISPLAY': ':0', 17:32:35 INFO - 'HOME': '/home/cltbld', 17:32:35 INFO - 'LANG': 'en_US.UTF-8', 17:32:35 INFO - 'LANGUAGE': 'en_US:en', 17:32:35 INFO - 'LOGNAME': 'cltbld', 17:32:35 INFO - 'MAIL': '/var/mail/cltbld', 17:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:35 INFO - 'MOZ_NO_REMOTE': '1', 17:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:35 INFO - 'NO_EM_RESTART': '1', 17:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:35 INFO - 'PWD': '/builds/slave/test', 17:32:35 INFO - 'SHELL': '/bin/bash', 17:32:35 INFO - 'SHLVL': '1', 17:32:35 INFO - 'TERM': 'linux', 17:32:35 INFO - 'TMOUT': '86400', 17:32:35 INFO - 'USER': 'cltbld', 17:32:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:35 INFO - '_': '/tools/buildbot/bin/python'} 17:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:32:35 INFO - Cleaning up... 17:32:35 INFO - Return code: 0 17:32:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:32:35 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')]} 17:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:35 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')]} 17:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:35 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:35 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 17:32:35 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 17:32:35 INFO - Using env: {'DISPLAY': ':0', 17:32:35 INFO - 'HOME': '/home/cltbld', 17:32:35 INFO - 'LANG': 'en_US.UTF-8', 17:32:35 INFO - 'LANGUAGE': 'en_US:en', 17:32:35 INFO - 'LOGNAME': 'cltbld', 17:32:35 INFO - 'MAIL': '/var/mail/cltbld', 17:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:35 INFO - 'MOZ_NO_REMOTE': '1', 17:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:35 INFO - 'NO_EM_RESTART': '1', 17:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:35 INFO - 'PWD': '/builds/slave/test', 17:32:35 INFO - 'SHELL': '/bin/bash', 17:32:35 INFO - 'SHLVL': '1', 17:32:35 INFO - 'TERM': 'linux', 17:32:35 INFO - 'TMOUT': '86400', 17:32:35 INFO - 'USER': 'cltbld', 17:32:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:35 INFO - '_': '/tools/buildbot/bin/python'} 17:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:32:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:32:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 INFO - Downloading docopt-0.6.1.tar.gz 17:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:32:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:32:38 INFO - Running setup.py install for blobuploader 17:32:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:32:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:32:38 INFO - Running setup.py install for requests 17:32:39 INFO - Running setup.py install for docopt 17:32:39 INFO - Successfully installed blobuploader requests docopt 17:32:39 INFO - Cleaning up... 17:32:39 INFO - Return code: 0 17:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:39 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')]} 17:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:39 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')]} 17:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:39 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:39 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 17:32:39 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 17:32:39 INFO - Using env: {'DISPLAY': ':0', 17:32:39 INFO - 'HOME': '/home/cltbld', 17:32:39 INFO - 'LANG': 'en_US.UTF-8', 17:32:39 INFO - 'LANGUAGE': 'en_US:en', 17:32:39 INFO - 'LOGNAME': 'cltbld', 17:32:39 INFO - 'MAIL': '/var/mail/cltbld', 17:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:39 INFO - 'MOZ_NO_REMOTE': '1', 17:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:39 INFO - 'NO_EM_RESTART': '1', 17:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:39 INFO - 'PWD': '/builds/slave/test', 17:32:39 INFO - 'SHELL': '/bin/bash', 17:32:39 INFO - 'SHLVL': '1', 17:32:39 INFO - 'TERM': 'linux', 17:32:39 INFO - 'TMOUT': '86400', 17:32:39 INFO - 'USER': 'cltbld', 17:32:39 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:39 INFO - '_': '/tools/buildbot/bin/python'} 17:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:39 INFO - Running setup.py (path:/tmp/pip-C478e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:39 INFO - Running setup.py (path:/tmp/pip-lm9X1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:39 INFO - Running setup.py (path:/tmp/pip-6WkLg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:39 INFO - Running setup.py (path:/tmp/pip-YcUm6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:39 INFO - Running setup.py (path:/tmp/pip-K8rRxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:39 INFO - Running setup.py (path:/tmp/pip-F6sdTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:39 INFO - Running setup.py (path:/tmp/pip-HSZ8l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:40 INFO - Running setup.py (path:/tmp/pip-xQie7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:40 INFO - Running setup.py (path:/tmp/pip-mF1g57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:40 INFO - Running setup.py (path:/tmp/pip-fwPyxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:40 INFO - Running setup.py (path:/tmp/pip-52PDlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:40 INFO - Running setup.py (path:/tmp/pip-qskcC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:40 INFO - Running setup.py (path:/tmp/pip-GUbf1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:40 INFO - Running setup.py (path:/tmp/pip-Q0foA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:40 INFO - Running setup.py (path:/tmp/pip-o1uvMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:40 INFO - Running setup.py (path:/tmp/pip-6brpKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:40 INFO - Running setup.py (path:/tmp/pip-EEfXJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:32:40 INFO - Running setup.py install for manifestparser 17:32:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:32:40 INFO - Running setup.py install for mozcrash 17:32:40 INFO - Running setup.py install for mozdebug 17:32:41 INFO - Running setup.py install for mozdevice 17:32:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Running setup.py install for mozfile 17:32:41 INFO - Running setup.py install for mozhttpd 17:32:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Running setup.py install for mozinfo 17:32:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Running setup.py install for mozInstall 17:32:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Running setup.py install for mozleak 17:32:41 INFO - Running setup.py install for mozlog 17:32:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Running setup.py install for moznetwork 17:32:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:32:41 INFO - Running setup.py install for mozprocess 17:32:41 INFO - Running setup.py install for mozprofile 17:32:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:32:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:32:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:32:42 INFO - Running setup.py install for mozrunner 17:32:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:32:42 INFO - Running setup.py install for mozscreenshot 17:32:42 INFO - Running setup.py install for moztest 17:32:42 INFO - Running setup.py install for mozversion 17:32:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:32:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:32:42 INFO - Cleaning up... 17:32:42 INFO - Return code: 0 17:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:42 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')]} 17:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:42 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')]} 17:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:42 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:42 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 17:32:42 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 17:32:42 INFO - Using env: {'DISPLAY': ':0', 17:32:42 INFO - 'HOME': '/home/cltbld', 17:32:42 INFO - 'LANG': 'en_US.UTF-8', 17:32:42 INFO - 'LANGUAGE': 'en_US:en', 17:32:42 INFO - 'LOGNAME': 'cltbld', 17:32:42 INFO - 'MAIL': '/var/mail/cltbld', 17:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:42 INFO - 'MOZ_NO_REMOTE': '1', 17:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:42 INFO - 'NO_EM_RESTART': '1', 17:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:42 INFO - 'PWD': '/builds/slave/test', 17:32:42 INFO - 'SHELL': '/bin/bash', 17:32:42 INFO - 'SHLVL': '1', 17:32:42 INFO - 'TERM': 'linux', 17:32:42 INFO - 'TMOUT': '86400', 17:32:42 INFO - 'USER': 'cltbld', 17:32:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:42 INFO - '_': '/tools/buildbot/bin/python'} 17:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:42 INFO - Running setup.py (path:/tmp/pip-_bZlx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:42 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)) 17:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:42 INFO - Running setup.py (path:/tmp/pip-rrkaJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:42 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)) 17:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:42 INFO - Running setup.py (path:/tmp/pip-GBEF4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:42 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)) 17:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:42 INFO - Running setup.py (path:/tmp/pip-e52UEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:43 INFO - Running setup.py (path:/tmp/pip-hJRatn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:43 INFO - Running setup.py (path:/tmp/pip-AJZM5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:43 INFO - Running setup.py (path:/tmp/pip-CG6uzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:43 INFO - Running setup.py (path:/tmp/pip-bXh4PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:43 INFO - Running setup.py (path:/tmp/pip-MddvE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:43 INFO - Running setup.py (path:/tmp/pip-dTt7My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:43 INFO - Running setup.py (path:/tmp/pip-3MOXaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:43 INFO - Running setup.py (path:/tmp/pip-FFkKWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:43 INFO - Running setup.py (path:/tmp/pip-qAgLOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:43 INFO - Running setup.py (path:/tmp/pip-9qEMPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:43 INFO - Running setup.py (path:/tmp/pip-zzwWiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:43 INFO - Running setup.py (path:/tmp/pip-zgMHbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:43 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)) 17:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:43 INFO - Running setup.py (path:/tmp/pip-s1G2Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:43 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)) 17:32:43 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)) 17:32:43 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)) 17:32:43 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)) 17:32:43 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)) 17:32:43 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)) 17:32:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:45 INFO - Downloading blessings-1.6.tar.gz 17:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:32:45 INFO - Installing collected packages: blessings 17:32:45 INFO - Running setup.py install for blessings 17:32:46 INFO - Successfully installed blessings 17:32:46 INFO - Cleaning up... 17:32:46 INFO - Return code: 0 17:32:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:46 INFO - Reading from file tmpfile_stdout 17:32:46 INFO - Current package versions: 17:32:46 INFO - argparse == 1.2.1 17:32:46 INFO - blessings == 1.6 17:32:46 INFO - blobuploader == 1.2.4 17:32:46 INFO - docopt == 0.6.1 17:32:46 INFO - functools32 == 3.2.3-2 17:32:46 INFO - jsonschema == 2.5.1 17:32:46 INFO - manifestparser == 1.1 17:32:46 INFO - mozInstall == 1.12 17:32:46 INFO - mozcrash == 0.17 17:32:46 INFO - mozdebug == 0.1 17:32:46 INFO - mozdevice == 0.48 17:32:46 INFO - mozfile == 1.2 17:32:46 INFO - mozhttpd == 0.7 17:32:46 INFO - mozinfo == 0.9 17:32:46 INFO - mozleak == 0.1 17:32:46 INFO - mozlog == 3.3 17:32:46 INFO - moznetwork == 0.27 17:32:46 INFO - mozprocess == 0.23 17:32:46 INFO - mozprofile == 0.28 17:32:46 INFO - mozrunner == 6.12 17:32:46 INFO - mozscreenshot == 0.1 17:32:46 INFO - mozsystemmonitor == 0.3 17:32:46 INFO - moztest == 0.7 17:32:46 INFO - mozversion == 1.4 17:32:46 INFO - psutil == 3.1.1 17:32:46 INFO - requests == 1.2.3 17:32:46 INFO - wsgiref == 0.1.2 17:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32: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')]} 17:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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')]} 17:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:46 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:46 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 17:32:46 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 17:32:46 INFO - Using env: {'DISPLAY': ':0', 17:32:46 INFO - 'HOME': '/home/cltbld', 17:32:46 INFO - 'LANG': 'en_US.UTF-8', 17:32:46 INFO - 'LANGUAGE': 'en_US:en', 17:32:46 INFO - 'LOGNAME': 'cltbld', 17:32:46 INFO - 'MAIL': '/var/mail/cltbld', 17:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:46 INFO - 'MOZ_NO_REMOTE': '1', 17:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:46 INFO - 'NO_EM_RESTART': '1', 17:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:46 INFO - 'PWD': '/builds/slave/test', 17:32:46 INFO - 'SHELL': '/bin/bash', 17:32:46 INFO - 'SHLVL': '1', 17:32:46 INFO - 'TERM': 'linux', 17:32:46 INFO - 'TMOUT': '86400', 17:32:46 INFO - 'USER': 'cltbld', 17:32:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:46 INFO - '_': '/tools/buildbot/bin/python'} 17:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 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)) 17:32:46 INFO - Cleaning up... 17:32:46 INFO - Return code: 0 17:32:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:32: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')]} 17:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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')]} 17:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:46 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 0x24d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2705400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', '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 17:32:46 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 17:32:46 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 17:32:46 INFO - Using env: {'DISPLAY': ':0', 17:32:46 INFO - 'HOME': '/home/cltbld', 17:32:46 INFO - 'LANG': 'en_US.UTF-8', 17:32:46 INFO - 'LANGUAGE': 'en_US:en', 17:32:46 INFO - 'LOGNAME': 'cltbld', 17:32:46 INFO - 'MAIL': '/var/mail/cltbld', 17:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:46 INFO - 'MOZ_NO_REMOTE': '1', 17:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:46 INFO - 'NO_EM_RESTART': '1', 17:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:46 INFO - 'PWD': '/builds/slave/test', 17:32:46 INFO - 'SHELL': '/bin/bash', 17:32:46 INFO - 'SHLVL': '1', 17:32:46 INFO - 'TERM': 'linux', 17:32:46 INFO - 'TMOUT': '86400', 17:32:46 INFO - 'USER': 'cltbld', 17:32:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:46 INFO - '_': '/tools/buildbot/bin/python'} 17:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:32:46 INFO - Cleaning up... 17:32:46 INFO - Return code: 0 17:32:46 INFO - Running post-action listener: _resource_record_post_action 17:32:46 INFO - Running post-action listener: _start_resource_monitoring 17:32:46 INFO - Starting resource monitoring. 17:32:46 INFO - [mozharness: 2016-07-30 00:32:46.778697Z] Finished create-virtualenv step (success) 17:32:46 INFO - [mozharness: 2016-07-30 00:32:46.779172Z] Running install step. 17:32:46 INFO - Running pre-action listener: _resource_record_pre_action 17:32:46 INFO - Running main action method: install 17:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:46 INFO - Reading from file tmpfile_stdout 17:32:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:32:47 INFO - Reading from file tmpfile_stdout 17:32:47 INFO - Output received: 17:32:47 INFO - Usage: mozinstall [options] installer 17:32:47 INFO - Options: 17:32:47 INFO - -h, --help show this help message and exit 17:32:47 INFO - -d DEST, --destination=DEST 17:32:47 INFO - Directory to install application into. [default: 17:32:47 INFO - "/builds/slave/test"] 17:32:47 INFO - --app=APP Application being installed. [default: firefox] 17:32:47 INFO - mkdir: /builds/slave/test/build/application 17:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:33:03 INFO - Reading from file tmpfile_stdout 17:33:03 INFO - Output received: 17:33:03 INFO - /builds/slave/test/build/application/firefox/firefox 17:33:03 INFO - Running post-action listener: _resource_record_post_action 17:33:03 INFO - [mozharness: 2016-07-30 00:33:03.495423Z] Finished install step (success) 17:33:03 INFO - [mozharness: 2016-07-30 00:33:03.495700Z] Running run-tests step. 17:33:03 INFO - Running pre-action listener: _resource_record_pre_action 17:33:03 INFO - Running main action method: run_tests 17:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:33:03 INFO - Python 2.7.3 17:33:03 INFO - Return code: 0 17:33:03 INFO - grabbing minidump binary from tooltool 17:33:03 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')]} 17:33:03 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 0x2794570>, '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 0x2795470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2795900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:33:03 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 17:33:03 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 17:33:03 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 17:33:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:33:03 INFO - Return code: 0 17:33:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:33:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:33:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:33:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:33:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:33:03 INFO - Using env: {'DISPLAY': ':0', 17:33:03 INFO - 'HOME': '/home/cltbld', 17:33:03 INFO - 'LANG': 'en_US.UTF-8', 17:33:03 INFO - 'LANGUAGE': 'en_US:en', 17:33:03 INFO - 'LOGNAME': 'cltbld', 17:33:03 INFO - 'MAIL': '/var/mail/cltbld', 17:33:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:33:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:03 INFO - 'MOZ_NO_REMOTE': '1', 17:33:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:03 INFO - 'NO_EM_RESTART': '1', 17:33:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:03 INFO - 'PWD': '/builds/slave/test', 17:33:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:33:03 INFO - 'SHELL': '/bin/bash', 17:33:03 INFO - 'SHLVL': '1', 17:33:03 INFO - 'TERM': 'linux', 17:33:03 INFO - 'TMOUT': '86400', 17:33:03 INFO - 'USER': 'cltbld', 17:33:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299', 17:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:03 INFO - '_': '/tools/buildbot/bin/python'} 17:33:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:33:03 INFO - mozversion application_buildid: 20160729155724 17:33:03 INFO - mozversion application_changeset: ff43d3e4c4fc8732b460ded61155c586e9e32573 17:33:03 INFO - mozversion application_display_name: Nightly 17:33:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:33:03 INFO - mozversion application_name: Firefox 17:33:03 INFO - mozversion application_remotingname: firefox 17:33:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:33:03 INFO - mozversion application_vendor: Mozilla 17:33:03 INFO - mozversion application_version: 50.0a1 17:33:03 INFO - mozversion platform_buildid: 20160729155724 17:33:03 INFO - mozversion platform_changeset: ff43d3e4c4fc8732b460ded61155c586e9e32573 17:33:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:33:03 INFO - mozversion platform_version: 50.0a1 17:33:03 INFO - using testdate: 1469838783 17:33:03 INFO - actual date: 1469838783 17:33:03 INFO - starting webserver on 'localhost:45028' 17:33:03 INFO - SUITE-START | Running 2 tests 17:33:03 INFO - TEST-START | dromaeo_css 17:33:03 INFO - operating with platform_type : linux_ 17:33:03 INFO - Initialising browser for dromaeo_css test... 17:33:03 INFO - TEST-INFO | started process 30406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxVnEPT/profile http://localhost:45028/getInfo.html) 17:33:07 INFO - PROCESS | 30406 | JavaScript error: , line 0: uncaught exception: undefined 17:33:08 INFO - PROCESS | 30406 | __metrics Screen width/height:1600/1200 17:33:08 INFO - PROCESS | 30406 | colorDepth:24 17:33:08 INFO - PROCESS | 30406 | Browser inner width/height: 1024/697 17:33:08 INFO - PROCESS | 30406 | __metrics 17:33:09 ERROR - PROCESS | 30406 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:33:10 INFO - TEST-INFO | 30406: exit 0 17:33:10 INFO - Browser initialized. 17:33:10 INFO - Running cycle 1/1 for dromaeo_css test... 17:33:10 INFO - TEST-INFO | started process 30523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxVnEPT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:22 INFO - PROCESS | 30523 | RSS: Main: 166338560 17:33:22 INFO - PROCESS | 30523 | 17:34:11 INFO - PROCESS | 30523 | 1469838851699 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] 17:36:24 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45028/tests/dromaeo/cssquery-ext.html) 17:36:25 INFO - PROCESS | 30523 | RSS: Main: 167833600 17:36:25 INFO - PROCESS | 30523 | 17:39:27 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-ext.html (next: http://localhost:45028/tests/dromaeo/cssquery-jquery.html) 17:39:28 INFO - PROCESS | 30523 | RSS: Main: 167829504 17:39:28 INFO - PROCESS | 30523 | 17:42:30 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45028/tests/dromaeo/cssquery-mootools.html) 17:42:31 INFO - PROCESS | 30523 | RSS: Main: 171347968 17:42:31 INFO - PROCESS | 30523 | 17:45:33 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45028/tests/dromaeo/cssquery-prototype.html) 17:45:33 INFO - PROCESS | 30523 | RSS: Main: 166248448 17:45:33 INFO - PROCESS | 30523 | 17:48:36 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45028/tests/dromaeo/cssquery-yui.html) 17:48:37 INFO - PROCESS | 30523 | RSS: Main: 168075264 17:48:37 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:45028/tests/dromaeo/cssquery-yui.html (next: http://localhost:45028/tests/dromaeo/cssquery-dojo.html) 17:51:39 INFO - PROCESS | 30523 | RSS: Main: 171356160 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | __start_tp_report 17:51:39 INFO - PROCESS | 30523 | _x_x_mozilla_page_load 17:51:39 INFO - PROCESS | 30523 | _x_x_mozilla_page_load_details 17:51:39 INFO - PROCESS | 30523 | |i|pagename|runs| 17:51:39 INFO - PROCESS | 30523 | |0;dojo.html;2690.488807126646;2697.1908427471776;2725.6456660634117;2726.6727992640886;2730.331068888123;4719.4100737407825;4861.489543597924;4886.8778280543;4921.188003979343;4941;4849.8545043648655;4850.9029819403595;4868.537488938554;4882.6093912487;4908.484609116045;4423.049044455442;4480.283154695249;4505.414296141497;4522.4346956630425;4588.747618880977;4582.1293954148605;4620.052889157714;4628.213203755369;4628.421447319085;4633.513481084488;4337.154254920292;4404.7357158570585;4425.203463376591;4508.61676757476;4579.198640237945;4439.089986552749;4462.241418958753;4506.346579745951;4509.458864936229;4515.525869783658;4409.977950110261;4415.668824838118;4423.137488189805;4442.067165895166;4497.168023915586;4729.787159577792;4751.073540659573;4751.976240118812;4752.168370535177;4799.520047995207;5079.898402031976;5082.186850104003;5098.133317336024;5122.871928201787;5128.384593848762;5097.439281679012;5121.974390128063;5130.4613015633195;5171.276021357013;5181.481851814826;4747.738874361943;4797.160496913027;4828.275758636232;4836.758162091881;4850.175470170079;5299.8410047698635;5305.495977882095;5308.177232528964;5335.9466405336225;5372.355317361941;5068.619853510928;5089;5089.083964886356;5089.694618322913;5123.897522049539;4951.009798040406;4974.8756281093265;4986.601071914238;5185.896282074337;5195.402528709171;5033.370828646419;5121.462246464068;5145.562627176657;5172.456892026358;5265;5189.792408303701;5191.454897235812;5198.558122559549;5198.7140707260705;5204.375474943031;4437.06821567468;4442.955570444319;4443.400140980926;4453.265211240109;4500.482444518857;3753.6997040236715;3834.539855217392;3864.265789499986;3885.3589157789215;3998.140399814054;4452.1763473757455;4511.751853648016;4530.546945305509;4547.2042392581825;4586.862394128181;5275.57795376369;5286.418493965661;5290.391604965402;5297.5232229099565;5346.652467589594;4345.34819777036;4447.799094244536;4488.349189367524;4502.5047244803045;4555.749433781108;4729.07782982322;4739.431268247763;4757.666963312535;4776.713397196179;4806.375171227788;4889.2910527973245;4893.168161412497;4896;4905.117078925828;4935.62982776286;5073.137566613758;5104.438511763628;5120.4111527174855;5120.923186152137;5196.116660167856;4772.0455908817685;4787.521247875185;4801.663883528259;4808.014357056725;4855.344528488608;5086.18621020635;5086.720230387216;5093.592512598909;5098.260752190986;5137.974310128426;5094.108531007133;5188.507091826271;5201.089809283436;5232.921506177334;5277.393099793419;5025.84922452327;5096.923546146737;5098.923516147335;5112.207607820794;5113.693178409308;5099.745012749274;5103.617228707788;5107.8467645969195;5112.9744351278005;5114.360704911886;4794.825267809409;4825.059113472839;4866.732329721899;4897.045076210247;4970.378702662168;5035.269885866455;5042.369703787027;5043.344365232496;5052.267421223828;5111.539961403491;4886.315915771724;4900.926486102782;4924.901501970012;4938;4972.577330926912 17:51:39 INFO - PROCESS | 30523 | |1;ext.html;559.3623269472799;563.8139413993381;565.3724365953792;591.3436085944601;605.0228880358222;35240.295194096136;39509.20981580367;39597.40603890944;39626.405603915926;39633.207335853265;31025.534616980764;31329.530057049164;31369.372612547737;31392.686073139263;31395.05814825559;7663.195364486733;7866.921330786676;7868.055833300012;7868.25251601097;7885.29032387085;7700.845983080335;7833.96083019587;7834.764957051269;7844.646990885395;7851.528908265494;7869.095054068798;7904.802379940519;7905.525668459882;7911.8417631647335;7921.287084162424;7825.334846538022;7849.882251766228;7852.214778522102;7858.449908506407;7860;7720;7767;7790.766277011699;7812.804679882992;7827.0607527096545;37472.063198419986;38019.80990095032;38074.61925380738;38078.23843523142;38118.80940595307;2467.7902378297867;2886.350571121502;2916.562515622674;3049.070033639739;3067.7545796336462;26174.513421224954;27139;27961.440771184665;28214;28476.715232847615;3224.742020638343;3273.2962413081063;3302.3890580242733;3315.5689760331;3375.6793104655017;237960;237994;238295;238329;239595;31811.681883181336;31885.521717174262;32101.35797284088;32861.17847053843;32902.8354858229;33763.15592110168;33828.32343353119;33851.83074084614;34001.65998339985;34033.31933361319;13973.90391441292;14081.788773168411;14129.717405651829;14164.150150990974;14166.079204851652;11760.411979400995;11777.823332650018;11831.585894493652;11847.881521184678;11866.347350895783;7830.2952734254195;7830.3735701144915;7839.176886426957;7941.444098913136;7971.60141992898;3083.4758091124563;3089.1504836170234;3131.7964332318784;3159;3159.8578063987175;802.1256830055268;813.3330668851485;819.8442295963748;872.4329186029132;873.5981448533619;27432.725672743018;28854;28880.711192888222;29140.854295728386;29172.83308667672;869.8173383589517;886.3839631456076;920.5351297594806;935.780091678455;994.1351024608637;14484.885749563895;15081.773773393188;15132.621684457756;15251.23743812805;15469.226538673247;405667;409717;410273;412911.741765169;413468;49545;49628.25557616639;49710.25434618411;49739.50260497421;49905;1105.4914739219887;1107.092184408777;1125.1055410948316;1144.3191301175787;1161.2742036227357;27224.183274501796;27863.721362786113;28372.290692732848;28402.431951360442;28719.85640071786;32520.186995325304;32568.51147232746;32606;32635.18412039718;32656;339957;342050;342464;343093;343601;25302.746972530775;25520.234392967497;25634.230973070837;25661.74338256668;25669.486610268064;42338.364924525544;42452;42523.574764251964;42733.35899961565;44303.11393772171;36834;37177.4423383644;37353.43969840509;37398.252034959696;37867.81066094652;36894.63105368912;37333.066673333386;37677.81161094177;38020.61979380171;38840.80579597084;35371.29257414786;35732.46401304034;36607.26785464329;36635.63364366322;38703;31919.521207181446;33745;34189.31621367509;34336.48495272523;34539.82730086333;26105.347366315993;26149.73850261473;26237.73762262353;26591.734082658924;26826.731732683205 17:51:39 INFO - PROCESS | 30523 | |2;jquery.html;368.80084754232735;377.9962200377996;382.1363717997326;388.5395805969928;391.5418959817014;16876.15619219039;16947.57631059224;17499.912500437495;17688.38090666827;17842;10999.450027498633;11064.834027489595;11103.112470879949;11104;11291.435428228577;4749.8812529686775;4786.21027530457;4795.5444232798;4809.90380192396;4889.6821706589135;3531.7704349217347;4791.3531673224015;4865.708057516543;6553.77061802837;6944.375006249436;6965.0597169382245;7116.1460624725105;7116.964415177917;7120.893186602205;7130.75042373517;6395.712192951329;6663.3336666333225;6703.3631804978695;6777.695003724795;6837.145356830396;6585.769498067544;6588.439982601484;6619.371159739817;6645.6344901030425;6658.00129980502;23125.768742312528;23991;24471.143509977064;24540.87729561341;24595.016199352183;2058.3207541511265;2094.706741056253;2594.416256342327;2600.466904284636;2645.6692913385828;14575;14917.254137293092;15049.398024079024;15255.847441525553;15288.770668439982;1817.164104511926;1897.2600685732575;1921.164293532318;1921.6637088509456;1947.7662680478293;81747;83053.58473207595;83826.58086709527;85547;87851.56074219588;15820;15820.208989550476;16644.83355166457;17004;17244.310227591006;28622.14133575996;28763.28091797722;29015.564766528518;29041.709582904325;29320.706792931796;8943;8966;9228.676996305232;9351;9416.576254068446;7482.476226664081;7494.5128566643;7502.17476077631;7633.313001829862;7851.411144164211;8156.184381561915;8410.158984101663;8540.914590854136;8675.6529738811;8714;1545.582692672972;1546.2732515717594;1640.8031036275722;3405.438102713025;3478.9478157827652;365.5302935727577;372.97948612826553;756.8826831841073;835.1272919798824;837.4556538250064;10310.536025878704;16352.427665031666;17988.730169047474;18030.188641511162;18701.81298187028;769.7921561178563;785.1441928298183;795.367682692261;806.4234072638092;832.7043899415742;9412.529373531295;9553.331266811396;10244.231682623684;10310.587576497006;10532.842007369896;292216;296637;296695;425513;426634;77957.61021194971;78710.21289787143;79484.60257698674;81358;86013.13986860176;898.4788822483075;909.4406939732149;931.4364809290417;940.1209868772719;945.5414124149781;15712.13583252932;15950.60123496922;16013.199340033185;16480;16616.335346586002;36334;38120;38210.80894595509;38603.80698096492;38787.2242555153;49271.507284926694;50838.491615083374;53623.73188134035;54321.45678543164;56671;7585.2035536270105;7598.924010760043;7727.536347819148;7737.845243094994;7931.048274207132;8692.478451292942;11298.322100673986;11386.715332116763;11600.883991160317;12248.142630015813;10232.744181395525;10248.743781405525;10488.580456781949;10520.526576303932;10616.946915265375;9532.666356677482;9702.75743106428;9830;10294.3823370598;10385.740356490845;10042.14641755459;10095.495225238561;10095.495225238856;10206.744831379276;10287.897121028695;7302.926970730225;7463;7651.808704782425;7674.424418168772;7768.961155194188;8493.617787199468;9448.811023779623;10076.294659373774;10093;10206.387616743019 17:51:39 INFO - PROCESS | 30523 | |3;mootools.html;1367.466687991683;1417.978730319045;1491.8060652115223;1697.5756060984745;1702.0978881192973;6853.657317134136;7436.851262974737;7496.6251687415615;8053.355731541477;8096.271335579804;7418.666160022798;7553.8866916996285;7758.883616745753;7760.49556778809;7766.9611651941805;2148.248113160393;2223.3885681437573;2224.1214720185517;2224.810891074261;2226.6103431899433;2154.967675484869;2191.9452013699706;2209.767974362685;2224.22152246714;2226.3988723044768;2214.6567282071305;2235.0165926992154;2235.474663454087;2243.921462748804;2247.9775202247934;2135.1993002624017;2146.5599552091785;2147.226998280618;2160.157538559963;2166.122720298282;2158.7301587301586;2179.618566750812;2181.520065585569;2189.824814014875;2203.7575866654656;7717;7724.536527808349;7744.612769361565;7756.340711039568;7773.650185741655;4534.274516077445;4638.814447422099;4640.048789998043;4651.488336283006;4666.2767271073035;2939.088882446448;2950.9409811803857;3023.712747289004;3041.102874651983;3060.158456424479;933.0902370189079;962.201372860531;984.6898227058525;1005.0602686488083;1007.5214273220236;10447.947760261226;10721.035106840343;10723.14214862809;10758.677239682822;10773.192010599314;4025.8993525162105;4280.914381712349;4323.6757243206885;4430.069685366045;4431.800568974404;9181.219596334253;9216.400933939272;9224.262059035394;9242;9268.443893366419;4769.713817170981;4773.64197685175;4775.761211939459;4776.522347765195;4780.0917825613715;3745.3632882410056;4164.8125834337525;4288.142371525707;4347.652187824967;4348.804303806273;3623.61951995042;3681.1533347330264;3692.5753538343433;3743.6630703236297;3784.9432258516144;1211.9516618125258;1241.2428418664608;1244.3840299052026;1247.0833937056257;1252.7431876465303;754.35125791819;761.0524896503888;772.1892013385923;773.6170595555236;779.1779672445512;5298.841034768963;5475.342958844964;5515.862103447365;5583.944160558423;5683.914741278884;404.16338179967187;411.1304590790457;412.3340804600608;413.3964411958574;418.2868209702511;3661.3958696814725;3754.511913451234;3783.5838057813617;3804.391297392404;3840.116773142193;9426.151646351724;9911.10800028001;9912.405255684538;9915.702528924145;9920.355176913477;9683;9687.660931867491;9688.757781055388;9694.75763105914;9700.320977531504;7180.60506672138;7285.70857165718;7356.66894989716;7410.258974102547;7427.145878224073;5272.894542109059;5333.280007198979;5360.865978350573;5369.489898459797;5514.779408823602;9045.050269721585;9046.185843274137;9082.591283392396;9099.59051842682;9112.088791120836;8556;8957.462552246887;9003.774905627411;9122.680706175252;9256.49089300095;6096.573239873166;6632.933670663231;6786.76246331376;6885.690143943434;7124.643767811693;7645.388368930583;7732.806679832825;7738.883916741366;7745.612719364122;7752.496087754278;6770.763023294161;6811.080504131879;6891.104156459628;6945.756898508528;7123.786286411416;6663.666816659244;6753.392194702304;6763.5941843489545;6777.2883847195335;6797.0823938767635;6519.771807986698;6524;6582.670866456754;6592.274849766426;6613;4294.9355759663;4550.7497087660495;4576.313552967082;4590.701604395704;4624.5375462453485;4562.680612357103;4592.655550833768;4621.029583787442;4621.584057434847;4800.087983283165 17:51:39 INFO - PROCESS | 30523 | |4;prototype.html;297.18571115144505;298.2499014977332;306.3826389824503;306.7193517931093;309.5897935235812;4869.196582563882;4948.31757202551;5047.611906725652;5109.284700141979;5124.2313652952025;5034.798608055673;5058.69647821131;5061.683962169835;5074.441811400752;5076.2385642153695;3997.940545755377;4009.3184158693093;4012.9398059029136;4017.4978127734107;4021.919561608766;3889.922201555967;3973.1259122992897;4001.6398524132824;4009.7995100245016;4027.4764280643476;3945.9605403946025;3975.9006024849323;3980.681545476355;3988.6011398860173;3992.6606238469767;3963.1083006323493;3972.344563147092;3979.900502487432;3983.7410568312966;4002.8598999035185;3244.9026529203925;3380.6619338066243;3387.5257463955068;3550.49104130746;3552.946705799415;4940.086084074458;4948.183549714293;4951.504849515056;4960.379952505937;4978.178600530908;4425.336199570058;4426.690131690783;4436.134953684033;4438.955610443919;4442.711223770445;5225.634205605609;5319.973400132974;5323.361196656388;5349.866253343658;5353.304070470853;3686.3733165361955;3691.446283057536;3700.8704695335805;3709.8330575124182;3712.888613341604;5588.161775733632;5603.439656034405;5618.269624948731;5619.634723742944;5620.325560932673;3765.5669597996034;3812.1232116613332;3856.2865869814173;3859.359772096848;3866.5553461352306;3876.534815822063;3915.158240978203;3921.529416469985;3926.823292951824;3932;4461.643068554507;4477.664175186809;4479.3057076153245;4479.61923236522;4488.685791994594;5307.893842123213;5325.866853328698;5329.094054010828;5333.86665333362;5349.331333583302;1281.8718128187293;1332.160738734591;1347.9258640774851;1353.1813252981804;1354.9322533873267;840.5545061117617;845.7166849105496;866.0646501778191;869.2046777198792;876.8684697295457;4126.566710495415;4132.276851550967;4173.269677806372;4173.561776013536;4192.113548903006;4815.6388270879825;4847.933454639973;4851.248056551241;4860.708357498562;4862.95137048632;4159.604837540429;4173.287363213935;4194;4197.958020419756;4198.916021679549;2475.5915273979954;2521.2814347911126;2602.453484768182;2616.489784492044;2621.108823000189;4540.523245059221;4563.608099529609;4565.201089809337;4570.428696412949;4589.862304130881;4869.321872969853;4898.995705880286;4975.975120124449;4978.751062446863;4992.427385373669;4229.033499422721;4452.329908085027;4499.572540608702;4538.500764915791;4562.361269422284;4863.003084367625;4865.9756701216265;4867.29424233477;4883.853484395474;4886.755662216804;4742.928856067231;4747.905041899074;4765.785539650655;4768.427788665383;4796.784144713566;4523.570260825217;4743.644226682944;5125;5155.871103222449;5162.406323272721;3683.263347330491;3733.1413774832486;3815.7328986970647;3856.749311294757;3863.469427524976;5474.91787623194;5490.6431081979545;5492.505674489315;5502.2296878437855;5502.339719233718;5296.2055691646565;5323.627346085892;5325.174597937326;5331.786728530816;5344.786208551614;5123.872747995435;5314.840554783363;5320.946790532045;5322.494363035506;5334.653247538898;5163.896722065613;5193.545807173998;5195.19474481456;5204.765785539736;5217.217417387422;5352.280165285245;5359.169328754049;5359.3032905722;5366.248725178556;5366.597505187048;4975.97992411562;5261.973690131525;5291.814786482455;5299.41706412302;5301.920471192858 17:51:39 INFO - PROCESS | 30523 | |5;yui.html;637;647.1716203259826;657.9144711187548;687.7524091327122;698.4203111417524;13119.409626566803;13232.338383080856;13699.041067125305;13721.725565488698;13758.931205343984;12482.251064936088;12596.433160507777;12647.873521264784;12685.682857928556;12709.555165569207;634.2547506679656;779.1507257089771;790.8853216283635;791.8851766493884;793.5199204481263;768.3161985832613;777.7705576854842;783.2598194706005;787.1734678587488;795.3915254830059;829.2371018662815;831.9584020798966;832.675256649907;834.6953362022848;836.8661014237723;819.213554987213;820.8235229425702;827.5200383777425;829.8589239829213;832.800127969286;606.348175711108;606.7087797857009;608.3156448994881;608.3946473259091;610.4536439886322;13440.731185376335;13470.52853150135;13478;13480.93259533696;13503.25732084735;13379.331033448387;13449.26029068401;13779.379927903268;13805.585832424942;13959.720805583831;10001.699949001542;10237.283390162691;10319.122874555596;10383.376997380181;10503.264771466;3296.686814752619;3299.703026727606;3304.438245498271;3328.118048717092;3407.2163402417336;59340.40659593392;60036.699816501074;60203;60566;61668;10438.68683939483;10484.213683973732;10517.737056573647;10544.314619549705;10578.100861426865;18817.811821881605;18833.340833070775;18837;19085.904570477058;19159.425217243504;6462.709178086998;6553.574017688835;6636.502262330345;6669.933300667029;6774.45804335652;3608.260306637133;3747.775133491999;3757.4363845423404;3761.981190094032;3831.731778775459;2825.745682888509;2913.0532576912588;2914.664813546427;2924.488214562443;2929.7802664800224;475.9619230461555;492.81273116216323;493.79754300737244;499.7551199912017;510.1455062769846;456.7442232349895;475.1542254786486;514.3133916221885;564.7515093358909;570.3611954610863;7703;7938.848866914265;7979.3616510679;8011.279562767543;8101.675932962733;421.6605632465833;484.2469959213387;502.5828562293288;543.3778323819205;564.6950646650763;3551;3828.789416582115;3930.6265904739003;3938.1139243669945;3993.6206060424215;74026.62986685032;97138.514307428;101384;101588.49205753925;105213;80591.59704201441;89504.5524772372;89511.55244223868;90088.5495572531;90430;76513;77268.61365693135;77763.61118194486;77955.61022194853;80336;7111.304795673766;7628.618569071636;7746.380289576708;7914.327282180849;7957.681692732457;45095.970681318766;45758;46018;46350.53649463462;46576.30135548037;56903;62115;63756.3624363769;64045;66048.66975665283;9883.802323953625;10121.848172277274;10154.695359139238;10162.949185254027;10225.74435639115;11049.381791681044;11227.438628068727;11434.085273178292;11617.941910290394;11720.296782192754;10017.949910250401;10306.793864122825;10507.894921050998;10783.19126065564;10947.069499092666;9569.904300956901;9628.75928101803;10026.448545330077;10325.74185645335;10419.739506512398;9543.9045609543;9622.95188524081;9719.854202187114;9864.358816676893;10095;8812.691555795516;8875.73372798817;9216.631334746535;9234.215091717278;9389.43663380172;8499.853107400819;8747.125287471203;8821.691240806542;8911.955440222757;9055.318638955936 17:51:39 INFO - PROCESS | 30523 | __end_tp_report 17:51:39 INFO - PROCESS | 30523 | __start_cc_report 17:51:39 INFO - PROCESS | 30523 | _x_x_mozilla_cycle_collect,373 17:51:39 INFO - PROCESS | 30523 | __end_cc_report 17:51:39 INFO - PROCESS | 30523 | __startTimestamp1469839899915__endTimestamp 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | ------- Summary: start ------- 17:51:39 INFO - PROCESS | 30523 | Number of tests: 6 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | [#0] dojo.html Cycles:165 Average:4792.09 Median:4893.17 stddev:489.81 (10.0%) stddev-sans-first:462.73 17:51:39 INFO - PROCESS | 30523 | Values: 2690.5 2697.2 2725.6 2726.7 2730.3 4719.4 4861.5 4886.9 4921.2 4941.0 4849.9 4850.9 4868.5 4882.6 4908.5 4423.0 4480.3 4505.4 4522.4 4588.7 4582.1 4620.1 4628.2 4628.4 4633.5 4337.2 4404.7 4425.2 4508.6 4579.2 4439.1 4462.2 4506.3 4509.5 4515.5 4410.0 4415.7 4423.1 4442.1 4497.2 4729.8 4751.1 4752.0 4752.2 4799.5 5079.9 5082.2 5098.1 5122.9 5128.4 5097.4 5122.0 5130.5 5171.3 5181.5 4747.7 4797.2 4828.3 4836.8 4850.2 5299.8 5305.5 5308.2 5335.9 5372.4 5068.6 5089.0 5089.1 5089.7 5123.9 4951.0 4974.9 4986.6 5185.9 5195.4 5033.4 5121.5 5145.6 5172.5 5265.0 5189.8 5191.5 5198.6 5198.7 5204.4 4437.1 4443.0 4443.4 4453.3 4500.5 3753.7 3834.5 3864.3 3885.4 3998.1 4452.2 4511.8 4530.5 4547.2 4586.9 5275.6 5286.4 5290.4 5297.5 5346.7 4345.3 4447.8 4488.3 4502.5 4555.7 4729.1 4739.4 4757.7 4776.7 4806.4 4889.3 4893.2 4896.0 4905.1 4935.6 5073.1 5104.4 5120.4 5120.9 5196.1 4772.0 4787.5 4801.7 4808.0 4855.3 5086.2 5086.7 5093.6 5098.3 5138.0 5094.1 5188.5 5201.1 5232.9 5277.4 5025.8 5096.9 5098.9 5112.2 5113.7 5099.7 5103.6 5107.8 5113.0 5114.4 4794.8 4825.1 4866.7 4897.0 4970.4 5035.3 5042.4 5043.3 5052.3 5111.5 4886.3 4900.9 4924.9 4938.0 4972.6 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | [#1] ext.html Cycles:180 Average:46473.41 Median:342778.50 stddev:89403.34 (26.1%) stddev-sans-first:89587.68 17:51:39 INFO - PROCESS | 30523 | Values: 559.4 563.8 565.4 591.3 605.0 35240.3 39509.2 39597.4 39626.4 39633.2 31025.5 31329.5 31369.4 31392.7 31395.1 7663.2 7866.9 7868.1 7868.3 7885.3 7700.8 7834.0 7834.8 7844.6 7851.5 7869.1 7904.8 7905.5 7911.8 7921.3 7825.3 7849.9 7852.2 7858.4 7860.0 7720.0 7767.0 7790.8 7812.8 7827.1 37472.1 38019.8 38074.6 38078.2 38118.8 2467.8 2886.4 2916.6 3049.1 3067.8 26174.5 27139.0 27961.4 28214.0 28476.7 3224.7 3273.3 3302.4 3315.6 3375.7 237960.0 237994.0 238295.0 238329.0 239595.0 31811.7 31885.5 32101.4 32861.2 32902.8 33763.2 33828.3 33851.8 34001.7 34033.3 13973.9 14081.8 14129.7 14164.2 14166.1 11760.4 11777.8 11831.6 11847.9 11866.3 7830.3 7830.4 7839.2 7941.4 7971.6 3083.5 3089.2 3131.8 3159.0 3159.9 802.1 813.3 819.8 872.4 873.6 27432.7 28854.0 28880.7 29140.9 29172.8 869.8 886.4 920.5 935.8 994.1 14484.9 15081.8 15132.6 15251.2 15469.2 405667.0 409717.0 410273.0 412911.7 413468.0 49545.0 49628.3 49710.3 49739.5 49905.0 1105.5 1107.1 1125.1 1144.3 1161.3 27224.2 27863.7 28372.3 28402.4 28719.9 32520.2 32568.5 32606.0 32635.2 32656.0 339957.0 342050.0 342464.0 343093.0 343601.0 25302.7 25520.2 25634.2 25661.7 25669.5 42338.4 42452.0 42523.6 42733.4 44303.1 36834.0 37177.4 37353.4 37398.3 37867.8 36894.6 37333.1 37677.8 38020.6 38840.8 35371.3 35732.5 36607.3 36635.6 38703.0 31919.5 33745.0 34189.3 34336.5 34539.8 26105.3 26149.7 26237.7 26591.7 26826.7 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | [#2] jquery.html Cycles:180 Average:24745.24 Median:19587.88 stddev:59045.04 (301.4%) stddev-sans-first:59182.31 17:51:39 INFO - PROCESS | 30523 | Values: 368.8 378.0 382.1 388.5 391.5 16876.2 16947.6 17499.9 17688.4 17842.0 10999.5 11064.8 11103.1 11104.0 11291.4 4749.9 4786.2 4795.5 4809.9 4889.7 3531.8 4791.4 4865.7 6553.8 6944.4 6965.1 7116.1 7117.0 7120.9 7130.8 6395.7 6663.3 6703.4 6777.7 6837.1 6585.8 6588.4 6619.4 6645.6 6658.0 23125.8 23991.0 24471.1 24540.9 24595.0 2058.3 2094.7 2594.4 2600.5 2645.7 14575.0 14917.3 15049.4 15255.8 15288.8 1817.2 1897.3 1921.2 1921.7 1947.8 81747.0 83053.6 83826.6 85547.0 87851.6 15820.0 15820.2 16644.8 17004.0 17244.3 28622.1 28763.3 29015.6 29041.7 29320.7 8943.0 8966.0 9228.7 9351.0 9416.6 7482.5 7494.5 7502.2 7633.3 7851.4 8156.2 8410.2 8540.9 8675.7 8714.0 1545.6 1546.3 1640.8 3405.4 3478.9 365.5 373.0 756.9 835.1 837.5 10310.5 16352.4 17988.7 18030.2 18701.8 769.8 785.1 795.4 806.4 832.7 9412.5 9553.3 10244.2 10310.6 10532.8 292216.0 296637.0 296695.0 425513.0 426634.0 77957.6 78710.2 79484.6 81358.0 86013.1 898.5 909.4 931.4 940.1 945.5 15712.1 15950.6 16013.2 16480.0 16616.3 36334.0 38120.0 38210.8 38603.8 38787.2 49271.5 50838.5 53623.7 54321.5 56671.0 7585.2 7598.9 7727.5 7737.8 7931.0 8692.5 11298.3 11386.7 11600.9 12248.1 10232.7 10248.7 10488.6 10520.5 10616.9 9532.7 9702.8 9830.0 10294.4 10385.7 10042.1 10095.5 10095.5 10206.7 10287.9 7302.9 7463.0 7651.8 7674.4 7769.0 8493.6 9448.8 10076.3 10093.0 10206.4 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | [#3] mootools.html Cycles:180 Average:5187.84 Median:4790.09 stddev:2910.54 (60.8%) stddev-sans-first:2904.55 17:51:39 INFO - PROCESS | 30523 | Values: 1367.5 1418.0 1491.8 1697.6 1702.1 6853.7 7436.9 7496.6 8053.4 8096.3 7418.7 7553.9 7758.9 7760.5 7767.0 2148.2 2223.4 2224.1 2224.8 2226.6 2155.0 2191.9 2209.8 2224.2 2226.4 2214.7 2235.0 2235.5 2243.9 2248.0 2135.2 2146.6 2147.2 2160.2 2166.1 2158.7 2179.6 2181.5 2189.8 2203.8 7717.0 7724.5 7744.6 7756.3 7773.7 4534.3 4638.8 4640.0 4651.5 4666.3 2939.1 2950.9 3023.7 3041.1 3060.2 933.1 962.2 984.7 1005.1 1007.5 10447.9 10721.0 10723.1 10758.7 10773.2 4025.9 4280.9 4323.7 4430.1 4431.8 9181.2 9216.4 9224.3 9242.0 9268.4 4769.7 4773.6 4775.8 4776.5 4780.1 3745.4 4164.8 4288.1 4347.7 4348.8 3623.6 3681.2 3692.6 3743.7 3784.9 1212.0 1241.2 1244.4 1247.1 1252.7 754.4 761.1 772.2 773.6 779.2 5298.8 5475.3 5515.9 5583.9 5683.9 404.2 411.1 412.3 413.4 418.3 3661.4 3754.5 3783.6 3804.4 3840.1 9426.2 9911.1 9912.4 9915.7 9920.4 9683.0 9687.7 9688.8 9694.8 9700.3 7180.6 7285.7 7356.7 7410.3 7427.1 5272.9 5333.3 5360.9 5369.5 5514.8 9045.1 9046.2 9082.6 9099.6 9112.1 8556.0 8957.5 9003.8 9122.7 9256.5 6096.6 6632.9 6786.8 6885.7 7124.6 7645.4 7732.8 7738.9 7745.6 7752.5 6770.8 6811.1 6891.1 6945.8 7123.8 6663.7 6753.4 6763.6 6777.3 6797.1 6519.8 6524.0 6582.7 6592.3 6613.0 4294.9 4550.7 4576.3 4590.7 4624.5 4562.7 4592.7 4621.0 4621.6 4800.1 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | [#4] prototype.html Cycles:180 Average:4263.76 Median:4666.40 stddev:1242.38 (26.6%) stddev-sans-first:1209.67 17:51:39 INFO - PROCESS | 30523 | Values: 297.2 298.2 306.4 306.7 309.6 4869.2 4948.3 5047.6 5109.3 5124.2 5034.8 5058.7 5061.7 5074.4 5076.2 3997.9 4009.3 4012.9 4017.5 4021.9 3889.9 3973.1 4001.6 4009.8 4027.5 3946.0 3975.9 3980.7 3988.6 3992.7 3963.1 3972.3 3979.9 3983.7 4002.9 3244.9 3380.7 3387.5 3550.5 3552.9 4940.1 4948.2 4951.5 4960.4 4978.2 4425.3 4426.7 4436.1 4439.0 4442.7 5225.6 5320.0 5323.4 5349.9 5353.3 3686.4 3691.4 3700.9 3709.8 3712.9 5588.2 5603.4 5618.3 5619.6 5620.3 3765.6 3812.1 3856.3 3859.4 3866.6 3876.5 3915.2 3921.5 3926.8 3932.0 4461.6 4477.7 4479.3 4479.6 4488.7 5307.9 5325.9 5329.1 5333.9 5349.3 1281.9 1332.2 1347.9 1353.2 1354.9 840.6 845.7 866.1 869.2 876.9 4126.6 4132.3 4173.3 4173.6 4192.1 4815.6 4847.9 4851.2 4860.7 4863.0 4159.6 4173.3 4194.0 4198.0 4198.9 2475.6 2521.3 2602.5 2616.5 2621.1 4540.5 4563.6 4565.2 4570.4 4589.9 4869.3 4899.0 4976.0 4978.8 4992.4 4229.0 4452.3 4499.6 4538.5 4562.4 4863.0 4866.0 4867.3 4883.9 4886.8 4742.9 4747.9 4765.8 4768.4 4796.8 4523.6 4743.6 5125.0 5155.9 5162.4 3683.3 3733.1 3815.7 3856.7 3863.5 5474.9 5490.6 5492.5 5502.2 5502.3 5296.2 5323.6 5325.2 5331.8 5344.8 5123.9 5314.8 5320.9 5322.5 5334.7 5163.9 5193.5 5195.2 5204.8 5217.2 5352.3 5359.2 5359.3 5366.2 5366.6 4976.0 5262.0 5291.8 5299.4 5301.9 17:51:39 INFO - PROCESS | 30523 | 17:51:39 INFO - PROCESS | 30523 | [#5] yui.html Cycles:180 Average:17653.87 Median:512.23 stddev:25797.59 (5036.3%) stddev-sans-first:25838.31 17:51:39 INFO - PROCESS | 30523 | Values: 637.0 647.2 657.9 687.8 698.4 13119.4 13232.3 13699.0 13721.7 13758.9 12482.3 12596.4 12647.9 12685.7 12709.6 634.3 779.2 790.9 791.9 793.5 768.3 777.8 783.3 787.2 795.4 829.2 832.0 832.7 834.7 836.9 819.2 820.8 827.5 829.9 832.8 606.3 606.7 608.3 608.4 610.5 13440.7 13470.5 13478.0 13480.9 13503.3 13379.3 13449.3 13779.4 13805.6 13959.7 10001.7 10237.3 10319.1 10383.4 10503.3 3296.7 3299.7 3304.4 3328.1 3407.2 59340.4 60036.7 60203.0 60566.0 61668.0 10438.7 10484.2 10517.7 10544.3 10578.1 18817.8 18833.3 18837.0 19085.9 19159.4 6462.7 6553.6 6636.5 6669.9 6774.5 3608.3 3747.8 3757.4 3762.0 3831.7 2825.7 2913.1 2914.7 2924.5 2929.8 476.0 492.8 493.8 499.8 510.1 456.7 475.2 514.3 564.8 570.4 7703.0 7938.8 7979.4 8011.3 8101.7 421.7 484.2 502.6 543.4 564.7 3551.0 3828.8 3930.6 3938.1 3993.6 74026.6 97138.5 101384.0 101588.5 105213.0 80591.6 89504.6 89511.6 90088.5 90430.0 76513.0 77268.6 77763.6 77955.6 80336.0 7111.3 7628.6 7746.4 7914.3 7957.7 45096.0 45758.0 46018.0 46350.5 46576.3 56903.0 62115.0 63756.4 64045.0 66048.7 9883.8 10121.8 10154.7 10162.9 10225.7 11049.4 11227.4 11434.1 11617.9 11720.3 10017.9 10306.8 10507.9 10783.2 10947.1 9569.9 9628.8 10026.4 10325.7 10419.7 9543.9 9623.0 9719.9 9864.4 10095.0 8812.7 8875.7 9216.6 9234.2 9389.4 8499.9 8747.1 8821.7 8912.0 9055.3 17:51:39 INFO - PROCESS | 30523 | -------- Summary: end -------- 17:51:39 INFO - PROCESS | 30523 | 17:51:40 INFO - TEST-INFO | 30523: exit 0 17:51:40 INFO - TEST-OK | dromaeo_css | took 1116966ms 17:51:40 INFO - TEST-START | kraken 17:51:40 INFO - operating with platform_type : linux_ 17:51:40 INFO - Initialising browser for kraken test... 17:51:40 INFO - TEST-INFO | started process 30769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5a7GJK/profile http://localhost:45028/getInfo.html) 17:51:44 INFO - PROCESS | 30769 | JavaScript error: , line 0: uncaught exception: undefined 17:51:45 INFO - PROCESS | 30769 | __metrics Screen width/height:1600/1200 17:51:45 INFO - PROCESS | 30769 | colorDepth:24 17:51:45 INFO - PROCESS | 30769 | Browser inner width/height: 1024/697 17:51:45 INFO - PROCESS | 30769 | __metrics 17:51:46 ERROR - PROCESS | 30769 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:51:46 INFO - TEST-INFO | 30769: exit 0 17:51:46 INFO - Browser initialized. 17:51:46 INFO - Running cycle 1/1 for kraken test... 17:51:46 INFO - TEST-INFO | started process 30887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5a7GJK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:58 INFO - PROCESS | 30887 | RSS: Main: 166420480 17:51:58 INFO - PROCESS | 30887 | 17:52:01 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-beat-detection) 17:52:02 INFO - PROCESS | 30887 | RSS: Main: 171339776 17:52:02 INFO - PROCESS | 30887 | 17:52:05 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-dft) 17:52:05 INFO - PROCESS | 30887 | RSS: Main: 170643456 17:52:05 INFO - PROCESS | 30887 | 17:52:08 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-fft) 17:52:09 INFO - PROCESS | 30887 | RSS: Main: 166883328 17:52:09 INFO - PROCESS | 30887 | 17:52:11 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45028/tests/kraken/driver.html?testName=audio-oscillator) 17:52:12 INFO - PROCESS | 30887 | RSS: Main: 167878656 17:52:12 INFO - PROCESS | 30887 | 17:52:14 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45028/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:52:15 INFO - PROCESS | 30887 | RSS: Main: 167632896 17:52:15 INFO - PROCESS | 30887 | 17:52:18 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45028/tests/kraken/driver.html?testName=imaging-darkroom) 17:52:19 INFO - PROCESS | 30887 | RSS: Main: 168288256 17:52:19 INFO - PROCESS | 30887 | 17:52:22 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45028/tests/kraken/driver.html?testName=imaging-desaturate) 17:52:23 INFO - PROCESS | 30887 | RSS: Main: 165339136 17:52:23 INFO - PROCESS | 30887 | 17:52:26 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45028/tests/kraken/driver.html?testName=json-parse-financial) 17:52:26 INFO - PROCESS | 30887 | RSS: Main: 167309312 17:52:26 INFO - PROCESS | 30887 | 17:52:28 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45028/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:52:29 INFO - PROCESS | 30887 | RSS: Main: 167137280 17:52:29 INFO - PROCESS | 30887 | 17:52:31 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:52:31 INFO - PROCESS | 30887 | RSS: Main: 167546880 17:52:31 INFO - PROCESS | 30887 | 17:52:33 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:52:34 INFO - PROCESS | 30887 | RSS: Main: 168415232 17:52:34 INFO - PROCESS | 30887 | 17:52:37 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:52:38 INFO - PROCESS | 30887 | RSS: Main: 168501248 17:52:38 INFO - PROCESS | 30887 | 17:52:40 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:52:41 INFO - PROCESS | 30887 | RSS: Main: 168742912 17:52:41 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | Cycle 1(1): loaded http://localhost:45028/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45028/tests/kraken/driver.html?testName=ai-astar) 17:52:43 INFO - PROCESS | 30887 | RSS: Main: 169529344 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | __start_tp_report 17:52:43 INFO - PROCESS | 30887 | _x_x_mozilla_page_load 17:52:43 INFO - PROCESS | 30887 | _x_x_mozilla_page_load_details 17:52:43 INFO - PROCESS | 30887 | |i|pagename|runs| 17:52:43 INFO - PROCESS | 30887 | |0;ai-astar;105;118;108;114;113;115;115;115;115;113 17:52:43 INFO - PROCESS | 30887 | |1;audio-beat-detection;147;122;147;179;125;159;149;129;186;123 17:52:43 INFO - PROCESS | 30887 | |2;audio-dft;166;164;165;174;161;162;162;164;162;162 17:52:43 INFO - PROCESS | 30887 | |3;audio-fft;79;76;76;177;77;77;75;75;155;79 17:52:43 INFO - PROCESS | 30887 | |4;audio-oscillator;87;87;150;86;86;84;132;85;86;140 17:52:43 INFO - PROCESS | 30887 | |5;imaging-gaussian-blur;117;118;117;118;117;117;118;119;118;119 17:52:43 INFO - PROCESS | 30887 | |6;imaging-darkroom;149;148;147;147;148;148;149;150;149;148 17:52:43 INFO - PROCESS | 30887 | |7;imaging-desaturate;96;95;95;96;96;96;96;96;95;96 17:52:43 INFO - PROCESS | 30887 | |8;json-parse-financial;64;63;63;63;64;61;62;62;63;72 17:52:43 INFO - PROCESS | 30887 | |9;json-stringify-tinderbox;66;67;65;66;66;66;66;67;66;66 17:52:43 INFO - PROCESS | 30887 | |10;stanford-crypto-aes;80;81;80;90;81;83;80;80;86;79 17:52:43 INFO - PROCESS | 30887 | |11;stanford-crypto-ccm;136;144;132;132;134;136;131;133;168;129 17:52:43 INFO - PROCESS | 30887 | |12;stanford-crypto-pbkdf2;169;167;171;168;167;167;171;168;167;168 17:52:43 INFO - PROCESS | 30887 | |13;stanford-crypto-sha256-iterative;69;68;74;68;70;70;75;69;67;72 17:52:43 INFO - PROCESS | 30887 | __end_tp_report 17:52:43 INFO - PROCESS | 30887 | __start_cc_report 17:52:43 INFO - PROCESS | 30887 | _x_x_mozilla_cycle_collect,979 17:52:43 INFO - PROCESS | 30887 | __end_cc_report 17:52:43 INFO - PROCESS | 30887 | __startTimestamp1469839963544__endTimestamp 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | ------- Summary: start ------- 17:52:43 INFO - PROCESS | 30887 | Number of tests: 14 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#0] ai-astar Cycles:10 Average:113.10 Median:115.00 stddev:3.81 (3.3%) stddev-sans-first:2.69 17:52:43 INFO - PROCESS | 30887 | Values: 105.0 118.0 108.0 114.0 113.0 115.0 115.0 115.0 115.0 113.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:148.00 stddev:22.85 (15.4%) stddev-sans-first:24.24 17:52:43 INFO - PROCESS | 30887 | Values: 147.0 122.0 147.0 179.0 125.0 159.0 149.0 129.0 186.0 123.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.79 (2.3%) stddev-sans-first:3.97 17:52:43 INFO - PROCESS | 30887 | Values: 166.0 164.0 165.0 174.0 161.0 162.0 162.0 164.0 162.0 162.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:38.01 (49.7%) stddev-sans-first:39.90 17:52:43 INFO - PROCESS | 30887 | Values: 79.0 76.0 76.0 177.0 77.0 77.0 75.0 75.0 155.0 79.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:86.00 stddev:26.83 (31.2%) stddev-sans-first:27.88 17:52:43 INFO - PROCESS | 30887 | Values: 87.0 87.0 150.0 86.0 86.0 84.0 132.0 85.0 86.0 140.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 17:52:43 INFO - PROCESS | 30887 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 118.0 119.0 118.0 119.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 17:52:43 INFO - PROCESS | 30887 | Values: 149.0 148.0 147.0 147.0 148.0 148.0 149.0 150.0 149.0 148.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:52:43 INFO - PROCESS | 30887 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.00 stddev:3.06 (4.9%) stddev-sans-first:3.24 17:52:43 INFO - PROCESS | 30887 | Values: 64.0 63.0 63.0 63.0 64.0 61.0 62.0 62.0 63.0 72.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:52:43 INFO - PROCESS | 30887 | Values: 66.0 67.0 65.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:3.46 (4.3%) stddev-sans-first:3.60 17:52:43 INFO - PROCESS | 30887 | Values: 80.0 81.0 80.0 90.0 81.0 83.0 80.0 80.0 86.0 79.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:135.00 stddev:11.47 (8.5%) stddev-sans-first:12.16 17:52:43 INFO - PROCESS | 30887 | Values: 136.0 144.0 132.0 132.0 134.0 136.0 131.0 133.0 168.0 129.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.00 stddev:1.57 (0.9%) stddev-sans-first:1.64 17:52:43 INFO - PROCESS | 30887 | Values: 169.0 167.0 171.0 168.0 167.0 167.0 171.0 168.0 167.0 168.0 17:52:43 INFO - PROCESS | 30887 | 17:52:43 INFO - PROCESS | 30887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:2.66 (3.8%) stddev-sans-first:2.78 17:52:43 INFO - PROCESS | 30887 | Values: 69.0 68.0 74.0 68.0 70.0 70.0 75.0 69.0 67.0 72.0 17:52:43 INFO - PROCESS | 30887 | -------- Summary: end -------- 17:52:43 INFO - PROCESS | 30887 | 17:52:44 INFO - TEST-INFO | 30887: exit 0 17:52:44 INFO - TEST-OK | kraken | took 63921ms 17:52:44 INFO - SUITE-END | took 1180s 17:52:44 INFO - Completed test suite (00:19:40) 17:52:44 INFO - javascript benchmark 17:52:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6418.0377762366925, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2690.488807126646, 2697.1908427471776, 2725.6456660634117, 2726.6727992640886, 2730.331068888123, 4719.4100737407825, 4861.489543597924, 4886.8778280543, 4921.188003979343, 4941.0, 4849.8545043648655, 4850.9029819403595, 4868.537488938554, 4882.6093912487, 4908.484609116045, 4423.049044455442, 4480.283154695249, 4505.414296141497, 4522.4346956630425, 4588.747618880977, 4582.1293954148605, 4620.052889157714, 4628.213203755369, 4628.421447319085, 4633.513481084488, 4337.154254920292, 4404.7357158570585, 4425.203463376591, 4508.61676757476, 4579.198640237945, 4439.089986552749, 4462.241418958753, 4506.346579745951, 4509.458864936229, 4515.525869783658, 4409.977950110261, 4415.668824838118, 4423.137488189805, 4442.067165895166, 4497.168023915586, 4729.787159577792, 4751.073540659573, 4751.976240118812, 4752.168370535177, 4799.520047995207, 5079.898402031976, 5082.186850104003, 5098.133317336024, 5122.871928201787, 5128.384593848762, 5097.439281679012, 5121.974390128063, 5130.4613015633195, 5171.276021357013, 5181.481851814826, 4747.738874361943, 4797.160496913027, 4828.275758636232, 4836.758162091881, 4850.175470170079, 5299.8410047698635, 5305.495977882095, 5308.177232528964, 5335.9466405336225, 5372.355317361941, 5068.619853510928, 5089.0, 5089.083964886356, 5089.694618322913, 5123.897522049539, 4951.009798040406, 4974.8756281093265, 4986.601071914238, 5185.896282074337, 5195.402528709171, 5033.370828646419, 5121.462246464068, 5145.562627176657, 5172.456892026358, 5265.0, 5189.792408303701, 5191.454897235812, 5198.558122559549, 5198.7140707260705, 5204.375474943031, 4437.06821567468, 4442.955570444319, 4443.400140980926, 4453.265211240109, 4500.482444518857, 3753.6997040236715, 3834.539855217392, 3864.265789499986, 3885.3589157789215, 3998.140399814054, 4452.1763473757455, 4511.751853648016, 4530.546945305509, 4547.2042392581825, 4586.862394128181, 5275.57795376369, 5286.418493965661, 5290.391604965402, 5297.5232229099565, 5346.652467589594, 4345.34819777036, 4447.799094244536, 4488.349189367524, 4502.5047244803045, 4555.749433781108, 4729.07782982322, 4739.431268247763, 4757.666963312535, 4776.713397196179, 4806.375171227788, 4889.2910527973245, 4893.168161412497, 4896.0, 4905.117078925828, 4935.62982776286, 5073.137566613758, 5104.438511763628, 5120.4111527174855, 5120.923186152137, 5196.116660167856, 4772.0455908817685, 4787.521247875185, 4801.663883528259, 4808.014357056725, 4855.344528488608, 5086.18621020635, 5086.720230387216, 5093.592512598909, 5098.260752190986, 5137.974310128426, 5094.108531007133, 5188.507091826271, 5201.089809283436, 5232.921506177334, 5277.393099793419, 5025.84922452327, 5096.923546146737, 5098.923516147335, 5112.207607820794, 5113.693178409308, 5099.745012749274, 5103.617228707788, 5107.8467645969195, 5112.9744351278005, 5114.360704911886, 4794.825267809409, 4825.059113472839, 4866.732329721899, 4897.045076210247, 4970.378702662168, 5035.269885866455, 5042.369703787027, 5043.344365232496, 5052.267421223828, 5111.539961403491, 4886.315915771724, 4900.926486102782, 4924.901501970012, 4938.0, 4972.577330926912], "value": 4761.383690768816, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.3623269472799, 563.8139413993381, 565.3724365953792, 591.3436085944601, 605.0228880358222, 35240.295194096136, 39509.20981580367, 39597.40603890944, 39626.405603915926, 39633.207335853265, 31025.534616980764, 31329.530057049164, 31369.372612547737, 31392.686073139263, 31395.05814825559, 7663.195364486733, 7866.921330786676, 7868.055833300012, 7868.25251601097, 7885.29032387085, 7700.845983080335, 7833.96083019587, 7834.764957051269, 7844.646990885395, 7851.528908265494, 7869.095054068798, 7904.802379940519, 7905.525668459882, 7911.8417631647335, 7921.287084162424, 7825.334846538022, 7849.882251766228, 7852.214778522102, 7858.449908506407, 7860.0, 7720.0, 7767.0, 7790.766277011699, 7812.804679882992, 7827.0607527096545, 37472.063198419986, 38019.80990095032, 38074.61925380738, 38078.23843523142, 38118.80940595307, 2467.7902378297867, 2886.350571121502, 2916.562515622674, 3049.070033639739, 3067.7545796336462, 26174.513421224954, 27139.0, 27961.440771184665, 28214.0, 28476.715232847615, 3224.742020638343, 3273.2962413081063, 3302.3890580242733, 3315.5689760331, 3375.6793104655017, 237960.0, 237994.0, 238295.0, 238329.0, 239595.0, 31811.681883181336, 31885.521717174262, 32101.35797284088, 32861.17847053843, 32902.8354858229, 33763.15592110168, 33828.32343353119, 33851.83074084614, 34001.65998339985, 34033.31933361319, 13973.90391441292, 14081.788773168411, 14129.717405651829, 14164.150150990974, 14166.079204851652, 11760.411979400995, 11777.823332650018, 11831.585894493652, 11847.881521184678, 11866.347350895783, 7830.2952734254195, 7830.3735701144915, 7839.176886426957, 7941.444098913136, 7971.60141992898, 3083.4758091124563, 3089.1504836170234, 3131.7964332318784, 3159.0, 3159.8578063987175, 802.1256830055268, 813.3330668851485, 819.8442295963748, 872.4329186029132, 873.5981448533619, 27432.725672743018, 28854.0, 28880.711192888222, 29140.854295728386, 29172.83308667672, 869.8173383589517, 886.3839631456076, 920.5351297594806, 935.780091678455, 994.1351024608637, 14484.885749563895, 15081.773773393188, 15132.621684457756, 15251.23743812805, 15469.226538673247, 405667.0, 409717.0, 410273.0, 412911.741765169, 413468.0, 49545.0, 49628.25557616639, 49710.25434618411, 49739.50260497421, 49905.0, 1105.4914739219887, 1107.092184408777, 1125.1055410948316, 1144.3191301175787, 1161.2742036227357, 27224.183274501796, 27863.721362786113, 28372.290692732848, 28402.431951360442, 28719.85640071786, 32520.186995325304, 32568.51147232746, 32606.0, 32635.18412039718, 32656.0, 339957.0, 342050.0, 342464.0, 343093.0, 343601.0, 25302.746972530775, 25520.234392967497, 25634.230973070837, 25661.74338256668, 25669.486610268064, 42338.364924525544, 42452.0, 42523.574764251964, 42733.35899961565, 44303.11393772171, 36834.0, 37177.4423383644, 37353.43969840509, 37398.252034959696, 37867.81066094652, 36894.63105368912, 37333.066673333386, 37677.81161094177, 38020.61979380171, 38840.80579597084, 35371.29257414786, 35732.46401304034, 36607.26785464329, 36635.63364366322, 38703.0, 31919.521207181446, 33745.0, 34189.31621367509, 34336.48495272523, 34539.82730086333, 26105.347366315993, 26149.73850261473, 26237.73762262353, 26591.734082658924, 26826.731732683205], "value": 16082.105489772279, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.80084754232735, 377.9962200377996, 382.1363717997326, 388.5395805969928, 391.5418959817014, 16876.15619219039, 16947.57631059224, 17499.912500437495, 17688.38090666827, 17842.0, 10999.450027498633, 11064.834027489595, 11103.112470879949, 11104.0, 11291.435428228577, 4749.8812529686775, 4786.21027530457, 4795.5444232798, 4809.90380192396, 4889.6821706589135, 3531.7704349217347, 4791.3531673224015, 4865.708057516543, 6553.77061802837, 6944.375006249436, 6965.0597169382245, 7116.1460624725105, 7116.964415177917, 7120.893186602205, 7130.75042373517, 6395.712192951329, 6663.3336666333225, 6703.3631804978695, 6777.695003724795, 6837.145356830396, 6585.769498067544, 6588.439982601484, 6619.371159739817, 6645.6344901030425, 6658.00129980502, 23125.768742312528, 23991.0, 24471.143509977064, 24540.87729561341, 24595.016199352183, 2058.3207541511265, 2094.706741056253, 2594.416256342327, 2600.466904284636, 2645.6692913385828, 14575.0, 14917.254137293092, 15049.398024079024, 15255.847441525553, 15288.770668439982, 1817.164104511926, 1897.2600685732575, 1921.164293532318, 1921.6637088509456, 1947.7662680478293, 81747.0, 83053.58473207595, 83826.58086709527, 85547.0, 87851.56074219588, 15820.0, 15820.208989550476, 16644.83355166457, 17004.0, 17244.310227591006, 28622.14133575996, 28763.28091797722, 29015.564766528518, 29041.709582904325, 29320.706792931796, 8943.0, 8966.0, 9228.676996305232, 9351.0, 9416.576254068446, 7482.476226664081, 7494.5128566643, 7502.17476077631, 7633.313001829862, 7851.411144164211, 8156.184381561915, 8410.158984101663, 8540.914590854136, 8675.6529738811, 8714.0, 1545.582692672972, 1546.2732515717594, 1640.8031036275722, 3405.438102713025, 3478.9478157827652, 365.5302935727577, 372.97948612826553, 756.8826831841073, 835.1272919798824, 837.4556538250064, 10310.536025878704, 16352.427665031666, 17988.730169047474, 18030.188641511162, 18701.81298187028, 769.7921561178563, 785.1441928298183, 795.367682692261, 806.4234072638092, 832.7043899415742, 9412.529373531295, 9553.331266811396, 10244.231682623684, 10310.587576497006, 10532.842007369896, 292216.0, 296637.0, 296695.0, 425513.0, 426634.0, 77957.61021194971, 78710.21289787143, 79484.60257698674, 81358.0, 86013.13986860176, 898.4788822483075, 909.4406939732149, 931.4364809290417, 940.1209868772719, 945.5414124149781, 15712.13583252932, 15950.60123496922, 16013.199340033185, 16480.0, 16616.335346586002, 36334.0, 38120.0, 38210.80894595509, 38603.80698096492, 38787.2242555153, 49271.507284926694, 50838.491615083374, 53623.73188134035, 54321.45678543164, 56671.0, 7585.2035536270105, 7598.924010760043, 7727.536347819148, 7737.845243094994, 7931.048274207132, 8692.478451292942, 11298.322100673986, 11386.715332116763, 11600.883991160317, 12248.142630015813, 10232.744181395525, 10248.743781405525, 10488.580456781949, 10520.526576303932, 10616.946915265375, 9532.666356677482, 9702.75743106428, 9830.0, 10294.3823370598, 10385.740356490845, 10042.14641755459, 10095.495225238561, 10095.495225238856, 10206.744831379276, 10287.897121028695, 7302.926970730225, 7463.0, 7651.808704782425, 7674.424418168772, 7768.961155194188, 8493.617787199468, 9448.811023779623, 10076.294659373774, 10093.0, 10206.387616743019], "value": 9025.559623771329, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.466687991683, 1417.978730319045, 1491.8060652115223, 1697.5756060984745, 1702.0978881192973, 6853.657317134136, 7436.851262974737, 7496.6251687415615, 8053.355731541477, 8096.271335579804, 7418.666160022798, 7553.8866916996285, 7758.883616745753, 7760.49556778809, 7766.9611651941805, 2148.248113160393, 2223.3885681437573, 2224.1214720185517, 2224.810891074261, 2226.6103431899433, 2154.967675484869, 2191.9452013699706, 2209.767974362685, 2224.22152246714, 2226.3988723044768, 2214.6567282071305, 2235.0165926992154, 2235.474663454087, 2243.921462748804, 2247.9775202247934, 2135.1993002624017, 2146.5599552091785, 2147.226998280618, 2160.157538559963, 2166.122720298282, 2158.7301587301586, 2179.618566750812, 2181.520065585569, 2189.824814014875, 2203.7575866654656, 7717.0, 7724.536527808349, 7744.612769361565, 7756.340711039568, 7773.650185741655, 4534.274516077445, 4638.814447422099, 4640.048789998043, 4651.488336283006, 4666.2767271073035, 2939.088882446448, 2950.9409811803857, 3023.712747289004, 3041.102874651983, 3060.158456424479, 933.0902370189079, 962.201372860531, 984.6898227058525, 1005.0602686488083, 1007.5214273220236, 10447.947760261226, 10721.035106840343, 10723.14214862809, 10758.677239682822, 10773.192010599314, 4025.8993525162105, 4280.914381712349, 4323.6757243206885, 4430.069685366045, 4431.800568974404, 9181.219596334253, 9216.400933939272, 9224.262059035394, 9242.0, 9268.443893366419, 4769.713817170981, 4773.64197685175, 4775.761211939459, 4776.522347765195, 4780.0917825613715, 3745.3632882410056, 4164.8125834337525, 4288.142371525707, 4347.652187824967, 4348.804303806273, 3623.61951995042, 3681.1533347330264, 3692.5753538343433, 3743.6630703236297, 3784.9432258516144, 1211.9516618125258, 1241.2428418664608, 1244.3840299052026, 1247.0833937056257, 1252.7431876465303, 754.35125791819, 761.0524896503888, 772.1892013385923, 773.6170595555236, 779.1779672445512, 5298.841034768963, 5475.342958844964, 5515.862103447365, 5583.944160558423, 5683.914741278884, 404.16338179967187, 411.1304590790457, 412.3340804600608, 413.3964411958574, 418.2868209702511, 3661.3958696814725, 3754.511913451234, 3783.5838057813617, 3804.391297392404, 3840.116773142193, 9426.151646351724, 9911.10800028001, 9912.405255684538, 9915.702528924145, 9920.355176913477, 9683.0, 9687.660931867491, 9688.757781055388, 9694.75763105914, 9700.320977531504, 7180.60506672138, 7285.70857165718, 7356.66894989716, 7410.258974102547, 7427.145878224073, 5272.894542109059, 5333.280007198979, 5360.865978350573, 5369.489898459797, 5514.779408823602, 9045.050269721585, 9046.185843274137, 9082.591283392396, 9099.59051842682, 9112.088791120836, 8556.0, 8957.462552246887, 9003.774905627411, 9122.680706175252, 9256.49089300095, 6096.573239873166, 6632.933670663231, 6786.76246331376, 6885.690143943434, 7124.643767811693, 7645.388368930583, 7732.806679832825, 7738.883916741366, 7745.612719364122, 7752.496087754278, 6770.763023294161, 6811.080504131879, 6891.104156459628, 6945.756898508528, 7123.786286411416, 6663.666816659244, 6753.392194702304, 6763.5941843489545, 6777.2883847195335, 6797.0823938767635, 6519.771807986698, 6524.0, 6582.670866456754, 6592.274849766426, 6613.0, 4294.9355759663, 4550.7497087660495, 4576.313552967082, 4590.701604395704, 4624.5375462453485, 4562.680612357103, 4592.655550833768, 4621.029583787442, 4621.584057434847, 4800.087983283165], "value": 4109.492972498575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.18571115144505, 298.2499014977332, 306.3826389824503, 306.7193517931093, 309.5897935235812, 4869.196582563882, 4948.31757202551, 5047.611906725652, 5109.284700141979, 5124.2313652952025, 5034.798608055673, 5058.69647821131, 5061.683962169835, 5074.441811400752, 5076.2385642153695, 3997.940545755377, 4009.3184158693093, 4012.9398059029136, 4017.4978127734107, 4021.919561608766, 3889.922201555967, 3973.1259122992897, 4001.6398524132824, 4009.7995100245016, 4027.4764280643476, 3945.9605403946025, 3975.9006024849323, 3980.681545476355, 3988.6011398860173, 3992.6606238469767, 3963.1083006323493, 3972.344563147092, 3979.900502487432, 3983.7410568312966, 4002.8598999035185, 3244.9026529203925, 3380.6619338066243, 3387.5257463955068, 3550.49104130746, 3552.946705799415, 4940.086084074458, 4948.183549714293, 4951.504849515056, 4960.379952505937, 4978.178600530908, 4425.336199570058, 4426.690131690783, 4436.134953684033, 4438.955610443919, 4442.711223770445, 5225.634205605609, 5319.973400132974, 5323.361196656388, 5349.866253343658, 5353.304070470853, 3686.3733165361955, 3691.446283057536, 3700.8704695335805, 3709.8330575124182, 3712.888613341604, 5588.161775733632, 5603.439656034405, 5618.269624948731, 5619.634723742944, 5620.325560932673, 3765.5669597996034, 3812.1232116613332, 3856.2865869814173, 3859.359772096848, 3866.5553461352306, 3876.534815822063, 3915.158240978203, 3921.529416469985, 3926.823292951824, 3932.0, 4461.643068554507, 4477.664175186809, 4479.3057076153245, 4479.61923236522, 4488.685791994594, 5307.893842123213, 5325.866853328698, 5329.094054010828, 5333.86665333362, 5349.331333583302, 1281.8718128187293, 1332.160738734591, 1347.9258640774851, 1353.1813252981804, 1354.9322533873267, 840.5545061117617, 845.7166849105496, 866.0646501778191, 869.2046777198792, 876.8684697295457, 4126.566710495415, 4132.276851550967, 4173.269677806372, 4173.561776013536, 4192.113548903006, 4815.6388270879825, 4847.933454639973, 4851.248056551241, 4860.708357498562, 4862.95137048632, 4159.604837540429, 4173.287363213935, 4194.0, 4197.958020419756, 4198.916021679549, 2475.5915273979954, 2521.2814347911126, 2602.453484768182, 2616.489784492044, 2621.108823000189, 4540.523245059221, 4563.608099529609, 4565.201089809337, 4570.428696412949, 4589.862304130881, 4869.321872969853, 4898.995705880286, 4975.975120124449, 4978.751062446863, 4992.427385373669, 4229.033499422721, 4452.329908085027, 4499.572540608702, 4538.500764915791, 4562.361269422284, 4863.003084367625, 4865.9756701216265, 4867.29424233477, 4883.853484395474, 4886.755662216804, 4742.928856067231, 4747.905041899074, 4765.785539650655, 4768.427788665383, 4796.784144713566, 4523.570260825217, 4743.644226682944, 5125.0, 5155.871103222449, 5162.406323272721, 3683.263347330491, 3733.1413774832486, 3815.7328986970647, 3856.749311294757, 3863.469427524976, 5474.91787623194, 5490.6431081979545, 5492.505674489315, 5502.2296878437855, 5502.339719233718, 5296.2055691646565, 5323.627346085892, 5325.174597937326, 5331.786728530816, 5344.786208551614, 5123.872747995435, 5314.840554783363, 5320.946790532045, 5322.494363035506, 5334.653247538898, 5163.896722065613, 5193.545807173998, 5195.19474481456, 5204.765785539736, 5217.217417387422, 5352.280165285245, 5359.169328754049, 5359.3032905722, 5366.248725178556, 5366.597505187048, 4975.97992411562, 5261.973690131525, 5291.814786482455, 5299.41706412302, 5301.920471192858], "value": 3868.698194687287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.0, 647.1716203259826, 657.9144711187548, 687.7524091327122, 698.4203111417524, 13119.409626566803, 13232.338383080856, 13699.041067125305, 13721.725565488698, 13758.931205343984, 12482.251064936088, 12596.433160507777, 12647.873521264784, 12685.682857928556, 12709.555165569207, 634.2547506679656, 779.1507257089771, 790.8853216283635, 791.8851766493884, 793.5199204481263, 768.3161985832613, 777.7705576854842, 783.2598194706005, 787.1734678587488, 795.3915254830059, 829.2371018662815, 831.9584020798966, 832.675256649907, 834.6953362022848, 836.8661014237723, 819.213554987213, 820.8235229425702, 827.5200383777425, 829.8589239829213, 832.800127969286, 606.348175711108, 606.7087797857009, 608.3156448994881, 608.3946473259091, 610.4536439886322, 13440.731185376335, 13470.52853150135, 13478.0, 13480.93259533696, 13503.25732084735, 13379.331033448387, 13449.26029068401, 13779.379927903268, 13805.585832424942, 13959.720805583831, 10001.699949001542, 10237.283390162691, 10319.122874555596, 10383.376997380181, 10503.264771466, 3296.686814752619, 3299.703026727606, 3304.438245498271, 3328.118048717092, 3407.2163402417336, 59340.40659593392, 60036.699816501074, 60203.0, 60566.0, 61668.0, 10438.68683939483, 10484.213683973732, 10517.737056573647, 10544.314619549705, 10578.100861426865, 18817.811821881605, 18833.340833070775, 18837.0, 19085.904570477058, 19159.425217243504, 6462.709178086998, 6553.574017688835, 6636.502262330345, 6669.933300667029, 6774.45804335652, 3608.260306637133, 3747.775133491999, 3757.4363845423404, 3761.981190094032, 3831.731778775459, 2825.745682888509, 2913.0532576912588, 2914.664813546427, 2924.488214562443, 2929.7802664800224, 475.9619230461555, 492.81273116216323, 493.79754300737244, 499.7551199912017, 510.1455062769846, 456.7442232349895, 475.1542254786486, 514.3133916221885, 564.7515093358909, 570.3611954610863, 7703.0, 7938.848866914265, 7979.3616510679, 8011.279562767543, 8101.675932962733, 421.6605632465833, 484.2469959213387, 502.5828562293288, 543.3778323819205, 564.6950646650763, 3551.0, 3828.789416582115, 3930.6265904739003, 3938.1139243669945, 3993.6206060424215, 74026.62986685032, 97138.514307428, 101384.0, 101588.49205753925, 105213.0, 80591.59704201441, 89504.5524772372, 89511.55244223868, 90088.5495572531, 90430.0, 76513.0, 77268.61365693135, 77763.61118194486, 77955.61022194853, 80336.0, 7111.304795673766, 7628.618569071636, 7746.380289576708, 7914.327282180849, 7957.681692732457, 45095.970681318766, 45758.0, 46018.0, 46350.53649463462, 46576.30135548037, 56903.0, 62115.0, 63756.3624363769, 64045.0, 66048.66975665283, 9883.802323953625, 10121.848172277274, 10154.695359139238, 10162.949185254027, 10225.74435639115, 11049.381791681044, 11227.438628068727, 11434.085273178292, 11617.941910290394, 11720.296782192754, 10017.949910250401, 10306.793864122825, 10507.894921050998, 10783.19126065564, 10947.069499092666, 9569.904300956901, 9628.75928101803, 10026.448545330077, 10325.74185645335, 10419.739506512398, 9543.9045609543, 9622.95188524081, 9719.854202187114, 9864.358816676893, 10095.0, 8812.691555795516, 8875.73372798817, 9216.631334746535, 9234.215091717278, 9389.43663380172, 8499.853107400819, 8747.125287471203, 8821.691240806542, 8911.955440222757, 9055.318638955936], "value": 6360.0972658039045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 108.0, 114.0, 113.0, 115.0, 115.0, 115.0, 115.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 147.0, 179.0, 125.0, 159.0, 149.0, 129.0, 186.0, 123.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 174.0, 161.0, 162.0, 162.0, 164.0, 162.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 76.0, 177.0, 77.0, 77.0, 75.0, 75.0, 155.0, 79.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 150.0, 86.0, 86.0, 84.0, 132.0, 85.0, 86.0, 140.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 148.0, 148.0, 149.0, 150.0, 149.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 61.0, 62.0, 62.0, 63.0, 72.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 90.0, 81.0, 83.0, 80.0, 80.0, 86.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 144.0, 132.0, 132.0, 134.0, 136.0, 131.0, 133.0, 168.0, 129.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 171.0, 168.0, 167.0, 167.0, 171.0, 168.0, 167.0, 168.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 74.0, 68.0, 70.0, 70.0, 75.0, 69.0, 67.0, 72.0], "value": 70.2, "unit": "score"}]}]} 17:52:44 INFO - Return code: 0 17:52:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:52:44 ERROR - # TBPL SUCCESS # 17:52:44 INFO - Running post-action listener: _resource_record_post_action 17:52:44 INFO - [mozharness: 2016-07-30 00:52:44.820977Z] Finished run-tests step (success) 17:52:44 INFO - Running post-run listener: _resource_record_post_run 17:52:44 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549871616; Read time: 16; Write time: 470604 17:52:44 INFO - TinderboxPrint: CPU usage
13.4% 17:52:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:52:44 INFO - TinderboxPrint: I/O write bytes / time
549,871,616 / 470,604 17:52:44 INFO - TinderboxPrint: CPU idle
8,270.5 (86.6%) 17:52:44 INFO - TinderboxPrint: CPU user
1,221.6 (12.8%) 17:52:44 INFO - TinderboxPrint: Swap in / out
0 / 0 17:52:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 260972544; Read time: 0; Write time: 255304 17:52:44 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288899072; Read time: 16; Write time: 215300 17:52:45 INFO - Running post-run listener: _upload_blobber_files 17:52:45 INFO - Blob upload gear active. 17:52:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:52:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:52:45 INFO - (blobuploader) - INFO - Open directory for files ... 17:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:46 INFO - (blobuploader) - INFO - Done attempting. 17:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:47 INFO - (blobuploader) - INFO - Done attempting. 17:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:51 INFO - (blobuploader) - INFO - Done attempting. 17:52:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:52:51 INFO - Return code: 0 17:52:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:52:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:52:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/daa66501c33ab276f0d21204d7a15e97019ac63baa3b3d59b6e5965004c520d319a3f570e256596c562eb42c4ebe65d8ec5b5aa6bcd72b231ec98f8df70482a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c5c504c9878c375e02e1274b22a5b67984625febfa120522745890f1ae4845cd0bc74595f1176488f460fe8a98f91b7007a28cb121072b45f626899cd67bfa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b17597670841449bbb2291b304bff06594aeba152b764f0990e80c4886275d944dc959142f03e4f2f24cf881889686f1a33d0c831474bf0f3d5986abbe5c1bf3"} 17:52:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:52:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:52:51 INFO - Contents: 17:52:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/daa66501c33ab276f0d21204d7a15e97019ac63baa3b3d59b6e5965004c520d319a3f570e256596c562eb42c4ebe65d8ec5b5aa6bcd72b231ec98f8df70482a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c5c504c9878c375e02e1274b22a5b67984625febfa120522745890f1ae4845cd0bc74595f1176488f460fe8a98f91b7007a28cb121072b45f626899cd67bfa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b17597670841449bbb2291b304bff06594aeba152b764f0990e80c4886275d944dc959142f03e4f2f24cf881889686f1a33d0c831474bf0f3d5986abbe5c1bf3"} 17:52:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:52:51 INFO - Copying logs to upload dir... 17:52:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:52:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.725849 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-29 17:52:51.051502) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 17:52:51.055509) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/daa66501c33ab276f0d21204d7a15e97019ac63baa3b3d59b6e5965004c520d319a3f570e256596c562eb42c4ebe65d8ec5b5aa6bcd72b231ec98f8df70482a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c5c504c9878c375e02e1274b22a5b67984625febfa120522745890f1ae4845cd0bc74595f1176488f460fe8a98f91b7007a28cb121072b45f626899cd67bfa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b17597670841449bbb2291b304bff06594aeba152b764f0990e80c4886275d944dc959142f03e4f2f24cf881889686f1a33d0c831474bf0f3d5986abbe5c1bf3"} build_url:https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/dYzY0WdDTcOlhi8faR126Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/daa66501c33ab276f0d21204d7a15e97019ac63baa3b3d59b6e5965004c520d319a3f570e256596c562eb42c4ebe65d8ec5b5aa6bcd72b231ec98f8df70482a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c5c504c9878c375e02e1274b22a5b67984625febfa120522745890f1ae4845cd0bc74595f1176488f460fe8a98f91b7007a28cb121072b45f626899cd67bfa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b17597670841449bbb2291b304bff06594aeba152b764f0990e80c4886275d944dc959142f03e4f2f24cf881889686f1a33d0c831474bf0f3d5986abbe5c1bf3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 17:52:51.081472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:52:51.081863) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469836116.173328-104306299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 17:52:51.165472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 17:52:51.165861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 17:52:51.166214) ========= ========= Total master_lag: 0.18 =========