builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1469529708.53 results: success (0) buildid: 20160726003003 builduid: bcc67e1f42a048a4a9b21024efd65fb3 revision: 5125ae09224aa5358f923b792a84f3f0e0a6c256 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.533954) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.534474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.534764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.550333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.550721) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 03:41:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.2M=0s 2016-07-26 03:41:49 (37.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095509 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.660642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.661025) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014978 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:48.710940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 03:41:48.711289) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5125ae09224aa5358f923b792a84f3f0e0a6c256 --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 5125ae09224aa5358f923b792a84f3f0e0a6c256 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 03:41:50,064 truncating revision to first 12 chars 2016-07-26 03:41:50,064 Setting DEBUG logging. 2016-07-26 03:41:50,064 attempt 1/10 2016-07-26 03:41:50,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5125ae09224a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 03:41:51,263 unpacking tar archive at: autoland-5125ae09224a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 03:41:50.230732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:50.231060) ========= script_repo_revision: 5125ae09224aa5358f923b792a84f3f0e0a6c256 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:50.231430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:50.231688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 03:41:50.242265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-26 03:41:50.242643) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:41:51 INFO - MultiFileLogger online at 20160726 03:41:51 in /builds/slave/test 03:41:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:41:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:51 INFO - {'append_to_log': False, 03:41:51 INFO - 'base_work_dir': '/builds/slave/test', 03:41:51 INFO - 'blob_upload_branch': 'Autoland', 03:41:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:51 INFO - 'branch': 'Autoland', 03:41:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:51 INFO - 'config_files': ('talos/linux_config.py',), 03:41:51 INFO - 'default_actions': ('clobber', 03:41:51 INFO - 'read-buildbot-config', 03:41:51 INFO - 'download-and-extract', 03:41:51 INFO - 'populate-webroot', 03:41:51 INFO - 'create-virtualenv', 03:41:51 INFO - 'install', 03:41:51 INFO - 'run-tests'), 03:41:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:51 INFO - 'download_minidump_stackwalk': True, 03:41:51 INFO - 'download_symbols': 'ondemand', 03:41:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:41:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:41:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:41:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:41:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:51 INFO - 'installer_path': 'installer.exe', 03:41:51 INFO - 'log_level': 'info', 03:41:51 INFO - 'log_name': 'talos', 03:41:51 INFO - 'log_to_console': True, 03:41:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:41:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:41:51 INFO - 'opt_config_files': (), 03:41:51 INFO - 'pip_index': False, 03:41:51 INFO - 'sps_profile': False, 03:41:51 INFO - 'sps_profile_interval': 0, 03:41:51 INFO - 'suite': 'dromaeojs', 03:41:51 INFO - 'system_bits': '32', 03:41:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:51 INFO - 'title': 'talos-linux64-ix-069', 03:41:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:51 INFO - 'use_talos_json': True, 03:41:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:51 INFO - 'work_dir': 'build'} 03:41:51 INFO - [mozharness: 2016-07-26 10:41:51.687796Z] Running clobber step. 03:41:51 INFO - Running pre-action listener: _resource_record_pre_action 03:41:51 INFO - Running main action method: clobber 03:41:51 INFO - rmtree: /builds/slave/test/build 03:41:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:52 INFO - Running post-action listener: _resource_record_post_action 03:41:52 INFO - [mozharness: 2016-07-26 10:41:52.165327Z] Finished clobber step (success) 03:41:52 INFO - [mozharness: 2016-07-26 10:41:52.165429Z] Running read-buildbot-config step. 03:41:52 INFO - Running pre-action listener: _resource_record_pre_action 03:41:52 INFO - Running main action method: read_buildbot_config 03:41:52 INFO - Using buildbot properties: 03:41:52 INFO - { 03:41:52 INFO - "project": "", 03:41:52 INFO - "product": "firefox", 03:41:52 INFO - "script_repo_revision": "production", 03:41:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:41:52 INFO - "repository": "", 03:41:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 03:41:52 INFO - "buildid": "20160726003003", 03:41:52 INFO - "pgo_build": "True", 03:41:52 INFO - "basedir": "/builds/slave/test", 03:41:52 INFO - "buildnumber": 62, 03:41:52 INFO - "slavename": "talos-linux64-ix-069", 03:41:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:41:52 INFO - "platform": "ubuntu64_hw", 03:41:52 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:41:52 INFO - "branch": "autoland", 03:41:52 INFO - "repo_path": "integration/autoland", 03:41:52 INFO - "revision": "5125ae09224aa5358f923b792a84f3f0e0a6c256", 03:41:52 INFO - "stage_platform": "linux64-pgo", 03:41:52 INFO - "builduid": "bcc67e1f42a048a4a9b21024efd65fb3", 03:41:52 INFO - "slavebuilddir": "test" 03:41:52 INFO - } 03:41:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:41:52 INFO - Running post-action listener: _resource_record_post_action 03:41:52 INFO - [mozharness: 2016-07-26 10:41:52.167888Z] Finished read-buildbot-config step (success) 03:41:52 INFO - [mozharness: 2016-07-26 10:41:52.167976Z] Running download-and-extract step. 03:41:52 INFO - Running pre-action listener: _resource_record_pre_action 03:41:52 INFO - Running main action method: download_and_extract 03:41:52 INFO - mkdir: /builds/slave/test/build/tests 03:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:52 INFO - https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:41:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:41:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:41:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:52 INFO - Downloaded 1361 bytes. 03:41:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:41:52 INFO - Using the following test package requirements: 03:41:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:41:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:41:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:41:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'jsshell-linux-x86_64.zip'], 03:41:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:41:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:41:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:41:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:41:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:41:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:41:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:52 INFO - https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:41:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:41:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:41:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:53 INFO - Downloaded 24311977 bytes. 03:41:53 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'] 03:41:53 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 03:41:55 INFO - Return code: 0 03:41:55 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 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:55 INFO - https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:41:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:41:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:41:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:56 INFO - Downloaded 24311977 bytes. 03:41:56 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'] 03:41:56 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 03:41:57 INFO - Return code: 0 03:41:57 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')]} 03:41:57 INFO - https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:41:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:41:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:41:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:58 INFO - Downloaded 14413725 bytes. 03:41:58 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'] 03:41:58 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 03:41:59 INFO - Return code: 0 03:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:59 INFO - https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZV7mCrNcSoeDH09GvnDf2w/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 03:42:00 INFO - Downloaded 60860233 bytes. 03:42:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:42:00 INFO - mkdir: /builds/slave/test/properties 03:42:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:42:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:42:00 INFO - Contents: 03:42:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:42:01 INFO - Running post-action listener: _resource_record_post_action 03:42:01 INFO - Running post-action listener: set_extra_try_arguments 03:42:01 INFO - [mozharness: 2016-07-26 10:42:01.482310Z] Finished download-and-extract step (success) 03:42:01 INFO - [mozharness: 2016-07-26 10:42:01.482633Z] Running populate-webroot step. 03:42:01 INFO - Running pre-action listener: _resource_record_pre_action 03:42:01 INFO - Running main action method: populate_webroot 03:42:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:42:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:42:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:42:01 INFO - '--tppagecycles', 03:42:01 INFO - '7'], 03:42:01 INFO - 'tests': ['tsvgm']}}, 03:42:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:42:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:42:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:42:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:42:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:42:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['damp', 'tps']}, 03:42:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'tests': ['damp', 'tps']}, 03:42:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['dromaeo_dom']}, 03:42:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:42:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['basic_compositor_video']}, 03:42:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:42:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['a11yr', 03:42:01 INFO - 'ts_paint', 03:42:01 INFO - 'tpaint', 03:42:01 INFO - 'sessionrestore', 03:42:01 INFO - 'sessionrestore_no_auto_restore', 03:42:01 INFO - 'tabpaint']}, 03:42:01 INFO - 'other-e10s': {'tests': ['a11yr', 03:42:01 INFO - 'ts_paint', 03:42:01 INFO - 'tpaint', 03:42:01 INFO - 'sessionrestore', 03:42:01 INFO - 'sessionrestore_no_auto_restore', 03:42:01 INFO - 'tabpaint']}, 03:42:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:42:01 INFO - 'ts_paint', 03:42:01 INFO - 'tpaint', 03:42:01 INFO - 'sessionrestore', 03:42:01 INFO - 'sessionrestore_no_auto_restore', 03:42:01 INFO - 'tabpaint']}, 03:42:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:42:01 INFO - 'ts_paint', 03:42:01 INFO - 'tpaint', 03:42:01 INFO - 'sessionrestore', 03:42:01 INFO - 'sessionrestore_no_auto_restore', 03:42:01 INFO - 'tabpaint']}, 03:42:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['a11yr', 03:42:01 INFO - 'ts_paint', 03:42:01 INFO - 'tpaint', 03:42:01 INFO - 'sessionrestore', 03:42:01 INFO - 'sessionrestore_no_auto_restore', 03:42:01 INFO - 'tabpaint']}, 03:42:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['a11yr', 03:42:01 INFO - 'ts_paint', 03:42:01 INFO - 'tpaint', 03:42:01 INFO - 'sessionrestore', 03:42:01 INFO - 'sessionrestore_no_auto_restore', 03:42:01 INFO - 'tabpaint']}, 03:42:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['tsvgx', 03:42:01 INFO - 'tsvgr_opacity', 03:42:01 INFO - 'tart', 03:42:01 INFO - 'tscrollx', 03:42:01 INFO - 'cart']}, 03:42:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:42:01 INFO - 'tsvgr_opacity', 03:42:01 INFO - 'tart', 03:42:01 INFO - 'tscrollx', 03:42:01 INFO - 'cart']}, 03:42:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'talos_options': ['--disable-e10s'], 03:42:01 INFO - 'tests': ['tp5o']}, 03:42:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'tests': ['tp5o']}, 03:42:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'talos_options': ['--disable-e10s', 03:42:01 INFO - '--xperf_path', 03:42:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:01 INFO - 'tests': ['tp5n']}, 03:42:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:42:01 INFO - 'talos_options': ['--xperf_path', 03:42:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:42:01 INFO - 'tests': ['tp5n']}}, 03:42:01 INFO - 'talos.zip': {'path': '', 03:42:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:42:01 INFO - Running post-action listener: _resource_record_post_action 03:42:01 INFO - [mozharness: 2016-07-26 10:42:01.501094Z] Finished populate-webroot step (success) 03:42:01 INFO - [mozharness: 2016-07-26 10:42:01.501184Z] Running create-virtualenv step. 03:42:01 INFO - Running pre-action listener: _resource_record_pre_action 03:42:01 INFO - Running main action method: create_virtualenv 03:42:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:42:01 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 03:42:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:42:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:42:01 INFO - Using real prefix '/usr' 03:42:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:42:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:42:04 INFO - Installing pip.................done. 03:42:04 INFO - Return code: 0 03:42:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:04 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:04 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 03:42:04 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 03:42:04 INFO - Using env: {'DISPLAY': ':0', 03:42:04 INFO - 'HOME': '/home/cltbld', 03:42:04 INFO - 'LANG': 'en_US.UTF-8', 03:42:04 INFO - 'LANGUAGE': 'en_US:en', 03:42:04 INFO - 'LOGNAME': 'cltbld', 03:42:04 INFO - 'MAIL': '/var/mail/cltbld', 03:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:04 INFO - 'MOZ_NO_REMOTE': '1', 03:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:04 INFO - 'NO_EM_RESTART': '1', 03:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:04 INFO - 'PWD': '/builds/slave/test', 03:42:04 INFO - 'SHELL': '/bin/bash', 03:42:04 INFO - 'SHLVL': '1', 03:42:04 INFO - 'TERM': 'linux', 03:42:04 INFO - 'TMOUT': '86400', 03:42:04 INFO - 'USER': 'cltbld', 03:42:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:04 INFO - '_': '/tools/buildbot/bin/python'} 03:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:04 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 03:42:04 INFO - Cleaning up... 03:42:04 INFO - Return code: 0 03:42:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:04 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:04 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 03:42:04 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 03:42:04 INFO - Using env: {'DISPLAY': ':0', 03:42:04 INFO - 'HOME': '/home/cltbld', 03:42:04 INFO - 'LANG': 'en_US.UTF-8', 03:42:04 INFO - 'LANGUAGE': 'en_US:en', 03:42:04 INFO - 'LOGNAME': 'cltbld', 03:42:04 INFO - 'MAIL': '/var/mail/cltbld', 03:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:04 INFO - 'MOZ_NO_REMOTE': '1', 03:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:04 INFO - 'NO_EM_RESTART': '1', 03:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:04 INFO - 'PWD': '/builds/slave/test', 03:42:04 INFO - 'SHELL': '/bin/bash', 03:42:04 INFO - 'SHLVL': '1', 03:42:04 INFO - 'TERM': 'linux', 03:42:04 INFO - 'TMOUT': '86400', 03:42:04 INFO - 'USER': 'cltbld', 03:42:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:04 INFO - '_': '/tools/buildbot/bin/python'} 03:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:04 INFO - Downloading/unpacking psutil>=3.1.1 03:42:04 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 03:42:04 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 03:42:04 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 03:42:04 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 03:42:04 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 03:42:04 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 03:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:42:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:06 INFO - Installing collected packages: psutil 03:42:06 INFO - Running setup.py install for psutil 03:42:06 INFO - building 'psutil._psutil_linux' extension 03:42:06 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 03:42:06 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 03:42:06 INFO - building 'psutil._psutil_posix' extension 03:42:06 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 03:42:06 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 03:42:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:42:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:42:07 INFO - Successfully installed psutil 03:42:07 INFO - Cleaning up... 03:42:07 INFO - Return code: 0 03:42:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:07 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:07 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 03:42:07 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 03:42:07 INFO - Using env: {'DISPLAY': ':0', 03:42:07 INFO - 'HOME': '/home/cltbld', 03:42:07 INFO - 'LANG': 'en_US.UTF-8', 03:42:07 INFO - 'LANGUAGE': 'en_US:en', 03:42:07 INFO - 'LOGNAME': 'cltbld', 03:42:07 INFO - 'MAIL': '/var/mail/cltbld', 03:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:07 INFO - 'MOZ_NO_REMOTE': '1', 03:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:07 INFO - 'NO_EM_RESTART': '1', 03:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:07 INFO - 'PWD': '/builds/slave/test', 03:42:07 INFO - 'SHELL': '/bin/bash', 03:42:07 INFO - 'SHLVL': '1', 03:42:07 INFO - 'TERM': 'linux', 03:42:07 INFO - 'TMOUT': '86400', 03:42:07 INFO - 'USER': 'cltbld', 03:42:07 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:07 INFO - '_': '/tools/buildbot/bin/python'} 03:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:42:09 INFO - Installing collected packages: mozsystemmonitor 03:42:09 INFO - Running setup.py install for mozsystemmonitor 03:42:09 INFO - Successfully installed mozsystemmonitor 03:42:09 INFO - Cleaning up... 03:42:09 INFO - Return code: 0 03:42:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:09 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:09 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 03:42:09 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 03:42:09 INFO - Using env: {'DISPLAY': ':0', 03:42:09 INFO - 'HOME': '/home/cltbld', 03:42:09 INFO - 'LANG': 'en_US.UTF-8', 03:42:09 INFO - 'LANGUAGE': 'en_US:en', 03:42:09 INFO - 'LOGNAME': 'cltbld', 03:42:09 INFO - 'MAIL': '/var/mail/cltbld', 03:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:09 INFO - 'MOZ_NO_REMOTE': '1', 03:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:09 INFO - 'NO_EM_RESTART': '1', 03:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:09 INFO - 'PWD': '/builds/slave/test', 03:42:09 INFO - 'SHELL': '/bin/bash', 03:42:09 INFO - 'SHLVL': '1', 03:42:09 INFO - 'TERM': 'linux', 03:42:09 INFO - 'TMOUT': '86400', 03:42:09 INFO - 'USER': 'cltbld', 03:42:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:09 INFO - '_': '/tools/buildbot/bin/python'} 03:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:42:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:42:11 INFO - warning: no files found matching '*.txt' 03:42:11 INFO - no previously-included directories found matching 'build' 03:42:11 INFO - no previously-included directories found matching 'dist' 03:42:11 INFO - no previously-included directories found matching '.git*' 03:42:11 INFO - Installing collected packages: jsonschema, functools32 03:42:11 INFO - Running setup.py install for functools32 03:42:11 INFO - warning: no files found matching '*.txt' 03:42:11 INFO - no previously-included directories found matching 'build' 03:42:11 INFO - no previously-included directories found matching 'dist' 03:42:11 INFO - no previously-included directories found matching '.git*' 03:42:11 INFO - Successfully installed jsonschema functools32 03:42:11 INFO - Cleaning up... 03:42:12 INFO - Return code: 0 03:42:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:12 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:12 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 03:42:12 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 03:42:12 INFO - Using env: {'DISPLAY': ':0', 03:42:12 INFO - 'HOME': '/home/cltbld', 03:42:12 INFO - 'LANG': 'en_US.UTF-8', 03:42:12 INFO - 'LANGUAGE': 'en_US:en', 03:42:12 INFO - 'LOGNAME': 'cltbld', 03:42:12 INFO - 'MAIL': '/var/mail/cltbld', 03:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:12 INFO - 'MOZ_NO_REMOTE': '1', 03:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:12 INFO - 'NO_EM_RESTART': '1', 03:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:12 INFO - 'PWD': '/builds/slave/test', 03:42:12 INFO - 'SHELL': '/bin/bash', 03:42:12 INFO - 'SHLVL': '1', 03:42:12 INFO - 'TERM': 'linux', 03:42:12 INFO - 'TMOUT': '86400', 03:42:12 INFO - 'USER': 'cltbld', 03:42:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:12 INFO - '_': '/tools/buildbot/bin/python'} 03:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:42:12 INFO - Cleaning up... 03:42:12 INFO - Return code: 0 03:42:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:12 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:12 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 03:42:12 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 03:42:12 INFO - Using env: {'DISPLAY': ':0', 03:42:12 INFO - 'HOME': '/home/cltbld', 03:42:12 INFO - 'LANG': 'en_US.UTF-8', 03:42:12 INFO - 'LANGUAGE': 'en_US:en', 03:42:12 INFO - 'LOGNAME': 'cltbld', 03:42:12 INFO - 'MAIL': '/var/mail/cltbld', 03:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:12 INFO - 'MOZ_NO_REMOTE': '1', 03:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:12 INFO - 'NO_EM_RESTART': '1', 03:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:12 INFO - 'PWD': '/builds/slave/test', 03:42:12 INFO - 'SHELL': '/bin/bash', 03:42:12 INFO - 'SHLVL': '1', 03:42:12 INFO - 'TERM': 'linux', 03:42:12 INFO - 'TMOUT': '86400', 03:42:12 INFO - 'USER': 'cltbld', 03:42:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:12 INFO - '_': '/tools/buildbot/bin/python'} 03:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:42:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:42:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:15 INFO - Downloading docopt-0.6.1.tar.gz 03:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:42:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:42:15 INFO - Running setup.py install for blobuploader 03:42:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:42:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:42:15 INFO - Running setup.py install for requests 03:42:15 INFO - Running setup.py install for docopt 03:42:15 INFO - Successfully installed blobuploader requests docopt 03:42:15 INFO - Cleaning up... 03:42:15 INFO - Return code: 0 03:42:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42:15 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')]} 03:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:15 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')]} 03:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:15 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:15 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 03:42:15 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 03:42:15 INFO - Using env: {'DISPLAY': ':0', 03:42:15 INFO - 'HOME': '/home/cltbld', 03:42:15 INFO - 'LANG': 'en_US.UTF-8', 03:42:15 INFO - 'LANGUAGE': 'en_US:en', 03:42:15 INFO - 'LOGNAME': 'cltbld', 03:42:15 INFO - 'MAIL': '/var/mail/cltbld', 03:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:15 INFO - 'MOZ_NO_REMOTE': '1', 03:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:15 INFO - 'NO_EM_RESTART': '1', 03:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:15 INFO - 'PWD': '/builds/slave/test', 03:42:15 INFO - 'SHELL': '/bin/bash', 03:42:15 INFO - 'SHLVL': '1', 03:42:15 INFO - 'TERM': 'linux', 03:42:15 INFO - 'TMOUT': '86400', 03:42:15 INFO - 'USER': 'cltbld', 03:42:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:15 INFO - '_': '/tools/buildbot/bin/python'} 03:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:15 INFO - Running setup.py (path:/tmp/pip-SR2xeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:16 INFO - Running setup.py (path:/tmp/pip-JS3loH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:16 INFO - Running setup.py (path:/tmp/pip-0dfBke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:16 INFO - Running setup.py (path:/tmp/pip-sBZRRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:16 INFO - Running setup.py (path:/tmp/pip-0Fd1JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:16 INFO - Running setup.py (path:/tmp/pip-_jq2_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:16 INFO - Running setup.py (path:/tmp/pip-Tj30Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:16 INFO - Running setup.py (path:/tmp/pip-DInHyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:16 INFO - Running setup.py (path:/tmp/pip-OKFM71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:16 INFO - Running setup.py (path:/tmp/pip-4wODP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:16 INFO - Running setup.py (path:/tmp/pip-9u6g2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:16 INFO - Running setup.py (path:/tmp/pip-ysLpRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:16 INFO - Running setup.py (path:/tmp/pip-H6e7TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:16 INFO - Running setup.py (path:/tmp/pip-RZ254l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:16 INFO - Running setup.py (path:/tmp/pip-V_tPA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:17 INFO - Running setup.py (path:/tmp/pip-XUNC6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:17 INFO - Running setup.py (path:/tmp/pip-McFYv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:42:17 INFO - Running setup.py install for manifestparser 03:42:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:42:17 INFO - Running setup.py install for mozcrash 03:42:17 INFO - Running setup.py install for mozdebug 03:42:17 INFO - Running setup.py install for mozdevice 03:42:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:42:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:42:17 INFO - Running setup.py install for mozfile 03:42:17 INFO - Running setup.py install for mozhttpd 03:42:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:42:17 INFO - Running setup.py install for mozinfo 03:42:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:42:17 INFO - Running setup.py install for mozInstall 03:42:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Running setup.py install for mozleak 03:42:18 INFO - Running setup.py install for mozlog 03:42:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Running setup.py install for moznetwork 03:42:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Running setup.py install for mozprocess 03:42:18 INFO - Running setup.py install for mozprofile 03:42:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Running setup.py install for mozrunner 03:42:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Running setup.py install for mozscreenshot 03:42:18 INFO - Running setup.py install for moztest 03:42:18 INFO - Running setup.py install for mozversion 03:42:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:42:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:42:18 INFO - Cleaning up... 03:42:19 INFO - Return code: 0 03:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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')]} 03:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:19 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:19 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 03:42:19 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 03:42:19 INFO - Using env: {'DISPLAY': ':0', 03:42:19 INFO - 'HOME': '/home/cltbld', 03:42:19 INFO - 'LANG': 'en_US.UTF-8', 03:42:19 INFO - 'LANGUAGE': 'en_US:en', 03:42:19 INFO - 'LOGNAME': 'cltbld', 03:42:19 INFO - 'MAIL': '/var/mail/cltbld', 03:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:19 INFO - 'MOZ_NO_REMOTE': '1', 03:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:19 INFO - 'NO_EM_RESTART': '1', 03:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:19 INFO - 'PWD': '/builds/slave/test', 03:42:19 INFO - 'SHELL': '/bin/bash', 03:42:19 INFO - 'SHLVL': '1', 03:42:19 INFO - 'TERM': 'linux', 03:42:19 INFO - 'TMOUT': '86400', 03:42:19 INFO - 'USER': 'cltbld', 03:42:19 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:19 INFO - '_': '/tools/buildbot/bin/python'} 03:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:42:19 INFO - Running setup.py (path:/tmp/pip-08kh10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:42:19 INFO - Running setup.py (path:/tmp/pip-q81byp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:42:19 INFO - Running setup.py (path:/tmp/pip-0ZvSg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:42:19 INFO - Running setup.py (path:/tmp/pip-Jv5JIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:42:19 INFO - Running setup.py (path:/tmp/pip-wFasfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:42:19 INFO - Running setup.py (path:/tmp/pip-azSICD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:42:19 INFO - Running setup.py (path:/tmp/pip-fKAyJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:42:19 INFO - Running setup.py (path:/tmp/pip-jJbfgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:42:19 INFO - Running setup.py (path:/tmp/pip-1xhBfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:42:19 INFO - Running setup.py (path:/tmp/pip-g23UHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:42:19 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)) 03:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:42:19 INFO - Running setup.py (path:/tmp/pip-7Uu_ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:42:20 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)) 03:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:42:20 INFO - Running setup.py (path:/tmp/pip-LOrP6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:42:20 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)) 03:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:42:20 INFO - Running setup.py (path:/tmp/pip-JcRFok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:42:20 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)) 03:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:42:20 INFO - Running setup.py (path:/tmp/pip-88jHUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:42:20 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)) 03:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:20 INFO - Running setup.py (path:/tmp/pip-DsLU7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:42:20 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)) 03:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:42:20 INFO - Running setup.py (path:/tmp/pip-rNmtQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:42:20 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)) 03:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:42:20 INFO - Running setup.py (path:/tmp/pip-n0kA4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:42:20 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)) 03:42:20 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)) 03:42:20 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)) 03:42:20 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)) 03:42:20 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)) 03:42:20 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)) 03:42:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:22 INFO - Downloading blessings-1.6.tar.gz 03:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:42:22 INFO - Installing collected packages: blessings 03:42:22 INFO - Running setup.py install for blessings 03:42:22 INFO - Successfully installed blessings 03:42:22 INFO - Cleaning up... 03:42:22 INFO - Return code: 0 03:42:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:42:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:22 INFO - Reading from file tmpfile_stdout 03:42:22 INFO - Current package versions: 03:42:22 INFO - argparse == 1.2.1 03:42:22 INFO - blessings == 1.6 03:42:22 INFO - blobuploader == 1.2.4 03:42:22 INFO - docopt == 0.6.1 03:42:22 INFO - functools32 == 3.2.3-2 03:42:22 INFO - jsonschema == 2.5.1 03:42:22 INFO - manifestparser == 1.1 03:42:22 INFO - mozInstall == 1.12 03:42:22 INFO - mozcrash == 0.17 03:42:22 INFO - mozdebug == 0.1 03:42:22 INFO - mozdevice == 0.48 03:42:22 INFO - mozfile == 1.2 03:42:22 INFO - mozhttpd == 0.7 03:42:22 INFO - mozinfo == 0.9 03:42:22 INFO - mozleak == 0.1 03:42:22 INFO - mozlog == 3.3 03:42:22 INFO - moznetwork == 0.27 03:42:22 INFO - mozprocess == 0.23 03:42:22 INFO - mozprofile == 0.28 03:42:22 INFO - mozrunner == 6.12 03:42:22 INFO - mozscreenshot == 0.1 03:42:22 INFO - mozsystemmonitor == 0.3 03:42:22 INFO - moztest == 0.7 03:42:22 INFO - mozversion == 1.4 03:42:22 INFO - psutil == 3.1.1 03:42:22 INFO - requests == 1.2.3 03:42:22 INFO - wsgiref == 0.1.2 03:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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')]} 03:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:22 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:22 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 03:42:22 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 03:42:22 INFO - Using env: {'DISPLAY': ':0', 03:42:22 INFO - 'HOME': '/home/cltbld', 03:42:22 INFO - 'LANG': 'en_US.UTF-8', 03:42:22 INFO - 'LANGUAGE': 'en_US:en', 03:42:22 INFO - 'LOGNAME': 'cltbld', 03:42:22 INFO - 'MAIL': '/var/mail/cltbld', 03:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:22 INFO - 'MOZ_NO_REMOTE': '1', 03:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:22 INFO - 'NO_EM_RESTART': '1', 03:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:22 INFO - 'PWD': '/builds/slave/test', 03:42:22 INFO - 'SHELL': '/bin/bash', 03:42:22 INFO - 'SHLVL': '1', 03:42:22 INFO - 'TERM': 'linux', 03:42:22 INFO - 'TMOUT': '86400', 03:42:22 INFO - 'USER': 'cltbld', 03:42:22 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:22 INFO - '_': '/tools/buildbot/bin/python'} 03:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 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)) 03:42:23 INFO - Cleaning up... 03:42:23 INFO - Return code: 0 03:42:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:42: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')]} 03:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42: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')]} 03:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:42:23 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 0x2493030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2754180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', '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 03:42:23 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 03:42:23 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 03:42:23 INFO - Using env: {'DISPLAY': ':0', 03:42:23 INFO - 'HOME': '/home/cltbld', 03:42:23 INFO - 'LANG': 'en_US.UTF-8', 03:42:23 INFO - 'LANGUAGE': 'en_US:en', 03:42:23 INFO - 'LOGNAME': 'cltbld', 03:42:23 INFO - 'MAIL': '/var/mail/cltbld', 03:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:23 INFO - 'MOZ_NO_REMOTE': '1', 03:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:23 INFO - 'NO_EM_RESTART': '1', 03:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:23 INFO - 'PWD': '/builds/slave/test', 03:42:23 INFO - 'SHELL': '/bin/bash', 03:42:23 INFO - 'SHLVL': '1', 03:42:23 INFO - 'TERM': 'linux', 03:42:23 INFO - 'TMOUT': '86400', 03:42:23 INFO - 'USER': 'cltbld', 03:42:23 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:23 INFO - '_': '/tools/buildbot/bin/python'} 03:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:42:23 INFO - Cleaning up... 03:42:23 INFO - Return code: 0 03:42:23 INFO - Running post-action listener: _resource_record_post_action 03:42:23 INFO - Running post-action listener: _start_resource_monitoring 03:42:23 INFO - Starting resource monitoring. 03:42:23 INFO - [mozharness: 2016-07-26 10:42:23.356512Z] Finished create-virtualenv step (success) 03:42:23 INFO - [mozharness: 2016-07-26 10:42:23.356989Z] Running install step. 03:42:23 INFO - Running pre-action listener: _resource_record_pre_action 03:42:23 INFO - Running main action method: install 03:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:23 INFO - Reading from file tmpfile_stdout 03:42:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:23 INFO - Reading from file tmpfile_stdout 03:42:23 INFO - Output received: 03:42:23 INFO - Usage: mozinstall [options] installer 03:42:23 INFO - Options: 03:42:23 INFO - -h, --help show this help message and exit 03:42:23 INFO - -d DEST, --destination=DEST 03:42:23 INFO - Directory to install application into. [default: 03:42:23 INFO - "/builds/slave/test"] 03:42:23 INFO - --app=APP Application being installed. [default: firefox] 03:42:23 INFO - mkdir: /builds/slave/test/build/application 03:42:23 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'] 03:42:23 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 03:42:40 INFO - Reading from file tmpfile_stdout 03:42:40 INFO - Output received: 03:42:40 INFO - /builds/slave/test/build/application/firefox/firefox 03:42:40 INFO - Running post-action listener: _resource_record_post_action 03:42:40 INFO - [mozharness: 2016-07-26 10:42:40.876824Z] Finished install step (success) 03:42:40 INFO - [mozharness: 2016-07-26 10:42:40.877164Z] Running run-tests step. 03:42:40 INFO - Running pre-action listener: _resource_record_pre_action 03:42:40 INFO - Running main action method: run_tests 03:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:40 INFO - Python 2.7.3 03:42:40 INFO - Return code: 0 03:42:40 INFO - grabbing minidump binary from tooltool 03:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:40 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 0x27523b0>, '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 0x27532b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2753740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:40 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 03:42:40 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 03:42:40 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 03:42:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:40 INFO - Return code: 0 03:42:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:42:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:42:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:42:40 INFO - Using env: {'DISPLAY': ':0', 03:42:40 INFO - 'HOME': '/home/cltbld', 03:42:40 INFO - 'LANG': 'en_US.UTF-8', 03:42:40 INFO - 'LANGUAGE': 'en_US:en', 03:42:40 INFO - 'LOGNAME': 'cltbld', 03:42:40 INFO - 'MAIL': '/var/mail/cltbld', 03:42:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:40 INFO - 'MOZ_NO_REMOTE': '1', 03:42:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:40 INFO - 'NO_EM_RESTART': '1', 03:42:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:40 INFO - 'PWD': '/builds/slave/test', 03:42:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:40 INFO - 'SHELL': '/bin/bash', 03:42:40 INFO - 'SHLVL': '1', 03:42:40 INFO - 'TERM': 'linux', 03:42:40 INFO - 'TMOUT': '86400', 03:42:40 INFO - 'USER': 'cltbld', 03:42:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780', 03:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:40 INFO - '_': '/tools/buildbot/bin/python'} 03:42:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:42:41 INFO - mozversion application_buildid: 20160726003003 03:42:41 INFO - mozversion application_changeset: 5125ae09224aa5358f923b792a84f3f0e0a6c256 03:42:41 INFO - mozversion application_display_name: Nightly 03:42:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:41 INFO - mozversion application_name: Firefox 03:42:41 INFO - mozversion application_remotingname: firefox 03:42:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:42:41 INFO - mozversion application_vendor: Mozilla 03:42:41 INFO - mozversion application_version: 50.0a1 03:42:41 INFO - mozversion platform_buildid: 20160726003003 03:42:41 INFO - mozversion platform_changeset: 5125ae09224aa5358f923b792a84f3f0e0a6c256 03:42:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:42:41 INFO - mozversion platform_version: 50.0a1 03:42:41 INFO - using testdate: 1469529761 03:42:41 INFO - actual date: 1469529761 03:42:41 INFO - starting webserver on 'localhost:33444' 03:42:41 INFO - SUITE-START | Running 2 tests 03:42:41 INFO - TEST-START | dromaeo_css 03:42:41 INFO - operating with platform_type : linux_ 03:42:41 INFO - Initialising browser for dromaeo_css test... 03:42:41 INFO - TEST-INFO | started process 14462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hKkhN/profile http://localhost:33444/getInfo.html) 03:42:44 INFO - PROCESS | 14462 | JavaScript error: , line 0: uncaught exception: undefined 03:42:45 INFO - PROCESS | 14462 | __metrics Screen width/height:1600/1200 03:42:45 INFO - PROCESS | 14462 | colorDepth:24 03:42:45 INFO - PROCESS | 14462 | Browser inner width/height: 1024/697 03:42:45 INFO - PROCESS | 14462 | __metrics 03:42:46 INFO - PROCESS | 14462 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:42:46 INFO - PROCESS | 14462 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:47 INFO - TEST-INFO | 14462: exit 0 03:42:47 INFO - Browser initialized. 03:42:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:47 INFO - TEST-INFO | started process 14545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hKkhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:59 INFO - PROCESS | 14545 | RSS: Main: 157790208 03:42:59 INFO - PROCESS | 14545 | 03:43:50 INFO - PROCESS | 14545 | 1469529830402 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] 03:45:58 INFO - PROCESS | 14545 | Cycle 1(1): loaded http://localhost:33444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33444/tests/dromaeo/cssquery-ext.html) 03:45:59 INFO - PROCESS | 14545 | RSS: Main: 247234560 03:45:59 INFO - PROCESS | 14545 | 03:49:01 INFO - PROCESS | 14545 | Cycle 1(1): loaded http://localhost:33444/tests/dromaeo/cssquery-ext.html (next: http://localhost:33444/tests/dromaeo/cssquery-jquery.html) 03:49:02 INFO - PROCESS | 14545 | RSS: Main: 245616640 03:49:02 INFO - PROCESS | 14545 | 03:52:04 INFO - PROCESS | 14545 | Cycle 1(1): loaded http://localhost:33444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33444/tests/dromaeo/cssquery-mootools.html) 03:52:04 INFO - PROCESS | 14545 | RSS: Main: 189825024 03:52:04 INFO - PROCESS | 14545 | 03:55:06 INFO - PROCESS | 14545 | Cycle 1(1): loaded http://localhost:33444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33444/tests/dromaeo/cssquery-prototype.html) 03:55:07 INFO - PROCESS | 14545 | RSS: Main: 189657088 03:55:07 INFO - PROCESS | 14545 | 03:58:10 INFO - PROCESS | 14545 | Cycle 1(1): loaded http://localhost:33444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33444/tests/dromaeo/cssquery-yui.html) 03:58:10 INFO - PROCESS | 14545 | RSS: Main: 191844352 03:58:10 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | Cycle 1(1): loaded http://localhost:33444/tests/dromaeo/cssquery-yui.html (next: http://localhost:33444/tests/dromaeo/cssquery-dojo.html) 04:01:13 INFO - PROCESS | 14545 | RSS: Main: 280854528 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | __start_tp_report 04:01:13 INFO - PROCESS | 14545 | _x_x_mozilla_page_load 04:01:13 INFO - PROCESS | 14545 | _x_x_mozilla_page_load_details 04:01:13 INFO - PROCESS | 14545 | |i|pagename|runs| 04:01:13 INFO - PROCESS | 14545 | |0;dojo.html;3014.382051679406;3028.4548781219373;3056.388722255548;3057.357954829485;3064.6169228846393;5170.870728231796;5201.271821944931;5226;5288.894222115556;5367.946320536798;5287.47125287471;5293.8941221175555;5294.311739473863;5349.7592608332625;5396.136618141099;4788.114198873202;4808.014357056803;4822.927656085161;4832.7583620819;4958.132326842806;4899;4920.97539512302;4931.3835770528685;4932.062908047459;4949.579285760715;4708.246680531099;4725.22033864412;4751.881202969919;4846.466888642247;4872.6101911847145;4758.381410416659;4758.809647614091;4768.642351823627;4768.928466073012;4775.522447755231;4711.104890070876;4744.7627618618935;4749.453812811502;4803.495632958524;4877;5238.449962753933;5260.8684782880355;5286.444923283077;5311.309529761106;5329.733513324357;5440.292761940962;5612.887742245173;5613.4386561343945;5656.604037717361;5665.915011274834;5685.374608793029;5719.656820590736;5726.885462290731;5765.394633563457;5774.97112514439;5349.117395629716;5369.114096174127;5377.220303056074;5378.19327100938;5383.16560933056;5561.026820306431;5759.251297331404;5789.652620842763;5857.560682948711;5865.090910908816;5591.41290164535;5640.407757185437;5641.576881733887;5643.209950606918;5651.971740141355;5665.461781130786;5708.20085188074;5714.657120572779;5715.514181294553;5726;5423.620346575781;5512.145617429305;5524.254225679482;5653.067243904792;5664.348599911063;5537.920105579374;5538.944610553924;5552.5280351169795;5563.63836350644;5587.7485513152005;4281.850135245314;4332.00363916301;4332.1119170569955;4340.283853164193;4374.4531933508315;3812.066043819282;3862.4592557042038;3878.6121387861554;3892;3903.746256493319;5332.0402327581405;5370.113931201387;5392.595555333366;5439.5104440600535;5440.075187218183;5638.577106717013;5653.321601407857;5656.179853921159;5658.632188907708;5662.462066103713;5227.660202086929;5309.787608495694;5335.093034184198;5396.865078373072;5401.702906340189;4924.01519696055;4931.654784165074;4958.281049247839;5005.199168133154;5009.273655319958;5822.359540450631;5830.47525722687;5835;5840.269966254218;5840.970795145997;5493.066178749702;5584.888302233851;5589.10574308125;5653.523083303657;5704.828855134353;5819.272590926134;5846.473817356458;5864.970675146597;5881.529477641693;5891.558133140117;5559.749811258423;5561.944380556304;5564.360098588714;5565.944340556704;5566.888662226814;5477.917831232455;5595.412481689364;5659.320881494247;5662.66024038559;5664.858378540404;5471.37079235893;5478.205660179331;5539.861503462445;5582.16267559853;5587.02227110246;5488.835334939959;5531.197976293495;5535.723213839373;5537.2524709163745;5537.7784888604;5376.569874410116;5437.592180586393;5462.562994960473;5503;5551.611387203018;5554.527865131509;5621.213030175697;5658.971705141448;5660.405657406078;5665.915011274917;5466.72666366688;5486.753096110605;5496.725163741717;5503.889922201613;5505.449455054462 04:01:13 INFO - PROCESS | 14545 | |1;ext.html;601.6390165900459;618.3105836991753;628.7139351595025;640.0463309668589;643.3116565275154;30488.390232195343;33282.833585832064;42901;44264.55735442653;44321.11357772843;45065;45323.320150197775;45331.77334113333;45437.31844022334;45488.77255613717;8865.069167737407;8993.730188094367;9006.549672516381;9020.684276050339;9035.59339829706;8956.32827537934;9021.188093071622;9030.548472576378;9032.593533291018;9041.728748137533;9039.954800225989;9084.409513381643;9091.727248182566;9092.090790920922;9094.681686140986;8947.239484643813;8996.280297576179;9019.639214431414;9030.86453703195;9044.864327035068;8874.778130546723;8940.508272045035;8943.284537237005;8952.55237238142;8954.686585969524;41764.791176043924;42180;42182.57817421848;42229.366559501635;42298.57701423008;3573.5890372607223;3580.838862251205;3620.3845346291196;3731.067233191702;3749.9625003750157;31437.528437073463;31643.525347119812;31710.365792684246;31753.364932701217;31898.350841016254;4072.8574499892657;4115.403266526367;4141.958580414218;4151.481064866892;4238.978805105986;332366;334736.3263183693;335313;335851;340973;57983.71008145017;58024.709876450346;58101.8379632405;58177.70911145417;58423.12365314524;53560;59583;60538.69730651407;60734;60853;16082.115483648278;17035.48893533196;17095.316187352368;17095.48713538596;17118.315267389164;13366.198028118344;13416.195028298333;13459.730805383837;13461.798073028913;13465.326733663474;14833.629159271104;16325.755113673304;16336.836631633532;16428;16609;5669.801556945487;5732.742026608813;5784.595078344475;5911.467967882912;5964.194833697482;916.812053529025;977.4672803322206;1077.719792853848;1113.716002419378;1143.89704926557;32571.51142732861;32690.182745431553;32846.507302390484;32904.3419131616;32976.835115824746;1097.4622435006788;1097.9945100274447;1105.6130354375905;1111.216592302425;1156.687694322545;16420.640235065897;17076.829231707772;17252.913735431495;17253.827461725472;17445.127743612768;523889;526706;527673;527761;528024;59315.40684593185;59362.40637593569;59423.405765942654;59465.40534594685;59497;1307.6077176847098;1362.434589645286;1366.453418632555;1381.205806661174;1389.5136702154368;30341.241468963453;31381.8430907844;32139.19652008625;32290;32529.83735081404;51697;51845.7407712959;52069.21896171636;52109.7394513025;52169.739151304;424516;427748;428923;429262;429595;35720;40064.7996760026;41018.58981410148;41140.58859411367;42279.577204227564;43879;47709.28436073531;48346.5165348342;48413.273800893716;48916.75541622269;40257.77293384152;41538.792306038275;42048.15903681848;42767;42870.78564607157;40063.79968100141;41225.79387103045;41300.58699413088;41570.67853792005;42802;40019.19433766988;40874.1825163501;41101.50637195872;41240.79379603203;41692.791536042125;35175.47236791501;37398;37982.240355193295;38085;38231.61768382392;27589;27653.446931060862;27794.444111118068;28021.299467513476;28040.298992524535 04:01:13 INFO - PROCESS | 14545 | |2;jquery.html;377.3735598905819;390.30915279954473;395.7803419102398;405.2098408104194;410.2308172177168;17975;18651.533711657183;20566.560340776152;20755.273565425214;20783;11116.5553377865;11694.590689325876;11696.649100526998;11697.824532632018;17199;4974.527419895104;5171.301874246966;5175.689458632475;5175.792968281265;5180.533751962323;3926.9018274543223;5037.773300201499;5114.795408183668;6620.172478440195;6631.336866313378;6706.497012724041;6707.698153583076;6717.126773519436;6718.496112791536;6720.227173875018;5819.883602327951;5835.737391817378;5850.297964244318;5854.209681692981;6223.0354295084335;5483.698396588186;5679.233303504016;5685.573581981368;5686.545076393879;5688.260526131618;12687.984961203081;12815.487380504768;12884.87115128846;12887.93556032214;12900.870991290061;2229.3869185973826;2346.8239882008916;2384.8449850759816;2392.9521409571885;2395.47299594089;9391.154796068387;9403.200727938134;9782.461964591945;11487.253328533701;13666.36003679555;1866.7853196882397;1890.5084677983823;1916.2430839818333;1916.32928475034;1958.4439869105533;82572.58713706453;82810.58594707047;83887;84676.57661711652;86259.56870215734;10310.587576497006;10378.377297362182;10627.84058239127;11084.445777711082;11249.887501125047;13955.441782328593;13962.162270263816;13987.160770353812;13992.790108148385;15652.68694626101;8087.514749115072;8155.918440815516;8241.546714930737;8376.455530390505;8433.367497437594;7799.5320280783335;7805.180456052033;8019.318357939524;8056.194380562014;8086.676532938734;4049.979750101231;4179.247735407595;4723.197056500403;4733.387249624155;4777.498362671939;1755.815639357849;1929.0644037641732;1960.9705854412196;1963.4993076765334;2032.5325175209489;885.5572213893054;949.586929685589;1018.5925629748012;1020.9982651006019;1036.036486067964;19452.805471945383;19829.801701982797;20016.499587510138;20088;20106.899465502873;936.7002559181133;936.8501039833594;972.601233494264;978.9021097890296;984.4044353166374;8587.313014958789;11094.667159985212;11099.34145439644;11145.72135696614;11282.266652667715;497992;502892;504123;504611;504947;92106;92390;93366.53316733374;93843;94052;962.8459446488528;1001.7796084861319;1013.5793645636978;1019.6278358399131;1034.5551412892378;16972.575685607957;17018.744718829475;17720.55698607545;17864.747338431964;17964.281428743227;39748.602513975646;42435.57564424316;42564.787176063925;42588.78705606576;43717.78141109274;50337.244941326644;60233.39766602278;60362.39637603568;62288.688556556925;62744;7787.5716835574585;7920.920790792018;7979.800504987422;8021.077576078592;8030.196980301923;11659.825102623638;12214;12843.293618851052;13324.200547967153;13414.664633383853;11198.272112312674;11497.195196336175;11542.713717991084;11565.768684626091;11808.527658893892;11413.315201087962;11614.070874330202;11676.241044332091;11777.823332649845;12097;10588.894111058791;11596.88403115958;11610.5355785771;11874.940625296818;12164.878351216728;6844.589324640538;6988.930110698828;7117.8576428470105;8426.283765879969;8477.788055298666;11277.32336059839;11381.374024428405;11391.715207119889;11449.713757156138;11517.654470365902 04:01:13 INFO - PROCESS | 14545 | |3;mootools.html;1319.564543700579;1461.0722191408456;1545.4436402894955;1667.5414261078201;1818.8453981411587;8539.658413663454;8810.69162579309;8858.291336693073;9144.542772861347;9155.77110572236;9029;9114.589843457044;9116.817663646723;9121;9121.224695900857;2343.3907184132077;2368.5144545368244;2376.9881150594224;2378.357843382286;2380.5595964746576;2293.655951607264;2342.2387723989686;2349.659299401586;2352.4118970257437;2353.199912029918;2283.8401311908174;2300.8734519601417;2306.8269879759;2327.0342807734855;2328.115316179858;2261.8303627228024;2281.269993602048;2286.4626812699003;2290.725112986444;2290.828187885915;2182.923597674074;2187.562487502506;2188.6607575825774;2192.090282532747;2197.4067001909557;9024.729258122201;9059.365844390895;9104;9122.407043542215;9165;5095.847124586268;5279.472052794728;5297.516695325315;5300.2314664373835;5305.920411193797;3312.2216279174377;3332.516785066176;3354.1782263345635;3373.4096533106854;3376.4428869236544;1070.983935240972;1071.266182664877;1073.6295977887617;1084.6095405653957;1090.2586241355875;12781.61655150347;12820.423080961378;12822.294773787438;12872.806907896389;12877.098603097787;4306.74159550428;4353.3469979503325;4471.910561788811;4484.865454036384;4574.176648203355;10010.399376037461;10013.449260290608;10014.24893133018;10016.49917504122;10020.599176032876;5309.761060752276;5324;5325.893482130413;5328.786848526015;5328.786848526093;4276.08064266178;4721.5986641135205;4790.089882922233;4835.8065677372515;5004;3820.67524260441;3898.5126859142606;3971.4439978403047;3971.543272523639;4010.959890401117;1166.4809159923752;1167.2937872586963;1173.5765643945397;1175.353555544447;1182.532899504691;844.4595458906305;893.2139717049085;930.1070971866948;979.7550612346913;988.7824678570703;6033;6061.151438798572;6205.596636218631;6372.904406433907;6408.679566021773;435.36654168185214;437.2719422162128;447.9865604031819;448.21338550843063;452.6763364194617;4202.600752928467;4331.7834108294455;4339.609435150852;4355.107203023373;4394.978025109854;11031.393273370042;11209.887901121048;11337.603183888525;11429.771404571862;11475.885241147482;10842.674719758419;11184.720381990515;11374.658760237206;11393.601223957121;11400.543978240943;8131.064927533291;8304.54325012118;8307.958460207661;8315.04376996641;8323.708670196635;6213.1922850029205;6286.717097730521;6321.494280457644;6431.292557818542;6564.179477565304;10633.946830266108;10674.57301707923;10701.357918524602;10747.247692661438;10792.352458852494;10029.498525073863;10250.487475626338;10284.382937023802;10295.897041029493;10468.424236667057;7632.923670763444;8373.07896131413;8534.487930724177;8537.402381833212;8708.129187081242;8918.509481978554;9069.093090690878;9078.54607269647;9082.318826087938;9083.091690831128;7827.9608601956625;7886.250806173404;7950.363970882431;7975.920240797518;8024.638891250024;7823.608819558885;7886.68453261886;7926.286634202949;7937;7975.960120199594;6970.059042029464;7133.821654458472;7184.281571842774;7186.317299856505;7204.24355442671;5378.139497680352;5401.945980540144;5415.675059496442;5510.201020851874;5591.776328946797;5342.171963345688;5363.222332761806;5424.294841670558;5450.727463626724;5465 04:01:13 INFO - PROCESS | 14545 | |4;prototype.html;299.83958582158544;304.98932537361185;306.80824484697064;312.28330980400006;315.4070347746238;5345.385280692722;5377.4084850666395;5378.677279363236;5394.1908713692965;5395.379531353896;5227.144363750871;5275.340582427197;5298.973505132469;5308.177232528955;5321.494458026481;4135.31767258402;4149.879532526224;4153.231652144348;4160.583941605845;4169.437125987998;3872.6514613684762;4076.368162934735;4092.9386059209137;4129.153523527684;4166.791660416982;4045.37296719009;4052.533958594755;4078.449409329747;4080;4085.2850751118585;3871.3805791073573;4050.9594904051023;4065.6544193743566;4067.5932406759384;4076.4700588923547;3435.587729472479;3525.700315473188;3531.682148606638;3535.893923182283;3550.3964326064374;5157.7936882524655;5160.200168973815;5168.793248270064;5189.948100518985;5198.818041368534;4406.933895991563;4601.976990115028;4604.122423485322;4637.026224492861;4667.929981050287;5108;5427.972860135714;5435.7825686972865;5463.31708536433;5503.284573005483;3885.9222815543812;3892.1048158923604;3893.552241492236;3899.707521935866;3909.2376986487648;5585.776568937237;5733.512651424592;5759.712014399263;5799.82600521985;5810.738516766755;3909.257241124177;3921.8431262749173;3938.5076865391825;3951.8221680024467;3962.663173630216;3994.820233089518;4011;4024.63778259958;4026.3960405938756;4029.657479114308;4650.86047418578;4666.533346665306;4666.719996800135;4671.462781780138;4678.578927896506;5424.213489044146;5529.889402211933;5536.944630553643;5556.444355564411;5561;1372.6225288045866;1384.3493558027913;1385.8336999560117;1387.6877702516854;1395.0165133580801;848.7538613801928;889.3152272749946;893.5130353956979;906.551257127726;908.1009800297658;4711.764411779397;4789.137955168103;4827.541383568555;4842.990159083941;4858.198397264412;5023.723695196726;5041.445441001487;5054.545090941833;5064.41759197697;5095.617828662791;4814.542618451242;4815.22956326986;4887.828925987645;4891.6575839691595;5028.296038554606;2922.4885645012037;2954.2023653613405;2974.6876577959;3002.774791890617;3068.309630333157;5941.940580594225;5947.732352044169;5954.106883967353;5965.224520812267;5976.282846058501;5860.736266867916;5868.823935281948;5876.677747506862;5884.47039766423;5886.323072846678;5693.750968367472;5881.705914704247;5885.2349194605285;5890.2637170354565;5903.881922361615;5687.260656114679;5694.4590263924865;5702.173184888251;5723.942760572508;5729.2551968245525;5416.729163541886;5650.29371328584;5674.786833135163;5726.455986681259;5748.655080695172;5895.764169433174;5930.9110363343725;5938.762449502145;5950.910736338872;5963.701814909324;3900.3369427196876;3938.960610393974;3953.150072734376;3975.7018223632763;3986.402039693953;5483.588730845123;5700.230468886647;5762.337331206965;5774.249347584787;5776.913346299725;5567.777288908398;5571;5573.5819813513335;5588.692621905834;5612.550995920398;5585.804496842591;5593.636413633101;5618.971905140448;5628.493435590816;5652.7173641318595;5273.894522109613;5508.807191748269;5521.668699878021;5536.390996990408;5563.527100196528;5645.1532270159805;5685.289338832646;5690.231818704422;5698.2592263005545;5698.886022279614;5423.5932305076485;5450.249931610785;5458.563314934875;5584.213051823377;5592.105263157875 04:01:13 INFO - PROCESS | 14545 | |5;yui.html;794.781435105346;795.3279478840379;813.5403497024184;822.3544517553721;861.2765277167181;14708.852911470896;15566.221688915537;15605.219739013033;15618.531444056667;15707.136107514083;14055.859441405582;14443.78334324986;14533.92733036336;14632.561023169323;14635.487757928475;814.6782021101661;831.6465502161587;835.0688981785296;838.1032295443878;839.5088873009297;670.0920253057111;801.410962942237;827.2224109337234;828.2297463359074;828.4449418889359;851.2423942691009;853.2448782827212;853.3471894001063;853.6457370191363;854.3763052971335;850.2135524639715;855.6449073634434;855.7603870916154;856.8800367948461;857.652650676477;511.40676814894914;511.71088335090553;605.7455868535226;608.4827896288164;627.0656721485;14241.572752817432;14679.339429725582;14713.485028024075;14716.411343546246;14726.779098313535;13764.862351376458;14010.929945350208;14302.785458218135;14348.92825535876;14587.854121458862;13240.933795330962;13287.175233563657;13292.73414531704;13452.05835591509;13753.312334383241;4585.518520555327;4627.652926030528;4641.350210970467;4646.4191976003;4865.975670121662;77412;78198.82701759478;78283.99999999943;78508.60745696293;80291.59854200692;11399.430028498542;11739.665734551549;11853.703657408634;11998.520059197708;12104.939475302566;22438.32685019452;22547.323580292617;22725;22756.658650120262;22816.543669126524;8764.342674299452;8812;8910.420822646507;8965.417247878868;9021.142991415805;4689.109069276827;4711.081339138835;4781.474037855833;4800.423949126127;4821.54195351441;3517.751198324558;3651.2697460507475;3690.3541880170865;3699.4635777812605;3717.3494638438706;600.5465873265744;611.3672349118641;615.6060121522229;618.6350053468475;620.0513214781391;634.6160572853357;686.9759558415532;711.1679335177854;746.2052913646949;757.2276278196209;9678.75803104914;10335.379877207391;10373.325733827278;10432.426216558011;10482.895171048192;658.5620562326;680.5542369747823;695.8538706871512;761.2958013837289;766.5324152267112;4397.626201772821;4707.764611769467;4761.381020467386;4790.4251489820745;4837.395325584302;73897;117504.41247793706;121486;123666;124391;101935.4903225479;104851.4757426208;106108;107856;108786;92496.53751731198;94386;94415.52792235995;95301;95448.52275738577;9102.49936253486;9212.539373031455;9220.157727609214;9351.53242337894;9434.103760142776;52589.7370513145;53574.73212633912;53936.460635393145;54025;55385.44614553803;67774;68515.65742171257;68738;71516.64241678758;76700;13526.526571569948;13712.862871371159;13720.725585488035;13747.656308592364;13968.790468142783;15375.154366509949;15376.461823836113;15464.825308067377;15630.531084067496;15719;10113.949430252802;14047.648808779863;14149.504767333094;14215.928920355746;14672.26638668041;13993.510227142002;13999.300034998005;14331.553994557611;14643.623585621157;14771.704565908407;13946.093503922213;14296.57110286693;14389;14497.492587759378;14498.347574358968;11137.443127843413;11345.829812552653;11465.26480599744;11514.76970460603;11627.069834413396;11402.600908968147;11930.403479826147;12276.81584776247;12292.262464252173;12629.93685031569 04:01:13 INFO - PROCESS | 14545 | __end_tp_report 04:01:13 INFO - PROCESS | 14545 | __start_cc_report 04:01:13 INFO - PROCESS | 14545 | _x_x_mozilla_cycle_collect,983 04:01:13 INFO - PROCESS | 14545 | __end_cc_report 04:01:13 INFO - PROCESS | 14545 | __startTimestamp1469530873733__endTimestamp 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | ------- Summary: start ------- 04:01:13 INFO - PROCESS | 14545 | Number of tests: 6 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | [#0] dojo.html Cycles:165 Average:5260.40 Median:5477.92 stddev:593.94 (10.8%) stddev-sans-first:569.02 04:01:13 INFO - PROCESS | 14545 | Values: 3014.4 3028.5 3056.4 3057.4 3064.6 5170.9 5201.3 5226.0 5288.9 5367.9 5287.5 5293.9 5294.3 5349.8 5396.1 4788.1 4808.0 4822.9 4832.8 4958.1 4899.0 4921.0 4931.4 4932.1 4949.6 4708.2 4725.2 4751.9 4846.5 4872.6 4758.4 4758.8 4768.6 4768.9 4775.5 4711.1 4744.8 4749.5 4803.5 4877.0 5238.4 5260.9 5286.4 5311.3 5329.7 5440.3 5612.9 5613.4 5656.6 5665.9 5685.4 5719.7 5726.9 5765.4 5775.0 5349.1 5369.1 5377.2 5378.2 5383.2 5561.0 5759.3 5789.7 5857.6 5865.1 5591.4 5640.4 5641.6 5643.2 5652.0 5665.5 5708.2 5714.7 5715.5 5726.0 5423.6 5512.1 5524.3 5653.1 5664.3 5537.9 5538.9 5552.5 5563.6 5587.7 4281.9 4332.0 4332.1 4340.3 4374.5 3812.1 3862.5 3878.6 3892.0 3903.7 5332.0 5370.1 5392.6 5439.5 5440.1 5638.6 5653.3 5656.2 5658.6 5662.5 5227.7 5309.8 5335.1 5396.9 5401.7 4924.0 4931.7 4958.3 5005.2 5009.3 5822.4 5830.5 5835.0 5840.3 5841.0 5493.1 5584.9 5589.1 5653.5 5704.8 5819.3 5846.5 5865.0 5881.5 5891.6 5559.7 5561.9 5564.4 5565.9 5566.9 5477.9 5595.4 5659.3 5662.7 5664.9 5471.4 5478.2 5539.9 5582.2 5587.0 5488.8 5531.2 5535.7 5537.3 5537.8 5376.6 5437.6 5462.6 5503.0 5551.6 5554.5 5621.2 5659.0 5660.4 5665.9 5466.7 5486.8 5496.7 5503.9 5505.4 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | [#1] ext.html Cycles:180 Average:59590.25 Median:42114.08 stddev:115786.87 (274.9%) stddev-sans-first:116026.98 04:01:13 INFO - PROCESS | 14545 | Values: 601.6 618.3 628.7 640.0 643.3 30488.4 33282.8 42901.0 44264.6 44321.1 45065.0 45323.3 45331.8 45437.3 45488.8 8865.1 8993.7 9006.5 9020.7 9035.6 8956.3 9021.2 9030.5 9032.6 9041.7 9040.0 9084.4 9091.7 9092.1 9094.7 8947.2 8996.3 9019.6 9030.9 9044.9 8874.8 8940.5 8943.3 8952.6 8954.7 41764.8 42180.0 42182.6 42229.4 42298.6 3573.6 3580.8 3620.4 3731.1 3750.0 31437.5 31643.5 31710.4 31753.4 31898.4 4072.9 4115.4 4142.0 4151.5 4239.0 332366.0 334736.3 335313.0 335851.0 340973.0 57983.7 58024.7 58101.8 58177.7 58423.1 53560.0 59583.0 60538.7 60734.0 60853.0 16082.1 17035.5 17095.3 17095.5 17118.3 13366.2 13416.2 13459.7 13461.8 13465.3 14833.6 16325.8 16336.8 16428.0 16609.0 5669.8 5732.7 5784.6 5911.5 5964.2 916.8 977.5 1077.7 1113.7 1143.9 32571.5 32690.2 32846.5 32904.3 32976.8 1097.5 1098.0 1105.6 1111.2 1156.7 16420.6 17076.8 17252.9 17253.8 17445.1 523889.0 526706.0 527673.0 527761.0 528024.0 59315.4 59362.4 59423.4 59465.4 59497.0 1307.6 1362.4 1366.5 1381.2 1389.5 30341.2 31381.8 32139.2 32290.0 32529.8 51697.0 51845.7 52069.2 52109.7 52169.7 424516.0 427748.0 428923.0 429262.0 429595.0 35720.0 40064.8 41018.6 41140.6 42279.6 43879.0 47709.3 48346.5 48413.3 48916.8 40257.8 41538.8 42048.2 42767.0 42870.8 40063.8 41225.8 41300.6 41570.7 42802.0 40019.2 40874.2 41101.5 41240.8 41692.8 35175.5 37398.0 37982.2 38085.0 38231.6 27589.0 27653.4 27794.4 28021.3 28040.3 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | [#2] jquery.html Cycles:180 Average:29003.98 Median:2161.34 stddev:83033.59 (3841.8%) stddev-sans-first:83238.70 04:01:13 INFO - PROCESS | 14545 | Values: 377.4 390.3 395.8 405.2 410.2 17975.0 18651.5 20566.6 20755.3 20783.0 11116.6 11694.6 11696.6 11697.8 17199.0 4974.5 5171.3 5175.7 5175.8 5180.5 3926.9 5037.8 5114.8 6620.2 6631.3 6706.5 6707.7 6717.1 6718.5 6720.2 5819.9 5835.7 5850.3 5854.2 6223.0 5483.7 5679.2 5685.6 5686.5 5688.3 12688.0 12815.5 12884.9 12887.9 12900.9 2229.4 2346.8 2384.8 2393.0 2395.5 9391.2 9403.2 9782.5 11487.3 13666.4 1866.8 1890.5 1916.2 1916.3 1958.4 82572.6 82810.6 83887.0 84676.6 86259.6 10310.6 10378.4 10627.8 11084.4 11249.9 13955.4 13962.2 13987.2 13992.8 15652.7 8087.5 8155.9 8241.5 8376.5 8433.4 7799.5 7805.2 8019.3 8056.2 8086.7 4050.0 4179.2 4723.2 4733.4 4777.5 1755.8 1929.1 1961.0 1963.5 2032.5 885.6 949.6 1018.6 1021.0 1036.0 19452.8 19829.8 20016.5 20088.0 20106.9 936.7 936.9 972.6 978.9 984.4 8587.3 11094.7 11099.3 11145.7 11282.3 497992.0 502892.0 504123.0 504611.0 504947.0 92106.0 92390.0 93366.5 93843.0 94052.0 962.8 1001.8 1013.6 1019.6 1034.6 16972.6 17018.7 17720.6 17864.7 17964.3 39748.6 42435.6 42564.8 42588.8 43717.8 50337.2 60233.4 60362.4 62288.7 62744.0 7787.6 7920.9 7979.8 8021.1 8030.2 11659.8 12214.0 12843.3 13324.2 13414.7 11198.3 11497.2 11542.7 11565.8 11808.5 11413.3 11614.1 11676.2 11777.8 12097.0 10588.9 11596.9 11610.5 11874.9 12164.9 6844.6 6988.9 7117.9 8426.3 8477.8 11277.3 11381.4 11391.7 11449.7 11517.7 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | [#3] mootools.html Cycles:180 Average:5933.13 Median:2459.95 stddev:3456.46 (140.5%) stddev-sans-first:3448.76 04:01:13 INFO - PROCESS | 14545 | Values: 1319.6 1461.1 1545.4 1667.5 1818.8 8539.7 8810.7 8858.3 9144.5 9155.8 9029.0 9114.6 9116.8 9121.0 9121.2 2343.4 2368.5 2377.0 2378.4 2380.6 2293.7 2342.2 2349.7 2352.4 2353.2 2283.8 2300.9 2306.8 2327.0 2328.1 2261.8 2281.3 2286.5 2290.7 2290.8 2182.9 2187.6 2188.7 2192.1 2197.4 9024.7 9059.4 9104.0 9122.4 9165.0 5095.8 5279.5 5297.5 5300.2 5305.9 3312.2 3332.5 3354.2 3373.4 3376.4 1071.0 1071.3 1073.6 1084.6 1090.3 12781.6 12820.4 12822.3 12872.8 12877.1 4306.7 4353.3 4471.9 4484.9 4574.2 10010.4 10013.4 10014.2 10016.5 10020.6 5309.8 5324.0 5325.9 5328.8 5328.8 4276.1 4721.6 4790.1 4835.8 5004.0 3820.7 3898.5 3971.4 3971.5 4011.0 1166.5 1167.3 1173.6 1175.4 1182.5 844.5 893.2 930.1 979.8 988.8 6033.0 6061.2 6205.6 6372.9 6408.7 435.4 437.3 448.0 448.2 452.7 4202.6 4331.8 4339.6 4355.1 4395.0 11031.4 11209.9 11337.6 11429.8 11475.9 10842.7 11184.7 11374.7 11393.6 11400.5 8131.1 8304.5 8308.0 8315.0 8323.7 6213.2 6286.7 6321.5 6431.3 6564.2 10633.9 10674.6 10701.4 10747.2 10792.4 10029.5 10250.5 10284.4 10295.9 10468.4 7632.9 8373.1 8534.5 8537.4 8708.1 8918.5 9069.1 9078.5 9082.3 9083.1 7828.0 7886.3 7950.4 7975.9 8024.6 7823.6 7886.7 7926.3 7937.0 7976.0 6970.1 7133.8 7184.3 7186.3 7204.2 5378.1 5401.9 5415.7 5510.2 5591.8 5342.2 5363.2 5424.3 5450.7 5465.0 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | [#4] prototype.html Cycles:180 Average:4617.25 Median:5212.98 stddev:1386.57 (26.6%) stddev-sans-first:1352.07 04:01:13 INFO - PROCESS | 14545 | Values: 299.8 305.0 306.8 312.3 315.4 5345.4 5377.4 5378.7 5394.2 5395.4 5227.1 5275.3 5299.0 5308.2 5321.5 4135.3 4149.9 4153.2 4160.6 4169.4 3872.7 4076.4 4092.9 4129.2 4166.8 4045.4 4052.5 4078.4 4080.0 4085.3 3871.4 4051.0 4065.7 4067.6 4076.5 3435.6 3525.7 3531.7 3535.9 3550.4 5157.8 5160.2 5168.8 5189.9 5198.8 4406.9 4602.0 4604.1 4637.0 4667.9 5108.0 5428.0 5435.8 5463.3 5503.3 3885.9 3892.1 3893.6 3899.7 3909.2 5585.8 5733.5 5759.7 5799.8 5810.7 3909.3 3921.8 3938.5 3951.8 3962.7 3994.8 4011.0 4024.6 4026.4 4029.7 4650.9 4666.5 4666.7 4671.5 4678.6 5424.2 5529.9 5536.9 5556.4 5561.0 1372.6 1384.3 1385.8 1387.7 1395.0 848.8 889.3 893.5 906.6 908.1 4711.8 4789.1 4827.5 4843.0 4858.2 5023.7 5041.4 5054.5 5064.4 5095.6 4814.5 4815.2 4887.8 4891.7 5028.3 2922.5 2954.2 2974.7 3002.8 3068.3 5941.9 5947.7 5954.1 5965.2 5976.3 5860.7 5868.8 5876.7 5884.5 5886.3 5693.8 5881.7 5885.2 5890.3 5903.9 5687.3 5694.5 5702.2 5723.9 5729.3 5416.7 5650.3 5674.8 5726.5 5748.7 5895.8 5930.9 5938.8 5950.9 5963.7 3900.3 3939.0 3953.2 3975.7 3986.4 5483.6 5700.2 5762.3 5774.2 5776.9 5567.8 5571.0 5573.6 5588.7 5612.6 5585.8 5593.6 5619.0 5628.5 5652.7 5273.9 5508.8 5521.7 5536.4 5563.5 5645.2 5685.3 5690.2 5698.3 5698.9 5423.6 5450.2 5458.6 5584.2 5592.1 04:01:13 INFO - PROCESS | 14545 | 04:01:13 INFO - PROCESS | 14545 | [#5] yui.html Cycles:180 Average:21390.16 Median:4634.50 stddev:30841.97 (665.5%) stddev-sans-first:30889.72 04:01:13 INFO - PROCESS | 14545 | Values: 794.8 795.3 813.5 822.4 861.3 14708.9 15566.2 15605.2 15618.5 15707.1 14055.9 14443.8 14533.9 14632.6 14635.5 814.7 831.6 835.1 838.1 839.5 670.1 801.4 827.2 828.2 828.4 851.2 853.2 853.3 853.6 854.4 850.2 855.6 855.8 856.9 857.7 511.4 511.7 605.7 608.5 627.1 14241.6 14679.3 14713.5 14716.4 14726.8 13764.9 14010.9 14302.8 14348.9 14587.9 13240.9 13287.2 13292.7 13452.1 13753.3 4585.5 4627.7 4641.4 4646.4 4866.0 77412.0 78198.8 78284.0 78508.6 80291.6 11399.4 11739.7 11853.7 11998.5 12104.9 22438.3 22547.3 22725.0 22756.7 22816.5 8764.3 8812.0 8910.4 8965.4 9021.1 4689.1 4711.1 4781.5 4800.4 4821.5 3517.8 3651.3 3690.4 3699.5 3717.3 600.5 611.4 615.6 618.6 620.1 634.6 687.0 711.2 746.2 757.2 9678.8 10335.4 10373.3 10432.4 10482.9 658.6 680.6 695.9 761.3 766.5 4397.6 4707.8 4761.4 4790.4 4837.4 73897.0 117504.4 121486.0 123666.0 124391.0 101935.5 104851.5 106108.0 107856.0 108786.0 92496.5 94386.0 94415.5 95301.0 95448.5 9102.5 9212.5 9220.2 9351.5 9434.1 52589.7 53574.7 53936.5 54025.0 55385.4 67774.0 68515.7 68738.0 71516.6 76700.0 13526.5 13712.9 13720.7 13747.7 13968.8 15375.2 15376.5 15464.8 15630.5 15719.0 10113.9 14047.6 14149.5 14215.9 14672.3 13993.5 13999.3 14331.6 14643.6 14771.7 13946.1 14296.6 14389.0 14497.5 14498.3 11137.4 11345.8 11465.3 11514.8 11627.1 11402.6 11930.4 12276.8 12292.3 12629.9 04:01:13 INFO - PROCESS | 14545 | -------- Summary: end -------- 04:01:13 INFO - PROCESS | 14545 | 04:01:14 INFO - TEST-INFO | 14545: exit 0 04:01:14 INFO - TEST-OK | dromaeo_css | took 1113273ms 04:01:14 INFO - TEST-START | kraken 04:01:14 INFO - operating with platform_type : linux_ 04:01:14 INFO - Initialising browser for kraken test... 04:01:14 INFO - TEST-INFO | started process 14736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoS2w5D/profile http://localhost:33444/getInfo.html) 04:01:17 INFO - PROCESS | 14736 | JavaScript error: , line 0: uncaught exception: undefined 04:01:18 INFO - PROCESS | 14736 | __metrics Screen width/height:1600/1200 04:01:18 INFO - PROCESS | 14736 | colorDepth:24 04:01:18 INFO - PROCESS | 14736 | Browser inner width/height: 1024/697 04:01:18 INFO - PROCESS | 14736 | __metrics 04:01:19 INFO - PROCESS | 14736 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:01:19 INFO - PROCESS | 14736 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:01:19 INFO - PROCESS | 14736 | console.error: PushService: 04:01:19 INFO - PROCESS | 14736 | stateChangeProcessEnqueue: Error transitioning state 04:01:19 INFO - PROCESS | 14736 | UnknownError 04:01:20 INFO - TEST-INFO | 14736: exit 0 04:01:20 INFO - Browser initialized. 04:01:20 INFO - Running cycle 1/1 for kraken test... 04:01:20 INFO - TEST-INFO | started process 14817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoS2w5D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:32 INFO - PROCESS | 14817 | RSS: Main: 157335552 04:01:32 INFO - PROCESS | 14817 | 04:01:34 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33444/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:35 INFO - PROCESS | 14817 | RSS: Main: 213917696 04:01:35 INFO - PROCESS | 14817 | 04:01:38 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33444/tests/kraken/driver.html?testName=audio-dft) 04:01:38 INFO - PROCESS | 14817 | RSS: Main: 192196608 04:01:38 INFO - PROCESS | 14817 | 04:01:42 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33444/tests/kraken/driver.html?testName=audio-fft) 04:01:42 INFO - PROCESS | 14817 | RSS: Main: 270864384 04:01:42 INFO - PROCESS | 14817 | 04:01:44 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33444/tests/kraken/driver.html?testName=audio-oscillator) 04:01:45 INFO - PROCESS | 14817 | RSS: Main: 180436992 04:01:45 INFO - PROCESS | 14817 | 04:01:47 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:48 INFO - PROCESS | 14817 | RSS: Main: 185495552 04:01:48 INFO - PROCESS | 14817 | 04:01:51 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33444/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:51 INFO - PROCESS | 14817 | RSS: Main: 222203904 04:01:51 INFO - PROCESS | 14817 | 04:01:55 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33444/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:55 INFO - PROCESS | 14817 | RSS: Main: 221200384 04:01:55 INFO - PROCESS | 14817 | 04:01:58 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33444/tests/kraken/driver.html?testName=json-parse-financial) 04:01:59 INFO - PROCESS | 14817 | RSS: Main: 221093888 04:01:59 INFO - PROCESS | 14817 | 04:02:00 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:02:01 INFO - PROCESS | 14817 | RSS: Main: 184926208 04:02:01 INFO - PROCESS | 14817 | 04:02:02 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:02:03 INFO - PROCESS | 14817 | RSS: Main: 189984768 04:02:03 INFO - PROCESS | 14817 | 04:02:05 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:02:06 INFO - PROCESS | 14817 | RSS: Main: 195645440 04:02:06 INFO - PROCESS | 14817 | 04:02:08 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:02:09 INFO - PROCESS | 14817 | RSS: Main: 190337024 04:02:09 INFO - PROCESS | 14817 | 04:02:11 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:02:12 INFO - PROCESS | 14817 | RSS: Main: 193499136 04:02:12 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:33444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33444/tests/kraken/driver.html?testName=ai-astar) 04:02:14 INFO - PROCESS | 14817 | RSS: Main: 244273152 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | __start_tp_report 04:02:14 INFO - PROCESS | 14817 | _x_x_mozilla_page_load 04:02:14 INFO - PROCESS | 14817 | _x_x_mozilla_page_load_details 04:02:14 INFO - PROCESS | 14817 | |i|pagename|runs| 04:02:14 INFO - PROCESS | 14817 | |0;ai-astar;102;112;111;111;109;110;110;112;109;109 04:02:14 INFO - PROCESS | 14817 | |1;audio-beat-detection;145;118;122;181;118;121;147;121;154;117 04:02:14 INFO - PROCESS | 14817 | |2;audio-dft;163;161;159;162;160;161;162;161;161;159 04:02:14 INFO - PROCESS | 14817 | |3;audio-fft;75;74;74;113;75;75;75;75;103;77 04:02:14 INFO - PROCESS | 14817 | |4;audio-oscillator;84;84;112;84;84;84;136;83;84;128 04:02:14 INFO - PROCESS | 14817 | |5;imaging-gaussian-blur;117;117;118;117;118;117;118;117;117;117 04:02:14 INFO - PROCESS | 14817 | |6;imaging-darkroom;147;147;146;148;147;148;147;148;146;146 04:02:14 INFO - PROCESS | 14817 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 04:02:14 INFO - PROCESS | 14817 | |8;json-parse-financial;52;52;53;52;51;53;53;52;51;52 04:02:14 INFO - PROCESS | 14817 | |9;json-stringify-tinderbox;61;61;60;61;60;60;60;61;61;63 04:02:14 INFO - PROCESS | 14817 | |10;stanford-crypto-aes;75;75;83;74;75;76;76;75;76;76 04:02:14 INFO - PROCESS | 14817 | |11;stanford-crypto-ccm;121;121;120;126;127;119;123;120;162;139 04:02:14 INFO - PROCESS | 14817 | |12;stanford-crypto-pbkdf2;155;157;154;154;155;158;158;160;154;158 04:02:14 INFO - PROCESS | 14817 | |13;stanford-crypto-sha256-iterative;68;65;66;63;62;63;65;72;62;61 04:02:14 INFO - PROCESS | 14817 | __end_tp_report 04:02:14 INFO - PROCESS | 14817 | __start_cc_report 04:02:14 INFO - PROCESS | 14817 | _x_x_mozilla_cycle_collect,1691 04:02:14 INFO - PROCESS | 14817 | __end_cc_report 04:02:14 INFO - PROCESS | 14817 | __startTimestamp1469530934471__endTimestamp 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | ------- Summary: start ------- 04:02:14 INFO - PROCESS | 14817 | Number of tests: 14 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.88 (2.6%) stddev-sans-first:1.22 04:02:14 INFO - PROCESS | 14817 | Values: 102.0 112.0 111.0 111.0 109.0 110.0 110.0 112.0 109.0 109.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:133.50 stddev:21.55 (16.1%) stddev-sans-first:22.52 04:02:14 INFO - PROCESS | 14817 | Values: 145.0 118.0 122.0 181.0 118.0 121.0 147.0 121.0 154.0 117.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 04:02:14 INFO - PROCESS | 14817 | Values: 163.0 161.0 159.0 162.0 160.0 161.0 162.0 161.0 161.0 159.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:14.14 (18.8%) stddev-sans-first:14.79 04:02:14 INFO - PROCESS | 14817 | Values: 75.0 74.0 74.0 113.0 75.0 75.0 75.0 75.0 103.0 77.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.00 stddev:20.85 (24.8%) stddev-sans-first:21.63 04:02:14 INFO - PROCESS | 14817 | Values: 84.0 84.0 112.0 84.0 84.0 84.0 136.0 83.0 84.0 128.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:02:14 INFO - PROCESS | 14817 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:02:14 INFO - PROCESS | 14817 | Values: 147.0 147.0 146.0 148.0 147.0 148.0 147.0 148.0 146.0 146.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:02:14 INFO - PROCESS | 14817 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 04:02:14 INFO - PROCESS | 14817 | Values: 52.0 52.0 53.0 52.0 51.0 53.0 53.0 52.0 51.0 52.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 04:02:14 INFO - PROCESS | 14817 | Values: 61.0 61.0 60.0 61.0 60.0 60.0 60.0 61.0 61.0 63.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:2.51 (3.3%) stddev-sans-first:2.64 04:02:14 INFO - PROCESS | 14817 | Values: 75.0 75.0 83.0 74.0 75.0 76.0 76.0 75.0 76.0 76.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:124.50 stddev:13.39 (10.8%) stddev-sans-first:13.97 04:02:14 INFO - PROCESS | 14817 | Values: 121.0 121.0 120.0 126.0 127.0 119.0 123.0 120.0 162.0 139.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:157.50 stddev:2.16 (1.4%) stddev-sans-first:2.24 04:02:14 INFO - PROCESS | 14817 | Values: 155.0 157.0 154.0 154.0 155.0 158.0 158.0 160.0 154.0 158.0 04:02:14 INFO - PROCESS | 14817 | 04:02:14 INFO - PROCESS | 14817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:3.33 (5.1%) stddev-sans-first:3.32 04:02:14 INFO - PROCESS | 14817 | Values: 68.0 65.0 66.0 63.0 62.0 63.0 65.0 72.0 62.0 61.0 04:02:14 INFO - PROCESS | 14817 | -------- Summary: end -------- 04:02:14 INFO - PROCESS | 14817 | 04:02:15 INFO - TEST-INFO | 14817: exit 0 04:02:15 INFO - TEST-OK | kraken | took 61121ms 04:02:15 INFO - SUITE-END | took 1174s 04:02:15 INFO - Completed test suite (00:19:34) 04:02:15 INFO - javascript benchmark 04:02:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.382051679406, 3028.4548781219373, 3056.388722255548, 3057.357954829485, 3064.6169228846393, 5170.870728231796, 5201.271821944931, 5226.0, 5288.894222115556, 5367.946320536798, 5287.47125287471, 5293.8941221175555, 5294.311739473863, 5349.7592608332625, 5396.136618141099, 4788.114198873202, 4808.014357056803, 4822.927656085161, 4832.7583620819, 4958.132326842806, 4899.0, 4920.97539512302, 4931.3835770528685, 4932.062908047459, 4949.579285760715, 4708.246680531099, 4725.22033864412, 4751.881202969919, 4846.466888642247, 4872.6101911847145, 4758.381410416659, 4758.809647614091, 4768.642351823627, 4768.928466073012, 4775.522447755231, 4711.104890070876, 4744.7627618618935, 4749.453812811502, 4803.495632958524, 4877.0, 5238.449962753933, 5260.8684782880355, 5286.444923283077, 5311.309529761106, 5329.733513324357, 5440.292761940962, 5612.887742245173, 5613.4386561343945, 5656.604037717361, 5665.915011274834, 5685.374608793029, 5719.656820590736, 5726.885462290731, 5765.394633563457, 5774.97112514439, 5349.117395629716, 5369.114096174127, 5377.220303056074, 5378.19327100938, 5383.16560933056, 5561.026820306431, 5759.251297331404, 5789.652620842763, 5857.560682948711, 5865.090910908816, 5591.41290164535, 5640.407757185437, 5641.576881733887, 5643.209950606918, 5651.971740141355, 5665.461781130786, 5708.20085188074, 5714.657120572779, 5715.514181294553, 5726.0, 5423.620346575781, 5512.145617429305, 5524.254225679482, 5653.067243904792, 5664.348599911063, 5537.920105579374, 5538.944610553924, 5552.5280351169795, 5563.63836350644, 5587.7485513152005, 4281.850135245314, 4332.00363916301, 4332.1119170569955, 4340.283853164193, 4374.4531933508315, 3812.066043819282, 3862.4592557042038, 3878.6121387861554, 3892.0, 3903.746256493319, 5332.0402327581405, 5370.113931201387, 5392.595555333366, 5439.5104440600535, 5440.075187218183, 5638.577106717013, 5653.321601407857, 5656.179853921159, 5658.632188907708, 5662.462066103713, 5227.660202086929, 5309.787608495694, 5335.093034184198, 5396.865078373072, 5401.702906340189, 4924.01519696055, 4931.654784165074, 4958.281049247839, 5005.199168133154, 5009.273655319958, 5822.359540450631, 5830.47525722687, 5835.0, 5840.269966254218, 5840.970795145997, 5493.066178749702, 5584.888302233851, 5589.10574308125, 5653.523083303657, 5704.828855134353, 5819.272590926134, 5846.473817356458, 5864.970675146597, 5881.529477641693, 5891.558133140117, 5559.749811258423, 5561.944380556304, 5564.360098588714, 5565.944340556704, 5566.888662226814, 5477.917831232455, 5595.412481689364, 5659.320881494247, 5662.66024038559, 5664.858378540404, 5471.37079235893, 5478.205660179331, 5539.861503462445, 5582.16267559853, 5587.02227110246, 5488.835334939959, 5531.197976293495, 5535.723213839373, 5537.2524709163745, 5537.7784888604, 5376.569874410116, 5437.592180586393, 5462.562994960473, 5503.0, 5551.611387203018, 5554.527865131509, 5621.213030175697, 5658.971705141448, 5660.405657406078, 5665.915011274917, 5466.72666366688, 5486.753096110605, 5496.725163741717, 5503.889922201613, 5505.449455054462], "value": 5220.224296986437, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.6390165900459, 618.3105836991753, 628.7139351595025, 640.0463309668589, 643.3116565275154, 30488.390232195343, 33282.833585832064, 42901.0, 44264.55735442653, 44321.11357772843, 45065.0, 45323.320150197775, 45331.77334113333, 45437.31844022334, 45488.77255613717, 8865.069167737407, 8993.730188094367, 9006.549672516381, 9020.684276050339, 9035.59339829706, 8956.32827537934, 9021.188093071622, 9030.548472576378, 9032.593533291018, 9041.728748137533, 9039.954800225989, 9084.409513381643, 9091.727248182566, 9092.090790920922, 9094.681686140986, 8947.239484643813, 8996.280297576179, 9019.639214431414, 9030.86453703195, 9044.864327035068, 8874.778130546723, 8940.508272045035, 8943.284537237005, 8952.55237238142, 8954.686585969524, 41764.791176043924, 42180.0, 42182.57817421848, 42229.366559501635, 42298.57701423008, 3573.5890372607223, 3580.838862251205, 3620.3845346291196, 3731.067233191702, 3749.9625003750157, 31437.528437073463, 31643.525347119812, 31710.365792684246, 31753.364932701217, 31898.350841016254, 4072.8574499892657, 4115.403266526367, 4141.958580414218, 4151.481064866892, 4238.978805105986, 332366.0, 334736.3263183693, 335313.0, 335851.0, 340973.0, 57983.71008145017, 58024.709876450346, 58101.8379632405, 58177.70911145417, 58423.12365314524, 53560.0, 59583.0, 60538.69730651407, 60734.0, 60853.0, 16082.115483648278, 17035.48893533196, 17095.316187352368, 17095.48713538596, 17118.315267389164, 13366.198028118344, 13416.195028298333, 13459.730805383837, 13461.798073028913, 13465.326733663474, 14833.629159271104, 16325.755113673304, 16336.836631633532, 16428.0, 16609.0, 5669.801556945487, 5732.742026608813, 5784.595078344475, 5911.467967882912, 5964.194833697482, 916.812053529025, 977.4672803322206, 1077.719792853848, 1113.716002419378, 1143.89704926557, 32571.51142732861, 32690.182745431553, 32846.507302390484, 32904.3419131616, 32976.835115824746, 1097.4622435006788, 1097.9945100274447, 1105.6130354375905, 1111.216592302425, 1156.687694322545, 16420.640235065897, 17076.829231707772, 17252.913735431495, 17253.827461725472, 17445.127743612768, 523889.0, 526706.0, 527673.0, 527761.0, 528024.0, 59315.40684593185, 59362.40637593569, 59423.405765942654, 59465.40534594685, 59497.0, 1307.6077176847098, 1362.434589645286, 1366.453418632555, 1381.205806661174, 1389.5136702154368, 30341.241468963453, 31381.8430907844, 32139.19652008625, 32290.0, 32529.83735081404, 51697.0, 51845.7407712959, 52069.21896171636, 52109.7394513025, 52169.739151304, 424516.0, 427748.0, 428923.0, 429262.0, 429595.0, 35720.0, 40064.7996760026, 41018.58981410148, 41140.58859411367, 42279.577204227564, 43879.0, 47709.28436073531, 48346.5165348342, 48413.273800893716, 48916.75541622269, 40257.77293384152, 41538.792306038275, 42048.15903681848, 42767.0, 42870.78564607157, 40063.79968100141, 41225.79387103045, 41300.58699413088, 41570.67853792005, 42802.0, 40019.19433766988, 40874.1825163501, 41101.50637195872, 41240.79379603203, 41692.791536042125, 35175.47236791501, 37398.0, 37982.240355193295, 38085.0, 38231.61768382392, 27589.0, 27653.446931060862, 27794.444111118068, 28021.299467513476, 28040.298992524535], "value": 20150.20967413619, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.3735598905819, 390.30915279954473, 395.7803419102398, 405.2098408104194, 410.2308172177168, 17975.0, 18651.533711657183, 20566.560340776152, 20755.273565425214, 20783.0, 11116.5553377865, 11694.590689325876, 11696.649100526998, 11697.824532632018, 17199.0, 4974.527419895104, 5171.301874246966, 5175.689458632475, 5175.792968281265, 5180.533751962323, 3926.9018274543223, 5037.773300201499, 5114.795408183668, 6620.172478440195, 6631.336866313378, 6706.497012724041, 6707.698153583076, 6717.126773519436, 6718.496112791536, 6720.227173875018, 5819.883602327951, 5835.737391817378, 5850.297964244318, 5854.209681692981, 6223.0354295084335, 5483.698396588186, 5679.233303504016, 5685.573581981368, 5686.545076393879, 5688.260526131618, 12687.984961203081, 12815.487380504768, 12884.87115128846, 12887.93556032214, 12900.870991290061, 2229.3869185973826, 2346.8239882008916, 2384.8449850759816, 2392.9521409571885, 2395.47299594089, 9391.154796068387, 9403.200727938134, 9782.461964591945, 11487.253328533701, 13666.36003679555, 1866.7853196882397, 1890.5084677983823, 1916.2430839818333, 1916.32928475034, 1958.4439869105533, 82572.58713706453, 82810.58594707047, 83887.0, 84676.57661711652, 86259.56870215734, 10310.587576497006, 10378.377297362182, 10627.84058239127, 11084.445777711082, 11249.887501125047, 13955.441782328593, 13962.162270263816, 13987.160770353812, 13992.790108148385, 15652.68694626101, 8087.514749115072, 8155.918440815516, 8241.546714930737, 8376.455530390505, 8433.367497437594, 7799.5320280783335, 7805.180456052033, 8019.318357939524, 8056.194380562014, 8086.676532938734, 4049.979750101231, 4179.247735407595, 4723.197056500403, 4733.387249624155, 4777.498362671939, 1755.815639357849, 1929.0644037641732, 1960.9705854412196, 1963.4993076765334, 2032.5325175209489, 885.5572213893054, 949.586929685589, 1018.5925629748012, 1020.9982651006019, 1036.036486067964, 19452.805471945383, 19829.801701982797, 20016.499587510138, 20088.0, 20106.899465502873, 936.7002559181133, 936.8501039833594, 972.601233494264, 978.9021097890296, 984.4044353166374, 8587.313014958789, 11094.667159985212, 11099.34145439644, 11145.72135696614, 11282.266652667715, 497992.0, 502892.0, 504123.0, 504611.0, 504947.0, 92106.0, 92390.0, 93366.53316733374, 93843.0, 94052.0, 962.8459446488528, 1001.7796084861319, 1013.5793645636978, 1019.6278358399131, 1034.5551412892378, 16972.575685607957, 17018.744718829475, 17720.55698607545, 17864.747338431964, 17964.281428743227, 39748.602513975646, 42435.57564424316, 42564.787176063925, 42588.78705606576, 43717.78141109274, 50337.244941326644, 60233.39766602278, 60362.39637603568, 62288.688556556925, 62744.0, 7787.5716835574585, 7920.920790792018, 7979.800504987422, 8021.077576078592, 8030.196980301923, 11659.825102623638, 12214.0, 12843.293618851052, 13324.200547967153, 13414.664633383853, 11198.272112312674, 11497.195196336175, 11542.713717991084, 11565.768684626091, 11808.527658893892, 11413.315201087962, 11614.070874330202, 11676.241044332091, 11777.823332649845, 12097.0, 10588.894111058791, 11596.88403115958, 11610.5355785771, 11874.940625296818, 12164.878351216728, 6844.589324640538, 6988.930110698828, 7117.8576428470105, 8426.283765879969, 8477.788055298666, 11277.32336059839, 11381.374024428405, 11391.715207119889, 11449.713757156138, 11517.654470365902], "value": 8914.912662291776, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.564543700579, 1461.0722191408456, 1545.4436402894955, 1667.5414261078201, 1818.8453981411587, 8539.658413663454, 8810.69162579309, 8858.291336693073, 9144.542772861347, 9155.77110572236, 9029.0, 9114.589843457044, 9116.817663646723, 9121.0, 9121.224695900857, 2343.3907184132077, 2368.5144545368244, 2376.9881150594224, 2378.357843382286, 2380.5595964746576, 2293.655951607264, 2342.2387723989686, 2349.659299401586, 2352.4118970257437, 2353.199912029918, 2283.8401311908174, 2300.8734519601417, 2306.8269879759, 2327.0342807734855, 2328.115316179858, 2261.8303627228024, 2281.269993602048, 2286.4626812699003, 2290.725112986444, 2290.828187885915, 2182.923597674074, 2187.562487502506, 2188.6607575825774, 2192.090282532747, 2197.4067001909557, 9024.729258122201, 9059.365844390895, 9104.0, 9122.407043542215, 9165.0, 5095.847124586268, 5279.472052794728, 5297.516695325315, 5300.2314664373835, 5305.920411193797, 3312.2216279174377, 3332.516785066176, 3354.1782263345635, 3373.4096533106854, 3376.4428869236544, 1070.983935240972, 1071.266182664877, 1073.6295977887617, 1084.6095405653957, 1090.2586241355875, 12781.61655150347, 12820.423080961378, 12822.294773787438, 12872.806907896389, 12877.098603097787, 4306.74159550428, 4353.3469979503325, 4471.910561788811, 4484.865454036384, 4574.176648203355, 10010.399376037461, 10013.449260290608, 10014.24893133018, 10016.49917504122, 10020.599176032876, 5309.761060752276, 5324.0, 5325.893482130413, 5328.786848526015, 5328.786848526093, 4276.08064266178, 4721.5986641135205, 4790.089882922233, 4835.8065677372515, 5004.0, 3820.67524260441, 3898.5126859142606, 3971.4439978403047, 3971.543272523639, 4010.959890401117, 1166.4809159923752, 1167.2937872586963, 1173.5765643945397, 1175.353555544447, 1182.532899504691, 844.4595458906305, 893.2139717049085, 930.1070971866948, 979.7550612346913, 988.7824678570703, 6033.0, 6061.151438798572, 6205.596636218631, 6372.904406433907, 6408.679566021773, 435.36654168185214, 437.2719422162128, 447.9865604031819, 448.21338550843063, 452.6763364194617, 4202.600752928467, 4331.7834108294455, 4339.609435150852, 4355.107203023373, 4394.978025109854, 11031.393273370042, 11209.887901121048, 11337.603183888525, 11429.771404571862, 11475.885241147482, 10842.674719758419, 11184.720381990515, 11374.658760237206, 11393.601223957121, 11400.543978240943, 8131.064927533291, 8304.54325012118, 8307.958460207661, 8315.04376996641, 8323.708670196635, 6213.1922850029205, 6286.717097730521, 6321.494280457644, 6431.292557818542, 6564.179477565304, 10633.946830266108, 10674.57301707923, 10701.357918524602, 10747.247692661438, 10792.352458852494, 10029.498525073863, 10250.487475626338, 10284.382937023802, 10295.897041029493, 10468.424236667057, 7632.923670763444, 8373.07896131413, 8534.487930724177, 8537.402381833212, 8708.129187081242, 8918.509481978554, 9069.093090690878, 9078.54607269647, 9082.318826087938, 9083.091690831128, 7827.9608601956625, 7886.250806173404, 7950.363970882431, 7975.920240797518, 8024.638891250024, 7823.608819558885, 7886.68453261886, 7926.286634202949, 7937.0, 7975.960120199594, 6970.059042029464, 7133.821654458472, 7184.281571842774, 7186.317299856505, 7204.24355442671, 5378.139497680352, 5401.945980540144, 5415.675059496442, 5510.201020851874, 5591.776328946797, 5342.171963345688, 5363.222332761806, 5424.294841670558, 5450.727463626724, 5465.0], "value": 4605.744314838148, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.83958582158544, 304.98932537361185, 306.80824484697064, 312.28330980400006, 315.4070347746238, 5345.385280692722, 5377.4084850666395, 5378.677279363236, 5394.1908713692965, 5395.379531353896, 5227.144363750871, 5275.340582427197, 5298.973505132469, 5308.177232528955, 5321.494458026481, 4135.31767258402, 4149.879532526224, 4153.231652144348, 4160.583941605845, 4169.437125987998, 3872.6514613684762, 4076.368162934735, 4092.9386059209137, 4129.153523527684, 4166.791660416982, 4045.37296719009, 4052.533958594755, 4078.449409329747, 4080.0, 4085.2850751118585, 3871.3805791073573, 4050.9594904051023, 4065.6544193743566, 4067.5932406759384, 4076.4700588923547, 3435.587729472479, 3525.700315473188, 3531.682148606638, 3535.893923182283, 3550.3964326064374, 5157.7936882524655, 5160.200168973815, 5168.793248270064, 5189.948100518985, 5198.818041368534, 4406.933895991563, 4601.976990115028, 4604.122423485322, 4637.026224492861, 4667.929981050287, 5108.0, 5427.972860135714, 5435.7825686972865, 5463.31708536433, 5503.284573005483, 3885.9222815543812, 3892.1048158923604, 3893.552241492236, 3899.707521935866, 3909.2376986487648, 5585.776568937237, 5733.512651424592, 5759.712014399263, 5799.82600521985, 5810.738516766755, 3909.257241124177, 3921.8431262749173, 3938.5076865391825, 3951.8221680024467, 3962.663173630216, 3994.820233089518, 4011.0, 4024.63778259958, 4026.3960405938756, 4029.657479114308, 4650.86047418578, 4666.533346665306, 4666.719996800135, 4671.462781780138, 4678.578927896506, 5424.213489044146, 5529.889402211933, 5536.944630553643, 5556.444355564411, 5561.0, 1372.6225288045866, 1384.3493558027913, 1385.8336999560117, 1387.6877702516854, 1395.0165133580801, 848.7538613801928, 889.3152272749946, 893.5130353956979, 906.551257127726, 908.1009800297658, 4711.764411779397, 4789.137955168103, 4827.541383568555, 4842.990159083941, 4858.198397264412, 5023.723695196726, 5041.445441001487, 5054.545090941833, 5064.41759197697, 5095.617828662791, 4814.542618451242, 4815.22956326986, 4887.828925987645, 4891.6575839691595, 5028.296038554606, 2922.4885645012037, 2954.2023653613405, 2974.6876577959, 3002.774791890617, 3068.309630333157, 5941.940580594225, 5947.732352044169, 5954.106883967353, 5965.224520812267, 5976.282846058501, 5860.736266867916, 5868.823935281948, 5876.677747506862, 5884.47039766423, 5886.323072846678, 5693.750968367472, 5881.705914704247, 5885.2349194605285, 5890.2637170354565, 5903.881922361615, 5687.260656114679, 5694.4590263924865, 5702.173184888251, 5723.942760572508, 5729.2551968245525, 5416.729163541886, 5650.29371328584, 5674.786833135163, 5726.455986681259, 5748.655080695172, 5895.764169433174, 5930.9110363343725, 5938.762449502145, 5950.910736338872, 5963.701814909324, 3900.3369427196876, 3938.960610393974, 3953.150072734376, 3975.7018223632763, 3986.402039693953, 5483.588730845123, 5700.230468886647, 5762.337331206965, 5774.249347584787, 5776.913346299725, 5567.777288908398, 5571.0, 5573.5819813513335, 5588.692621905834, 5612.550995920398, 5585.804496842591, 5593.636413633101, 5618.971905140448, 5628.493435590816, 5652.7173641318595, 5273.894522109613, 5508.807191748269, 5521.668699878021, 5536.390996990408, 5563.527100196528, 5645.1532270159805, 5685.289338832646, 5690.231818704422, 5698.2592263005545, 5698.886022279614, 5423.5932305076485, 5450.249931610785, 5458.563314934875, 5584.213051823377, 5592.105263157875], "value": 4166.931287197419, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.781435105346, 795.3279478840379, 813.5403497024184, 822.3544517553721, 861.2765277167181, 14708.852911470896, 15566.221688915537, 15605.219739013033, 15618.531444056667, 15707.136107514083, 14055.859441405582, 14443.78334324986, 14533.92733036336, 14632.561023169323, 14635.487757928475, 814.6782021101661, 831.6465502161587, 835.0688981785296, 838.1032295443878, 839.5088873009297, 670.0920253057111, 801.410962942237, 827.2224109337234, 828.2297463359074, 828.4449418889359, 851.2423942691009, 853.2448782827212, 853.3471894001063, 853.6457370191363, 854.3763052971335, 850.2135524639715, 855.6449073634434, 855.7603870916154, 856.8800367948461, 857.652650676477, 511.40676814894914, 511.71088335090553, 605.7455868535226, 608.4827896288164, 627.0656721485, 14241.572752817432, 14679.339429725582, 14713.485028024075, 14716.411343546246, 14726.779098313535, 13764.862351376458, 14010.929945350208, 14302.785458218135, 14348.92825535876, 14587.854121458862, 13240.933795330962, 13287.175233563657, 13292.73414531704, 13452.05835591509, 13753.312334383241, 4585.518520555327, 4627.652926030528, 4641.350210970467, 4646.4191976003, 4865.975670121662, 77412.0, 78198.82701759478, 78283.99999999943, 78508.60745696293, 80291.59854200692, 11399.430028498542, 11739.665734551549, 11853.703657408634, 11998.520059197708, 12104.939475302566, 22438.32685019452, 22547.323580292617, 22725.0, 22756.658650120262, 22816.543669126524, 8764.342674299452, 8812.0, 8910.420822646507, 8965.417247878868, 9021.142991415805, 4689.109069276827, 4711.081339138835, 4781.474037855833, 4800.423949126127, 4821.54195351441, 3517.751198324558, 3651.2697460507475, 3690.3541880170865, 3699.4635777812605, 3717.3494638438706, 600.5465873265744, 611.3672349118641, 615.6060121522229, 618.6350053468475, 620.0513214781391, 634.6160572853357, 686.9759558415532, 711.1679335177854, 746.2052913646949, 757.2276278196209, 9678.75803104914, 10335.379877207391, 10373.325733827278, 10432.426216558011, 10482.895171048192, 658.5620562326, 680.5542369747823, 695.8538706871512, 761.2958013837289, 766.5324152267112, 4397.626201772821, 4707.764611769467, 4761.381020467386, 4790.4251489820745, 4837.395325584302, 73897.0, 117504.41247793706, 121486.0, 123666.0, 124391.0, 101935.4903225479, 104851.4757426208, 106108.0, 107856.0, 108786.0, 92496.53751731198, 94386.0, 94415.52792235995, 95301.0, 95448.52275738577, 9102.49936253486, 9212.539373031455, 9220.157727609214, 9351.53242337894, 9434.103760142776, 52589.7370513145, 53574.73212633912, 53936.460635393145, 54025.0, 55385.44614553803, 67774.0, 68515.65742171257, 68738.0, 71516.64241678758, 76700.0, 13526.526571569948, 13712.862871371159, 13720.725585488035, 13747.656308592364, 13968.790468142783, 15375.154366509949, 15376.461823836113, 15464.825308067377, 15630.531084067496, 15719.0, 10113.949430252802, 14047.648808779863, 14149.504767333094, 14215.928920355746, 14672.26638668041, 13993.510227142002, 13999.300034998005, 14331.553994557611, 14643.623585621157, 14771.704565908407, 13946.093503922213, 14296.57110286693, 14389.0, 14497.492587759378, 14498.347574358968, 11137.443127843413, 11345.829812552653, 11465.26480599744, 11514.76970460603, 11627.069834413396, 11402.600908968147, 11930.403479826147, 12276.81584776247, 12292.262464252173, 12629.93685031569], "value": 7748.962856546593, "unit": "score"}], "name": "dromaeo_css", "value": 7201.372733430532, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 109.0, 110.0, 110.0, 112.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 122.0, 181.0, 118.0, 121.0, 147.0, 121.0, 154.0, 117.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 159.0, 162.0, 160.0, 161.0, 162.0, 161.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 113.0, 75.0, 75.0, 75.0, 75.0, 103.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 84.0, 84.0, 136.0, 83.0, 84.0, 128.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 147.0, 148.0, 147.0, 148.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 51.0, 53.0, 53.0, 52.0, 51.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 63.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 83.0, 74.0, 75.0, 76.0, 76.0, 75.0, 76.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 120.0, 126.0, 127.0, 119.0, 123.0, 120.0, 162.0, 139.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 154.0, 154.0, 155.0, 158.0, 158.0, 160.0, 154.0, 158.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 66.0, 63.0, 62.0, 63.0, 65.0, 72.0, 62.0, 61.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1479.7999999999997, "alertThreshold": 2.0}]} 04:02:15 INFO - Return code: 0 04:02:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:02:15 INFO - # TBPL SUCCESS # 04:02:15 INFO - Running post-action listener: _resource_record_post_action 04:02:15 INFO - [mozharness: 2016-07-26 11:02:15.758064Z] Finished run-tests step (success) 04:02:15 INFO - Running post-run listener: _resource_record_post_run 04:02:15 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 553439232; Read time: 0; Write time: 775352 04:02:15 INFO - TinderboxPrint: CPU usage
13.1% 04:02:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:02:15 INFO - TinderboxPrint: I/O write bytes / time
553,439,232 / 775,352 04:02:15 INFO - TinderboxPrint: CPU idle
8,270.6 (86.9%) 04:02:15 INFO - TinderboxPrint: CPU user
1,195.4 (12.6%) 04:02:15 INFO - TinderboxPrint: Swap in / out
0 / 0 04:02:15 INFO - install - Wall time: 18s; CPU: 16.0%; Read bytes: 0; Write bytes: 258015232; Read time: 0; Write time: 511568 04:02:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295424000; Read time: 0; Write time: 263784 04:02:16 INFO - Running post-run listener: _upload_blobber_files 04:02:16 INFO - Blob upload gear active. 04:02:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:16 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 04:02:16 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:16 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:17 INFO - (blobuploader) - INFO - Done attempting. 04:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:02:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:30 INFO - (blobuploader) - INFO - Done attempting. 04:02:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:02:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:02:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:31 INFO - (blobuploader) - INFO - Done attempting. 04:02:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:31 INFO - Return code: 0 04:02:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e3f59d145691014373cc759633744ea5be32e9071b309b48ad0537ef98fe253f1cfc4ed158bf7dd0de79ed30f087eba55a612b9bb8bf3daf07c6bdca62a64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28be77f134d484f7296fc3e95d56871f381a07673a8659e9fd9174a20ddfa9579719108c8fa0882b507a5ab08dd0db7aae7d35927c14aa37d0d942d9ea755ff4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/552cad890d8164fb113a6fa7af10be6c80eec398250003b49261af496b1a6807656142e4d63255a9979ee678fc00c46d63318e25fba5e30d42a5613946996549"} 04:02:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:31 INFO - Contents: 04:02:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e3f59d145691014373cc759633744ea5be32e9071b309b48ad0537ef98fe253f1cfc4ed158bf7dd0de79ed30f087eba55a612b9bb8bf3daf07c6bdca62a64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28be77f134d484f7296fc3e95d56871f381a07673a8659e9fd9174a20ddfa9579719108c8fa0882b507a5ab08dd0db7aae7d35927c14aa37d0d942d9ea755ff4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/552cad890d8164fb113a6fa7af10be6c80eec398250003b49261af496b1a6807656142e4d63255a9979ee678fc00c46d63318e25fba5e30d42a5613946996549"} 04:02:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:31 INFO - Copying logs to upload dir... 04:02:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.696252 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-26 04:02:29.933794) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 04:02:29.937407) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e3f59d145691014373cc759633744ea5be32e9071b309b48ad0537ef98fe253f1cfc4ed158bf7dd0de79ed30f087eba55a612b9bb8bf3daf07c6bdca62a64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28be77f134d484f7296fc3e95d56871f381a07673a8659e9fd9174a20ddfa9579719108c8fa0882b507a5ab08dd0db7aae7d35927c14aa37d0d942d9ea755ff4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/552cad890d8164fb113a6fa7af10be6c80eec398250003b49261af496b1a6807656142e4d63255a9979ee678fc00c46d63318e25fba5e30d42a5613946996549"} build_url:https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/ZV7mCrNcSoeDH09GvnDf2w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e3f59d145691014373cc759633744ea5be32e9071b309b48ad0537ef98fe253f1cfc4ed158bf7dd0de79ed30f087eba55a612b9bb8bf3daf07c6bdca62a64d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28be77f134d484f7296fc3e95d56871f381a07673a8659e9fd9174a20ddfa9579719108c8fa0882b507a5ab08dd0db7aae7d35927c14aa37d0d942d9ea755ff4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/552cad890d8164fb113a6fa7af10be6c80eec398250003b49261af496b1a6807656142e4d63255a9979ee678fc00c46d63318e25fba5e30d42a5613946996549"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 04:02:29.963340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 04:02:29.963697) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469529709.128796-320930780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 04:02:30.049359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 04:02:30.049701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 04:02:30.050029) ========= ========= Total master_lag: 0.15 =========