builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1469679417.82 results: success (0) buildid: 20160727183027 builduid: 9db3f2ce887d4ad39bf372eabbed73e1 revision: ffc7874fcb7ef819f55c29172fb2fb09589c2405 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:57.819671) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:57.820718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:57.821025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:57.862873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:57.863168) ========= 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=db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 21:16:57-- 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% 67.1M=0s 2016-07-27 21:16:57 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096580 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:57.986526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:57.986847) ========= 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=db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018836 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:58.036044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:58.036395) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ffc7874fcb7ef819f55c29172fb2fb09589c2405 --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 ffc7874fcb7ef819f55c29172fb2fb09589c2405 --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=db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 21:16:58,081 truncating revision to first 12 chars 2016-07-27 21:16:58,081 Setting DEBUG logging. 2016-07-27 21:16:58,081 attempt 1/10 2016-07-27 21:16:58,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ffc7874fcb7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 21:16:58,413 unpacking tar archive at: autoland-ffc7874fcb7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:58.732285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:58.732589) ========= script_repo_revision: ffc7874fcb7ef819f55c29172fb2fb09589c2405 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:58.732957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:58.733236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 21:16:58.745972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-27 21:16:58.746254) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:16:58 INFO - MultiFileLogger online at 20160727 21:16:58 in /builds/slave/test 21:16:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:16:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:16:58 INFO - {'append_to_log': False, 21:16:58 INFO - 'base_work_dir': '/builds/slave/test', 21:16:58 INFO - 'blob_upload_branch': 'Autoland', 21:16:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:16:58 INFO - 'branch': 'Autoland', 21:16:58 INFO - 'buildbot_json_path': 'buildprops.json', 21:16:58 INFO - 'config_files': ('talos/linux_config.py',), 21:16:58 INFO - 'default_actions': ('clobber', 21:16:58 INFO - 'read-buildbot-config', 21:16:58 INFO - 'download-and-extract', 21:16:58 INFO - 'populate-webroot', 21:16:58 INFO - 'create-virtualenv', 21:16:58 INFO - 'install', 21:16:58 INFO - 'run-tests'), 21:16:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:16:58 INFO - 'download_minidump_stackwalk': True, 21:16:58 INFO - 'download_symbols': 'ondemand', 21:16:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:16:58 INFO - 'tooltool.py': '/tools/tooltool.py', 21:16:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:16:58 INFO - '/tools/misc-python/virtualenv.py')}, 21:16:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:16:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:16:58 INFO - 'installer_path': 'installer.exe', 21:16:58 INFO - 'log_level': 'info', 21:16:58 INFO - 'log_name': 'talos', 21:16:58 INFO - 'log_to_console': True, 21:16:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:16:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:16:58 INFO - 'opt_config_files': (), 21:16:58 INFO - 'pip_index': False, 21:16:58 INFO - 'sps_profile': False, 21:16:58 INFO - 'sps_profile_interval': 0, 21:16:58 INFO - 'suite': 'dromaeojs-e10s', 21:16:58 INFO - 'system_bits': '32', 21:16:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:16:58 INFO - 'title': 'talos-linux64-ix-031', 21:16:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:16:58 INFO - 'use_talos_json': True, 21:16:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:16:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:16:58 INFO - 'work_dir': 'build'} 21:16:58 INFO - [mozharness: 2016-07-28 04:16:58.886038Z] Running clobber step. 21:16:58 INFO - Running pre-action listener: _resource_record_pre_action 21:16:58 INFO - Running main action method: clobber 21:16:58 INFO - rmtree: /builds/slave/test/build 21:16:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:16:59 INFO - Running post-action listener: _resource_record_post_action 21:16:59 INFO - [mozharness: 2016-07-28 04:16:59.353775Z] Finished clobber step (success) 21:16:59 INFO - [mozharness: 2016-07-28 04:16:59.353875Z] Running read-buildbot-config step. 21:16:59 INFO - Running pre-action listener: _resource_record_pre_action 21:16:59 INFO - Running main action method: read_buildbot_config 21:16:59 INFO - Using buildbot properties: 21:16:59 INFO - { 21:16:59 INFO - "project": "", 21:16:59 INFO - "product": "firefox", 21:16:59 INFO - "script_repo_revision": "production", 21:16:59 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:16:59 INFO - "repository": "", 21:16:59 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 21:16:59 INFO - "buildid": "20160727183027", 21:16:59 INFO - "pgo_build": "True", 21:16:59 INFO - "basedir": "/builds/slave/test", 21:16:59 INFO - "buildnumber": 69, 21:16:59 INFO - "slavename": "talos-linux64-ix-031", 21:16:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:16:59 INFO - "platform": "ubuntu64_hw", 21:16:59 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:16:59 INFO - "branch": "autoland", 21:16:59 INFO - "repo_path": "integration/autoland", 21:16:59 INFO - "revision": "ffc7874fcb7ef819f55c29172fb2fb09589c2405", 21:16:59 INFO - "stage_platform": "linux64-pgo", 21:16:59 INFO - "builduid": "9db3f2ce887d4ad39bf372eabbed73e1", 21:16:59 INFO - "slavebuilddir": "test" 21:16:59 INFO - } 21:16:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:16:59 INFO - Running post-action listener: _resource_record_post_action 21:16:59 INFO - [mozharness: 2016-07-28 04:16:59.356289Z] Finished read-buildbot-config step (success) 21:16:59 INFO - [mozharness: 2016-07-28 04:16:59.356378Z] Running download-and-extract step. 21:16:59 INFO - Running pre-action listener: _resource_record_pre_action 21:16:59 INFO - Running main action method: download_and_extract 21:16:59 INFO - mkdir: /builds/slave/test/build/tests 21:16: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')]} 21:16:59 INFO - https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:06 INFO - Downloaded 1361 bytes. 21:17:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:17:06 INFO - Using the following test package requirements: 21:17:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:17:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:17:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:17:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'jsshell-linux-x86_64.zip'], 21:17:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:17:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:17:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:17:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:17:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:17:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:17:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:17:06 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')]} 21:17:06 INFO - https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:10 INFO - Downloaded 24317955 bytes. 21:17:10 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'] 21:17:10 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 21:17:11 INFO - Return code: 0 21:17:11 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 21:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:11 INFO - https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:14 INFO - Downloaded 24317955 bytes. 21:17:14 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'] 21:17:14 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 21:17:15 INFO - Return code: 0 21:17: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')]} 21:17:15 INFO - https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:16 INFO - Downloaded 14413725 bytes. 21:17:16 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'] 21:17:16 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 21:17:16 INFO - Return code: 0 21:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:16 INFO - https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XvGFr_v6Qbm31GaoLs5scQ/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 21:17:18 INFO - Downloaded 60985786 bytes. 21:17:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:17:18 INFO - mkdir: /builds/slave/test/properties 21:17:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:17:18 INFO - Writing to file /builds/slave/test/properties/build_url 21:17:18 INFO - Contents: 21:17:18 INFO - build_url:https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:17:18 INFO - Running post-action listener: _resource_record_post_action 21:17:18 INFO - Running post-action listener: set_extra_try_arguments 21:17:18 INFO - [mozharness: 2016-07-28 04:17:18.814471Z] Finished download-and-extract step (success) 21:17:18 INFO - [mozharness: 2016-07-28 04:17:18.814702Z] Running populate-webroot step. 21:17:18 INFO - Running pre-action listener: _resource_record_pre_action 21:17:18 INFO - Running main action method: populate_webroot 21:17:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:17:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:17:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:17:18 INFO - '--tppagecycles', 21:17:18 INFO - '7'], 21:17:18 INFO - 'tests': ['tsvgm']}}, 21:17:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:17:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:17:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:17:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:17:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['damp', 'tps']}, 21:17:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'tests': ['damp', 'tps']}, 21:17:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['dromaeo_dom']}, 21:17:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:17:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['basic_compositor_video']}, 21:17:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:17:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['a11yr', 21:17:18 INFO - 'ts_paint', 21:17:18 INFO - 'tpaint', 21:17:18 INFO - 'sessionrestore', 21:17:18 INFO - 'sessionrestore_no_auto_restore', 21:17:18 INFO - 'tabpaint']}, 21:17:18 INFO - 'other-e10s': {'tests': ['a11yr', 21:17:18 INFO - 'ts_paint', 21:17:18 INFO - 'tpaint', 21:17:18 INFO - 'sessionrestore', 21:17:18 INFO - 'sessionrestore_no_auto_restore', 21:17:18 INFO - 'tabpaint']}, 21:17:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:17:18 INFO - 'ts_paint', 21:17:18 INFO - 'tpaint', 21:17:18 INFO - 'sessionrestore', 21:17:18 INFO - 'sessionrestore_no_auto_restore', 21:17:18 INFO - 'tabpaint']}, 21:17:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:17:18 INFO - 'ts_paint', 21:17:18 INFO - 'tpaint', 21:17:18 INFO - 'sessionrestore', 21:17:18 INFO - 'sessionrestore_no_auto_restore', 21:17:18 INFO - 'tabpaint']}, 21:17:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['a11yr', 21:17:18 INFO - 'ts_paint', 21:17:18 INFO - 'tpaint', 21:17:18 INFO - 'sessionrestore', 21:17:18 INFO - 'sessionrestore_no_auto_restore', 21:17:18 INFO - 'tabpaint']}, 21:17:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['a11yr', 21:17:18 INFO - 'ts_paint', 21:17:18 INFO - 'tpaint', 21:17:18 INFO - 'sessionrestore', 21:17:18 INFO - 'sessionrestore_no_auto_restore', 21:17:18 INFO - 'tabpaint']}, 21:17:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['tsvgx', 21:17:18 INFO - 'tsvgr_opacity', 21:17:18 INFO - 'tart', 21:17:18 INFO - 'tscrollx', 21:17:18 INFO - 'cart']}, 21:17:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:17:18 INFO - 'tsvgr_opacity', 21:17:18 INFO - 'tart', 21:17:18 INFO - 'tscrollx', 21:17:18 INFO - 'cart']}, 21:17:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'talos_options': ['--disable-e10s'], 21:17:18 INFO - 'tests': ['tp5o']}, 21:17:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'tests': ['tp5o']}, 21:17:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'talos_options': ['--disable-e10s', 21:17:18 INFO - '--xperf_path', 21:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:18 INFO - 'tests': ['tp5n']}, 21:17:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:18 INFO - 'talos_options': ['--xperf_path', 21:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:18 INFO - 'tests': ['tp5n']}}, 21:17:18 INFO - 'talos.zip': {'path': '', 21:17:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:17:18 INFO - Running post-action listener: _resource_record_post_action 21:17:18 INFO - [mozharness: 2016-07-28 04:17:18.837068Z] Finished populate-webroot step (success) 21:17:18 INFO - [mozharness: 2016-07-28 04:17:18.837158Z] Running create-virtualenv step. 21:17:18 INFO - Running pre-action listener: _resource_record_pre_action 21:17:18 INFO - Running main action method: create_virtualenv 21:17:18 INFO - Creating virtualenv /builds/slave/test/build/venv 21:17:18 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 21:17:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:17:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:17:18 INFO - Using real prefix '/usr' 21:17:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:17:19 INFO - Installing distribute.............................................................................................................................................................................................done. 21:17:21 INFO - Installing pip.................done. 21:17:21 INFO - Return code: 0 21:17:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:17:21 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')]} 21:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:21 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')]} 21:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:21 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:21 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 21:17:21 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 21:17:21 INFO - Using env: {'DISPLAY': ':0', 21:17:21 INFO - 'HOME': '/home/cltbld', 21:17:21 INFO - 'LANG': 'en_US.UTF-8', 21:17:21 INFO - 'LANGUAGE': 'en_US:en', 21:17:21 INFO - 'LOGNAME': 'cltbld', 21:17:21 INFO - 'MAIL': '/var/mail/cltbld', 21:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:21 INFO - 'MOZ_NO_REMOTE': '1', 21:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:21 INFO - 'NO_EM_RESTART': '1', 21:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:21 INFO - 'PWD': '/builds/slave/test', 21:17:21 INFO - 'SHELL': '/bin/bash', 21:17:21 INFO - 'SHLVL': '1', 21:17:21 INFO - 'TERM': 'linux', 21:17:21 INFO - 'TMOUT': '86400', 21:17:21 INFO - 'USER': 'cltbld', 21:17:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:21 INFO - '_': '/tools/buildbot/bin/python'} 21:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:21 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 21:17:21 INFO - Cleaning up... 21:17:21 INFO - Return code: 0 21:17:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:17:21 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')]} 21:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:21 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')]} 21:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:21 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:21 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 21:17:21 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 21:17:21 INFO - Using env: {'DISPLAY': ':0', 21:17:21 INFO - 'HOME': '/home/cltbld', 21:17:21 INFO - 'LANG': 'en_US.UTF-8', 21:17:21 INFO - 'LANGUAGE': 'en_US:en', 21:17:21 INFO - 'LOGNAME': 'cltbld', 21:17:21 INFO - 'MAIL': '/var/mail/cltbld', 21:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:21 INFO - 'MOZ_NO_REMOTE': '1', 21:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:21 INFO - 'NO_EM_RESTART': '1', 21:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:21 INFO - 'PWD': '/builds/slave/test', 21:17:21 INFO - 'SHELL': '/bin/bash', 21:17:21 INFO - 'SHLVL': '1', 21:17:21 INFO - 'TERM': 'linux', 21:17:21 INFO - 'TMOUT': '86400', 21:17:21 INFO - 'USER': 'cltbld', 21:17:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:21 INFO - '_': '/tools/buildbot/bin/python'} 21:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:21 INFO - Downloading/unpacking psutil>=3.1.1 21:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:23 INFO - Installing collected packages: psutil 21:17:23 INFO - Running setup.py install for psutil 21:17:23 INFO - building 'psutil._psutil_linux' extension 21:17:23 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 21:17:24 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 21:17:24 INFO - building 'psutil._psutil_posix' extension 21:17:24 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 21:17:24 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 21:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:24 INFO - Successfully installed psutil 21:17:24 INFO - Cleaning up... 21:17:24 INFO - Return code: 0 21:17:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:17:24 INFO - Using env: {'DISPLAY': ':0', 21:17:24 INFO - 'HOME': '/home/cltbld', 21:17:24 INFO - 'LANG': 'en_US.UTF-8', 21:17:24 INFO - 'LANGUAGE': 'en_US:en', 21:17:24 INFO - 'LOGNAME': 'cltbld', 21:17:24 INFO - 'MAIL': '/var/mail/cltbld', 21:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:24 INFO - 'MOZ_NO_REMOTE': '1', 21:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:24 INFO - 'NO_EM_RESTART': '1', 21:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:24 INFO - 'PWD': '/builds/slave/test', 21:17:24 INFO - 'SHELL': '/bin/bash', 21:17:24 INFO - 'SHLVL': '1', 21:17:24 INFO - 'TERM': 'linux', 21:17:24 INFO - 'TMOUT': '86400', 21:17:24 INFO - 'USER': 'cltbld', 21:17:24 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:24 INFO - '_': '/tools/buildbot/bin/python'} 21:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:17:26 INFO - Installing collected packages: mozsystemmonitor 21:17:26 INFO - Running setup.py install for mozsystemmonitor 21:17:26 INFO - Successfully installed mozsystemmonitor 21:17:26 INFO - Cleaning up... 21:17:26 INFO - Return code: 0 21:17:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:17:26 INFO - Using env: {'DISPLAY': ':0', 21:17:26 INFO - 'HOME': '/home/cltbld', 21:17:26 INFO - 'LANG': 'en_US.UTF-8', 21:17:26 INFO - 'LANGUAGE': 'en_US:en', 21:17:26 INFO - 'LOGNAME': 'cltbld', 21:17:26 INFO - 'MAIL': '/var/mail/cltbld', 21:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:26 INFO - 'MOZ_NO_REMOTE': '1', 21:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:26 INFO - 'NO_EM_RESTART': '1', 21:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:26 INFO - 'PWD': '/builds/slave/test', 21:17:26 INFO - 'SHELL': '/bin/bash', 21:17:26 INFO - 'SHLVL': '1', 21:17:26 INFO - 'TERM': 'linux', 21:17:26 INFO - 'TMOUT': '86400', 21:17:26 INFO - 'USER': 'cltbld', 21:17:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:26 INFO - '_': '/tools/buildbot/bin/python'} 21:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:26 INFO - Downloading/unpacking jsonschema==2.5.1 21:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:17:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 21:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:17:29 INFO - warning: no files found matching '*.txt' 21:17:29 INFO - no previously-included directories found matching 'build' 21:17:29 INFO - no previously-included directories found matching 'dist' 21:17:29 INFO - no previously-included directories found matching '.git*' 21:17:29 INFO - Installing collected packages: jsonschema, functools32 21:17:29 INFO - Running setup.py install for functools32 21:17:29 INFO - warning: no files found matching '*.txt' 21:17:29 INFO - no previously-included directories found matching 'build' 21:17:29 INFO - no previously-included directories found matching 'dist' 21:17:29 INFO - no previously-included directories found matching '.git*' 21:17:29 INFO - Successfully installed jsonschema functools32 21:17:29 INFO - Cleaning up... 21:17:29 INFO - Return code: 0 21:17:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:17:29 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')]} 21:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:29 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')]} 21:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:29 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:29 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 21:17:29 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 21:17:29 INFO - Using env: {'DISPLAY': ':0', 21:17:29 INFO - 'HOME': '/home/cltbld', 21:17:29 INFO - 'LANG': 'en_US.UTF-8', 21:17:29 INFO - 'LANGUAGE': 'en_US:en', 21:17:29 INFO - 'LOGNAME': 'cltbld', 21:17:29 INFO - 'MAIL': '/var/mail/cltbld', 21:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:29 INFO - 'MOZ_NO_REMOTE': '1', 21:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:29 INFO - 'NO_EM_RESTART': '1', 21:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:29 INFO - 'PWD': '/builds/slave/test', 21:17:29 INFO - 'SHELL': '/bin/bash', 21:17:29 INFO - 'SHLVL': '1', 21:17:29 INFO - 'TERM': 'linux', 21:17:29 INFO - 'TMOUT': '86400', 21:17:29 INFO - 'USER': 'cltbld', 21:17:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:29 INFO - '_': '/tools/buildbot/bin/python'} 21:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:17:29 INFO - Cleaning up... 21:17:29 INFO - Return code: 0 21:17:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:17:29 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')]} 21:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:29 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')]} 21:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:29 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:29 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 21:17:29 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 21:17:29 INFO - Using env: {'DISPLAY': ':0', 21:17:29 INFO - 'HOME': '/home/cltbld', 21:17:29 INFO - 'LANG': 'en_US.UTF-8', 21:17:29 INFO - 'LANGUAGE': 'en_US:en', 21:17:29 INFO - 'LOGNAME': 'cltbld', 21:17:29 INFO - 'MAIL': '/var/mail/cltbld', 21:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:29 INFO - 'MOZ_NO_REMOTE': '1', 21:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:29 INFO - 'NO_EM_RESTART': '1', 21:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:29 INFO - 'PWD': '/builds/slave/test', 21:17:29 INFO - 'SHELL': '/bin/bash', 21:17:29 INFO - 'SHLVL': '1', 21:17:29 INFO - 'TERM': 'linux', 21:17:29 INFO - 'TMOUT': '86400', 21:17:29 INFO - 'USER': 'cltbld', 21:17:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:29 INFO - '_': '/tools/buildbot/bin/python'} 21:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:29 INFO - Downloading/unpacking blobuploader==1.2.4 21:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:31 INFO - Downloading blobuploader-1.2.4.tar.gz 21:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:17:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:17:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:17:32 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 21:17:32 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 21:17:32 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 21:17:32 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 21:17:32 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 21:17:32 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 21:17:32 INFO - Downloading docopt-0.6.1.tar.gz 21:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:17:32 INFO - Installing collected packages: blobuploader, requests, docopt 21:17:32 INFO - Running setup.py install for blobuploader 21:17:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:17:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:17:32 INFO - Running setup.py install for requests 21:17:32 INFO - Running setup.py install for docopt 21:17:32 INFO - Successfully installed blobuploader requests docopt 21:17:32 INFO - Cleaning up... 21:17:32 INFO - Return code: 0 21:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:32 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')]} 21:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:32 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')]} 21:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:32 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:32 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 21:17:32 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 21:17:32 INFO - Using env: {'DISPLAY': ':0', 21:17:32 INFO - 'HOME': '/home/cltbld', 21:17:32 INFO - 'LANG': 'en_US.UTF-8', 21:17:32 INFO - 'LANGUAGE': 'en_US:en', 21:17:32 INFO - 'LOGNAME': 'cltbld', 21:17:32 INFO - 'MAIL': '/var/mail/cltbld', 21:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:32 INFO - 'MOZ_NO_REMOTE': '1', 21:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:32 INFO - 'NO_EM_RESTART': '1', 21:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:32 INFO - 'PWD': '/builds/slave/test', 21:17:32 INFO - 'SHELL': '/bin/bash', 21:17:32 INFO - 'SHLVL': '1', 21:17:32 INFO - 'TERM': 'linux', 21:17:32 INFO - 'TMOUT': '86400', 21:17:32 INFO - 'USER': 'cltbld', 21:17:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:32 INFO - '_': '/tools/buildbot/bin/python'} 21:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:17:33 INFO - Running setup.py (path:/tmp/pip-RLjYYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:17:33 INFO - Running setup.py (path:/tmp/pip-RYh0mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:17:33 INFO - Running setup.py (path:/tmp/pip-I7bvfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:17:33 INFO - Running setup.py (path:/tmp/pip-eZHGc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:17:33 INFO - Running setup.py (path:/tmp/pip-LbNLJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:17:33 INFO - Running setup.py (path:/tmp/pip-lzOIN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:17:33 INFO - Running setup.py (path:/tmp/pip-9KtKXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:17:33 INFO - Running setup.py (path:/tmp/pip-sCTdCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:17:33 INFO - Running setup.py (path:/tmp/pip-YJY3Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:17:33 INFO - Running setup.py (path:/tmp/pip-1_LG7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:17:33 INFO - Running setup.py (path:/tmp/pip-ziudMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:17:33 INFO - Running setup.py (path:/tmp/pip-onX9KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:17:34 INFO - Running setup.py (path:/tmp/pip-Go2rlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:17:34 INFO - Running setup.py (path:/tmp/pip-bSQryG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:34 INFO - Running setup.py (path:/tmp/pip-vWctqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:17:34 INFO - Running setup.py (path:/tmp/pip-dIP7KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:17:34 INFO - Running setup.py (path:/tmp/pip-4m7En5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:17:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:17:34 INFO - Running setup.py install for manifestparser 21:17:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:17:34 INFO - Running setup.py install for mozcrash 21:17:34 INFO - Running setup.py install for mozdebug 21:17:34 INFO - Running setup.py install for mozdevice 21:17:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:17:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:17:34 INFO - Running setup.py install for mozfile 21:17:34 INFO - Running setup.py install for mozhttpd 21:17:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:17:34 INFO - Running setup.py install for mozinfo 21:17:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Running setup.py install for mozInstall 21:17:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Running setup.py install for mozleak 21:17:35 INFO - Running setup.py install for mozlog 21:17:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Running setup.py install for moznetwork 21:17:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Running setup.py install for mozprocess 21:17:35 INFO - Running setup.py install for mozprofile 21:17:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Running setup.py install for mozrunner 21:17:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:17:35 INFO - Running setup.py install for mozscreenshot 21:17:35 INFO - Running setup.py install for moztest 21:17:36 INFO - Running setup.py install for mozversion 21:17:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:17:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:17:36 INFO - Cleaning up... 21:17:36 INFO - Return code: 0 21:17:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:36 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')]} 21:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:36 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')]} 21:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:36 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:36 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 21:17:36 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 21:17:36 INFO - Using env: {'DISPLAY': ':0', 21:17:36 INFO - 'HOME': '/home/cltbld', 21:17:36 INFO - 'LANG': 'en_US.UTF-8', 21:17:36 INFO - 'LANGUAGE': 'en_US:en', 21:17:36 INFO - 'LOGNAME': 'cltbld', 21:17:36 INFO - 'MAIL': '/var/mail/cltbld', 21:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:36 INFO - 'MOZ_NO_REMOTE': '1', 21:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:36 INFO - 'NO_EM_RESTART': '1', 21:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:36 INFO - 'PWD': '/builds/slave/test', 21:17:36 INFO - 'SHELL': '/bin/bash', 21:17:36 INFO - 'SHLVL': '1', 21:17:36 INFO - 'TERM': 'linux', 21:17:36 INFO - 'TMOUT': '86400', 21:17:36 INFO - 'USER': 'cltbld', 21:17:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:36 INFO - '_': '/tools/buildbot/bin/python'} 21:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:17:36 INFO - Running setup.py (path:/tmp/pip-_YuRlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:17:36 INFO - Running setup.py (path:/tmp/pip-L__YnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:17:36 INFO - Running setup.py (path:/tmp/pip-Ajrg49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:17:36 INFO - Running setup.py (path:/tmp/pip-jJeM3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:17:36 INFO - Running setup.py (path:/tmp/pip-i1acya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:17:36 INFO - Running setup.py (path:/tmp/pip-0xS8FX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:17:36 INFO - Running setup.py (path:/tmp/pip-pa5kCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:17:36 INFO - Running setup.py (path:/tmp/pip-lfReAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:17:36 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)) 21:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:17:36 INFO - Running setup.py (path:/tmp/pip-X5mmTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:17:37 INFO - Running setup.py (path:/tmp/pip-rlcUK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:17:37 INFO - Running setup.py (path:/tmp/pip-k2Dmii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:17:37 INFO - Running setup.py (path:/tmp/pip-jQ0u86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:17:37 INFO - Running setup.py (path:/tmp/pip-jnZu8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:17:37 INFO - Running setup.py (path:/tmp/pip-hjqqLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:37 INFO - Running setup.py (path:/tmp/pip-lly4pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:17:37 INFO - Running setup.py (path:/tmp/pip-EWychy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:17:37 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)) 21:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:17:37 INFO - Running setup.py (path:/tmp/pip-hFSuBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:17:37 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)) 21:17:37 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)) 21:17:37 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)) 21:17:37 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)) 21:17:37 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)) 21:17:37 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)) 21:17:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:17:37 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 21:17:37 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 21:17:37 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 21:17:37 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 21:17:37 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 21:17:37 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 21:17:39 INFO - Downloading blessings-1.6.tar.gz 21:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:17:39 INFO - Installing collected packages: blessings 21:17:39 INFO - Running setup.py install for blessings 21:17:39 INFO - Successfully installed blessings 21:17:39 INFO - Cleaning up... 21:17:39 INFO - Return code: 0 21:17:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:17:39 INFO - Reading from file tmpfile_stdout 21:17:39 INFO - Current package versions: 21:17:39 INFO - argparse == 1.2.1 21:17:39 INFO - blessings == 1.6 21:17:39 INFO - blobuploader == 1.2.4 21:17:39 INFO - docopt == 0.6.1 21:17:39 INFO - functools32 == 3.2.3-2 21:17:39 INFO - jsonschema == 2.5.1 21:17:39 INFO - manifestparser == 1.1 21:17:39 INFO - mozInstall == 1.12 21:17:39 INFO - mozcrash == 0.17 21:17:39 INFO - mozdebug == 0.1 21:17:39 INFO - mozdevice == 0.48 21:17:39 INFO - mozfile == 1.2 21:17:39 INFO - mozhttpd == 0.7 21:17:39 INFO - mozinfo == 0.9 21:17:39 INFO - mozleak == 0.1 21:17:39 INFO - mozlog == 3.3 21:17:39 INFO - moznetwork == 0.27 21:17:39 INFO - mozprocess == 0.23 21:17:39 INFO - mozprofile == 0.28 21:17:39 INFO - mozrunner == 6.12 21:17:39 INFO - mozscreenshot == 0.1 21:17:39 INFO - mozsystemmonitor == 0.3 21:17:39 INFO - moztest == 0.7 21:17:39 INFO - mozversion == 1.4 21:17:39 INFO - psutil == 3.1.1 21:17:39 INFO - requests == 1.2.3 21:17:39 INFO - wsgiref == 0.1.2 21:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:39 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:39 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 21:17:39 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 21:17:39 INFO - Using env: {'DISPLAY': ':0', 21:17:39 INFO - 'HOME': '/home/cltbld', 21:17:39 INFO - 'LANG': 'en_US.UTF-8', 21:17:39 INFO - 'LANGUAGE': 'en_US:en', 21:17:39 INFO - 'LOGNAME': 'cltbld', 21:17:39 INFO - 'MAIL': '/var/mail/cltbld', 21:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:39 INFO - 'MOZ_NO_REMOTE': '1', 21:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:39 INFO - 'NO_EM_RESTART': '1', 21:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:39 INFO - 'PWD': '/builds/slave/test', 21:17:39 INFO - 'SHELL': '/bin/bash', 21:17:39 INFO - 'SHLVL': '1', 21:17:39 INFO - 'TERM': 'linux', 21:17:39 INFO - 'TMOUT': '86400', 21:17:39 INFO - 'USER': 'cltbld', 21:17:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:39 INFO - '_': '/tools/buildbot/bin/python'} 21:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 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)) 21:17:40 INFO - Cleaning up... 21:17:40 INFO - Return code: 0 21:17:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:17: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')]} 21:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17: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')]} 21:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:40 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 0x24c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, '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': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', '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 21:17:40 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 21:17:40 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 21:17:40 INFO - Using env: {'DISPLAY': ':0', 21:17:40 INFO - 'HOME': '/home/cltbld', 21:17:40 INFO - 'LANG': 'en_US.UTF-8', 21:17:40 INFO - 'LANGUAGE': 'en_US:en', 21:17:40 INFO - 'LOGNAME': 'cltbld', 21:17:40 INFO - 'MAIL': '/var/mail/cltbld', 21:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:40 INFO - 'MOZ_NO_REMOTE': '1', 21:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:40 INFO - 'NO_EM_RESTART': '1', 21:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:40 INFO - 'PWD': '/builds/slave/test', 21:17:40 INFO - 'SHELL': '/bin/bash', 21:17:40 INFO - 'SHLVL': '1', 21:17:40 INFO - 'TERM': 'linux', 21:17:40 INFO - 'TMOUT': '86400', 21:17:40 INFO - 'USER': 'cltbld', 21:17:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:40 INFO - '_': '/tools/buildbot/bin/python'} 21:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:17:40 INFO - Cleaning up... 21:17:40 INFO - Return code: 0 21:17:40 INFO - Running post-action listener: _resource_record_post_action 21:17:40 INFO - Running post-action listener: _start_resource_monitoring 21:17:40 INFO - Starting resource monitoring. 21:17:40 INFO - [mozharness: 2016-07-28 04:17:40.465115Z] Finished create-virtualenv step (success) 21:17:40 INFO - [mozharness: 2016-07-28 04:17:40.465563Z] Running install step. 21:17:40 INFO - Running pre-action listener: _resource_record_pre_action 21:17:40 INFO - Running main action method: install 21:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:17:40 INFO - Reading from file tmpfile_stdout 21:17:40 INFO - Detecting whether we're running mozinstall >=1.0... 21:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:17:40 INFO - Reading from file tmpfile_stdout 21:17:40 INFO - Output received: 21:17:40 INFO - Usage: mozinstall [options] installer 21:17:40 INFO - Options: 21:17:40 INFO - -h, --help show this help message and exit 21:17:40 INFO - -d DEST, --destination=DEST 21:17:40 INFO - Directory to install application into. [default: 21:17:40 INFO - "/builds/slave/test"] 21:17:40 INFO - --app=APP Application being installed. [default: firefox] 21:17:40 INFO - mkdir: /builds/slave/test/build/application 21:17:40 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'] 21:17:40 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 21:17:58 INFO - Reading from file tmpfile_stdout 21:17:58 INFO - Output received: 21:17:58 INFO - /builds/slave/test/build/application/firefox/firefox 21:17:58 INFO - Running post-action listener: _resource_record_post_action 21:17:58 INFO - [mozharness: 2016-07-28 04:17:58.054133Z] Finished install step (success) 21:17:58 INFO - [mozharness: 2016-07-28 04:17:58.054412Z] Running run-tests step. 21:17:58 INFO - Running pre-action listener: _resource_record_pre_action 21:17:58 INFO - Running main action method: run_tests 21:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:17:58 INFO - Python 2.7.3 21:17:58 INFO - Return code: 0 21:17:58 INFO - grabbing minidump binary from tooltool 21:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:58 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 0x27883b0>, '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 0x27892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:17:58 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 21:17:58 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 21:17:58 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 21:17:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:17:58 INFO - Return code: 0 21:17:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:17:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:17:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:17:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:17:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:17:58 INFO - Using env: {'DISPLAY': ':0', 21:17:58 INFO - 'HOME': '/home/cltbld', 21:17:58 INFO - 'LANG': 'en_US.UTF-8', 21:17:58 INFO - 'LANGUAGE': 'en_US:en', 21:17:58 INFO - 'LOGNAME': 'cltbld', 21:17:58 INFO - 'MAIL': '/var/mail/cltbld', 21:17:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:17:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:58 INFO - 'MOZ_NO_REMOTE': '1', 21:17:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:58 INFO - 'NO_EM_RESTART': '1', 21:17:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:58 INFO - 'PWD': '/builds/slave/test', 21:17:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:17:58 INFO - 'SHELL': '/bin/bash', 21:17:58 INFO - 'SHLVL': '1', 21:17:58 INFO - 'TERM': 'linux', 21:17:58 INFO - 'TMOUT': '86400', 21:17:58 INFO - 'USER': 'cltbld', 21:17:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264', 21:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:58 INFO - '_': '/tools/buildbot/bin/python'} 21:17:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:17:58 INFO - mozversion application_buildid: 20160727183027 21:17:58 INFO - mozversion application_changeset: ffc7874fcb7ef819f55c29172fb2fb09589c2405 21:17:58 INFO - mozversion application_display_name: Nightly 21:17:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:17:58 INFO - mozversion application_name: Firefox 21:17:58 INFO - mozversion application_remotingname: firefox 21:17:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:17:58 INFO - mozversion application_vendor: Mozilla 21:17:58 INFO - mozversion application_version: 50.0a1 21:17:58 INFO - mozversion platform_buildid: 20160727183027 21:17:58 INFO - mozversion platform_changeset: ffc7874fcb7ef819f55c29172fb2fb09589c2405 21:17:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:17:58 INFO - mozversion platform_version: 50.0a1 21:17:58 INFO - using testdate: 1469679478 21:17:58 INFO - actual date: 1469679478 21:17:58 INFO - starting webserver on 'localhost:54013' 21:17:58 INFO - SUITE-START | Running 2 tests 21:17:58 INFO - TEST-START | dromaeo_css 21:17:58 INFO - operating with platform_type : linux_ 21:17:58 INFO - Initialising browser for dromaeo_css test... 21:17:58 INFO - TEST-INFO | started process 15274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9M7X0G/profile http://localhost:54013/getInfo.html) 21:18:01 INFO - PROCESS | 15274 | JavaScript error: , line 0: uncaught exception: undefined 21:18:02 INFO - PROCESS | 15274 | __metrics Screen width/height:1600/1200 21:18:02 INFO - PROCESS | 15274 | colorDepth:24 21:18:02 INFO - PROCESS | 15274 | Browser inner width/height: 1024/697 21:18:02 INFO - PROCESS | 15274 | __metrics 21:18:03 ERROR - PROCESS | 15274 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 21:18:04 INFO - TEST-INFO | 15274: exit 0 21:18:04 INFO - Browser initialized. 21:18:04 INFO - Running cycle 1/1 for dromaeo_css test... 21:18:04 INFO - TEST-INFO | started process 15393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9M7X0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:16 INFO - PROCESS | 15393 | RSS: Main: 165031936 21:18:16 INFO - PROCESS | 15393 | 21:19:05 INFO - PROCESS | 15393 | 1469679545837 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] 21:21:14 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54013/tests/dromaeo/cssquery-ext.html) 21:21:15 INFO - PROCESS | 15393 | RSS: Main: 170201088 21:21:15 INFO - PROCESS | 15393 | 21:24:17 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-ext.html (next: http://localhost:54013/tests/dromaeo/cssquery-jquery.html) 21:24:18 INFO - PROCESS | 15393 | RSS: Main: 167391232 21:24:18 INFO - PROCESS | 15393 | 21:27:19 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54013/tests/dromaeo/cssquery-mootools.html) 21:27:20 INFO - PROCESS | 15393 | RSS: Main: 170549248 21:27:20 INFO - PROCESS | 15393 | 21:30:22 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54013/tests/dromaeo/cssquery-prototype.html) 21:30:22 INFO - PROCESS | 15393 | RSS: Main: 164818944 21:30:22 INFO - PROCESS | 15393 | 21:33:25 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54013/tests/dromaeo/cssquery-yui.html) 21:33:26 INFO - PROCESS | 15393 | RSS: Main: 168005632 21:33:26 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-yui.html (next: http://localhost:54013/tests/dromaeo/cssquery-dojo.html) 21:36:28 INFO - PROCESS | 15393 | RSS: Main: 170512384 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | __start_tp_report 21:36:28 INFO - PROCESS | 15393 | _x_x_mozilla_page_load 21:36:28 INFO - PROCESS | 15393 | _x_x_mozilla_page_load_details 21:36:28 INFO - PROCESS | 15393 | |i|pagename|runs| 21:36:28 INFO - PROCESS | 15393 | |0;dojo.html;3165.730912872406;3174.918540888499;3202.983985080074;3203.19920019995;3209.9518507222383;5328.200769884519;5534.640248383852;5584.4973952344335;5610.943890561093;5624.465675760806;5460.235567020621;5461.0716178249695;5506.614536982413;5506.80726174584;5580.637258578189;4982.651214414984;5013.398392192924;5065.822696205633;5067.239914012891;5119.897602047957;5080.822171224008;5110.8466745997675;5182.948170518284;5183.196604526304;5210.7655155517905;4953.504649535035;5009.348784657989;5029.245613158019;5031.874203144932;5108;5034.0686972910125;5039.47085556015;5047.848564543033;5048.949510504922;5107;4970.229614409773;4989.376327959005;4994.800207991676;5021.347224860781;5037.823676171353;5456.454354564551;5467.9453205467835;5469.206964990094;5469.753861076261;5562.054450743383;5910.261217347832;5911.467967882868;5929.229200203989;5937.67342796146;5937.703114844284;5788.855278618026;5964.463198312173;5972.4027597240365;5975.581709280352;5989.520838332923;5466.207399926989;5499.972500137474;5503.532199762985;5523.061079616475;5572.60991730579;6081.6351018939;6101.908471372933;6104.481119104837;6104.816855494342;6110.175126357884;5627.803026894121;5821.301443826683;5821.592488525847;5826.796062137805;5839.503642190376;5750.0512415450985;5819.709014549256;5856.648601083949;5878.2358293421585;5958.165856780054;5639.154126881001;5819.447152520504;5841.065429531254;5867.14926335679;5881.911771323434;5825.825225243249;5876.265466816648;5903.291605007426;5911.083782013795;5920.822375328747;4395.362672412482;4480.574345437179;4497.302918047708;4504.144212599595;4544.227481328182;4039.8788036358956;4046.5751096135073;4051;4081.9795901020307;4090.754554726726;5717.514011309086;5739.139129130664;5745.3105627324985;5777.45114214149;5798.768049277982;5754.165645981309;5797.942020579824;5926.111083337534;6040.818775436744;6067.362926892701;5669.461401166883;5685.857853553694;5740.684262365527;5763;5797.391273916178;5108.6168537359845;5115.2071428928575;5124.615653825978;5169.224616307584;5212.817551385683;5924.7926322578505;6130.581587307925;6160.274585882739;6206.348333425016;6213.751449942042;6008.969955150284;6076.66578338178;6080.361562035922;6098.371716891094;6134.079888016833;6197.845053873689;6204.224471941007;6248.375162483897;6259.374062593704;6271.655058971618;5656.095024796013;5771.797987070432;5850.185925351475;5886.05823068307;5959.374265702212;5895.174675545341;5943.316518600416;5953.434423729739;5992.13114098462;6002.039673652194;5784.421557844182;5785.884282314414;5790.94209057904;5798.188253644409;5804.82585522435;5609;5638.633488823213;5735.7705691773535;5751.424857514216;5778.942210578009;5683.06229472149;5692.772289108555;5702.743376547983;5743.885122297447;5751.654900705971;5714.085746280575;5772.336181339199;5784.595078344475;5816.069428891357;5817.156512305776;5557.472040156179;5614.494695477427;5670.121131224667;5678.943210567842;5682.943170568242 21:36:28 INFO - PROCESS | 15393 | |1;ext.html;551.3360931606944;580.6516090345792;593.531110422766;604.6402390577605;643.8551325951659;39504.60495395049;43561.128777424434;43668.816559172075;43686.78156609216;43811.12377752443;43183;43638.34542481857;43772.56227437725;43853.780731096296;43947.56052439482;8781.824363512726;8888.777780555472;8915.420497667663;8915.509646969414;8923.063078376741;8732.694355697551;8873.911260887406;8883.24492418142;8883.600237989305;8943.552822358855;8907.376483646114;8935.195832375084;8948.970868350125;8964.327675424336;8978.41640293382;8867.645294188225;8922.776930576723;8930.19628233462;8950.060243674418;8971.327150463741;8804.251638610725;8815.074417186168;8829.735107946708;8861.601227944759;8867.157620026088;41093.79453102745;41192;41359.379609305586;41516;41592.1681566367;3707.258548290326;3720.553533575961;3767.547894252707;3794.1273507093247;3842.846286148551;32753;32864;33184;33318;34382.312353753034;4398.714083584557;4440.067585806984;4540.818367265306;4548.340490628841;4550.590446859798;345742;346554;347108;347857;348650;30727;31378.372432551678;57181;57347.99282025109;57642.42357576371;35602.8219858899;36276.455853162224;36288.09279767974;36299;36347;13046.54337098197;13116.08187426871;13118.606441806762;13124.475020999243;13132;11743.236689615147;11960.222585532087;11969.88030119705;11976.28142311464;11987.820182697093;8156.0620528639965;8183.427160098736;8196.385475948993;8258.669653213805;8292.419530632798;3175.8729650813707;3193.61676598805;3195.744340452758;3219.0825614700166;3262.7716059876057;1035.7627524547092;1066.6000249906285;1081.7187531241777;1102.9117670586334;1171.8652354979115;32777.50833737496;32985.505217421756;32997;33137.83431082877;33453.66546334554;1078.7195329214303;1107.0866535108569;1123.6179698902413;1128.8927551882557;1132.64887884756;16990.660186796194;17226.569335766708;17339.133043348036;17406.56483587895;17436.5640858977;580122;583110;583339;584847;585915;58325.12512312319;58528.12207816886;59104.408955909894;59150.40849591535;59247.111293330636;1318.762622727899;1322.2066759943957;1349.7098123903409;1366.658335416146;1367.7401293754353;30833;32804;32917.67082329242;32927.83536082304;33063.50404743883;51226.48773512217;51264.487355127465;51734.48265517447;51769.482305177975;51833.7408312956;450589;452708;461555;464444;466104;27238.72761272441;27287.590686139327;27451.31371715723;27536.58695119615;27690.169294921183;48389.27416088691;48468.272975904685;48678;48931.75534122306;50124.498755011984;39986.80006599949;40059.59940400675;41193.438073053236;41437.79281103575;41891;40465.78602641926;40621.39067914043;41829.1634167321;42373.78813106038;43168.78415607902;40580.59419405768;40869.38695919623;41454.79272603738;41888.58111418847;41923.58076419197;32672;38910.805445973725;39213.607863920995;40102.398464023645;40328.39507407333;29094.41811163807;29206.269843253238;29374.706252937198;29421.11736647904;29644.258893527833 21:36:28 INFO - PROCESS | 15393 | |2;jquery.html;380;385.6028389885114;388.6075064185174;393.9350007248803;415.95840415958406;18060.277588896446;19717.605647887052;19732.112054957543;19849.90075049623;20090.698639520382;18240.17919193636;18387.72418413725;18393.356232531863;19189.32837350693;19519.902400488012;5628.943710562883;5755.65466072037;5764.596478246524;5790.68151251681;5878.118282257674;5603.7478313475995;5661.60368774186;5742.913856292159;5747.310322761275;5751.194832723422;5611.158326251075;5617.719114044302;5664.518515926151;5670.546356291507;5725.828225153231;5689.800856970028;5714.142878568227;5718.17086522454;5726.455986681259;5727.284089488814;4747.501512341189;4980.501949805027;5002.52476014778;5040.873978150539;5046.84859454217;13282.269475178862;13283.601491955256;13302.933485332609;13474.179808680185;13578.796318055238;2268.8071513921172;2350.8001819845335;2382.0590866607595;2392.294273189413;2423.75762423758;9476.763080922963;9483.762905927339;9535.38020028696;10019.348742331726;10058.295919285652;1781.3943259291773;1844.7509586205824;1849.2418108575419;1874.521996890784;1886.8490520758444;73557;81851.59074204651;83148.58425707833;88403.55798221032;89385.55307223488;10355.896441035493;10434.68695939123;10708;10859.294145880493;10952.397618131079;14082.295885205698;14115.364808583638;14136.081154725116;14142.080764750259;14197.78703319451;7469.215732348134;7833.1775163608145;7968.84062318762;7977.960110199412;8165.63254653542;7666.846663066707;7779.416543759241;8037.437379383504;8065.919340806634;8074.798130046678;4406.272964960745;4495.415595972568;4518.615917647036;4577;4606.30905364198;1736.9392071277698;1767.354915455875;1788.1059470264868;1794.5334213104686;1795.64087182564;947.3557980573277;965.0976337124671;1039.3607931122306;1046.2414749306693;1053.4364115198484;19637.705434418494;20093.49766255826;20118.39644810658;20181.697274540893;20423;976.72651657536;977.2279898879806;977.8826540815147;979.647326962293;1002.6390499420203;10684.57261709523;11055.957124917211;11129.888701112885;11136.832947505794;11196.552137914556;495926;503977;517086;521183;525055;92092;93699;95001.24371921767;96157;96599.51700241453;966.840471322238;1028.2493779540828;1029.2177944762034;1036.3574583758118;1039.5322105052755;16774.748378774573;17289.654206916042;17867.642647147244;18211.635767284846;18400.63198735991;44004.33993490036;44685;44795.32807007832;45892;46095.07809843851;60859;61633.69183154056;62792.686036569525;62857.68571157115;62908;7752.26353496417;7897.763067107996;8009.159038300894;8046.316063134465;8066.072401673882;11253.381064041228;12465.439055242718;12825.23048617086;12853.742925141632;12906.354682266037;11233.49449274801;11290;11480.081593472669;11508.654740357802;11627.476763545492;10652.307600005975;11063.83404248953;11160.609378672032;11414.828777568177;11486.885131148581;11224.831627525757;11521.82717259225;11566.074714023027;11634.94182529082;11661.6501504955;7791.675415179547;7850.803729906798;7967.760967170994;8000.559829252134;8132.430729848854;10885.183611229348;10987.230893837355;11044.944775276394;11045.171612128961;11102.389368584805 21:36:28 INFO - PROCESS | 15393 | |3;mootools.html;1389.1942673249516;1472.8158980127484;1502.7219964306605;1639.1967935711505;1650.64511130107;7695.499792513483;8529.658813647455;8576.099509551485;9137;9173.541322933852;8710.869336959935;9009.954950225256;9030.72907812765;9035.096490350961;9048.095190480964;2261.23118139832;2285.931422057341;2297.207463425124;2299.701038864945;2308.572914010905;2273.090763694527;2285.531466049456;2333.9649905251435;2336.9649455258186;2343.95312093758;2313.8033267172227;2322.442613772691;2323.6514522821626;2323.8954247058837;2332.918347857817;2301.8158547316257;2305.1931823861596;2312;2324.0006797077335;2329.2895666821782;2295.9426014349606;2298.0577963035244;2298.9195378161853;2305.250793492122;2307.596170670143;8973.641054357819;9006.504642244674;9058.592363343665;9065;9080.046595107484;5105.463926287724;5215.400228973641;5225.634205605609;5239.240310155006;5245.973770131163;3151.353972435645;3204.7115759581516;3300.240944582735;3382.458806590934;3398.2863598644312;1051.978960420795;1060.3107979813105;1074.854894589236;1074.9570017199303;1080.2924084724518;12515.249085054835;12581.496740130475;12585.622431327074;12631.178973366794;12675.619731408073;4472.664550158751;4638.072385522842;4759.809607615656;4763.976180119077;4807.302941073594;10362.326448780805;10429.791404171874;10436.63471778484;10480.63317783874;10508.422036787897;5365.302510673588;5370;5373.059714549938;5374.650647707965;5386.542143917733;4310.676699247506;4857.1742803723455;4945.4312754033745;4948.331975183376;4969.577585905238;3899.8245078971513;3934.409838524244;4022.3966405039478;4025.6376926076796;4086.7956602169775;1211.660734994203;1211.927284362941;1217.117589747426;1220.798568236249;1225.185251807556;978.496074521622;984.4437892590663;996.3623281100101;996.8903420623726;999.2555546118189;6052.092186172022;6058;6069.544784141119;6128.080787881764;6164.815055548341;409.86269599683845;412.8142335948835;418.0864810389309;1051.3324039234988;1097.2757979733337;4179;4300.462442194726;4383.452068491439;4409.206342858252;4436.26801577736;11011.174161937726;11391;11401.201915865975;11417.429128543707;11426.371549564687;11178.944105279421;11204.607838725606;11263.94368028171;11285.943570282096;11304.434778261219;7942.880856787153;8132.105468398471;8155;8435.11431299717;8498.915010849812;6328.145700330397;6337.524685648687;6516.706748196438;6532.545558796324;6587.835304117244;10373.896261037293;10420.270581059252;10462.790744185226;10492.160627149657;10546.419946902994;10000.849987250052;10243.38539687621;10351.43067131315;10564.102051325723;10698.89301106979;6998.2651821558;7461.328480436787;7613.010308659839;7667;7876.09424916142;8832.160944710242;8944.329175312008;8948.955255223682;8951.328650351119;8963;7488.138864030706;7569.129550101588;7650.65572049248;7761.7671469855995;7843.294103530709;7731.729389471341;7758.92241077582;7851.646675899484;7883.960580197062;7893.329067029367;7304.598247096248;7373.705051797868;7391.334779869838;7412.740554080797;7435.851282974202;5026.421961474477;5271;5324.6006549508165;5326.786928522815;5460.5904557159165;5171.276021356938;5399.892002159856;5401.216823560483;5452.672839629635;5480.885672851265 21:36:28 INFO - PROCESS | 15393 | |4;prototype.html;299.52674773857296;313.7756504099568;313.81014486235813;320.7882797353747;324.0279162512463;5435.347758269003;5455.563554915607;5619.550435965123;5702.344230413509;5720.542356611466;5504.091824848895;5516.696581688016;5534.284371844721;5536.861578460531;5542.889142217154;4358.716683415583;4390.626796722282;4400.933985990205;4415.315626077947;4429.822807087713;4010.3182458981896;4174.874753757377;4236.364545318212;4414.492333381654;4415.763586195871;4185.121124563845;4205.222033923718;4217.536071032184;4221.915561688765;4231.026863821323;4169.937450938239;4202.936955945664;4218.957810421887;4231.132617813356;4238.512571054337;3574.4817001534634;3653.429025519026;3662.5971143174497;3668.137987572918;3697.85208591656;5391.218273350381;5394.460553944614;5419.187121931703;5451.509364157245;5451.672899625995;4847.897345698756;4867.440244371872;4867.586255168279;4868.464468908417;4889.193283108283;5645.435456454363;5798.666306749471;5818.359980402152;5860.355360910296;5861.150133230701;4010.6991975601654;4018.537868145142;4020;4034;4046.5953404659595;5961.612495187799;6134;6166.784162554289;6176.258848938156;6196.566240363131;4074.2258970795456;4080.959190408117;4107.630313271819;4107.732997355162;4110.588941105865;4142.46148000758;4156.210320039183;4178.913482494512;4182.351735481006;4194.2450358935075;4853.927191092136;4854.320395144682;4870.391201099863;4872.902541949212;4882.194437917704;5591.9720401398545;5666.801661941895;5825.058345535477;5871.922356716062;5881.705914704333;1393.6794537256487;1428.8928330375263;1428.9854203515413;1430.370636919752;1430.4206796247536;873.8907636545432;913.4108500017585;916.7662246127195;932.6362718539775;935.6070450410843;4991.6006719463085;4995.95165981953;5035.571976382049;5055.747212639353;5074.619403544675;5319.840404787863;5336.252924590561;5342.492463215988;5353.732313384316;5355.518003379714;4739;4995.775190116454;5053;5091.66904151229;5115.335006449138;2839.829610223393;2840.8210592603837;2847.843368614746;2868.498012847743;2880.0927707771984;5493.862653433616;5536.031194540939;5544.889102217933;5548.55611551075;5572.210896590276;5222.764975576109;5309.65487243328;5381.327334083239;5392.865178370572;5495;5442.924747517719;5443.374011988592;5450.291462109901;5475.260839786658;5497.725113744297;5191.221316802359;5342.706151161723;5344.331958505187;5350.732463376893;5353.527779860569;5210.030282738802;5253.605979551626;5255.369355677343;5307.814226502054;5321;5552.444755524415;5556.72216389187;5560.221568980427;5560.27716396882;5569.412717375529;3797.7721336719887;3870.41943708446;3875;3894.9415758764208;3910.081130934171;5771.797987070432;5928.288605367384;5984.521238300838;5999.250093738283;6027.547933904887;5812.505936995402;5901.675407852609;5907.232059832194;5927.673977931255;5937.19847820556;5907.616004959664;5910.586258962004;5925.792597259076;5927.762889484372;5938.168656388023;5647.5481961442165;5798.275215598051;5841.678707670949;5867.20792692981;5894.440028197314;5951.166836642787;5966.552508561962;6019.284503916363;6026.246719160105;6031.69841507914;5705.258316418839;5748.6838223898085;5771.730219351736;5788.189653448605;5824.592278540462 21:36:28 INFO - PROCESS | 15393 | |5;yui.html;680.5100327764009;733.2264460993653;762.4548447859781;766.3486036868666;779.431015358788;14644;15258.389664413424;15282.312295946695;17523.474295771117;17672.20475078621;16086.83913160868;16837.242324095416;16881.577960550992;16938.491845244633;17036.914815425906;772.8029352515101;797.972070977516;799.436397339874;802.2098233240254;803.1807556292578;800.0719165767711;819.0621738109861;820.5117954816874;824.8432797768405;828.1511450762986;867.440500876934;871.4161511787086;872.2978002707817;873.838339907116;875.0636818604096;858.6050416808307;861.5907443964129;861.7716305179133;862.6463150108489;866.2463656618751;627.9575903999385;630.6562923206864;631.4096319940824;635.71710588788;635.895077312243;16038.35846566136;16042.43851465193;16044.278007489691;16054.919725401298;16064.036157830567;15268.921368400628;15417.460388886335;15454.1500217488;15686.450974215848;15727.68544629101;11837.053035757119;12246.755064898742;12276;12343.074269429828;12754.36228188587;3988.3219852624834;4002.7998600070173;4006.1186538961383;4018.3771515415156;4114.691398145121;81071;82164.30260638286;82167;82828;83707.16292837115;11326.660200194008;11817;11980.28118312904;11984.64046078619;12224.511019559119;23464.413389665395;23468.765312347;23624.881875590854;23742.525149497258;23753.049878005033;8358.582070896431;8672.913270867211;8688.6524539019;8817.515036672916;8902.465852048897;4636.930446043312;4758.1673207188605;4785.569298763128;4786.16242157621;4917.58200552957;3459.08334291413;3517.9296414071573;3546.1666508370513;3563.6614521620922;3564.144605294711;646.7380710812129;647.1716203259834;648.2804087462912;665.544102289933;666.7932940788371;639.4852144024012;694.9722011119499;712.7113519024804;713.875071862422;725.7278520554792;8804.603792829337;8856;9240.445573265626;9439.575219115157;9616.692902437653;574.2047264538644;648.4034688086971;663.4062514049898;742.7697413801739;751.4326683354142;4356.912861742748;4501;4588.649079153681;4613.331066995267;4754.429468463806;116397;116991;118569.40715296369;123067;123840.38079809723;61190.38809611936;86379.56810215909;89273;97148;97189.51405242928;89140.5542972281;89476;90591;91911.54044229737;92093;9085.773420588135;9171.816563668823;9361.765955851159;9576.281778866753;9652.179564737076;53893.461065388845;54574.727126364116;55316.44683553113;55368;56284.718576406856;71934.64032679803;72723;78192;79510;80337;13176.275304858325;13202.207867527979;13238.470461181445;13336.066475347021;13357.465701371837;14192;14582.343794529485;14928.328225229674;14932.62668433298;14946;13431.731365372443;13677.589672309847;14380.28098595087;14482.637934051732;14654.194019328614;13911.455318469285;13912.443502260201;14013.789793152908;14382.496612618508;15274.083554986737;13930.164190148624;14004.719905601627;14183.361748721127;14384.208868511914;14675.92662036683;11520.942395288304;11890.702732431759;11895.762084758084;12213.450394732436;12664.6833829155;10742.24804263694;11256.7748645025;11928.463219154984;12260.26438413698;12490.250584964931 21:36:28 INFO - PROCESS | 15393 | __end_tp_report 21:36:28 INFO - PROCESS | 15393 | __start_cc_report 21:36:28 INFO - PROCESS | 15393 | _x_x_mozilla_cycle_collect,364 21:36:28 INFO - PROCESS | 15393 | __end_cc_report 21:36:28 INFO - PROCESS | 15393 | __startTimestamp1469680588766__endTimestamp 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | ------- Summary: start ------- 21:36:28 INFO - PROCESS | 15393 | Number of tests: 6 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | [#0] dojo.html Cycles:165 Average:5508.25 Median:5735.77 stddev:629.37 (11.0%) stddev-sans-first:603.87 21:36:28 INFO - PROCESS | 15393 | Values: 3165.7 3174.9 3203.0 3203.2 3210.0 5328.2 5534.6 5584.5 5610.9 5624.5 5460.2 5461.1 5506.6 5506.8 5580.6 4982.7 5013.4 5065.8 5067.2 5119.9 5080.8 5110.8 5182.9 5183.2 5210.8 4953.5 5009.3 5029.2 5031.9 5108.0 5034.1 5039.5 5047.8 5048.9 5107.0 4970.2 4989.4 4994.8 5021.3 5037.8 5456.5 5467.9 5469.2 5469.8 5562.1 5910.3 5911.5 5929.2 5937.7 5937.7 5788.9 5964.5 5972.4 5975.6 5989.5 5466.2 5500.0 5503.5 5523.1 5572.6 6081.6 6101.9 6104.5 6104.8 6110.2 5627.8 5821.3 5821.6 5826.8 5839.5 5750.1 5819.7 5856.6 5878.2 5958.2 5639.2 5819.4 5841.1 5867.1 5881.9 5825.8 5876.3 5903.3 5911.1 5920.8 4395.4 4480.6 4497.3 4504.1 4544.2 4039.9 4046.6 4051.0 4082.0 4090.8 5717.5 5739.1 5745.3 5777.5 5798.8 5754.2 5797.9 5926.1 6040.8 6067.4 5669.5 5685.9 5740.7 5763.0 5797.4 5108.6 5115.2 5124.6 5169.2 5212.8 5924.8 6130.6 6160.3 6206.3 6213.8 6009.0 6076.7 6080.4 6098.4 6134.1 6197.8 6204.2 6248.4 6259.4 6271.7 5656.1 5771.8 5850.2 5886.1 5959.4 5895.2 5943.3 5953.4 5992.1 6002.0 5784.4 5785.9 5790.9 5798.2 5804.8 5609.0 5638.6 5735.8 5751.4 5778.9 5683.1 5692.8 5702.7 5743.9 5751.7 5714.1 5772.3 5784.6 5816.1 5817.2 5557.5 5614.5 5670.1 5678.9 5682.9 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | [#1] ext.html Cycles:180 Average:60790.28 Median:41192.72 stddev:126067.45 (306.0%) stddev-sans-first:126339.97 21:36:28 INFO - PROCESS | 15393 | Values: 551.3 580.7 593.5 604.6 643.9 39504.6 43561.1 43668.8 43686.8 43811.1 43183.0 43638.3 43772.6 43853.8 43947.6 8781.8 8888.8 8915.4 8915.5 8923.1 8732.7 8873.9 8883.2 8883.6 8943.6 8907.4 8935.2 8949.0 8964.3 8978.4 8867.6 8922.8 8930.2 8950.1 8971.3 8804.3 8815.1 8829.7 8861.6 8867.2 41093.8 41192.0 41359.4 41516.0 41592.2 3707.3 3720.6 3767.5 3794.1 3842.8 32753.0 32864.0 33184.0 33318.0 34382.3 4398.7 4440.1 4540.8 4548.3 4550.6 345742.0 346554.0 347108.0 347857.0 348650.0 30727.0 31378.4 57181.0 57348.0 57642.4 35602.8 36276.5 36288.1 36299.0 36347.0 13046.5 13116.1 13118.6 13124.5 13132.0 11743.2 11960.2 11969.9 11976.3 11987.8 8156.1 8183.4 8196.4 8258.7 8292.4 3175.9 3193.6 3195.7 3219.1 3262.8 1035.8 1066.6 1081.7 1102.9 1171.9 32777.5 32985.5 32997.0 33137.8 33453.7 1078.7 1107.1 1123.6 1128.9 1132.6 16990.7 17226.6 17339.1 17406.6 17436.6 580122.0 583110.0 583339.0 584847.0 585915.0 58325.1 58528.1 59104.4 59150.4 59247.1 1318.8 1322.2 1349.7 1366.7 1367.7 30833.0 32804.0 32917.7 32927.8 33063.5 51226.5 51264.5 51734.5 51769.5 51833.7 450589.0 452708.0 461555.0 464444.0 466104.0 27238.7 27287.6 27451.3 27536.6 27690.2 48389.3 48468.3 48678.0 48931.8 50124.5 39986.8 40059.6 41193.4 41437.8 41891.0 40465.8 40621.4 41829.2 42373.8 43168.8 40580.6 40869.4 41454.8 41888.6 41923.6 32672.0 38910.8 39213.6 40102.4 40328.4 29094.4 29206.3 29374.7 29421.1 29644.3 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | [#2] jquery.html Cycles:180 Average:29552.99 Median:382.80 stddev:84660.57 (22116.1%) stddev-sans-first:84869.72 21:36:28 INFO - PROCESS | 15393 | Values: 380.0 385.6 388.6 393.9 416.0 18060.3 19717.6 19732.1 19849.9 20090.7 18240.2 18387.7 18393.4 19189.3 19519.9 5628.9 5755.7 5764.6 5790.7 5878.1 5603.7 5661.6 5742.9 5747.3 5751.2 5611.2 5617.7 5664.5 5670.5 5725.8 5689.8 5714.1 5718.2 5726.5 5727.3 4747.5 4980.5 5002.5 5040.9 5046.8 13282.3 13283.6 13302.9 13474.2 13578.8 2268.8 2350.8 2382.1 2392.3 2423.8 9476.8 9483.8 9535.4 10019.3 10058.3 1781.4 1844.8 1849.2 1874.5 1886.8 73557.0 81851.6 83148.6 88403.6 89385.6 10355.9 10434.7 10708.0 10859.3 10952.4 14082.3 14115.4 14136.1 14142.1 14197.8 7469.2 7833.2 7968.8 7978.0 8165.6 7666.8 7779.4 8037.4 8065.9 8074.8 4406.3 4495.4 4518.6 4577.0 4606.3 1736.9 1767.4 1788.1 1794.5 1795.6 947.4 965.1 1039.4 1046.2 1053.4 19637.7 20093.5 20118.4 20181.7 20423.0 976.7 977.2 977.9 979.6 1002.6 10684.6 11056.0 11129.9 11136.8 11196.6 495926.0 503977.0 517086.0 521183.0 525055.0 92092.0 93699.0 95001.2 96157.0 96599.5 966.8 1028.2 1029.2 1036.4 1039.5 16774.7 17289.7 17867.6 18211.6 18400.6 44004.3 44685.0 44795.3 45892.0 46095.1 60859.0 61633.7 62792.7 62857.7 62908.0 7752.3 7897.8 8009.2 8046.3 8066.1 11253.4 12465.4 12825.2 12853.7 12906.4 11233.5 11290.0 11480.1 11508.7 11627.5 10652.3 11063.8 11160.6 11414.8 11486.9 11224.8 11521.8 11566.1 11634.9 11661.7 7791.7 7850.8 7967.8 8000.6 8132.4 10885.2 10987.2 11044.9 11045.2 11102.4 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | [#3] mootools.html Cycles:180 Average:5904.86 Median:4454.47 stddev:3407.26 (76.5%) stddev-sans-first:3399.92 21:36:28 INFO - PROCESS | 15393 | Values: 1389.2 1472.8 1502.7 1639.2 1650.6 7695.5 8529.7 8576.1 9137.0 9173.5 8710.9 9010.0 9030.7 9035.1 9048.1 2261.2 2285.9 2297.2 2299.7 2308.6 2273.1 2285.5 2334.0 2337.0 2344.0 2313.8 2322.4 2323.7 2323.9 2332.9 2301.8 2305.2 2312.0 2324.0 2329.3 2295.9 2298.1 2298.9 2305.3 2307.6 8973.6 9006.5 9058.6 9065.0 9080.0 5105.5 5215.4 5225.6 5239.2 5246.0 3151.4 3204.7 3300.2 3382.5 3398.3 1052.0 1060.3 1074.9 1075.0 1080.3 12515.2 12581.5 12585.6 12631.2 12675.6 4472.7 4638.1 4759.8 4764.0 4807.3 10362.3 10429.8 10436.6 10480.6 10508.4 5365.3 5370.0 5373.1 5374.7 5386.5 4310.7 4857.2 4945.4 4948.3 4969.6 3899.8 3934.4 4022.4 4025.6 4086.8 1211.7 1211.9 1217.1 1220.8 1225.2 978.5 984.4 996.4 996.9 999.3 6052.1 6058.0 6069.5 6128.1 6164.8 409.9 412.8 418.1 1051.3 1097.3 4179.0 4300.5 4383.5 4409.2 4436.3 11011.2 11391.0 11401.2 11417.4 11426.4 11178.9 11204.6 11263.9 11285.9 11304.4 7942.9 8132.1 8155.0 8435.1 8498.9 6328.1 6337.5 6516.7 6532.5 6587.8 10373.9 10420.3 10462.8 10492.2 10546.4 10000.8 10243.4 10351.4 10564.1 10698.9 6998.3 7461.3 7613.0 7667.0 7876.1 8832.2 8944.3 8949.0 8951.3 8963.0 7488.1 7569.1 7650.7 7761.8 7843.3 7731.7 7758.9 7851.6 7884.0 7893.3 7304.6 7373.7 7391.3 7412.7 7435.9 5026.4 5271.0 5324.6 5326.8 5460.6 5171.3 5399.9 5401.2 5452.7 5480.9 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | [#4] prototype.html Cycles:180 Average:4710.35 Median:5342.60 stddev:1400.51 (26.2%) stddev-sans-first:1364.75 21:36:28 INFO - PROCESS | 15393 | Values: 299.5 313.8 313.8 320.8 324.0 5435.3 5455.6 5619.6 5702.3 5720.5 5504.1 5516.7 5534.3 5536.9 5542.9 4358.7 4390.6 4400.9 4415.3 4429.8 4010.3 4174.9 4236.4 4414.5 4415.8 4185.1 4205.2 4217.5 4221.9 4231.0 4169.9 4202.9 4219.0 4231.1 4238.5 3574.5 3653.4 3662.6 3668.1 3697.9 5391.2 5394.5 5419.2 5451.5 5451.7 4847.9 4867.4 4867.6 4868.5 4889.2 5645.4 5798.7 5818.4 5860.4 5861.2 4010.7 4018.5 4020.0 4034.0 4046.6 5961.6 6134.0 6166.8 6176.3 6196.6 4074.2 4081.0 4107.6 4107.7 4110.6 4142.5 4156.2 4178.9 4182.4 4194.2 4853.9 4854.3 4870.4 4872.9 4882.2 5592.0 5666.8 5825.1 5871.9 5881.7 1393.7 1428.9 1429.0 1430.4 1430.4 873.9 913.4 916.8 932.6 935.6 4991.6 4996.0 5035.6 5055.7 5074.6 5319.8 5336.3 5342.5 5353.7 5355.5 4739.0 4995.8 5053.0 5091.7 5115.3 2839.8 2840.8 2847.8 2868.5 2880.1 5493.9 5536.0 5544.9 5548.6 5572.2 5222.8 5309.7 5381.3 5392.9 5495.0 5442.9 5443.4 5450.3 5475.3 5497.7 5191.2 5342.7 5344.3 5350.7 5353.5 5210.0 5253.6 5255.4 5307.8 5321.0 5552.4 5556.7 5560.2 5560.3 5569.4 3797.8 3870.4 3875.0 3894.9 3910.1 5771.8 5928.3 5984.5 5999.3 6027.5 5812.5 5901.7 5907.2 5927.7 5937.2 5907.6 5910.6 5925.8 5927.8 5938.2 5647.5 5798.3 5841.7 5867.2 5894.4 5951.2 5966.6 6019.3 6026.2 6031.7 5705.3 5748.7 5771.7 5788.2 5824.6 21:36:28 INFO - PROCESS | 15393 | 21:36:28 INFO - PROCESS | 15393 | [#5] yui.html Cycles:180 Average:21337.09 Median:4756.30 stddev:30354.53 (638.2%) stddev-sans-first:30400.06 21:36:28 INFO - PROCESS | 15393 | Values: 680.5 733.2 762.5 766.3 779.4 14644.0 15258.4 15282.3 17523.5 17672.2 16086.8 16837.2 16881.6 16938.5 17036.9 772.8 798.0 799.4 802.2 803.2 800.1 819.1 820.5 824.8 828.2 867.4 871.4 872.3 873.8 875.1 858.6 861.6 861.8 862.6 866.2 628.0 630.7 631.4 635.7 635.9 16038.4 16042.4 16044.3 16054.9 16064.0 15268.9 15417.5 15454.2 15686.5 15727.7 11837.1 12246.8 12276.0 12343.1 12754.4 3988.3 4002.8 4006.1 4018.4 4114.7 81071.0 82164.3 82167.0 82828.0 83707.2 11326.7 11817.0 11980.3 11984.6 12224.5 23464.4 23468.8 23624.9 23742.5 23753.0 8358.6 8672.9 8688.7 8817.5 8902.5 4636.9 4758.2 4785.6 4786.2 4917.6 3459.1 3517.9 3546.2 3563.7 3564.1 646.7 647.2 648.3 665.5 666.8 639.5 695.0 712.7 713.9 725.7 8804.6 8856.0 9240.4 9439.6 9616.7 574.2 648.4 663.4 742.8 751.4 4356.9 4501.0 4588.6 4613.3 4754.4 116397.0 116991.0 118569.4 123067.0 123840.4 61190.4 86379.6 89273.0 97148.0 97189.5 89140.6 89476.0 90591.0 91911.5 92093.0 9085.8 9171.8 9361.8 9576.3 9652.2 53893.5 54574.7 55316.4 55368.0 56284.7 71934.6 72723.0 78192.0 79510.0 80337.0 13176.3 13202.2 13238.5 13336.1 13357.5 14192.0 14582.3 14928.3 14932.6 14946.0 13431.7 13677.6 14380.3 14482.6 14654.2 13911.5 13912.4 14013.8 14382.5 15274.1 13930.2 14004.7 14183.4 14384.2 14675.9 11520.9 11890.7 11895.8 12213.5 12664.7 10742.2 11256.8 11928.5 12260.3 12490.3 21:36:28 INFO - PROCESS | 15393 | -------- Summary: end -------- 21:36:28 INFO - PROCESS | 15393 | 21:36:29 INFO - TEST-INFO | 15393: exit 0 21:36:29 INFO - TEST-OK | dromaeo_css | took 1111194ms 21:36:29 INFO - TEST-START | kraken 21:36:29 INFO - operating with platform_type : linux_ 21:36:29 INFO - Initialising browser for kraken test... 21:36:29 INFO - TEST-INFO | started process 15640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtmE91/profile http://localhost:54013/getInfo.html) 21:36:32 INFO - PROCESS | 15640 | JavaScript error: , line 0: uncaught exception: undefined 21:36:33 INFO - PROCESS | 15640 | __metrics Screen width/height:1600/1200 21:36:33 INFO - PROCESS | 15640 | colorDepth:24 21:36:33 INFO - PROCESS | 15640 | Browser inner width/height: 1024/697 21:36:33 INFO - PROCESS | 15640 | __metrics 21:36:34 ERROR - PROCESS | 15640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 21:36:35 INFO - TEST-INFO | 15640: exit 0 21:36:35 INFO - Browser initialized. 21:36:35 INFO - Running cycle 1/1 for kraken test... 21:36:35 INFO - TEST-INFO | started process 15761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtmE91/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:47 INFO - PROCESS | 15761 | RSS: Main: 165089280 21:36:47 INFO - PROCESS | 15761 | 21:36:50 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-beat-detection) 21:36:50 INFO - PROCESS | 15761 | RSS: Main: 170708992 21:36:50 INFO - PROCESS | 15761 | 21:36:53 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-dft) 21:36:54 INFO - PROCESS | 15761 | RSS: Main: 169369600 21:36:54 INFO - PROCESS | 15761 | 21:36:57 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-fft) 21:36:57 INFO - PROCESS | 15761 | RSS: Main: 165187584 21:36:57 INFO - PROCESS | 15761 | 21:36:59 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-oscillator) 21:37:00 INFO - PROCESS | 15761 | RSS: Main: 166572032 21:37:00 INFO - PROCESS | 15761 | 21:37:02 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:37:03 INFO - PROCESS | 15761 | RSS: Main: 166662144 21:37:03 INFO - PROCESS | 15761 | 21:37:06 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-darkroom) 21:37:07 INFO - PROCESS | 15761 | RSS: Main: 166674432 21:37:07 INFO - PROCESS | 15761 | 21:37:10 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-desaturate) 21:37:11 INFO - PROCESS | 15761 | RSS: Main: 163758080 21:37:11 INFO - PROCESS | 15761 | 21:37:14 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54013/tests/kraken/driver.html?testName=json-parse-financial) 21:37:14 INFO - PROCESS | 15761 | RSS: Main: 165801984 21:37:14 INFO - PROCESS | 15761 | 21:37:16 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:37:16 INFO - PROCESS | 15761 | RSS: Main: 165847040 21:37:16 INFO - PROCESS | 15761 | 21:37:18 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:37:19 INFO - PROCESS | 15761 | RSS: Main: 166051840 21:37:19 INFO - PROCESS | 15761 | 21:37:21 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:37:21 INFO - PROCESS | 15761 | RSS: Main: 166944768 21:37:21 INFO - PROCESS | 15761 | 21:37:24 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:37:25 INFO - PROCESS | 15761 | RSS: Main: 167153664 21:37:25 INFO - PROCESS | 15761 | 21:37:27 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:37:28 INFO - PROCESS | 15761 | RSS: Main: 167211008 21:37:28 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54013/tests/kraken/driver.html?testName=ai-astar) 21:37:30 INFO - PROCESS | 15761 | RSS: Main: 168017920 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | __start_tp_report 21:37:30 INFO - PROCESS | 15761 | _x_x_mozilla_page_load 21:37:30 INFO - PROCESS | 15761 | _x_x_mozilla_page_load_details 21:37:30 INFO - PROCESS | 15761 | |i|pagename|runs| 21:37:30 INFO - PROCESS | 15761 | |0;ai-astar;102;111;106;110;112;111;112;110;110;111 21:37:30 INFO - PROCESS | 15761 | |1;audio-beat-detection;152;118;147;179;126;148;148;127;182;120 21:37:30 INFO - PROCESS | 15761 | |2;audio-dft;163;163;160;161;163;164;173;160;161;160 21:37:30 INFO - PROCESS | 15761 | |3;audio-fft;75;75;74;172;77;75;74;75;184;75 21:37:30 INFO - PROCESS | 15761 | |4;audio-oscillator;83;85;144;83;83;83;152;85;84;147 21:37:30 INFO - PROCESS | 15761 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;118;118 21:37:30 INFO - PROCESS | 15761 | |6;imaging-darkroom;148;147;147;146;148;147;147;148;148;147 21:37:30 INFO - PROCESS | 15761 | |7;imaging-desaturate;97;95;95;96;95;96;95;95;96;96 21:37:30 INFO - PROCESS | 15761 | |8;json-parse-financial;52;53;54;52;54;58;53;53;53;52 21:37:30 INFO - PROCESS | 15761 | |9;json-stringify-tinderbox;64;63;62;62;63;63;62;63;63;64 21:37:30 INFO - PROCESS | 15761 | |10;stanford-crypto-aes;78;76;76;75;76;77;78;78;80;78 21:37:30 INFO - PROCESS | 15761 | |11;stanford-crypto-ccm;130;124;123;128;124;128;121;122;174;139 21:37:30 INFO - PROCESS | 15761 | |12;stanford-crypto-pbkdf2;158;162;160;159;160;159;156;163;160;156 21:37:30 INFO - PROCESS | 15761 | |13;stanford-crypto-sha256-iterative;63;66;62;73;63;71;66;63;63;66 21:37:30 INFO - PROCESS | 15761 | __end_tp_report 21:37:30 INFO - PROCESS | 15761 | __start_cc_report 21:37:30 INFO - PROCESS | 15761 | _x_x_mozilla_cycle_collect,880 21:37:30 INFO - PROCESS | 15761 | __end_cc_report 21:37:30 INFO - PROCESS | 15761 | __startTimestamp1469680650479__endTimestamp 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | ------- Summary: start ------- 21:37:30 INFO - PROCESS | 15761 | Number of tests: 14 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:1.80 21:37:30 INFO - PROCESS | 15761 | Values: 102.0 111.0 106.0 110.0 112.0 111.0 112.0 110.0 110.0 111.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:148.00 stddev:22.69 (15.3%) stddev-sans-first:23.91 21:37:30 INFO - PROCESS | 15761 | Values: 152.0 118.0 147.0 179.0 126.0 148.0 148.0 127.0 182.0 120.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:3.88 (2.4%) stddev-sans-first:4.12 21:37:30 INFO - PROCESS | 15761 | Values: 163.0 163.0 160.0 161.0 163.0 164.0 173.0 160.0 161.0 160.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.00 stddev:43.53 (58.0%) stddev-sans-first:45.53 21:37:30 INFO - PROCESS | 15761 | Values: 75.0 75.0 74.0 172.0 77.0 75.0 74.0 75.0 184.0 75.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:83.00 stddev:30.96 (37.3%) stddev-sans-first:31.99 21:37:30 INFO - PROCESS | 15761 | Values: 83.0 85.0 144.0 83.0 83.0 83.0 152.0 85.0 84.0 147.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:37:30 INFO - PROCESS | 15761 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 21:37:30 INFO - PROCESS | 15761 | Values: 148.0 147.0 147.0 146.0 148.0 147.0 147.0 148.0 148.0 147.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 21:37:30 INFO - PROCESS | 15761 | Values: 97.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.78 (3.4%) stddev-sans-first:1.81 21:37:30 INFO - PROCESS | 15761 | Values: 52.0 53.0 54.0 52.0 54.0 58.0 53.0 53.0 53.0 52.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 21:37:30 INFO - PROCESS | 15761 | Values: 64.0 63.0 62.0 62.0 63.0 63.0 62.0 63.0 63.0 64.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:78.00 stddev:1.48 (1.9%) stddev-sans-first:1.54 21:37:30 INFO - PROCESS | 15761 | Values: 78.0 76.0 76.0 75.0 76.0 77.0 78.0 78.0 80.0 78.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:128.00 stddev:15.90 (12.4%) stddev-sans-first:16.85 21:37:30 INFO - PROCESS | 15761 | Values: 130.0 124.0 123.0 128.0 124.0 128.0 121.0 122.0 174.0 139.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:160.00 stddev:2.26 (1.4%) stddev-sans-first:2.35 21:37:30 INFO - PROCESS | 15761 | Values: 158.0 162.0 160.0 159.0 160.0 159.0 156.0 163.0 160.0 156.0 21:37:30 INFO - PROCESS | 15761 | 21:37:30 INFO - PROCESS | 15761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:3.72 (5.6%) stddev-sans-first:3.82 21:37:30 INFO - PROCESS | 15761 | Values: 63.0 66.0 62.0 73.0 63.0 71.0 66.0 63.0 63.0 66.0 21:37:30 INFO - PROCESS | 15761 | -------- Summary: end -------- 21:37:30 INFO - PROCESS | 15761 | 21:37:31 INFO - TEST-INFO | 15761: exit 0 21:37:31 INFO - TEST-OK | kraken | took 61987ms 21:37:31 INFO - SUITE-END | took 1173s 21:37:31 INFO - Completed test suite (00:19:33) 21:37:31 INFO - javascript benchmark 21:37:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7222.104934726052, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.730912872406, 3174.918540888499, 3202.983985080074, 3203.19920019995, 3209.9518507222383, 5328.200769884519, 5534.640248383852, 5584.4973952344335, 5610.943890561093, 5624.465675760806, 5460.235567020621, 5461.0716178249695, 5506.614536982413, 5506.80726174584, 5580.637258578189, 4982.651214414984, 5013.398392192924, 5065.822696205633, 5067.239914012891, 5119.897602047957, 5080.822171224008, 5110.8466745997675, 5182.948170518284, 5183.196604526304, 5210.7655155517905, 4953.504649535035, 5009.348784657989, 5029.245613158019, 5031.874203144932, 5108.0, 5034.0686972910125, 5039.47085556015, 5047.848564543033, 5048.949510504922, 5107.0, 4970.229614409773, 4989.376327959005, 4994.800207991676, 5021.347224860781, 5037.823676171353, 5456.454354564551, 5467.9453205467835, 5469.206964990094, 5469.753861076261, 5562.054450743383, 5910.261217347832, 5911.467967882868, 5929.229200203989, 5937.67342796146, 5937.703114844284, 5788.855278618026, 5964.463198312173, 5972.4027597240365, 5975.581709280352, 5989.520838332923, 5466.207399926989, 5499.972500137474, 5503.532199762985, 5523.061079616475, 5572.60991730579, 6081.6351018939, 6101.908471372933, 6104.481119104837, 6104.816855494342, 6110.175126357884, 5627.803026894121, 5821.301443826683, 5821.592488525847, 5826.796062137805, 5839.503642190376, 5750.0512415450985, 5819.709014549256, 5856.648601083949, 5878.2358293421585, 5958.165856780054, 5639.154126881001, 5819.447152520504, 5841.065429531254, 5867.14926335679, 5881.911771323434, 5825.825225243249, 5876.265466816648, 5903.291605007426, 5911.083782013795, 5920.822375328747, 4395.362672412482, 4480.574345437179, 4497.302918047708, 4504.144212599595, 4544.227481328182, 4039.8788036358956, 4046.5751096135073, 4051.0, 4081.9795901020307, 4090.754554726726, 5717.514011309086, 5739.139129130664, 5745.3105627324985, 5777.45114214149, 5798.768049277982, 5754.165645981309, 5797.942020579824, 5926.111083337534, 6040.818775436744, 6067.362926892701, 5669.461401166883, 5685.857853553694, 5740.684262365527, 5763.0, 5797.391273916178, 5108.6168537359845, 5115.2071428928575, 5124.615653825978, 5169.224616307584, 5212.817551385683, 5924.7926322578505, 6130.581587307925, 6160.274585882739, 6206.348333425016, 6213.751449942042, 6008.969955150284, 6076.66578338178, 6080.361562035922, 6098.371716891094, 6134.079888016833, 6197.845053873689, 6204.224471941007, 6248.375162483897, 6259.374062593704, 6271.655058971618, 5656.095024796013, 5771.797987070432, 5850.185925351475, 5886.05823068307, 5959.374265702212, 5895.174675545341, 5943.316518600416, 5953.434423729739, 5992.13114098462, 6002.039673652194, 5784.421557844182, 5785.884282314414, 5790.94209057904, 5798.188253644409, 5804.82585522435, 5609.0, 5638.633488823213, 5735.7705691773535, 5751.424857514216, 5778.942210578009, 5683.06229472149, 5692.772289108555, 5702.743376547983, 5743.885122297447, 5751.654900705971, 5714.085746280575, 5772.336181339199, 5784.595078344475, 5816.069428891357, 5817.156512305776, 5557.472040156179, 5614.494695477427, 5670.121131224667, 5678.943210567842, 5682.943170568242], "value": 5465.493562279688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.3360931606944, 580.6516090345792, 593.531110422766, 604.6402390577605, 643.8551325951659, 39504.60495395049, 43561.128777424434, 43668.816559172075, 43686.78156609216, 43811.12377752443, 43183.0, 43638.34542481857, 43772.56227437725, 43853.780731096296, 43947.56052439482, 8781.824363512726, 8888.777780555472, 8915.420497667663, 8915.509646969414, 8923.063078376741, 8732.694355697551, 8873.911260887406, 8883.24492418142, 8883.600237989305, 8943.552822358855, 8907.376483646114, 8935.195832375084, 8948.970868350125, 8964.327675424336, 8978.41640293382, 8867.645294188225, 8922.776930576723, 8930.19628233462, 8950.060243674418, 8971.327150463741, 8804.251638610725, 8815.074417186168, 8829.735107946708, 8861.601227944759, 8867.157620026088, 41093.79453102745, 41192.0, 41359.379609305586, 41516.0, 41592.1681566367, 3707.258548290326, 3720.553533575961, 3767.547894252707, 3794.1273507093247, 3842.846286148551, 32753.0, 32864.0, 33184.0, 33318.0, 34382.312353753034, 4398.714083584557, 4440.067585806984, 4540.818367265306, 4548.340490628841, 4550.590446859798, 345742.0, 346554.0, 347108.0, 347857.0, 348650.0, 30727.0, 31378.372432551678, 57181.0, 57347.99282025109, 57642.42357576371, 35602.8219858899, 36276.455853162224, 36288.09279767974, 36299.0, 36347.0, 13046.54337098197, 13116.08187426871, 13118.606441806762, 13124.475020999243, 13132.0, 11743.236689615147, 11960.222585532087, 11969.88030119705, 11976.28142311464, 11987.820182697093, 8156.0620528639965, 8183.427160098736, 8196.385475948993, 8258.669653213805, 8292.419530632798, 3175.8729650813707, 3193.61676598805, 3195.744340452758, 3219.0825614700166, 3262.7716059876057, 1035.7627524547092, 1066.6000249906285, 1081.7187531241777, 1102.9117670586334, 1171.8652354979115, 32777.50833737496, 32985.505217421756, 32997.0, 33137.83431082877, 33453.66546334554, 1078.7195329214303, 1107.0866535108569, 1123.6179698902413, 1128.8927551882557, 1132.64887884756, 16990.660186796194, 17226.569335766708, 17339.133043348036, 17406.56483587895, 17436.5640858977, 580122.0, 583110.0, 583339.0, 584847.0, 585915.0, 58325.12512312319, 58528.12207816886, 59104.408955909894, 59150.40849591535, 59247.111293330636, 1318.762622727899, 1322.2066759943957, 1349.7098123903409, 1366.658335416146, 1367.7401293754353, 30833.0, 32804.0, 32917.67082329242, 32927.83536082304, 33063.50404743883, 51226.48773512217, 51264.487355127465, 51734.48265517447, 51769.482305177975, 51833.7408312956, 450589.0, 452708.0, 461555.0, 464444.0, 466104.0, 27238.72761272441, 27287.590686139327, 27451.31371715723, 27536.58695119615, 27690.169294921183, 48389.27416088691, 48468.272975904685, 48678.0, 48931.75534122306, 50124.498755011984, 39986.80006599949, 40059.59940400675, 41193.438073053236, 41437.79281103575, 41891.0, 40465.78602641926, 40621.39067914043, 41829.1634167321, 42373.78813106038, 43168.78415607902, 40580.59419405768, 40869.38695919623, 41454.79272603738, 41888.58111418847, 41923.58076419197, 32672.0, 38910.805445973725, 39213.607863920995, 40102.398464023645, 40328.39507407333, 29094.41811163807, 29206.269843253238, 29374.706252937198, 29421.11736647904, 29644.258893527833], "value": 18915.25195652525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.0, 385.6028389885114, 388.6075064185174, 393.9350007248803, 415.95840415958406, 18060.277588896446, 19717.605647887052, 19732.112054957543, 19849.90075049623, 20090.698639520382, 18240.17919193636, 18387.72418413725, 18393.356232531863, 19189.32837350693, 19519.902400488012, 5628.943710562883, 5755.65466072037, 5764.596478246524, 5790.68151251681, 5878.118282257674, 5603.7478313475995, 5661.60368774186, 5742.913856292159, 5747.310322761275, 5751.194832723422, 5611.158326251075, 5617.719114044302, 5664.518515926151, 5670.546356291507, 5725.828225153231, 5689.800856970028, 5714.142878568227, 5718.17086522454, 5726.455986681259, 5727.284089488814, 4747.501512341189, 4980.501949805027, 5002.52476014778, 5040.873978150539, 5046.84859454217, 13282.269475178862, 13283.601491955256, 13302.933485332609, 13474.179808680185, 13578.796318055238, 2268.8071513921172, 2350.8001819845335, 2382.0590866607595, 2392.294273189413, 2423.75762423758, 9476.763080922963, 9483.762905927339, 9535.38020028696, 10019.348742331726, 10058.295919285652, 1781.3943259291773, 1844.7509586205824, 1849.2418108575419, 1874.521996890784, 1886.8490520758444, 73557.0, 81851.59074204651, 83148.58425707833, 88403.55798221032, 89385.55307223488, 10355.896441035493, 10434.68695939123, 10708.0, 10859.294145880493, 10952.397618131079, 14082.295885205698, 14115.364808583638, 14136.081154725116, 14142.080764750259, 14197.78703319451, 7469.215732348134, 7833.1775163608145, 7968.84062318762, 7977.960110199412, 8165.63254653542, 7666.846663066707, 7779.416543759241, 8037.437379383504, 8065.919340806634, 8074.798130046678, 4406.272964960745, 4495.415595972568, 4518.615917647036, 4577.0, 4606.30905364198, 1736.9392071277698, 1767.354915455875, 1788.1059470264868, 1794.5334213104686, 1795.64087182564, 947.3557980573277, 965.0976337124671, 1039.3607931122306, 1046.2414749306693, 1053.4364115198484, 19637.705434418494, 20093.49766255826, 20118.39644810658, 20181.697274540893, 20423.0, 976.72651657536, 977.2279898879806, 977.8826540815147, 979.647326962293, 1002.6390499420203, 10684.57261709523, 11055.957124917211, 11129.888701112885, 11136.832947505794, 11196.552137914556, 495926.0, 503977.0, 517086.0, 521183.0, 525055.0, 92092.0, 93699.0, 95001.24371921767, 96157.0, 96599.51700241453, 966.840471322238, 1028.2493779540828, 1029.2177944762034, 1036.3574583758118, 1039.5322105052755, 16774.748378774573, 17289.654206916042, 17867.642647147244, 18211.635767284846, 18400.63198735991, 44004.33993490036, 44685.0, 44795.32807007832, 45892.0, 46095.07809843851, 60859.0, 61633.69183154056, 62792.686036569525, 62857.68571157115, 62908.0, 7752.26353496417, 7897.763067107996, 8009.159038300894, 8046.316063134465, 8066.072401673882, 11253.381064041228, 12465.439055242718, 12825.23048617086, 12853.742925141632, 12906.354682266037, 11233.49449274801, 11290.0, 11480.081593472669, 11508.654740357802, 11627.476763545492, 10652.307600005975, 11063.83404248953, 11160.609378672032, 11414.828777568177, 11486.885131148581, 11224.831627525757, 11521.82717259225, 11566.074714023027, 11634.94182529082, 11661.6501504955, 7791.675415179547, 7850.803729906798, 7967.760967170994, 8000.559829252134, 8132.430729848854, 10885.183611229348, 10987.230893837355, 11044.944775276394, 11045.171612128961, 11102.389368584805], "value": 8954.836998777268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.1942673249516, 1472.8158980127484, 1502.7219964306605, 1639.1967935711505, 1650.64511130107, 7695.499792513483, 8529.658813647455, 8576.099509551485, 9137.0, 9173.541322933852, 8710.869336959935, 9009.954950225256, 9030.72907812765, 9035.096490350961, 9048.095190480964, 2261.23118139832, 2285.931422057341, 2297.207463425124, 2299.701038864945, 2308.572914010905, 2273.090763694527, 2285.531466049456, 2333.9649905251435, 2336.9649455258186, 2343.95312093758, 2313.8033267172227, 2322.442613772691, 2323.6514522821626, 2323.8954247058837, 2332.918347857817, 2301.8158547316257, 2305.1931823861596, 2312.0, 2324.0006797077335, 2329.2895666821782, 2295.9426014349606, 2298.0577963035244, 2298.9195378161853, 2305.250793492122, 2307.596170670143, 8973.641054357819, 9006.504642244674, 9058.592363343665, 9065.0, 9080.046595107484, 5105.463926287724, 5215.400228973641, 5225.634205605609, 5239.240310155006, 5245.973770131163, 3151.353972435645, 3204.7115759581516, 3300.240944582735, 3382.458806590934, 3398.2863598644312, 1051.978960420795, 1060.3107979813105, 1074.854894589236, 1074.9570017199303, 1080.2924084724518, 12515.249085054835, 12581.496740130475, 12585.622431327074, 12631.178973366794, 12675.619731408073, 4472.664550158751, 4638.072385522842, 4759.809607615656, 4763.976180119077, 4807.302941073594, 10362.326448780805, 10429.791404171874, 10436.63471778484, 10480.63317783874, 10508.422036787897, 5365.302510673588, 5370.0, 5373.059714549938, 5374.650647707965, 5386.542143917733, 4310.676699247506, 4857.1742803723455, 4945.4312754033745, 4948.331975183376, 4969.577585905238, 3899.8245078971513, 3934.409838524244, 4022.3966405039478, 4025.6376926076796, 4086.7956602169775, 1211.660734994203, 1211.927284362941, 1217.117589747426, 1220.798568236249, 1225.185251807556, 978.496074521622, 984.4437892590663, 996.3623281100101, 996.8903420623726, 999.2555546118189, 6052.092186172022, 6058.0, 6069.544784141119, 6128.080787881764, 6164.815055548341, 409.86269599683845, 412.8142335948835, 418.0864810389309, 1051.3324039234988, 1097.2757979733337, 4179.0, 4300.462442194726, 4383.452068491439, 4409.206342858252, 4436.26801577736, 11011.174161937726, 11391.0, 11401.201915865975, 11417.429128543707, 11426.371549564687, 11178.944105279421, 11204.607838725606, 11263.94368028171, 11285.943570282096, 11304.434778261219, 7942.880856787153, 8132.105468398471, 8155.0, 8435.11431299717, 8498.915010849812, 6328.145700330397, 6337.524685648687, 6516.706748196438, 6532.545558796324, 6587.835304117244, 10373.896261037293, 10420.270581059252, 10462.790744185226, 10492.160627149657, 10546.419946902994, 10000.849987250052, 10243.38539687621, 10351.43067131315, 10564.102051325723, 10698.89301106979, 6998.2651821558, 7461.328480436787, 7613.010308659839, 7667.0, 7876.09424916142, 8832.160944710242, 8944.329175312008, 8948.955255223682, 8951.328650351119, 8963.0, 7488.138864030706, 7569.129550101588, 7650.65572049248, 7761.7671469855995, 7843.294103530709, 7731.729389471341, 7758.92241077582, 7851.646675899484, 7883.960580197062, 7893.329067029367, 7304.598247096248, 7373.705051797868, 7391.334779869838, 7412.740554080797, 7435.851282974202, 5026.421961474477, 5271.0, 5324.6006549508165, 5326.786928522815, 5460.5904557159165, 5171.276021356938, 5399.892002159856, 5401.216823560483, 5452.672839629635, 5480.885672851265], "value": 4654.0665019653425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.52674773857296, 313.7756504099568, 313.81014486235813, 320.7882797353747, 324.0279162512463, 5435.347758269003, 5455.563554915607, 5619.550435965123, 5702.344230413509, 5720.542356611466, 5504.091824848895, 5516.696581688016, 5534.284371844721, 5536.861578460531, 5542.889142217154, 4358.716683415583, 4390.626796722282, 4400.933985990205, 4415.315626077947, 4429.822807087713, 4010.3182458981896, 4174.874753757377, 4236.364545318212, 4414.492333381654, 4415.763586195871, 4185.121124563845, 4205.222033923718, 4217.536071032184, 4221.915561688765, 4231.026863821323, 4169.937450938239, 4202.936955945664, 4218.957810421887, 4231.132617813356, 4238.512571054337, 3574.4817001534634, 3653.429025519026, 3662.5971143174497, 3668.137987572918, 3697.85208591656, 5391.218273350381, 5394.460553944614, 5419.187121931703, 5451.509364157245, 5451.672899625995, 4847.897345698756, 4867.440244371872, 4867.586255168279, 4868.464468908417, 4889.193283108283, 5645.435456454363, 5798.666306749471, 5818.359980402152, 5860.355360910296, 5861.150133230701, 4010.6991975601654, 4018.537868145142, 4020.0, 4034.0, 4046.5953404659595, 5961.612495187799, 6134.0, 6166.784162554289, 6176.258848938156, 6196.566240363131, 4074.2258970795456, 4080.959190408117, 4107.630313271819, 4107.732997355162, 4110.588941105865, 4142.46148000758, 4156.210320039183, 4178.913482494512, 4182.351735481006, 4194.2450358935075, 4853.927191092136, 4854.320395144682, 4870.391201099863, 4872.902541949212, 4882.194437917704, 5591.9720401398545, 5666.801661941895, 5825.058345535477, 5871.922356716062, 5881.705914704333, 1393.6794537256487, 1428.8928330375263, 1428.9854203515413, 1430.370636919752, 1430.4206796247536, 873.8907636545432, 913.4108500017585, 916.7662246127195, 932.6362718539775, 935.6070450410843, 4991.6006719463085, 4995.95165981953, 5035.571976382049, 5055.747212639353, 5074.619403544675, 5319.840404787863, 5336.252924590561, 5342.492463215988, 5353.732313384316, 5355.518003379714, 4739.0, 4995.775190116454, 5053.0, 5091.66904151229, 5115.335006449138, 2839.829610223393, 2840.8210592603837, 2847.843368614746, 2868.498012847743, 2880.0927707771984, 5493.862653433616, 5536.031194540939, 5544.889102217933, 5548.55611551075, 5572.210896590276, 5222.764975576109, 5309.65487243328, 5381.327334083239, 5392.865178370572, 5495.0, 5442.924747517719, 5443.374011988592, 5450.291462109901, 5475.260839786658, 5497.725113744297, 5191.221316802359, 5342.706151161723, 5344.331958505187, 5350.732463376893, 5353.527779860569, 5210.030282738802, 5253.605979551626, 5255.369355677343, 5307.814226502054, 5321.0, 5552.444755524415, 5556.72216389187, 5560.221568980427, 5560.27716396882, 5569.412717375529, 3797.7721336719887, 3870.41943708446, 3875.0, 3894.9415758764208, 3910.081130934171, 5771.797987070432, 5928.288605367384, 5984.521238300838, 5999.250093738283, 6027.547933904887, 5812.505936995402, 5901.675407852609, 5907.232059832194, 5927.673977931255, 5937.19847820556, 5907.616004959664, 5910.586258962004, 5925.792597259076, 5927.762889484372, 5938.168656388023, 5647.5481961442165, 5798.275215598051, 5841.678707670949, 5867.20792692981, 5894.440028197314, 5951.166836642787, 5966.552508561962, 6019.284503916363, 6026.246719160105, 6031.69841507914, 5705.258316418839, 5748.6838223898085, 5771.730219351736, 5788.189653448605, 5824.592278540462], "value": 4254.317668104931, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.5100327764009, 733.2264460993653, 762.4548447859781, 766.3486036868666, 779.431015358788, 14644.0, 15258.389664413424, 15282.312295946695, 17523.474295771117, 17672.20475078621, 16086.83913160868, 16837.242324095416, 16881.577960550992, 16938.491845244633, 17036.914815425906, 772.8029352515101, 797.972070977516, 799.436397339874, 802.2098233240254, 803.1807556292578, 800.0719165767711, 819.0621738109861, 820.5117954816874, 824.8432797768405, 828.1511450762986, 867.440500876934, 871.4161511787086, 872.2978002707817, 873.838339907116, 875.0636818604096, 858.6050416808307, 861.5907443964129, 861.7716305179133, 862.6463150108489, 866.2463656618751, 627.9575903999385, 630.6562923206864, 631.4096319940824, 635.71710588788, 635.895077312243, 16038.35846566136, 16042.43851465193, 16044.278007489691, 16054.919725401298, 16064.036157830567, 15268.921368400628, 15417.460388886335, 15454.1500217488, 15686.450974215848, 15727.68544629101, 11837.053035757119, 12246.755064898742, 12276.0, 12343.074269429828, 12754.36228188587, 3988.3219852624834, 4002.7998600070173, 4006.1186538961383, 4018.3771515415156, 4114.691398145121, 81071.0, 82164.30260638286, 82167.0, 82828.0, 83707.16292837115, 11326.660200194008, 11817.0, 11980.28118312904, 11984.64046078619, 12224.511019559119, 23464.413389665395, 23468.765312347, 23624.881875590854, 23742.525149497258, 23753.049878005033, 8358.582070896431, 8672.913270867211, 8688.6524539019, 8817.515036672916, 8902.465852048897, 4636.930446043312, 4758.1673207188605, 4785.569298763128, 4786.16242157621, 4917.58200552957, 3459.08334291413, 3517.9296414071573, 3546.1666508370513, 3563.6614521620922, 3564.144605294711, 646.7380710812129, 647.1716203259834, 648.2804087462912, 665.544102289933, 666.7932940788371, 639.4852144024012, 694.9722011119499, 712.7113519024804, 713.875071862422, 725.7278520554792, 8804.603792829337, 8856.0, 9240.445573265626, 9439.575219115157, 9616.692902437653, 574.2047264538644, 648.4034688086971, 663.4062514049898, 742.7697413801739, 751.4326683354142, 4356.912861742748, 4501.0, 4588.649079153681, 4613.331066995267, 4754.429468463806, 116397.0, 116991.0, 118569.40715296369, 123067.0, 123840.38079809723, 61190.38809611936, 86379.56810215909, 89273.0, 97148.0, 97189.51405242928, 89140.5542972281, 89476.0, 90591.0, 91911.54044229737, 92093.0, 9085.773420588135, 9171.816563668823, 9361.765955851159, 9576.281778866753, 9652.179564737076, 53893.461065388845, 54574.727126364116, 55316.44683553113, 55368.0, 56284.718576406856, 71934.64032679803, 72723.0, 78192.0, 79510.0, 80337.0, 13176.275304858325, 13202.207867527979, 13238.470461181445, 13336.066475347021, 13357.465701371837, 14192.0, 14582.343794529485, 14928.328225229674, 14932.62668433298, 14946.0, 13431.731365372443, 13677.589672309847, 14380.28098595087, 14482.637934051732, 14654.194019328614, 13911.455318469285, 13912.443502260201, 14013.789793152908, 14382.496612618508, 15274.083554986737, 13930.164190148624, 14004.719905601627, 14183.361748721127, 14384.208868511914, 14675.92662036683, 11520.942395288304, 11890.702732431759, 11895.762084758084, 12213.450394732436, 12664.6833829155, 10742.24804263694, 11256.7748645025, 11928.463219154984, 12260.26438413698, 12490.250584964931], "value": 7740.686084932154, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 110.0, 112.0, 111.0, 112.0, 110.0, 110.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 147.0, 179.0, 126.0, 148.0, 148.0, 127.0, 182.0, 120.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 160.0, 161.0, 163.0, 164.0, 173.0, 160.0, 161.0, 160.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 172.0, 77.0, 75.0, 74.0, 75.0, 184.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 144.0, 83.0, 83.0, 83.0, 152.0, 85.0, 84.0, 147.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 52.0, 54.0, 58.0, 53.0, 53.0, 53.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 64.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 75.0, 76.0, 77.0, 78.0, 78.0, 80.0, 78.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 123.0, 128.0, 124.0, 128.0, 121.0, 122.0, 174.0, 139.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 160.0, 159.0, 160.0, 159.0, 156.0, 163.0, 160.0, 156.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 62.0, 73.0, 63.0, 71.0, 66.0, 63.0, 63.0, 66.0], "value": 65.6, "unit": "score"}]}]} 21:37:31 INFO - Return code: 0 21:37:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:37:31 ERROR - # TBPL SUCCESS # 21:37:31 INFO - Running post-action listener: _resource_record_post_action 21:37:31 INFO - [mozharness: 2016-07-28 04:37:31.776357Z] Finished run-tests step (success) 21:37:31 INFO - Running post-run listener: _resource_record_post_run 21:37:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554196992; Read time: 92; Write time: 719608 21:37:31 INFO - TinderboxPrint: CPU usage
13.4% 21:37:31 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 92 21:37:31 INFO - TinderboxPrint: I/O write bytes / time
554,196,992 / 719,608 21:37:31 INFO - TinderboxPrint: CPU idle
8,228.7 (86.6%) 21:37:31 INFO - TinderboxPrint: CPU user
1,214.3 (12.8%) 21:37:31 INFO - TinderboxPrint: Swap in / out
0 / 0 21:37:31 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 257515520; Read time: 0; Write time: 410068 21:37:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296681472; Read time: 76; Write time: 309540 21:37:32 INFO - Running post-run listener: _upload_blobber_files 21:37:32 INFO - Blob upload gear active. 21:37:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:37:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:37:32 INFO - (blobuploader) - INFO - Open directory for files ... 21:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:33 INFO - (blobuploader) - INFO - Done attempting. 21:37:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:37:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:37:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:37 INFO - (blobuploader) - INFO - Done attempting. 21:37:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:37:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:37:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:37:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:37:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:37:37 INFO - (blobuploader) - INFO - Done attempting. 21:37:37 INFO - (blobuploader) - INFO - Iteration through files over. 21:37:37 INFO - Return code: 0 21:37:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:37:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:37:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d31c9479ea4f7e4c6956e26386f7d304b1fa28c1a35497f2f653d0a036727c2cce0b41d9796f6f687311a9fc01019499aa31bae41591f6358ed1d0087ddf0b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4cb83aecc40efd6ecc59ae84693630c8df9635dc98a9bcb4c4760acf388827d3eb2b02eb47afc6d1664f48f2b4cafc14f2e47ac840aa8ed82ba9549265c4eaf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f7f06516b76d476094d8dfe9ab746a226864cff9b7d9197b3bc00ead4d7f868d7f60c5edc680f8cf4aee808093b42fd15d90d8edd4bbee1095da135fdcb5e4ad"} 21:37:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:37:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:37:37 INFO - Contents: 21:37:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d31c9479ea4f7e4c6956e26386f7d304b1fa28c1a35497f2f653d0a036727c2cce0b41d9796f6f687311a9fc01019499aa31bae41591f6358ed1d0087ddf0b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4cb83aecc40efd6ecc59ae84693630c8df9635dc98a9bcb4c4760acf388827d3eb2b02eb47afc6d1664f48f2b4cafc14f2e47ac840aa8ed82ba9549265c4eaf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f7f06516b76d476094d8dfe9ab746a226864cff9b7d9197b3bc00ead4d7f868d7f60c5edc680f8cf4aee808093b42fd15d90d8edd4bbee1095da135fdcb5e4ad"} 21:37:37 INFO - Running post-run listener: copy_logs_to_upload_dir 21:37:37 INFO - Copying logs to upload dir... 21:37:37 INFO - mkdir: /builds/slave/test/build/upload/logs 21:37:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.112669 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-27 21:37:37.878940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 21:37:37.882798) ========= 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=db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d31c9479ea4f7e4c6956e26386f7d304b1fa28c1a35497f2f653d0a036727c2cce0b41d9796f6f687311a9fc01019499aa31bae41591f6358ed1d0087ddf0b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4cb83aecc40efd6ecc59ae84693630c8df9635dc98a9bcb4c4760acf388827d3eb2b02eb47afc6d1664f48f2b4cafc14f2e47ac840aa8ed82ba9549265c4eaf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f7f06516b76d476094d8dfe9ab746a226864cff9b7d9197b3bc00ead4d7f868d7f60c5edc680f8cf4aee808093b42fd15d90d8edd4bbee1095da135fdcb5e4ad"} build_url:https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/XvGFr_v6Qbm31GaoLs5scQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d31c9479ea4f7e4c6956e26386f7d304b1fa28c1a35497f2f653d0a036727c2cce0b41d9796f6f687311a9fc01019499aa31bae41591f6358ed1d0087ddf0b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4cb83aecc40efd6ecc59ae84693630c8df9635dc98a9bcb4c4760acf388827d3eb2b02eb47afc6d1664f48f2b4cafc14f2e47ac840aa8ed82ba9549265c4eaf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f7f06516b76d476094d8dfe9ab746a226864cff9b7d9197b3bc00ead4d7f868d7f60c5edc680f8cf4aee808093b42fd15d90d8edd4bbee1095da135fdcb5e4ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 21:37:37.907954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:37:37.908286) ========= 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=db0483c52d987ecb441a263b000001ad-1469678336.85165-1570802264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 21:37:37.992561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 21:37:37.992916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 21:37:37.993262) ========= ========= Total master_lag: 0.18 =========