builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1471554741.1 results: success (0) buildid: 20160818131455 builduid: af465e1b6a53428bac3efa3851d63088 revision: 9276295f33de11de11d3215afeb480c59405a6c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.105221) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.105681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.105964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.127883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.128256) ========= 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=6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 14:12:21-- 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% 221M=0s 2016-08-18 14:12:21 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.275823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.276149) ========= 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=6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024697 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.329595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.333033) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9276295f33de11de11d3215afeb480c59405a6c9 --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 9276295f33de11de11d3215afeb480c59405a6c9 --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=6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 14:12:21,530 truncating revision to first 12 chars 2016-08-18 14:12:21,530 Setting DEBUG logging. 2016-08-18 14:12:21,530 attempt 1/10 2016-08-18 14:12:21,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9276295f33de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 14:12:21,816 unpacking tar archive at: autoland-9276295f33de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615092 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.962387) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.965826) ========= script_repo_revision: 9276295f33de11de11d3215afeb480c59405a6c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.966334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.966613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 14:12:21.978296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 43 secs) (at 2016-08-18 14:12:21.978705) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:12:22 INFO - MultiFileLogger online at 20160818 14:12:22 in /builds/slave/test 14:12:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 14:12:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:12:22 INFO - {'append_to_log': False, 14:12:22 INFO - 'base_work_dir': '/builds/slave/test', 14:12:22 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:12:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:12:22 INFO - 'branch': 'Autoland-Non-PGO', 14:12:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:22 INFO - 'config_files': ('talos/linux_config.py',), 14:12:22 INFO - 'default_actions': ('clobber', 14:12:22 INFO - 'read-buildbot-config', 14:12:22 INFO - 'download-and-extract', 14:12:22 INFO - 'populate-webroot', 14:12:22 INFO - 'create-virtualenv', 14:12:22 INFO - 'install', 14:12:22 INFO - 'run-tests'), 14:12:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:22 INFO - 'download_minidump_stackwalk': True, 14:12:22 INFO - 'download_symbols': 'ondemand', 14:12:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:22 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:22 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:22 INFO - 'installer_path': 'installer.exe', 14:12:22 INFO - 'log_level': 'info', 14:12:22 INFO - 'log_name': 'talos', 14:12:22 INFO - 'log_to_console': True, 14:12:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:12:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:12:22 INFO - 'opt_config_files': (), 14:12:22 INFO - 'pip_index': False, 14:12:22 INFO - 'sps_profile': False, 14:12:22 INFO - 'sps_profile_interval': 0, 14:12:22 INFO - 'suite': 'dromaeojs-e10s', 14:12:22 INFO - 'system_bits': '32', 14:12:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:22 INFO - 'title': 'talos-linux64-ix-050', 14:12:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:22 INFO - 'use_talos_json': True, 14:12:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:12:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:22 INFO - 'work_dir': 'build'} 14:12:22 INFO - [mozharness: 2016-08-18 21:12:22.274945Z] Running clobber step. 14:12:22 INFO - Running pre-action listener: _resource_record_pre_action 14:12:22 INFO - Running main action method: clobber 14:12:22 INFO - rmtree: /builds/slave/test/build 14:12:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:12:22 INFO - Running post-action listener: _resource_record_post_action 14:12:22 INFO - [mozharness: 2016-08-18 21:12:22.731141Z] Finished clobber step (success) 14:12:22 INFO - [mozharness: 2016-08-18 21:12:22.731243Z] Running read-buildbot-config step. 14:12:22 INFO - Running pre-action listener: _resource_record_pre_action 14:12:22 INFO - Running main action method: read_buildbot_config 14:12:22 INFO - Using buildbot properties: 14:12:22 INFO - { 14:12:22 INFO - "project": "", 14:12:22 INFO - "product": "firefox", 14:12:22 INFO - "script_repo_revision": "production", 14:12:22 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 14:12:22 INFO - "repository": "", 14:12:22 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 14:12:22 INFO - "buildid": "20160818131455", 14:12:22 INFO - "pgo_build": "False", 14:12:22 INFO - "basedir": "/builds/slave/test", 14:12:22 INFO - "buildnumber": 352, 14:12:22 INFO - "slavename": "talos-linux64-ix-050", 14:12:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:12:22 INFO - "platform": "ubuntu64_hw", 14:12:22 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 14:12:22 INFO - "branch": "autoland", 14:12:22 INFO - "repo_path": "integration/autoland", 14:12:22 INFO - "revision": "9276295f33de11de11d3215afeb480c59405a6c9", 14:12:22 INFO - "stage_platform": "linux64", 14:12:22 INFO - "builduid": "af465e1b6a53428bac3efa3851d63088", 14:12:22 INFO - "slavebuilddir": "test" 14:12:22 INFO - } 14:12:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:12:22 INFO - Running post-action listener: _resource_record_post_action 14:12:22 INFO - [mozharness: 2016-08-18 21:12:22.733722Z] Finished read-buildbot-config step (success) 14:12:22 INFO - [mozharness: 2016-08-18 21:12:22.733809Z] Running download-and-extract step. 14:12:22 INFO - Running pre-action listener: _resource_record_pre_action 14:12:22 INFO - Running main action method: download_and_extract 14:12:22 INFO - mkdir: /builds/slave/test/build/tests 14:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:22 INFO - trying https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:12:22 INFO - Downloading https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:12:23 INFO - Downloaded 1361 bytes. 14:12:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:12:23 INFO - Using the following test package requirements: 14:12:23 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:23 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:12:23 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:12:23 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'jsshell-linux-x86_64.zip'], 14:12:23 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:12:23 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:23 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:12:23 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:12:23 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:12:23 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:23 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:12:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:23 INFO - trying https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:12:23 INFO - Downloading https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:12:24 INFO - Downloaded 20317434 bytes. 14:12:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:12:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:28 INFO - trying https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:12:29 INFO - Downloaded 20317434 bytes. 14:12:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 14:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:33 INFO - trying https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:12:34 INFO - Downloaded 14413981 bytes. 14:12:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 14:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:34 INFO - trying https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:12:34 INFO - Downloading https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:12:35 INFO - Downloaded 55767967 bytes. 14:12:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:12:35 INFO - mkdir: /builds/slave/test/properties 14:12:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:12:35 INFO - Writing to file /builds/slave/test/properties/build_url 14:12:35 INFO - Contents: 14:12:35 INFO - build_url:https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:12:36 INFO - Running post-action listener: _resource_record_post_action 14:12:36 INFO - Running post-action listener: set_extra_try_arguments 14:12:36 INFO - [mozharness: 2016-08-18 21:12:36.546353Z] Finished download-and-extract step (success) 14:12:36 INFO - [mozharness: 2016-08-18 21:12:36.546653Z] Running populate-webroot step. 14:12:36 INFO - Running pre-action listener: _resource_record_pre_action 14:12:36 INFO - Running main action method: populate_webroot 14:12:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:12:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:12:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:12:36 INFO - '--tppagecycles', 14:12:36 INFO - '7'], 14:12:36 INFO - 'tests': ['tsvgm']}}, 14:12:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:12:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:12:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:12:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:12:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['damp', 'tps']}, 14:12:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'tests': ['damp', 'tps']}, 14:12:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['dromaeo_dom']}, 14:12:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:12:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['basic_compositor_video']}, 14:12:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:12:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other-e10s': {'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['a11yr', 14:12:36 INFO - 'ts_paint', 14:12:36 INFO - 'tpaint', 14:12:36 INFO - 'sessionrestore', 14:12:36 INFO - 'sessionrestore_no_auto_restore', 14:12:36 INFO - 'tabpaint']}, 14:12:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tsvgx', 14:12:36 INFO - 'tsvgr_opacity', 14:12:36 INFO - 'tart', 14:12:36 INFO - 'tscrollx', 14:12:36 INFO - 'cart']}, 14:12:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:12:36 INFO - 'tsvgr_opacity', 14:12:36 INFO - 'tart', 14:12:36 INFO - 'tscrollx', 14:12:36 INFO - 'cart']}, 14:12:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s'], 14:12:36 INFO - 'tests': ['tp5o']}, 14:12:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'tests': ['tp5o']}, 14:12:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--disable-e10s', 14:12:36 INFO - '--xperf_path', 14:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:36 INFO - 'tests': ['tp5n']}, 14:12:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:36 INFO - 'talos_options': ['--xperf_path', 14:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:36 INFO - 'tests': ['tp5n']}}, 14:12:36 INFO - 'talos.zip': {'path': '', 14:12:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:12:36 INFO - Running post-action listener: _resource_record_post_action 14:12:36 INFO - [mozharness: 2016-08-18 21:12:36.565573Z] Finished populate-webroot step (success) 14:12:36 INFO - [mozharness: 2016-08-18 21:12:36.565666Z] Running create-virtualenv step. 14:12:36 INFO - Running pre-action listener: _resource_record_pre_action 14:12:36 INFO - Running main action method: create_virtualenv 14:12:36 INFO - Creating virtualenv /builds/slave/test/build/venv 14:12:36 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 14:12:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:12:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:12:36 INFO - Using real prefix '/usr' 14:12:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:12:37 INFO - Installing distribute.............................................................................................................................................................................................done. 14:12:39 INFO - Installing pip.................done. 14:12:39 INFO - Return code: 0 14:12:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:39 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:12:39 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 14:12:39 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 14:12:39 INFO - Using env: {'DISPLAY': ':0', 14:12:39 INFO - 'HOME': '/home/cltbld', 14:12:39 INFO - 'LANG': 'en_US.UTF-8', 14:12:39 INFO - 'LANGUAGE': 'en_US:en', 14:12:39 INFO - 'LOGNAME': 'cltbld', 14:12:39 INFO - 'MAIL': '/var/mail/cltbld', 14:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:39 INFO - 'MOZ_NO_REMOTE': '1', 14:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:39 INFO - 'NO_EM_RESTART': '1', 14:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:39 INFO - 'PWD': '/builds/slave/test', 14:12:39 INFO - 'SHELL': '/bin/bash', 14:12:39 INFO - 'SHLVL': '1', 14:12:39 INFO - 'TERM': 'linux', 14:12:39 INFO - 'TMOUT': '86400', 14:12:39 INFO - 'USER': 'cltbld', 14:12:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:39 INFO - '_': '/tools/buildbot/bin/python'} 14:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:39 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 14:12:39 INFO - Cleaning up... 14:12:39 INFO - Return code: 0 14:12:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:39 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:12:39 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 14:12:39 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 14:12:39 INFO - Using env: {'DISPLAY': ':0', 14:12:39 INFO - 'HOME': '/home/cltbld', 14:12:39 INFO - 'LANG': 'en_US.UTF-8', 14:12:39 INFO - 'LANGUAGE': 'en_US:en', 14:12:39 INFO - 'LOGNAME': 'cltbld', 14:12:39 INFO - 'MAIL': '/var/mail/cltbld', 14:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:39 INFO - 'MOZ_NO_REMOTE': '1', 14:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:39 INFO - 'NO_EM_RESTART': '1', 14:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:39 INFO - 'PWD': '/builds/slave/test', 14:12:39 INFO - 'SHELL': '/bin/bash', 14:12:39 INFO - 'SHLVL': '1', 14:12:39 INFO - 'TERM': 'linux', 14:12:39 INFO - 'TMOUT': '86400', 14:12:39 INFO - 'USER': 'cltbld', 14:12:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:39 INFO - '_': '/tools/buildbot/bin/python'} 14:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:39 INFO - Downloading/unpacking psutil>=3.1.1 14:12:39 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 14:12:39 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 14:12:39 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 14:12:39 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 14:12:39 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 14:12:39 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 14:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:12:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:41 INFO - Installing collected packages: psutil 14:12:41 INFO - Running setup.py install for psutil 14:12:41 INFO - building 'psutil._psutil_linux' extension 14:12:41 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 14:12:41 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 14:12:41 INFO - building 'psutil._psutil_posix' extension 14:12:41 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 14:12:41 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 14:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:42 INFO - Successfully installed psutil 14:12:42 INFO - Cleaning up... 14:12:42 INFO - Return code: 0 14:12:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:42 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:12:42 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 14:12:42 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 14:12:42 INFO - Using env: {'DISPLAY': ':0', 14:12:42 INFO - 'HOME': '/home/cltbld', 14:12:42 INFO - 'LANG': 'en_US.UTF-8', 14:12:42 INFO - 'LANGUAGE': 'en_US:en', 14:12:42 INFO - 'LOGNAME': 'cltbld', 14:12:42 INFO - 'MAIL': '/var/mail/cltbld', 14:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:42 INFO - 'MOZ_NO_REMOTE': '1', 14:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:42 INFO - 'NO_EM_RESTART': '1', 14:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:42 INFO - 'PWD': '/builds/slave/test', 14:12:42 INFO - 'SHELL': '/bin/bash', 14:12:42 INFO - 'SHLVL': '1', 14:12:42 INFO - 'TERM': 'linux', 14:12:42 INFO - 'TMOUT': '86400', 14:12:42 INFO - 'USER': 'cltbld', 14:12:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:42 INFO - '_': '/tools/buildbot/bin/python'} 14:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:12:42 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 14:12:42 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 14:12:42 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 14:12:42 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 14:12:42 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 14:12:42 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 14:12:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:12:44 INFO - Installing collected packages: mozsystemmonitor 14:12:44 INFO - Running setup.py install for mozsystemmonitor 14:12:44 INFO - Successfully installed mozsystemmonitor 14:12:44 INFO - Cleaning up... 14:12:44 INFO - Return code: 0 14:12:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:12:44 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:12:44 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 14:12:44 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 14:12:44 INFO - Using env: {'DISPLAY': ':0', 14:12:44 INFO - 'HOME': '/home/cltbld', 14:12:44 INFO - 'LANG': 'en_US.UTF-8', 14:12:44 INFO - 'LANGUAGE': 'en_US:en', 14:12:44 INFO - 'LOGNAME': 'cltbld', 14:12:44 INFO - 'MAIL': '/var/mail/cltbld', 14:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:44 INFO - 'MOZ_NO_REMOTE': '1', 14:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:44 INFO - 'NO_EM_RESTART': '1', 14:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:44 INFO - 'PWD': '/builds/slave/test', 14:12:44 INFO - 'SHELL': '/bin/bash', 14:12:44 INFO - 'SHLVL': '1', 14:12:44 INFO - 'TERM': 'linux', 14:12:44 INFO - 'TMOUT': '86400', 14:12:44 INFO - 'USER': 'cltbld', 14:12:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:44 INFO - '_': '/tools/buildbot/bin/python'} 14:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:12:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:12:46 INFO - warning: no files found matching '*.txt' 14:12:46 INFO - no previously-included directories found matching 'build' 14:12:46 INFO - no previously-included directories found matching 'dist' 14:12:46 INFO - no previously-included directories found matching '.git*' 14:12:46 INFO - Installing collected packages: jsonschema, functools32 14:12:46 INFO - Running setup.py install for functools32 14:12:46 INFO - warning: no files found matching '*.txt' 14:12:46 INFO - no previously-included directories found matching 'build' 14:12:46 INFO - no previously-included directories found matching 'dist' 14:12:46 INFO - no previously-included directories found matching '.git*' 14:12:46 INFO - Successfully installed jsonschema functools32 14:12:46 INFO - Cleaning up... 14:12:46 INFO - Return code: 0 14:12:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:12:46 INFO - Using env: {'DISPLAY': ':0', 14:12:46 INFO - 'HOME': '/home/cltbld', 14:12:46 INFO - 'LANG': 'en_US.UTF-8', 14:12:46 INFO - 'LANGUAGE': 'en_US:en', 14:12:46 INFO - 'LOGNAME': 'cltbld', 14:12:46 INFO - 'MAIL': '/var/mail/cltbld', 14:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:46 INFO - 'MOZ_NO_REMOTE': '1', 14:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:46 INFO - 'NO_EM_RESTART': '1', 14:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:46 INFO - 'PWD': '/builds/slave/test', 14:12:46 INFO - 'SHELL': '/bin/bash', 14:12:46 INFO - 'SHLVL': '1', 14:12:46 INFO - 'TERM': 'linux', 14:12:46 INFO - 'TMOUT': '86400', 14:12:46 INFO - 'USER': 'cltbld', 14:12:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:46 INFO - '_': '/tools/buildbot/bin/python'} 14:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:12:47 INFO - Cleaning up... 14:12:47 INFO - Return code: 0 14:12:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:12:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:47 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:47 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:12:47 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 14:12:47 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 14:12:47 INFO - Using env: {'DISPLAY': ':0', 14:12:47 INFO - 'HOME': '/home/cltbld', 14:12:47 INFO - 'LANG': 'en_US.UTF-8', 14:12:47 INFO - 'LANGUAGE': 'en_US:en', 14:12:47 INFO - 'LOGNAME': 'cltbld', 14:12:47 INFO - 'MAIL': '/var/mail/cltbld', 14:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:47 INFO - 'MOZ_NO_REMOTE': '1', 14:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:47 INFO - 'NO_EM_RESTART': '1', 14:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:47 INFO - 'PWD': '/builds/slave/test', 14:12:47 INFO - 'SHELL': '/bin/bash', 14:12:47 INFO - 'SHLVL': '1', 14:12:47 INFO - 'TERM': 'linux', 14:12:47 INFO - 'TMOUT': '86400', 14:12:47 INFO - 'USER': 'cltbld', 14:12:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:47 INFO - '_': '/tools/buildbot/bin/python'} 14:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:47 INFO - Downloading/unpacking blobuploader==1.2.4 14:12:47 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 14:12:47 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 14:12:47 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 14:12:47 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 14:12:47 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 14:12:47 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 14:14:48 INFO - Cleaning up... 14:14:48 INFO - Exception: 14:14:48 ERROR - Traceback (most recent call last): 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/basecommand.py", line 122, in main 14:14:48 INFO - status = self.run(options, args) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/commands/install.py", line 278, in run 14:14:48 INFO - requirement_set.prepare_files(finder, force_root_egg_info=self.bundle, bundle=self.bundle) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/req.py", line 1177, in prepare_files 14:14:48 INFO - url = finder.find_requirement(req_to_install, upgrade=self.upgrade) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 252, in find_requirement 14:14:48 INFO - for page in self._get_pages(locations, req): 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 387, in _get_pages 14:14:48 INFO - page = self._get_page(location, req) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 568, in _get_page 14:14:48 INFO - session=self.session, 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/index.py", line 670, in get_page 14:14:48 INFO - resp = session.get(url, headers={"Accept": "text/html"}) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 395, in get 14:14:48 INFO - return self.request('GET', url, **kwargs) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/download.py", line 237, in request 14:14:48 INFO - return super(PipSession, self).request(method, url, *args, **kwargs) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 383, in request 14:14:48 INFO - resp = self.send(prep, **send_kwargs) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 506, in send 14:14:48 INFO - history = [resp for resp in gen] if allow_redirects else [] 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 168, in resolve_redirects 14:14:48 INFO - allow_redirects=False, 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/sessions.py", line 486, in send 14:14:48 INFO - r = adapter.send(request, **kwargs) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/adapters.py", line 394, in send 14:14:48 INFO - r.content 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/models.py", line 679, in content 14:14:48 INFO - self._content = bytes().join(self.iter_content(CONTENT_CHUNK_SIZE)) or bytes() 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/models.py", line 616, in generate 14:14:48 INFO - decode_content=True): 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/packages/urllib3/response.py", line 236, in stream 14:14:48 INFO - data = self.read(amt=amt, decode_content=decode_content) 14:14:48 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg/pip/_vendor/requests/packages/urllib3/response.py", line 183, in read 14:14:48 INFO - data = self._fp.read(amt) 14:14:48 INFO - File "/usr/lib/python2.7/httplib.py", line 541, in read 14:14:48 INFO - return self._read_chunked(amt) 14:14:48 INFO - File "/usr/lib/python2.7/httplib.py", line 601, in _read_chunked 14:14:48 INFO - value.append(self._safe_read(chunk_left)) 14:14:48 INFO - File "/usr/lib/python2.7/httplib.py", line 647, in _safe_read 14:14:48 INFO - chunk = self.fp.read(min(amt, MAXAMOUNT)) 14:14:48 INFO - File "/usr/lib/python2.7/socket.py", line 380, in read 14:14:48 INFO - data = self._sock.recv(left) 14:14:48 INFO - timeout: timed out 14:14:48 INFO - Storing debug log for failure in /home/cltbld/.pip/pip.log 14:14:48 WARNING - Return code: 2 14:14:48 INFO - retry: Failed, sleeping 60 seconds before retrying 14:15:49 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 #2 14:15:49 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 14:15:49 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 14:15:49 INFO - Using env: {'DISPLAY': ':0', 14:15:49 INFO - 'HOME': '/home/cltbld', 14:15:49 INFO - 'LANG': 'en_US.UTF-8', 14:15:49 INFO - 'LANGUAGE': 'en_US:en', 14:15:49 INFO - 'LOGNAME': 'cltbld', 14:15:49 INFO - 'MAIL': '/var/mail/cltbld', 14:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:49 INFO - 'MOZ_NO_REMOTE': '1', 14:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:49 INFO - 'NO_EM_RESTART': '1', 14:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:49 INFO - 'PWD': '/builds/slave/test', 14:15:49 INFO - 'SHELL': '/bin/bash', 14:15:49 INFO - 'SHLVL': '1', 14:15:49 INFO - 'TERM': 'linux', 14:15:49 INFO - 'TMOUT': '86400', 14:15:49 INFO - 'USER': 'cltbld', 14:15:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:49 INFO - '_': '/tools/buildbot/bin/python'} 14:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:49 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:49 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 14:15:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 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 14:15:51 INFO - Downloading docopt-0.6.1.tar.gz 14:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:51 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:51 INFO - Running setup.py install for blobuploader 14:15:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:51 INFO - Running setup.py install for requests 14:15:52 INFO - Running setup.py install for docopt 14:15:52 INFO - Successfully installed blobuploader requests docopt 14:15:52 INFO - Cleaning up... 14:15:52 INFO - Return code: 0 14:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:52 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:15:52 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 14:15:52 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 14:15:52 INFO - Using env: {'DISPLAY': ':0', 14:15:52 INFO - 'HOME': '/home/cltbld', 14:15:52 INFO - 'LANG': 'en_US.UTF-8', 14:15:52 INFO - 'LANGUAGE': 'en_US:en', 14:15:52 INFO - 'LOGNAME': 'cltbld', 14:15:52 INFO - 'MAIL': '/var/mail/cltbld', 14:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:52 INFO - 'MOZ_NO_REMOTE': '1', 14:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:52 INFO - 'NO_EM_RESTART': '1', 14:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:52 INFO - 'PWD': '/builds/slave/test', 14:15:52 INFO - 'SHELL': '/bin/bash', 14:15:52 INFO - 'SHLVL': '1', 14:15:52 INFO - 'TERM': 'linux', 14:15:52 INFO - 'TMOUT': '86400', 14:15:52 INFO - 'USER': 'cltbld', 14:15:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:52 INFO - '_': '/tools/buildbot/bin/python'} 14:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:52 INFO - Running setup.py (path:/tmp/pip-i9Fsaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:52 INFO - Running setup.py (path:/tmp/pip-hjsdCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:52 INFO - Running setup.py (path:/tmp/pip-9VH9KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:52 INFO - Running setup.py (path:/tmp/pip-ZWDTWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:53 INFO - Running setup.py (path:/tmp/pip-09mkm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:53 INFO - Running setup.py (path:/tmp/pip-xvdjeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:53 INFO - Running setup.py (path:/tmp/pip-53fWvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:53 INFO - Running setup.py (path:/tmp/pip-DB_SK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:53 INFO - Running setup.py (path:/tmp/pip-oJGOkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:53 INFO - Running setup.py (path:/tmp/pip-CEjM8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:53 INFO - Running setup.py (path:/tmp/pip-OQAVHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:53 INFO - Running setup.py (path:/tmp/pip-DLQvxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:53 INFO - Running setup.py (path:/tmp/pip-USvB5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:53 INFO - Running setup.py (path:/tmp/pip-Wz32OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:53 INFO - Running setup.py (path:/tmp/pip-LVsPTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:53 INFO - Running setup.py (path:/tmp/pip-ODWp2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:53 INFO - Running setup.py (path:/tmp/pip-hWQWhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:53 INFO - Running setup.py install for manifestparser 14:15:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Running setup.py install for mozcrash 14:15:54 INFO - Running setup.py install for mozdebug 14:15:54 INFO - Running setup.py install for mozdevice 14:15:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Running setup.py install for mozfile 14:15:54 INFO - Running setup.py install for mozhttpd 14:15:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Running setup.py install for mozinfo 14:15:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Running setup.py install for mozInstall 14:15:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Running setup.py install for mozleak 14:15:54 INFO - Running setup.py install for mozlog 14:15:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:54 INFO - Running setup.py install for moznetwork 14:15:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:55 INFO - Running setup.py install for mozprocess 14:15:55 INFO - Running setup.py install for mozprofile 14:15:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:55 INFO - Running setup.py install for mozrunner 14:15:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:55 INFO - Running setup.py install for mozscreenshot 14:15:55 INFO - Running setup.py install for moztest 14:15:55 INFO - Running setup.py install for mozversion 14:15:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:55 INFO - Cleaning up... 14:15:55 INFO - Return code: 0 14:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:55 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:15:55 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 14:15:55 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 14:15:55 INFO - Using env: {'DISPLAY': ':0', 14:15:55 INFO - 'HOME': '/home/cltbld', 14:15:55 INFO - 'LANG': 'en_US.UTF-8', 14:15:55 INFO - 'LANGUAGE': 'en_US:en', 14:15:55 INFO - 'LOGNAME': 'cltbld', 14:15:55 INFO - 'MAIL': '/var/mail/cltbld', 14:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:55 INFO - 'MOZ_NO_REMOTE': '1', 14:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:55 INFO - 'NO_EM_RESTART': '1', 14:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:55 INFO - 'PWD': '/builds/slave/test', 14:15:55 INFO - 'SHELL': '/bin/bash', 14:15:55 INFO - 'SHLVL': '1', 14:15:55 INFO - 'TERM': 'linux', 14:15:55 INFO - 'TMOUT': '86400', 14:15:55 INFO - 'USER': 'cltbld', 14:15:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:55 INFO - '_': '/tools/buildbot/bin/python'} 14:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:55 INFO - Running setup.py (path:/tmp/pip-2Vklm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:56 INFO - Running setup.py (path:/tmp/pip-dcJ06O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:56 INFO - Running setup.py (path:/tmp/pip-fhf6F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:56 INFO - Running setup.py (path:/tmp/pip-GEnGk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:56 INFO - Running setup.py (path:/tmp/pip-n96yp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:56 INFO - Running setup.py (path:/tmp/pip-Ng1CRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:56 INFO - Running setup.py (path:/tmp/pip-UhNoka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:56 INFO - Running setup.py (path:/tmp/pip-EcHe76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:56 INFO - Running setup.py (path:/tmp/pip-msvZBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:56 INFO - Running setup.py (path:/tmp/pip-QPtton-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:56 INFO - Running setup.py (path:/tmp/pip-27LMw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:56 INFO - Running setup.py (path:/tmp/pip-4GgoZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:56 INFO - Running setup.py (path:/tmp/pip-KQhcZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:56 INFO - Running setup.py (path:/tmp/pip-S94YVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:56 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)) 14:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:56 INFO - Running setup.py (path:/tmp/pip-A9UeUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:57 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)) 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:57 INFO - Running setup.py (path:/tmp/pip-SCXwCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:57 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)) 14:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:57 INFO - Running setup.py (path:/tmp/pip-4M9AkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 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)) 14:15:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:57 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 14:15:57 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 14:15:57 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 14:15:57 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 14:15:57 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 14:15:57 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 14:15:59 INFO - Downloading blessings-1.6.tar.gz 14:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:59 INFO - Installing collected packages: blessings 14:15:59 INFO - Running setup.py install for blessings 14:15:59 INFO - Successfully installed blessings 14:15:59 INFO - Cleaning up... 14:15:59 INFO - Return code: 0 14:15:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:59 INFO - Reading from file tmpfile_stdout 14:15:59 INFO - Current package versions: 14:15:59 INFO - argparse == 1.2.1 14:15:59 INFO - blessings == 1.6 14:15:59 INFO - blobuploader == 1.2.4 14:15:59 INFO - docopt == 0.6.1 14:15:59 INFO - functools32 == 3.2.3-2 14:15:59 INFO - jsonschema == 2.5.1 14:15:59 INFO - manifestparser == 1.1 14:15:59 INFO - mozInstall == 1.12 14:15:59 INFO - mozcrash == 0.17 14:15:59 INFO - mozdebug == 0.1 14:15:59 INFO - mozdevice == 0.48 14:15:59 INFO - mozfile == 1.2 14:15:59 INFO - mozhttpd == 0.7 14:15:59 INFO - mozinfo == 0.9 14:15:59 INFO - mozleak == 0.1 14:15:59 INFO - mozlog == 3.3 14:15:59 INFO - moznetwork == 0.27 14:15:59 INFO - mozprocess == 0.23 14:15:59 INFO - mozprofile == 0.28 14:15:59 INFO - mozrunner == 6.12 14:15:59 INFO - mozscreenshot == 0.1 14:15:59 INFO - mozsystemmonitor == 0.3 14:15:59 INFO - moztest == 0.7 14:15:59 INFO - mozversion == 1.4 14:15:59 INFO - psutil == 3.1.1 14:15:59 INFO - requests == 1.2.3 14:15:59 INFO - wsgiref == 0.1.2 14:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:59 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:15:59 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 14:15:59 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 14:15:59 INFO - Using env: {'DISPLAY': ':0', 14:15:59 INFO - 'HOME': '/home/cltbld', 14:15:59 INFO - 'LANG': 'en_US.UTF-8', 14:15:59 INFO - 'LANGUAGE': 'en_US:en', 14:15:59 INFO - 'LOGNAME': 'cltbld', 14:15:59 INFO - 'MAIL': '/var/mail/cltbld', 14:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:59 INFO - 'MOZ_NO_REMOTE': '1', 14:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:59 INFO - 'NO_EM_RESTART': '1', 14:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:59 INFO - 'PWD': '/builds/slave/test', 14:15:59 INFO - 'SHELL': '/bin/bash', 14:15:59 INFO - 'SHLVL': '1', 14:15:59 INFO - 'TERM': 'linux', 14:15:59 INFO - 'TMOUT': '86400', 14:15:59 INFO - 'USER': 'cltbld', 14:15:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:59 INFO - '_': '/tools/buildbot/bin/python'} 14:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 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)) 14:15:59 INFO - Cleaning up... 14:15:59 INFO - Return code: 0 14:15:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:59 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 0x7f5df97c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, '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': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', '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 14:15:59 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 14:15:59 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 14:15:59 INFO - Using env: {'DISPLAY': ':0', 14:15:59 INFO - 'HOME': '/home/cltbld', 14:15:59 INFO - 'LANG': 'en_US.UTF-8', 14:15:59 INFO - 'LANGUAGE': 'en_US:en', 14:15:59 INFO - 'LOGNAME': 'cltbld', 14:15:59 INFO - 'MAIL': '/var/mail/cltbld', 14:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:59 INFO - 'MOZ_NO_REMOTE': '1', 14:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:59 INFO - 'NO_EM_RESTART': '1', 14:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:59 INFO - 'PWD': '/builds/slave/test', 14:15:59 INFO - 'SHELL': '/bin/bash', 14:15:59 INFO - 'SHLVL': '1', 14:15:59 INFO - 'TERM': 'linux', 14:15:59 INFO - 'TMOUT': '86400', 14:15:59 INFO - 'USER': 'cltbld', 14:15:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:59 INFO - '_': '/tools/buildbot/bin/python'} 14:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:16:00 INFO - Cleaning up... 14:16:00 INFO - Return code: 0 14:16:00 INFO - Running post-action listener: _resource_record_post_action 14:16:00 INFO - Running post-action listener: _start_resource_monitoring 14:16:00 INFO - Starting resource monitoring. 14:16:00 INFO - [mozharness: 2016-08-18 21:16:00.125179Z] Finished create-virtualenv step (success) 14:16:00 INFO - [mozharness: 2016-08-18 21:16:00.125644Z] Running install step. 14:16:00 INFO - Running pre-action listener: _resource_record_pre_action 14:16:00 INFO - Running main action method: install 14:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:00 INFO - Reading from file tmpfile_stdout 14:16:00 INFO - Detecting whether we're running mozinstall >=1.0... 14:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:16:00 INFO - Reading from file tmpfile_stdout 14:16:00 INFO - Output received: 14:16:00 INFO - Usage: mozinstall [options] installer 14:16:00 INFO - Options: 14:16:00 INFO - -h, --help show this help message and exit 14:16:00 INFO - -d DEST, --destination=DEST 14:16:00 INFO - Directory to install application into. [default: 14:16:00 INFO - "/builds/slave/test"] 14:16:00 INFO - --app=APP Application being installed. [default: firefox] 14:16:00 INFO - mkdir: /builds/slave/test/build/application 14:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:16:16 INFO - Reading from file tmpfile_stdout 14:16:16 INFO - Output received: 14:16:16 INFO - /builds/slave/test/build/application/firefox/firefox 14:16:16 INFO - Running post-action listener: _resource_record_post_action 14:16:16 INFO - [mozharness: 2016-08-18 21:16:16.501191Z] Finished install step (success) 14:16:16 INFO - [mozharness: 2016-08-18 21:16:16.501447Z] Running run-tests step. 14:16:16 INFO - Running pre-action listener: _resource_record_pre_action 14:16:16 INFO - Running main action method: run_tests 14:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:16 INFO - Python 2.7.3 14:16:16 INFO - Return code: 0 14:16:16 INFO - grabbing minidump binary from tooltool 14:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:16 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 0x256a090>, '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 0x256d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:16 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 14:16:16 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 14:16:16 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 14:16:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:16 INFO - Return code: 0 14:16:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:16:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:16:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 14:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 14:16:16 INFO - Using env: {'DISPLAY': ':0', 14:16:16 INFO - 'HOME': '/home/cltbld', 14:16:16 INFO - 'LANG': 'en_US.UTF-8', 14:16:16 INFO - 'LANGUAGE': 'en_US:en', 14:16:16 INFO - 'LOGNAME': 'cltbld', 14:16:16 INFO - 'MAIL': '/var/mail/cltbld', 14:16:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:16 INFO - 'MOZ_NO_REMOTE': '1', 14:16:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:16 INFO - 'NO_EM_RESTART': '1', 14:16:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:16 INFO - 'PWD': '/builds/slave/test', 14:16:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:16 INFO - 'SHELL': '/bin/bash', 14:16:16 INFO - 'SHLVL': '1', 14:16:16 INFO - 'TERM': 'linux', 14:16:16 INFO - 'TMOUT': '86400', 14:16:16 INFO - 'USER': 'cltbld', 14:16:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750', 14:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:16 INFO - '_': '/tools/buildbot/bin/python'} 14:16:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 14:16:16 INFO - mozversion application_buildid: 20160818131455 14:16:16 INFO - mozversion application_changeset: 9276295f33de11de11d3215afeb480c59405a6c9 14:16:16 INFO - mozversion application_display_name: Nightly 14:16:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:16 INFO - mozversion application_name: Firefox 14:16:16 INFO - mozversion application_remotingname: firefox 14:16:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:16:16 INFO - mozversion application_vendor: Mozilla 14:16:16 INFO - mozversion application_version: 51.0a1 14:16:16 INFO - mozversion platform_buildid: 20160818131455 14:16:16 INFO - mozversion platform_changeset: 9276295f33de11de11d3215afeb480c59405a6c9 14:16:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:16:16 INFO - mozversion platform_version: 51.0a1 14:16:16 INFO - using testdate: 1471554976 14:16:16 INFO - actual date: 1471554976 14:16:16 INFO - starting webserver on 'localhost:34490' 14:16:16 INFO - SUITE-START | Running 2 tests 14:16:16 INFO - TEST-START | dromaeo_css 14:16:16 INFO - operating with platform_type : linux_ 14:16:16 INFO - Initialising browser for dromaeo_css test... 14:16:16 INFO - TEST-INFO | started process 18409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikQpYL/profile http://localhost:34490/getInfo.html) 14:16:21 INFO - PROCESS | 18409 | __metrics Screen width/height:1600/1200 14:16:21 INFO - PROCESS | 18409 | colorDepth:24 14:16:21 INFO - PROCESS | 18409 | Browser inner width/height: 1024/697 14:16:21 INFO - PROCESS | 18409 | __metrics 14:16:21 ERROR - PROCESS | 18409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2980: TypeError: this.tabs is undefined 14:16:22 INFO - TEST-INFO | 18409: exit 0 14:16:22 INFO - Browser initialized. 14:16:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:22 INFO - TEST-INFO | started process 18531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikQpYL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:34 INFO - PROCESS | 18531 | RSS: Main: 164196352 14:16:34 INFO - PROCESS | 18531 | 14:17:24 INFO - PROCESS | 18531 | 1471555044481 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] 14:19:37 INFO - PROCESS | 18531 | Cycle 1(1): loaded http://localhost:34490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34490/tests/dromaeo/cssquery-ext.html) 14:19:38 INFO - PROCESS | 18531 | RSS: Main: 167215104 14:19:38 INFO - PROCESS | 18531 | 14:22:40 INFO - PROCESS | 18531 | Cycle 1(1): loaded http://localhost:34490/tests/dromaeo/cssquery-ext.html (next: http://localhost:34490/tests/dromaeo/cssquery-jquery.html) 14:22:41 INFO - PROCESS | 18531 | RSS: Main: 165113856 14:22:41 INFO - PROCESS | 18531 | 14:25:43 INFO - PROCESS | 18531 | Cycle 1(1): loaded http://localhost:34490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34490/tests/dromaeo/cssquery-mootools.html) 14:25:44 INFO - PROCESS | 18531 | RSS: Main: 166916096 14:25:44 INFO - PROCESS | 18531 | 14:28:46 INFO - PROCESS | 18531 | Cycle 1(1): loaded http://localhost:34490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34490/tests/dromaeo/cssquery-prototype.html) 14:28:46 INFO - PROCESS | 18531 | RSS: Main: 163520512 14:28:46 INFO - PROCESS | 18531 | 14:31:49 INFO - PROCESS | 18531 | Cycle 1(1): loaded http://localhost:34490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34490/tests/dromaeo/cssquery-yui.html) 14:31:50 INFO - PROCESS | 18531 | RSS: Main: 166195200 14:31:50 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | Cycle 1(1): loaded http://localhost:34490/tests/dromaeo/cssquery-yui.html (next: http://localhost:34490/tests/dromaeo/cssquery-dojo.html) 14:34:53 INFO - PROCESS | 18531 | RSS: Main: 166522880 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | __start_tp_report 14:34:53 INFO - PROCESS | 18531 | _x_x_mozilla_page_load 14:34:53 INFO - PROCESS | 18531 | _x_x_mozilla_page_load_details 14:34:53 INFO - PROCESS | 18531 | |i|pagename|runs| 14:34:53 INFO - PROCESS | 18531 | |0;dojo.html;2608.1653870761356;2630.4344565918323;2631.250093723288;2633.920982370529;2644.2860427684514;4630.884227894304;4673.018666080123;4711.835085771999;4762.1428142934255;4780.4741478437345;4595.678302518825;4634.374359461472;4669.9066018679605;4677.789499472523;4720.575148236658;4237.6609871210385;4284.228838809013;4311.137772445508;4351.608355248027;4360.411344468504;4354.695171338008;4361.433013708213;4397.736135831844;4405.845795397177;4436.911261774762;4247.936280955788;4251.447311849471;4263.97868010661;4269.402283680287;4330.242207613686;4308.569143085698;4336.414584031147;4356.346548017791;4359.80380882861;4367.061081867382;4274.422952901349;4291.249031419489;4295.806688699016;4309.224339618867;4329.134173165379;4591.977040114812;4659.277811939155;4687.22660760974;4702.412198475191;4725.480197178307;4992.076465853828;5004.749762511859;5005.874853128665;5011.348524691767;5040.7731652075745;5049.5455409013;5059.241113832954;5061.6962982221185;5073.695578265316;5081.59347252219;4621.976890115528;4637.211674015425;4644.744539050317;4669.696469729457;4784.186688263004;5126.359205099363;5134.820281290212;5135.948640513622;5140.357455318085;5200.765965531485;4920.089783390084;4935.580475659537;4944.159492886218;4954.9009019819405;4977.9751101244265;4889.584385327287;5007.198848184273;5013.147764879979;5065.721385323769;5078.771455284521;5057.31726216956;5059.772310246048;5060.316857224301;5094;5140.177571588528;5036.874078148076;5053.494650534991;5055.090083784954;5060.114479966065;5063.215201643678;4054.189162167578;4217.0511634881905;4227.42929704486;4261.403403523509;4315.784210789448;3734.5705243896755;3747.194353214072;3747.362948298796;3759.2105657811617;3795.070207799107;4472.239719247736;4477.507474177838;4498.6626003049905;4502.594766471033;4514.6614003949835;4919.926201106986;4953.628477864175;4960.751962401865;4969.055879382906;5037;4373.147236288957;4393.033532622818;4394.978025109854;4399.978000109979;4416.889577760582;4473.932891006638;4476.082403107355;4484.080763443486;4500.8649740507835;4511.616512596466;4699.882502937386;4805.879853003703;4812.230043193073;4816.710997340241;4873.1471992400475;5084.720340381315;5087.618428617794;5105.540501354896;5115.897682046412;5146.279520867157;4831.299461577981;4848.5636292733825;4865.416150062015;4871.585915197106;4885.2427873679635;4866.221404575251;4876.634252431011;4884.535969082932;4931.211006238985;4997.300377947163;5040.596752259884;5053;5056.64603477753;5063.518965698253;5066.113430149783;4886.29148773433;4913.213885778401;4921.237208232729;4926.975365123151;4980;4751.00228951924;4823.710577365369;4866.099771542276;4896.510348965075;4917.877053073702;4781.13939490895;4820.25286080658;4854.538818812207;4855.562999330077;4856.320115183948;4926.187179115406;4954.083494553519;4958.504149585013;4960.181570040902;4964.702117872939;4650.906981860411;4729.527047295243;4763.928541071956;4769.213079841926;4859.562639362474 14:34:53 INFO - PROCESS | 18531 | |1;ext.html;546.6829239041354;557.9721013949303;565.4091474409244;567.0700051914861;581.1544203184367;34417;38420.80789596052;38473.61526384735;38517.614823851756;38525;39030;39455;39517.80241098798;39550.8022459888;39661;7616.771496855104;7714.382849372037;7755.922440775605;7760.417968652346;7781.922180778205;7614.695412183506;7615.47690461907;7691.769246922573;7699.769006929801;7705.422093342993;7679.500832445873;7709.653065612033;7711.074671039483;7725.420593455485;7732.884006739903;7644.006279183698;7658.081030276347;7707.460477766558;7714.961425192894;7725.690972361099;7646.464747467679;7657.961710191469;7697.461177717562;7704.845903081963;7709.614519274014;36386.63613363859;36604.450933236025;36894;36937.07657308562;36996.815015925014;3054.7403470704794;3059.938801223985;3115.9532607010915;3126.45287074761;3338.065341704327;28518.572221416696;28658.713412866022;28742.71257287442;28973.565396518858;30057.398852022838;3215.935681286361;3257.9022629321157;3261.641219465857;3272.378248132847;3288.391647545212;249622;250860;251250;252394.73802631052;253851;31368.215794605316;51188.74405627948;51217.23174152391;51442.48557514377;51482.22776658353;31656.841715791274;33055.876339167466;33136.50295245525;33175;33257.83371083129;13459.327033648278;13592.592222233348;13601.979851511176;13613.387397567134;13625.386857591433;10362.689119326282;10397.58409663605;10437.32157409766;10438.164946804238;10443.68668939933;7641.503302285334;7725.343345815669;7845.764627061198;7857.1357150713375;7913.841723165505;2993.491106511898;3030.9393812123635;3046.7257946784894;3071.600691910082;3093.1184612385364;854.6026097864523;862.8101817600118;904.371461834019;924.2236521322121;972.8686627305365;27413.17760467189;28195.57706634402;28430.14709558675;28683.56974645382;28795.28011799722;922.3267015078895;966.6181858165985;989.9109080182674;997.152420442618;1033.1579762493693;14453.771429428407;14943.40226390954;15133.394664213529;15188.696226075417;15447.845521544865;386182;387306;390601;391193;392065;49084.50915490871;49150;49437;49494.257586136235;49610.50389496059;1110.6057349640923;1131.0725205331714;1131.937743424103;1138.2146319039837;1153.55011545499;26441;27238.72761272362;27447;28119.57820632651;28156.577651334836;42157.57842421537;46958;48766.75616621894;48778.512214878814;52254.21618675799;329149;333478;334397;335416;337670;37836.62163378331;38032;38129.61870381261;38341.23317533689;38908;42162;42430.36354454624;42475;42646.78676606597;43348.56651433571;35407.29185416329;35895;36350.63649363472;36395.81802091079;36852.447213291285;35137.47293790647;35372.823135885184;35415.11462213465;35781.46327805137;36478.8176059118;34851.47722784211;34889.82555087208;34990.65009349976;35019.47470787889;35313.29373412466;30831.845840770653;32901.34197315992;32901.34197315992;32928.83535582307;33324.333513330086;25279.11523096683;25355.74644253534;25454;25618.743812561635;25922.74077259203 14:34:53 INFO - PROCESS | 18531 | |2;jquery.html;359.9982000089999;365.1164182677919;367.42131143449063;373.6506366547277;384.7326108354695;15654.452094176706;16133.596660083504;16921.661566768656;17179.484615461526;17198.312067517316;15466;15496.380144794195;15765.60585985351;15833;15857;4333.783310834454;4597.655175861807;4604.171249175147;4635.953640463603;4647.953520464803;4611.4005179326805;4631;4632.467266264389;4642.558956899089;4648.930266046012;4624.28323609841;5198.7660555274915;5463.7814487420455;5495.148252020923;5499.037668408033;5345.893082138336;5457.808976685817;5483.533899618497;5495.752691128889;5496.395396506361;5218.295530103425;5330.440303768126;5331.760070796823;5335.1730481775385;5338.973305133488;11875;11892.702682432922;12097.879021209763;12209.633710988684;12328.07539434546;1832.9266829326812;1847.3811273223487;1865.3657756362902;1976.2885361269932;2350.447644803487;9016.549172541412;9144.4970526621;9261.72214833556;9384.577694003787;9624.759381015461;1705.360489816319;1715.6911755883937;1741.8867773594675;1744.2295322293517;1767.920443580042;72388;72747.63626181889;74096.25903740947;75188;75473.6226318865;9597.376170548892;9919.553620087114;9930.453825039547;9988.650397236062;10027;13815.447382104603;13815.654608634664;13828.37772300249;13830.930845345709;13858.584242472742;6609.1408116944485;6865.588064716133;6907.551009184387;7090.787276381717;7101.82245443868;6393.232812062489;6427.517936154807;6586.736530538725;6615.702293396808;6649.268580456146;3998.5601583825755;4136.276151673505;4150.501939767248;4167.374893765898;4211.642010429086;1767.4432553745787;1768.2308195934809;1823.4529641107615;1846.796852346241;1871.5882505848692;822.0915887943736;845.4251109245649;878.2929741558107;880.6946379779743;931.7763736703142;16624.33502659904;17153.656926861393;17274.49519819619;17654.205560749797;18082;841.1252297610416;846.4075147396724;864.5849992003873;876.1370050500252;888.0542222532981;8572.096191229024;9822.705318840446;9990.80018399628;9999.50002499872;10088.949555252177;365741;368284;374676;385771;388117;78623.21376786273;79740.60129699315;80643;82158.58920705358;82637.58681206555;832.820943497151;856.7130011446111;870.4124715816924;872.5898827551041;874.3267683883374;14988.1756503389;15267.312970916113;15350.30923608418;15426.614334641723;16085.437009704605;34941.47587786135;36765.81617091897;38455.80772096122;39621;40581.18837623172;49270;49898.501014989386;51536.74231628968;52310.47689523056;52875.47124528705;7080.8937865933085;7351.338379545867;7373.152087510005;7636.434530921259;7874.173211812907;11996.820047699466;12065.758684826429;12130.636080917586;12218.938905305416;12273.202241854251;10391.688249352532;10397.116245118947;10399.740006499595;10582.042322170422;10843.1867609928;10354.948225258826;10552.20858435605;10564.154867610727;10710.678679639623;10728.678139655824;9946.552405141641;10039.397636141855;10245.385276883411;10329.845052324372;10715.410652414192;7184.425245980414;7283.927160728537;7511;7557.659905304165;7558.546487210565;9958.55186516623;10295.3822770634;10566.788664226826;10744.785104298027;11030.558777649125 14:34:53 INFO - PROCESS | 18531 | |3;mootools.html;1350.2371160294435;1387.431153227177;1436.303392854466;1625.634232297734;1639.8524132828043;6619.867602647944;7375.741849035285;7423.331900128987;8034.437589368747;8037.316828069621;7490.250974902507;7810.9609451952665;7820.45256832022;7845.176256493058;7870.449068565203;2154.515234072333;2172.9674054889188;2184.137265780016;2186.0272178880405;2188.4638263625434;2145.710329105574;2181.8581792183536;2191.145453273217;2215.9556808863813;2219.966700499494;2172.663237198237;2183.4323076000273;2184.9890750546306;2191.638379667353;2191.9561608767817;2070.9482262943397;2080.2823026055985;2090.8640938339036;2091.393495886191;2092.801183887528;2081.4067990622752;2131.870108842316;2137.6259154647873;2141.4111119442277;2142.9892850535803;7761.3402860756905;7841.21587841217;7885.1326354101;7959.920400796033;7966.960165199195;4473.619742321906;4598.816047358102;4598.8620341389815;4603.424571928509;4612.238980568202;2744.3962328287744;2812.985935070332;2843.6018957345987;2853.586229996639;2858.1854171561004;887.6005797391135;916.2990312411011;931.8928323242847;935.1536859142487;938.0525669074216;10490.58037678492;10500.842487362619;10523.579056837718;10583.94708026455;10635.308704934154;3932.9016774580864;4068.572799856032;4167.354060120686;4204.432401625802;4213.389058586549;9078.818423631623;9081.863772043425;9088.091190880992;9090.590923408463;9111.13444222811;4515.14212299662;4545.727256364628;4546.340780586863;4576.970181709155;4587.564181402761;3678.7240956928335;4053.412255223035;4122.196171746541;4136.544980052192;4213.0310028693575;3604.4953706481115;3644.908877278089;3684.6868016218923;3715.554133503997;3774.7168962327387;1179.3808250668467;1181.7931861924128;1191.4697959408154;1207.7946749052683;1210.2980271442543;738.4535443771571;837.4389159263308;845.8900342955376;861.4314552395514;874.2001069021774;5074.619403544749;5108.208227724708;5139.460356662571;5189.377274727057;5257.447967963385;413.39850517496967;414.10759812603885;426.8548693444244;427.4272474883671;432.2543612268811;3678.889633311005;3703.166787472797;3755.211405604799;3781.697464202912;3911.941320880189;9187.632494700138;9527.190188833889;9536.28477864163;9537.2370210383;9555.378900371454;9351.532423378803;9443.858342124873;9453.054694530492;9493.240540756722;9502.239820814319;6794.660266986631;7057.082579264663;7126.786196414116;7258.854822903512;7283.4537409694485;5274.578033757367;5542.612017158922;5552.305961754781;5613.57898157648;5621.634593751393;8487.618057187317;8675.82648347017;8762.737117886474;8776.824463510822;8895.866562001445;8402;8670.956645216733;8906.332025098272;8909.599068042084;8922.68770593052;5998.580099393001;6379.776707815204;6447.677616119269;6509.707063182073;6778;7225.205227425085;7277.854442911218;7302.780916572511;7307.7807665770115;7333.4866559340335;6319.8104056878365;6411.775587854403;6582.111414958919;6591.802245932629;6600.53796234259;6307.716152773228;6380.680965951777;6467.159269294962;6625.602463852184;6636.502262330441;5903.173555702291;5971;5972.074328479092;5990.071538911476;6002.489788367863;4392.890177745582;4481.663875209438;4523.7285762854335;4530.501644819134;4537.614302784168;4424.889377765581;4509.391232183613;4581.5647513486165;4629.652776041878;4730.408698912636 14:34:53 INFO - PROCESS | 18531 | |4;prototype.html;297.89275860690157;301.86265249311566;302.9227546975521;307.4696149142729;307.7353476010632;4986.850394488167;4992.226204938232;5010.79956801728;5014.874628134298;5025.572826309759;4916.901661966758;4928.802847886089;4930.2251189571725;4937.5556199942;4958.752062396875;3675.2649470105953;3763.1721021375392;3879.9612003880025;3881.165549406877;3901.590333015035;3896.4739760132443;3910.863119790808;3914.94127588085;3946;3948.6643635291034;3860.82626281818;3889.7860617666015;3890.727649064567;3899.7270191086636;3936.9370270027075;3825.7895815730126;3838.9424158637644;3874.6900247980093;3927.410888366739;3936.409538569223;3399.201187720884;3406.2165701888457;3410.437277849152;3414.6926776589976;3431.9313613727836;4820.035992801454;4852.660313778037;4853.174960256765;4861.319415281863;4870.707757534559;4343;4426.402435671175;4428.424304840382;4434.73391596502;4439.66702497314;5106.897862042739;5120.206368012964;5148.665336753099;5150.536451719326;5164.431912489623;3706.314331848617;3711.5175027246287;3723.255348930225;3723.9813800930824;3735.2902948439983;5418.783248670048;5420.214068960018;5420.322459692538;5423.566114710814;5430.83707488776;3663.9633603664156;3788.8673896413493;3826.732128750961;3828.2534905693124;3845.1732877431486;3878.1855810279594;3887.4168874669026;3892.96107038926;3896.941545876814;3900.90247743803;4436.3567282743825;4436.378906953029;4440.7335559866515;4443.555644435531;4450.777461126995;5013.944282844016;5184.662996905189;5255.5795536357;5265.26246338715;5267.367915850123;1337.6856438736888;1356.525216174331;1357.5248662968079;1358.5177262071822;1362.5571689200851;835.9926288821955;865.7230584887367;875.1205038935956;886.6877022007465;891.7235656946367;4368.759718215529;4464.821407143743;4634.983782054817;4651.767411629405;4667.556582124693;5364.088105022156;5389.838304850782;5405.864853378697;5412.107002344648;5420.159875219348;4651.162790697707;4661.603763680125;4674.135284972291;4676.485586585472;4686.976565117153;2708.2416923261517;2862.5706144078554;2865.9283517911804;2867.680866801295;2878.3955369372247;5122.206058061007;5139.691618502827;5154.407243167084;5171.5862730981435;5175.534201921845;5306.257124002643;5456.372517160577;5505.9724701376235;5536.916946245809;5557.221988921554;5068.214426763784;5107.259447380109;5121.539061484485;5128.025745067926;5138.563222126011;5406.405295417422;5448.583368324185;5454.754536045808;5456.399796022355;5466.234727138283;5029.5221953914315;5275.762590683352;5343.145096784496;5346.893062138814;5352.9732351338;5157.086246270845;5168.534831864999;5174.4566820484815;5185.455527169744;5203.19350500673;3769.509963704701;3805.105800137021;3805.7906815125434;3809.9522631276623;3814.5422549294262;5089;5298.145649022811;5373.489518495737;5513.338399392099;5514.393416724077;5239.554637855673;5261.736913154404;5267.604929630216;5281.392639846466;5281.735913204401;5244.213367994831;5292.306461932145;5301.522862942354;5308.389535203347;5333.226682131147;5058.215976523645;5118.513741194581;5151.433342332415;5177.378714554277;5182.8079541704865;5012.47369026247;5111.693298402108;5279;5290.867728306669;5306.336707911511;5100.566451851634;5107.872303192301;5111.207762796773;5126.871828204325;5159.896802063862 14:34:53 INFO - PROCESS | 18531 | |5;yui.html;589.2840199158022;645.425162603248;645.7191121861989;728.0026363881483;753.126373406848;12485.313307768069;13187.80218296724;13196.802047969277;13242.53651122211;13280.136791108594;12999.090063695545;13017.479300827956;13020.674483137926;13047.804282935764;13108.541201057966;627.8901192291354;750.0586763611674;754.8226166850814;770.7418014964993;778.4122987144698;765.4794739577086;766.0386215299791;766.3486036868672;766.9923300767005;767.9846403071936;813.1746277528314;815.7267315449332;818.2717381530442;819.4223072733708;823.5717426938019;807.8263173417685;810.2019510781904;810.440795850864;810.9107998120202;811.8416908702806;597.5846786483396;597.671280795565;599.8830228105521;600.2047287344243;601.7502736364404;12749.936250318782;12767.42546585406;12808.423620937081;12829;12829.101962862604;13111.934440327832;13218.933905330412;13283.402246898913;13528.458861645522;13849.723005539832;10339.379637221715;10450.425226612533;10602.787944241072;10631.229235880332;10659.626913058006;3237.2068843133584;3268.1339445047083;3272.8363581820813;3321.0701003718996;3341.248219150696;58647;60800.695996520175;61123.69438152781;62511.68744156296;66581.334186658;9152.771180720536;9384;9617.807643847224;9631.9036809631;9794.608215671293;17242.396516121877;17246.65506689859;17386.21762020712;17603;17608.295668173385;6690.29751876046;6846.246912839583;6851.417629501449;6981.406580440618;7005.334493223136;3768.4347347898033;3816.732828701964;3830.272248272819;3860.0542866997766;3884.8446062157764;2908.840013799261;3000.294930691286;3027.5610036545017;3032.3935212957495;3037.240689827543;519.9038177937093;520.7422325948679;523.2595876834313;523.9056969745407;528.3712382265169;497.5471622861254;565.7623798004848;586.9999999999915;605.4157737783061;616.6331033035336;7832.530048197126;8078.555679437687;8097.311728503143;8288.958555207186;8490.108538603357;553.8975289571442;564.0298686259626;601.3986013986014;602.1148911100674;603.7494439807431;3626.075350785533;3689.8524059037336;3863.265979463893;3971.582983786661;4031.113155105872;57914.93843243567;60547.69726151341;96907;105428;108345;85036.57481712676;86231.5688421554;90300;92214;92856;54466.72766636221;75617.62191189009;82086.58956705297;82205.17794821975;83230.58384707916;7270.418366530559;7403.740869069772;7435.194441420224;7538.585377804054;7635.694572217049;45428.77285613551;46423.76788116038;47644.7617761909;48169.5183048179;49348.25977610267;60597;62014;68546.31453685599;70938.64530677313;71079;9041.59312830911;9092.59083341238;9273.53632318395;9468.715938521855;9930.652427165014;11137.554497819996;11246.7750644985;11370.488328025423;11492.080633549464;11891.46488408041;9986.650467233612;10221.131203847755;10274.486275686037;10477.842832357368;10772.569097236335;9451.102145296185;9498.287628428034;9500.524973751146;9578.521073946136;9699.272554558294;9845.360051596623;9852.211823054282;10016.499175041074;10190.490475476048;10555;8154.83690326202;8164.714235001747;8201.876971845546;8582.957085214533;8730.17063378978;8827.602757875782;9117.77205569866;9122.133397327243;9164.404313719588;9164.541772911194 14:34:53 INFO - PROCESS | 18531 | __end_tp_report 14:34:53 INFO - PROCESS | 18531 | __start_cc_report 14:34:53 INFO - PROCESS | 18531 | _x_x_mozilla_cycle_collect,384 14:34:53 INFO - PROCESS | 18531 | __end_cc_report 14:34:53 INFO - PROCESS | 18531 | __startTimestamp1471556093317__endTimestamp 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | ------- Summary: start ------- 14:34:53 INFO - PROCESS | 18531 | Number of tests: 6 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | [#0] dojo.html Cycles:165 Average:4656.19 Median:4805.88 stddev:486.39 (10.1%) stddev-sans-first:460.59 14:34:53 INFO - PROCESS | 18531 | Values: 2608.2 2630.4 2631.3 2633.9 2644.3 4630.9 4673.0 4711.8 4762.1 4780.5 4595.7 4634.4 4669.9 4677.8 4720.6 4237.7 4284.2 4311.1 4351.6 4360.4 4354.7 4361.4 4397.7 4405.8 4436.9 4247.9 4251.4 4264.0 4269.4 4330.2 4308.6 4336.4 4356.3 4359.8 4367.1 4274.4 4291.2 4295.8 4309.2 4329.1 4592.0 4659.3 4687.2 4702.4 4725.5 4992.1 5004.7 5005.9 5011.3 5040.8 5049.5 5059.2 5061.7 5073.7 5081.6 4622.0 4637.2 4644.7 4669.7 4784.2 5126.4 5134.8 5135.9 5140.4 5200.8 4920.1 4935.6 4944.2 4954.9 4978.0 4889.6 5007.2 5013.1 5065.7 5078.8 5057.3 5059.8 5060.3 5094.0 5140.2 5036.9 5053.5 5055.1 5060.1 5063.2 4054.2 4217.1 4227.4 4261.4 4315.8 3734.6 3747.2 3747.4 3759.2 3795.1 4472.2 4477.5 4498.7 4502.6 4514.7 4919.9 4953.6 4960.8 4969.1 5037.0 4373.1 4393.0 4395.0 4400.0 4416.9 4473.9 4476.1 4484.1 4500.9 4511.6 4699.9 4805.9 4812.2 4816.7 4873.1 5084.7 5087.6 5105.5 5115.9 5146.3 4831.3 4848.6 4865.4 4871.6 4885.2 4866.2 4876.6 4884.5 4931.2 4997.3 5040.6 5053.0 5056.6 5063.5 5066.1 4886.3 4913.2 4921.2 4927.0 4980.0 4751.0 4823.7 4866.1 4896.5 4917.9 4781.1 4820.3 4854.5 4855.6 4856.3 4926.2 4954.1 4958.5 4960.2 4964.7 4650.9 4729.5 4763.9 4769.2 4859.6 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | [#1] ext.html Cycles:180 Average:47088.83 Median:36391.23 stddev:87052.40 (239.2%) stddev-sans-first:87226.47 14:34:53 INFO - PROCESS | 18531 | Values: 546.7 558.0 565.4 567.1 581.2 34417.0 38420.8 38473.6 38517.6 38525.0 39030.0 39455.0 39517.8 39550.8 39661.0 7616.8 7714.4 7755.9 7760.4 7781.9 7614.7 7615.5 7691.8 7699.8 7705.4 7679.5 7709.7 7711.1 7725.4 7732.9 7644.0 7658.1 7707.5 7715.0 7725.7 7646.5 7658.0 7697.5 7704.8 7709.6 36386.6 36604.5 36894.0 36937.1 36996.8 3054.7 3059.9 3116.0 3126.5 3338.1 28518.6 28658.7 28742.7 28973.6 30057.4 3215.9 3257.9 3261.6 3272.4 3288.4 249622.0 250860.0 251250.0 252394.7 253851.0 31368.2 51188.7 51217.2 51442.5 51482.2 31656.8 33055.9 33136.5 33175.0 33257.8 13459.3 13592.6 13602.0 13613.4 13625.4 10362.7 10397.6 10437.3 10438.2 10443.7 7641.5 7725.3 7845.8 7857.1 7913.8 2993.5 3030.9 3046.7 3071.6 3093.1 854.6 862.8 904.4 924.2 972.9 27413.2 28195.6 28430.1 28683.6 28795.3 922.3 966.6 989.9 997.2 1033.2 14453.8 14943.4 15133.4 15188.7 15447.8 386182.0 387306.0 390601.0 391193.0 392065.0 49084.5 49150.0 49437.0 49494.3 49610.5 1110.6 1131.1 1131.9 1138.2 1153.6 26441.0 27238.7 27447.0 28119.6 28156.6 42157.6 46958.0 48766.8 48778.5 52254.2 329149.0 333478.0 334397.0 335416.0 337670.0 37836.6 38032.0 38129.6 38341.2 38908.0 42162.0 42430.4 42475.0 42646.8 43348.6 35407.3 35895.0 36350.6 36395.8 36852.4 35137.5 35372.8 35415.1 35781.5 36478.8 34851.5 34889.8 34990.7 35019.5 35313.3 30831.8 32901.3 32901.3 32928.8 33324.3 25279.1 25355.7 25454.0 25618.7 25922.7 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | [#2] jquery.html Cycles:180 Average:23904.66 Median:4465.72 stddev:62528.71 (1400.2%) stddev-sans-first:62679.13 14:34:53 INFO - PROCESS | 18531 | Values: 360.0 365.1 367.4 373.7 384.7 15654.5 16133.6 16921.7 17179.5 17198.3 15466.0 15496.4 15765.6 15833.0 15857.0 4333.8 4597.7 4604.2 4636.0 4648.0 4611.4 4631.0 4632.5 4642.6 4648.9 4624.3 5198.8 5463.8 5495.1 5499.0 5345.9 5457.8 5483.5 5495.8 5496.4 5218.3 5330.4 5331.8 5335.2 5339.0 11875.0 11892.7 12097.9 12209.6 12328.1 1832.9 1847.4 1865.4 1976.3 2350.4 9016.5 9144.5 9261.7 9384.6 9624.8 1705.4 1715.7 1741.9 1744.2 1767.9 72388.0 72747.6 74096.3 75188.0 75473.6 9597.4 9919.6 9930.5 9988.7 10027.0 13815.4 13815.7 13828.4 13830.9 13858.6 6609.1 6865.6 6907.6 7090.8 7101.8 6393.2 6427.5 6586.7 6615.7 6649.3 3998.6 4136.3 4150.5 4167.4 4211.6 1767.4 1768.2 1823.5 1846.8 1871.6 822.1 845.4 878.3 880.7 931.8 16624.3 17153.7 17274.5 17654.2 18082.0 841.1 846.4 864.6 876.1 888.1 8572.1 9822.7 9990.8 9999.5 10088.9 365741.0 368284.0 374676.0 385771.0 388117.0 78623.2 79740.6 80643.0 82158.6 82637.6 832.8 856.7 870.4 872.6 874.3 14988.2 15267.3 15350.3 15426.6 16085.4 34941.5 36765.8 38455.8 39621.0 40581.2 49270.0 49898.5 51536.7 52310.5 52875.5 7080.9 7351.3 7373.2 7636.4 7874.2 11996.8 12065.8 12130.6 12218.9 12273.2 10391.7 10397.1 10399.7 10582.0 10843.2 10354.9 10552.2 10564.2 10710.7 10728.7 9946.6 10039.4 10245.4 10329.8 10715.4 7184.4 7283.9 7511.0 7557.7 7558.5 9958.6 10295.4 10566.8 10744.8 11030.6 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | [#3] mootools.html Cycles:180 Average:5052.34 Median:5091.41 stddev:2837.23 (55.7%) stddev-sans-first:2831.55 14:34:53 INFO - PROCESS | 18531 | Values: 1350.2 1387.4 1436.3 1625.6 1639.9 6619.9 7375.7 7423.3 8034.4 8037.3 7490.3 7811.0 7820.5 7845.2 7870.4 2154.5 2173.0 2184.1 2186.0 2188.5 2145.7 2181.9 2191.1 2216.0 2220.0 2172.7 2183.4 2185.0 2191.6 2192.0 2070.9 2080.3 2090.9 2091.4 2092.8 2081.4 2131.9 2137.6 2141.4 2143.0 7761.3 7841.2 7885.1 7959.9 7967.0 4473.6 4598.8 4598.9 4603.4 4612.2 2744.4 2813.0 2843.6 2853.6 2858.2 887.6 916.3 931.9 935.2 938.1 10490.6 10500.8 10523.6 10583.9 10635.3 3932.9 4068.6 4167.4 4204.4 4213.4 9078.8 9081.9 9088.1 9090.6 9111.1 4515.1 4545.7 4546.3 4577.0 4587.6 3678.7 4053.4 4122.2 4136.5 4213.0 3604.5 3644.9 3684.7 3715.6 3774.7 1179.4 1181.8 1191.5 1207.8 1210.3 738.5 837.4 845.9 861.4 874.2 5074.6 5108.2 5139.5 5189.4 5257.4 413.4 414.1 426.9 427.4 432.3 3678.9 3703.2 3755.2 3781.7 3911.9 9187.6 9527.2 9536.3 9537.2 9555.4 9351.5 9443.9 9453.1 9493.2 9502.2 6794.7 7057.1 7126.8 7258.9 7283.5 5274.6 5542.6 5552.3 5613.6 5621.6 8487.6 8675.8 8762.7 8776.8 8895.9 8402.0 8671.0 8906.3 8909.6 8922.7 5998.6 6379.8 6447.7 6509.7 6778.0 7225.2 7277.9 7302.8 7307.8 7333.5 6319.8 6411.8 6582.1 6591.8 6600.5 6307.7 6380.7 6467.2 6625.6 6636.5 5903.2 5971.0 5972.1 5990.1 6002.5 4392.9 4481.7 4523.7 4530.5 4537.6 4424.9 4509.4 4581.6 4629.7 4730.4 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | [#4] prototype.html Cycles:180 Average:4348.45 Median:4989.54 stddev:1267.58 (25.4%) stddev-sans-first:1234.14 14:34:53 INFO - PROCESS | 18531 | Values: 297.9 301.9 302.9 307.5 307.7 4986.9 4992.2 5010.8 5014.9 5025.6 4916.9 4928.8 4930.2 4937.6 4958.8 3675.3 3763.2 3880.0 3881.2 3901.6 3896.5 3910.9 3914.9 3946.0 3948.7 3860.8 3889.8 3890.7 3899.7 3936.9 3825.8 3838.9 3874.7 3927.4 3936.4 3399.2 3406.2 3410.4 3414.7 3431.9 4820.0 4852.7 4853.2 4861.3 4870.7 4343.0 4426.4 4428.4 4434.7 4439.7 5106.9 5120.2 5148.7 5150.5 5164.4 3706.3 3711.5 3723.3 3724.0 3735.3 5418.8 5420.2 5420.3 5423.6 5430.8 3664.0 3788.9 3826.7 3828.3 3845.2 3878.2 3887.4 3893.0 3896.9 3900.9 4436.4 4436.4 4440.7 4443.6 4450.8 5013.9 5184.7 5255.6 5265.3 5267.4 1337.7 1356.5 1357.5 1358.5 1362.6 836.0 865.7 875.1 886.7 891.7 4368.8 4464.8 4635.0 4651.8 4667.6 5364.1 5389.8 5405.9 5412.1 5420.2 4651.2 4661.6 4674.1 4676.5 4687.0 2708.2 2862.6 2865.9 2867.7 2878.4 5122.2 5139.7 5154.4 5171.6 5175.5 5306.3 5456.4 5506.0 5536.9 5557.2 5068.2 5107.3 5121.5 5128.0 5138.6 5406.4 5448.6 5454.8 5456.4 5466.2 5029.5 5275.8 5343.1 5346.9 5353.0 5157.1 5168.5 5174.5 5185.5 5203.2 3769.5 3805.1 3805.8 3810.0 3814.5 5089.0 5298.1 5373.5 5513.3 5514.4 5239.6 5261.7 5267.6 5281.4 5281.7 5244.2 5292.3 5301.5 5308.4 5333.2 5058.2 5118.5 5151.4 5177.4 5182.8 5012.5 5111.7 5279.0 5290.9 5306.3 5100.6 5107.9 5111.2 5126.9 5159.9 14:34:53 INFO - PROCESS | 18531 | 14:34:53 INFO - PROCESS | 18531 | [#5] yui.html Cycles:180 Average:17421.75 Median:604.58 stddev:25551.21 (4226.3%) stddev-sans-first:25591.63 14:34:53 INFO - PROCESS | 18531 | Values: 589.3 645.4 645.7 728.0 753.1 12485.3 13187.8 13196.8 13242.5 13280.1 12999.1 13017.5 13020.7 13047.8 13108.5 627.9 750.1 754.8 770.7 778.4 765.5 766.0 766.3 767.0 768.0 813.2 815.7 818.3 819.4 823.6 807.8 810.2 810.4 810.9 811.8 597.6 597.7 599.9 600.2 601.8 12749.9 12767.4 12808.4 12829.0 12829.1 13111.9 13218.9 13283.4 13528.5 13849.7 10339.4 10450.4 10602.8 10631.2 10659.6 3237.2 3268.1 3272.8 3321.1 3341.2 58647.0 60800.7 61123.7 62511.7 66581.3 9152.8 9384.0 9617.8 9631.9 9794.6 17242.4 17246.7 17386.2 17603.0 17608.3 6690.3 6846.2 6851.4 6981.4 7005.3 3768.4 3816.7 3830.3 3860.1 3884.8 2908.8 3000.3 3027.6 3032.4 3037.2 519.9 520.7 523.3 523.9 528.4 497.5 565.8 587.0 605.4 616.6 7832.5 8078.6 8097.3 8289.0 8490.1 553.9 564.0 601.4 602.1 603.7 3626.1 3689.9 3863.3 3971.6 4031.1 57914.9 60547.7 96907.0 105428.0 108345.0 85036.6 86231.6 90300.0 92214.0 92856.0 54466.7 75617.6 82086.6 82205.2 83230.6 7270.4 7403.7 7435.2 7538.6 7635.7 45428.8 46423.8 47644.8 48169.5 49348.3 60597.0 62014.0 68546.3 70938.6 71079.0 9041.6 9092.6 9273.5 9468.7 9930.7 11137.6 11246.8 11370.5 11492.1 11891.5 9986.7 10221.1 10274.5 10477.8 10772.6 9451.1 9498.3 9500.5 9578.5 9699.3 9845.4 9852.2 10016.5 10190.5 10555.0 8154.8 8164.7 8201.9 8583.0 8730.2 8827.6 9117.8 9122.1 9164.4 9164.5 14:34:53 INFO - PROCESS | 18531 | -------- Summary: end -------- 14:34:53 INFO - PROCESS | 18531 | 14:34:54 INFO - TEST-INFO | 18531: exit 0 14:34:54 INFO - TEST-OK | dromaeo_css | took 1117386ms 14:34:54 INFO - TEST-START | kraken 14:34:54 INFO - operating with platform_type : linux_ 14:34:54 INFO - Initialising browser for kraken test... 14:34:54 INFO - TEST-INFO | started process 18890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzgh8es/profile http://localhost:34490/getInfo.html) 14:34:58 INFO - PROCESS | 18890 | __metrics Screen width/height:1600/1200 14:34:58 INFO - PROCESS | 18890 | colorDepth:24 14:34:58 INFO - PROCESS | 18890 | Browser inner width/height: 1024/697 14:34:58 INFO - PROCESS | 18890 | __metrics 14:34:59 ERROR - PROCESS | 18890 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2980: TypeError: this.tabs is undefined 14:34:59 INFO - TEST-INFO | 18890: exit 0 14:34:59 INFO - Browser initialized. 14:34:59 INFO - Running cycle 1/1 for kraken test... 14:34:59 INFO - TEST-INFO | started process 19010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzgh8es/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:11 INFO - PROCESS | 19010 | RSS: Main: 164294656 14:35:11 INFO - PROCESS | 19010 | 14:35:14 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34490/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:15 INFO - PROCESS | 19010 | RSS: Main: 168992768 14:35:15 INFO - PROCESS | 19010 | 14:35:18 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34490/tests/kraken/driver.html?testName=audio-dft) 14:35:18 INFO - PROCESS | 19010 | RSS: Main: 168620032 14:35:18 INFO - PROCESS | 19010 | 14:35:22 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34490/tests/kraken/driver.html?testName=audio-fft) 14:35:22 INFO - PROCESS | 19010 | RSS: Main: 164315136 14:35:22 INFO - PROCESS | 19010 | 14:35:24 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34490/tests/kraken/driver.html?testName=audio-oscillator) 14:35:25 INFO - PROCESS | 19010 | RSS: Main: 164970496 14:35:25 INFO - PROCESS | 19010 | 14:35:27 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:28 INFO - PROCESS | 19010 | RSS: Main: 165265408 14:35:28 INFO - PROCESS | 19010 | 14:35:31 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34490/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:32 INFO - PROCESS | 19010 | RSS: Main: 165335040 14:35:32 INFO - PROCESS | 19010 | 14:35:35 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34490/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:36 INFO - PROCESS | 19010 | RSS: Main: 163086336 14:35:36 INFO - PROCESS | 19010 | 14:35:39 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34490/tests/kraken/driver.html?testName=json-parse-financial) 14:35:39 INFO - PROCESS | 19010 | RSS: Main: 164552704 14:35:39 INFO - PROCESS | 19010 | 14:35:41 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:42 INFO - PROCESS | 19010 | RSS: Main: 164667392 14:35:42 INFO - PROCESS | 19010 | 14:35:44 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:44 INFO - PROCESS | 19010 | RSS: Main: 165036032 14:35:44 INFO - PROCESS | 19010 | 14:35:47 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:47 INFO - PROCESS | 19010 | RSS: Main: 166182912 14:35:47 INFO - PROCESS | 19010 | 14:35:50 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:51 INFO - PROCESS | 19010 | RSS: Main: 166133760 14:35:51 INFO - PROCESS | 19010 | 14:35:54 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:54 INFO - PROCESS | 19010 | RSS: Main: 166137856 14:35:54 INFO - PROCESS | 19010 | 14:35:56 INFO - PROCESS | 19010 | Cycle 1(1): loaded http://localhost:34490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34490/tests/kraken/driver.html?testName=ai-astar) 14:35:56 INFO - PROCESS | 19010 | RSS: Main: 167034880 14:35:56 INFO - PROCESS | 19010 | 14:35:56 INFO - PROCESS | 19010 | __start_tp_report 14:35:56 INFO - PROCESS | 19010 | _x_x_mozilla_page_load 14:35:56 INFO - PROCESS | 19010 | _x_x_mozilla_page_load_details 14:35:56 INFO - PROCESS | 19010 | |i|pagename|runs| 14:35:56 INFO - PROCESS | 19010 | |0;ai-astar;106;115;109;115;117;115;120;113;114;116 14:35:56 INFO - PROCESS | 19010 | |1;audio-beat-detection;160;129;147;181;127;155;151;129;198;127 14:35:56 INFO - PROCESS | 19010 | |2;audio-dft;164;166;165;170;163;163;164;164;164;169 14:35:56 INFO - PROCESS | 19010 | |3;audio-fft;76;75;77;177;78;75;76;77;158;78 14:35:56 INFO - PROCESS | 19010 | |4;audio-oscillator;88;87;139;87;86;87;137;87;86;141 14:35:56 INFO - PROCESS | 19010 | |5;imaging-gaussian-blur;117;118;118;118;118;118;119;117;118;118 14:35:56 INFO - PROCESS | 19010 | |6;imaging-darkroom;148;148;147;148;149;149;148;148;147;147 14:35:56 INFO - PROCESS | 19010 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;100 14:35:56 INFO - PROCESS | 19010 | |8;json-parse-financial;65;65;70;66;66;77;66;66;70;69 14:35:56 INFO - PROCESS | 19010 | |9;json-stringify-tinderbox;65;66;66;65;67;66;65;66;67;66 14:35:56 INFO - PROCESS | 19010 | |10;stanford-crypto-aes;91;89;86;83;83;82;88;84;83;85 14:35:56 INFO - PROCESS | 19010 | |11;stanford-crypto-ccm;135;139;144;142;133;135;148;142;161;137 14:35:56 INFO - PROCESS | 19010 | |12;stanford-crypto-pbkdf2;172;175;178;176;172;172;173;178;172;172 14:35:56 INFO - PROCESS | 19010 | |13;stanford-crypto-sha256-iterative;69;72;70;71;71;69;68;68;68;70 14:35:56 INFO - PROCESS | 19010 | __end_tp_report 14:35:56 INFO - PROCESS | 19010 | __start_cc_report 14:35:56 INFO - PROCESS | 19010 | _x_x_mozilla_cycle_collect,930 14:35:57 INFO - PROCESS | 19010 | __end_cc_report 14:35:57 INFO - PROCESS | 19010 | __startTimestamp1471556156993__endTimestamp 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | ------- Summary: start ------- 14:35:57 INFO - PROCESS | 19010 | Number of tests: 14 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.97 (3.5%) stddev-sans-first:2.98 14:35:57 INFO - PROCESS | 19010 | Values: 106.0 115.0 109.0 115.0 117.0 115.0 120.0 113.0 114.0 116.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:153.00 stddev:24.35 (15.9%) stddev-sans-first:25.58 14:35:57 INFO - PROCESS | 19010 | Values: 160.0 129.0 147.0 181.0 127.0 155.0 151.0 129.0 198.0 127.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:2.44 (1.5%) stddev-sans-first:2.55 14:35:57 INFO - PROCESS | 19010 | Values: 164.0 166.0 165.0 170.0 163.0 163.0 164.0 164.0 164.0 169.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.50 stddev:38.64 (50.5%) stddev-sans-first:40.39 14:35:57 INFO - PROCESS | 19010 | Values: 76.0 75.0 77.0 177.0 78.0 75.0 76.0 77.0 158.0 78.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:87.00 stddev:25.21 (29.0%) stddev-sans-first:26.19 14:35:57 INFO - PROCESS | 19010 | Values: 88.0 87.0 139.0 87.0 86.0 87.0 137.0 87.0 86.0 141.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 14:35:57 INFO - PROCESS | 19010 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 119.0 117.0 118.0 118.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:35:57 INFO - PROCESS | 19010 | Values: 148.0 148.0 147.0 148.0 149.0 149.0 148.0 148.0 147.0 147.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 14:35:57 INFO - PROCESS | 19010 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 100.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.50 stddev:3.71 (5.5%) stddev-sans-first:3.77 14:35:57 INFO - PROCESS | 19010 | Values: 65.0 65.0 70.0 66.0 66.0 77.0 66.0 66.0 70.0 69.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 14:35:57 INFO - PROCESS | 19010 | Values: 65.0 66.0 66.0 65.0 67.0 66.0 65.0 66.0 67.0 66.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:3.03 (3.5%) stddev-sans-first:2.44 14:35:57 INFO - PROCESS | 19010 | Values: 91.0 89.0 86.0 83.0 83.0 82.0 88.0 84.0 83.0 85.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:142.00 stddev:8.25 (5.8%) stddev-sans-first:8.40 14:35:57 INFO - PROCESS | 19010 | Values: 135.0 139.0 144.0 142.0 133.0 135.0 148.0 142.0 161.0 137.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.00 stddev:2.54 (1.5%) stddev-sans-first:2.59 14:35:57 INFO - PROCESS | 19010 | Values: 172.0 175.0 178.0 176.0 172.0 172.0 173.0 178.0 172.0 172.0 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - PROCESS | 19010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.43 (2.0%) stddev-sans-first:1.50 14:35:57 INFO - PROCESS | 19010 | Values: 69.0 72.0 70.0 71.0 71.0 69.0 68.0 68.0 68.0 70.0 14:35:57 INFO - PROCESS | 19010 | -------- Summary: end -------- 14:35:57 INFO - PROCESS | 19010 | 14:35:57 INFO - TEST-INFO | 19010: exit 0 14:35:58 INFO - TEST-OK | kraken | took 63861ms 14:35:58 INFO - SUITE-END | took 1181s 14:35:58 INFO - Completed test suite (00:19:41) 14:35:58 INFO - javascript benchmark 14:35:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6281.602052209478, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.1653870761356, 2630.4344565918323, 2631.250093723288, 2633.920982370529, 2644.2860427684514, 4630.884227894304, 4673.018666080123, 4711.835085771999, 4762.1428142934255, 4780.4741478437345, 4595.678302518825, 4634.374359461472, 4669.9066018679605, 4677.789499472523, 4720.575148236658, 4237.6609871210385, 4284.228838809013, 4311.137772445508, 4351.608355248027, 4360.411344468504, 4354.695171338008, 4361.433013708213, 4397.736135831844, 4405.845795397177, 4436.911261774762, 4247.936280955788, 4251.447311849471, 4263.97868010661, 4269.402283680287, 4330.242207613686, 4308.569143085698, 4336.414584031147, 4356.346548017791, 4359.80380882861, 4367.061081867382, 4274.422952901349, 4291.249031419489, 4295.806688699016, 4309.224339618867, 4329.134173165379, 4591.977040114812, 4659.277811939155, 4687.22660760974, 4702.412198475191, 4725.480197178307, 4992.076465853828, 5004.749762511859, 5005.874853128665, 5011.348524691767, 5040.7731652075745, 5049.5455409013, 5059.241113832954, 5061.6962982221185, 5073.695578265316, 5081.59347252219, 4621.976890115528, 4637.211674015425, 4644.744539050317, 4669.696469729457, 4784.186688263004, 5126.359205099363, 5134.820281290212, 5135.948640513622, 5140.357455318085, 5200.765965531485, 4920.089783390084, 4935.580475659537, 4944.159492886218, 4954.9009019819405, 4977.9751101244265, 4889.584385327287, 5007.198848184273, 5013.147764879979, 5065.721385323769, 5078.771455284521, 5057.31726216956, 5059.772310246048, 5060.316857224301, 5094.0, 5140.177571588528, 5036.874078148076, 5053.494650534991, 5055.090083784954, 5060.114479966065, 5063.215201643678, 4054.189162167578, 4217.0511634881905, 4227.42929704486, 4261.403403523509, 4315.784210789448, 3734.5705243896755, 3747.194353214072, 3747.362948298796, 3759.2105657811617, 3795.070207799107, 4472.239719247736, 4477.507474177838, 4498.6626003049905, 4502.594766471033, 4514.6614003949835, 4919.926201106986, 4953.628477864175, 4960.751962401865, 4969.055879382906, 5037.0, 4373.147236288957, 4393.033532622818, 4394.978025109854, 4399.978000109979, 4416.889577760582, 4473.932891006638, 4476.082403107355, 4484.080763443486, 4500.8649740507835, 4511.616512596466, 4699.882502937386, 4805.879853003703, 4812.230043193073, 4816.710997340241, 4873.1471992400475, 5084.720340381315, 5087.618428617794, 5105.540501354896, 5115.897682046412, 5146.279520867157, 4831.299461577981, 4848.5636292733825, 4865.416150062015, 4871.585915197106, 4885.2427873679635, 4866.221404575251, 4876.634252431011, 4884.535969082932, 4931.211006238985, 4997.300377947163, 5040.596752259884, 5053.0, 5056.64603477753, 5063.518965698253, 5066.113430149783, 4886.29148773433, 4913.213885778401, 4921.237208232729, 4926.975365123151, 4980.0, 4751.00228951924, 4823.710577365369, 4866.099771542276, 4896.510348965075, 4917.877053073702, 4781.13939490895, 4820.25286080658, 4854.538818812207, 4855.562999330077, 4856.320115183948, 4926.187179115406, 4954.083494553519, 4958.504149585013, 4960.181570040902, 4964.702117872939, 4650.906981860411, 4729.527047295243, 4763.928541071956, 4769.213079841926, 4859.562639362474], "value": 4625.134488124527, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.6829239041354, 557.9721013949303, 565.4091474409244, 567.0700051914861, 581.1544203184367, 34417.0, 38420.80789596052, 38473.61526384735, 38517.614823851756, 38525.0, 39030.0, 39455.0, 39517.80241098798, 39550.8022459888, 39661.0, 7616.771496855104, 7714.382849372037, 7755.922440775605, 7760.417968652346, 7781.922180778205, 7614.695412183506, 7615.47690461907, 7691.769246922573, 7699.769006929801, 7705.422093342993, 7679.500832445873, 7709.653065612033, 7711.074671039483, 7725.420593455485, 7732.884006739903, 7644.006279183698, 7658.081030276347, 7707.460477766558, 7714.961425192894, 7725.690972361099, 7646.464747467679, 7657.961710191469, 7697.461177717562, 7704.845903081963, 7709.614519274014, 36386.63613363859, 36604.450933236025, 36894.0, 36937.07657308562, 36996.815015925014, 3054.7403470704794, 3059.938801223985, 3115.9532607010915, 3126.45287074761, 3338.065341704327, 28518.572221416696, 28658.713412866022, 28742.71257287442, 28973.565396518858, 30057.398852022838, 3215.935681286361, 3257.9022629321157, 3261.641219465857, 3272.378248132847, 3288.391647545212, 249622.0, 250860.0, 251250.0, 252394.73802631052, 253851.0, 31368.215794605316, 51188.74405627948, 51217.23174152391, 51442.48557514377, 51482.22776658353, 31656.841715791274, 33055.876339167466, 33136.50295245525, 33175.0, 33257.83371083129, 13459.327033648278, 13592.592222233348, 13601.979851511176, 13613.387397567134, 13625.386857591433, 10362.689119326282, 10397.58409663605, 10437.32157409766, 10438.164946804238, 10443.68668939933, 7641.503302285334, 7725.343345815669, 7845.764627061198, 7857.1357150713375, 7913.841723165505, 2993.491106511898, 3030.9393812123635, 3046.7257946784894, 3071.600691910082, 3093.1184612385364, 854.6026097864523, 862.8101817600118, 904.371461834019, 924.2236521322121, 972.8686627305365, 27413.17760467189, 28195.57706634402, 28430.14709558675, 28683.56974645382, 28795.28011799722, 922.3267015078895, 966.6181858165985, 989.9109080182674, 997.152420442618, 1033.1579762493693, 14453.771429428407, 14943.40226390954, 15133.394664213529, 15188.696226075417, 15447.845521544865, 386182.0, 387306.0, 390601.0, 391193.0, 392065.0, 49084.50915490871, 49150.0, 49437.0, 49494.257586136235, 49610.50389496059, 1110.6057349640923, 1131.0725205331714, 1131.937743424103, 1138.2146319039837, 1153.55011545499, 26441.0, 27238.72761272362, 27447.0, 28119.57820632651, 28156.577651334836, 42157.57842421537, 46958.0, 48766.75616621894, 48778.512214878814, 52254.21618675799, 329149.0, 333478.0, 334397.0, 335416.0, 337670.0, 37836.62163378331, 38032.0, 38129.61870381261, 38341.23317533689, 38908.0, 42162.0, 42430.36354454624, 42475.0, 42646.78676606597, 43348.56651433571, 35407.29185416329, 35895.0, 36350.63649363472, 36395.81802091079, 36852.447213291285, 35137.47293790647, 35372.823135885184, 35415.11462213465, 35781.46327805137, 36478.8176059118, 34851.47722784211, 34889.82555087208, 34990.65009349976, 35019.47470787889, 35313.29373412466, 30831.845840770653, 32901.34197315992, 32901.34197315992, 32928.83535582307, 33324.333513330086, 25279.11523096683, 25355.74644253534, 25454.0, 25618.743812561635, 25922.74077259203], "value": 16528.70126295322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.9982000089999, 365.1164182677919, 367.42131143449063, 373.6506366547277, 384.7326108354695, 15654.452094176706, 16133.596660083504, 16921.661566768656, 17179.484615461526, 17198.312067517316, 15466.0, 15496.380144794195, 15765.60585985351, 15833.0, 15857.0, 4333.783310834454, 4597.655175861807, 4604.171249175147, 4635.953640463603, 4647.953520464803, 4611.4005179326805, 4631.0, 4632.467266264389, 4642.558956899089, 4648.930266046012, 4624.28323609841, 5198.7660555274915, 5463.7814487420455, 5495.148252020923, 5499.037668408033, 5345.893082138336, 5457.808976685817, 5483.533899618497, 5495.752691128889, 5496.395396506361, 5218.295530103425, 5330.440303768126, 5331.760070796823, 5335.1730481775385, 5338.973305133488, 11875.0, 11892.702682432922, 12097.879021209763, 12209.633710988684, 12328.07539434546, 1832.9266829326812, 1847.3811273223487, 1865.3657756362902, 1976.2885361269932, 2350.447644803487, 9016.549172541412, 9144.4970526621, 9261.72214833556, 9384.577694003787, 9624.759381015461, 1705.360489816319, 1715.6911755883937, 1741.8867773594675, 1744.2295322293517, 1767.920443580042, 72388.0, 72747.63626181889, 74096.25903740947, 75188.0, 75473.6226318865, 9597.376170548892, 9919.553620087114, 9930.453825039547, 9988.650397236062, 10027.0, 13815.447382104603, 13815.654608634664, 13828.37772300249, 13830.930845345709, 13858.584242472742, 6609.1408116944485, 6865.588064716133, 6907.551009184387, 7090.787276381717, 7101.82245443868, 6393.232812062489, 6427.517936154807, 6586.736530538725, 6615.702293396808, 6649.268580456146, 3998.5601583825755, 4136.276151673505, 4150.501939767248, 4167.374893765898, 4211.642010429086, 1767.4432553745787, 1768.2308195934809, 1823.4529641107615, 1846.796852346241, 1871.5882505848692, 822.0915887943736, 845.4251109245649, 878.2929741558107, 880.6946379779743, 931.7763736703142, 16624.33502659904, 17153.656926861393, 17274.49519819619, 17654.205560749797, 18082.0, 841.1252297610416, 846.4075147396724, 864.5849992003873, 876.1370050500252, 888.0542222532981, 8572.096191229024, 9822.705318840446, 9990.80018399628, 9999.50002499872, 10088.949555252177, 365741.0, 368284.0, 374676.0, 385771.0, 388117.0, 78623.21376786273, 79740.60129699315, 80643.0, 82158.58920705358, 82637.58681206555, 832.820943497151, 856.7130011446111, 870.4124715816924, 872.5898827551041, 874.3267683883374, 14988.1756503389, 15267.312970916113, 15350.30923608418, 15426.614334641723, 16085.437009704605, 34941.47587786135, 36765.81617091897, 38455.80772096122, 39621.0, 40581.18837623172, 49270.0, 49898.501014989386, 51536.74231628968, 52310.47689523056, 52875.47124528705, 7080.8937865933085, 7351.338379545867, 7373.152087510005, 7636.434530921259, 7874.173211812907, 11996.820047699466, 12065.758684826429, 12130.636080917586, 12218.938905305416, 12273.202241854251, 10391.688249352532, 10397.116245118947, 10399.740006499595, 10582.042322170422, 10843.1867609928, 10354.948225258826, 10552.20858435605, 10564.154867610727, 10710.678679639623, 10728.678139655824, 9946.552405141641, 10039.397636141855, 10245.385276883411, 10329.845052324372, 10715.410652414192, 7184.425245980414, 7283.927160728537, 7511.0, 7557.659905304165, 7558.546487210565, 9958.55186516623, 10295.3822770634, 10566.788664226826, 10744.785104298027, 11030.558777649125], "value": 8004.95042487793, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.2371160294435, 1387.431153227177, 1436.303392854466, 1625.634232297734, 1639.8524132828043, 6619.867602647944, 7375.741849035285, 7423.331900128987, 8034.437589368747, 8037.316828069621, 7490.250974902507, 7810.9609451952665, 7820.45256832022, 7845.176256493058, 7870.449068565203, 2154.515234072333, 2172.9674054889188, 2184.137265780016, 2186.0272178880405, 2188.4638263625434, 2145.710329105574, 2181.8581792183536, 2191.145453273217, 2215.9556808863813, 2219.966700499494, 2172.663237198237, 2183.4323076000273, 2184.9890750546306, 2191.638379667353, 2191.9561608767817, 2070.9482262943397, 2080.2823026055985, 2090.8640938339036, 2091.393495886191, 2092.801183887528, 2081.4067990622752, 2131.870108842316, 2137.6259154647873, 2141.4111119442277, 2142.9892850535803, 7761.3402860756905, 7841.21587841217, 7885.1326354101, 7959.920400796033, 7966.960165199195, 4473.619742321906, 4598.816047358102, 4598.8620341389815, 4603.424571928509, 4612.238980568202, 2744.3962328287744, 2812.985935070332, 2843.6018957345987, 2853.586229996639, 2858.1854171561004, 887.6005797391135, 916.2990312411011, 931.8928323242847, 935.1536859142487, 938.0525669074216, 10490.58037678492, 10500.842487362619, 10523.579056837718, 10583.94708026455, 10635.308704934154, 3932.9016774580864, 4068.572799856032, 4167.354060120686, 4204.432401625802, 4213.389058586549, 9078.818423631623, 9081.863772043425, 9088.091190880992, 9090.590923408463, 9111.13444222811, 4515.14212299662, 4545.727256364628, 4546.340780586863, 4576.970181709155, 4587.564181402761, 3678.7240956928335, 4053.412255223035, 4122.196171746541, 4136.544980052192, 4213.0310028693575, 3604.4953706481115, 3644.908877278089, 3684.6868016218923, 3715.554133503997, 3774.7168962327387, 1179.3808250668467, 1181.7931861924128, 1191.4697959408154, 1207.7946749052683, 1210.2980271442543, 738.4535443771571, 837.4389159263308, 845.8900342955376, 861.4314552395514, 874.2001069021774, 5074.619403544749, 5108.208227724708, 5139.460356662571, 5189.377274727057, 5257.447967963385, 413.39850517496967, 414.10759812603885, 426.8548693444244, 427.4272474883671, 432.2543612268811, 3678.889633311005, 3703.166787472797, 3755.211405604799, 3781.697464202912, 3911.941320880189, 9187.632494700138, 9527.190188833889, 9536.28477864163, 9537.2370210383, 9555.378900371454, 9351.532423378803, 9443.858342124873, 9453.054694530492, 9493.240540756722, 9502.239820814319, 6794.660266986631, 7057.082579264663, 7126.786196414116, 7258.854822903512, 7283.4537409694485, 5274.578033757367, 5542.612017158922, 5552.305961754781, 5613.57898157648, 5621.634593751393, 8487.618057187317, 8675.82648347017, 8762.737117886474, 8776.824463510822, 8895.866562001445, 8402.0, 8670.956645216733, 8906.332025098272, 8909.599068042084, 8922.68770593052, 5998.580099393001, 6379.776707815204, 6447.677616119269, 6509.707063182073, 6778.0, 7225.205227425085, 7277.854442911218, 7302.780916572511, 7307.7807665770115, 7333.4866559340335, 6319.8104056878365, 6411.775587854403, 6582.111414958919, 6591.802245932629, 6600.53796234259, 6307.716152773228, 6380.680965951777, 6467.159269294962, 6625.602463852184, 6636.502262330441, 5903.173555702291, 5971.0, 5972.074328479092, 5990.071538911476, 6002.489788367863, 4392.890177745582, 4481.663875209438, 4523.7285762854335, 4530.501644819134, 4537.614302784168, 4424.889377765581, 4509.391232183613, 4581.5647513486165, 4629.652776041878, 4730.408698912636], "value": 4013.824435222813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.89275860690157, 301.86265249311566, 302.9227546975521, 307.4696149142729, 307.7353476010632, 4986.850394488167, 4992.226204938232, 5010.79956801728, 5014.874628134298, 5025.572826309759, 4916.901661966758, 4928.802847886089, 4930.2251189571725, 4937.5556199942, 4958.752062396875, 3675.2649470105953, 3763.1721021375392, 3879.9612003880025, 3881.165549406877, 3901.590333015035, 3896.4739760132443, 3910.863119790808, 3914.94127588085, 3946.0, 3948.6643635291034, 3860.82626281818, 3889.7860617666015, 3890.727649064567, 3899.7270191086636, 3936.9370270027075, 3825.7895815730126, 3838.9424158637644, 3874.6900247980093, 3927.410888366739, 3936.409538569223, 3399.201187720884, 3406.2165701888457, 3410.437277849152, 3414.6926776589976, 3431.9313613727836, 4820.035992801454, 4852.660313778037, 4853.174960256765, 4861.319415281863, 4870.707757534559, 4343.0, 4426.402435671175, 4428.424304840382, 4434.73391596502, 4439.66702497314, 5106.897862042739, 5120.206368012964, 5148.665336753099, 5150.536451719326, 5164.431912489623, 3706.314331848617, 3711.5175027246287, 3723.255348930225, 3723.9813800930824, 3735.2902948439983, 5418.783248670048, 5420.214068960018, 5420.322459692538, 5423.566114710814, 5430.83707488776, 3663.9633603664156, 3788.8673896413493, 3826.732128750961, 3828.2534905693124, 3845.1732877431486, 3878.1855810279594, 3887.4168874669026, 3892.96107038926, 3896.941545876814, 3900.90247743803, 4436.3567282743825, 4436.378906953029, 4440.7335559866515, 4443.555644435531, 4450.777461126995, 5013.944282844016, 5184.662996905189, 5255.5795536357, 5265.26246338715, 5267.367915850123, 1337.6856438736888, 1356.525216174331, 1357.5248662968079, 1358.5177262071822, 1362.5571689200851, 835.9926288821955, 865.7230584887367, 875.1205038935956, 886.6877022007465, 891.7235656946367, 4368.759718215529, 4464.821407143743, 4634.983782054817, 4651.767411629405, 4667.556582124693, 5364.088105022156, 5389.838304850782, 5405.864853378697, 5412.107002344648, 5420.159875219348, 4651.162790697707, 4661.603763680125, 4674.135284972291, 4676.485586585472, 4686.976565117153, 2708.2416923261517, 2862.5706144078554, 2865.9283517911804, 2867.680866801295, 2878.3955369372247, 5122.206058061007, 5139.691618502827, 5154.407243167084, 5171.5862730981435, 5175.534201921845, 5306.257124002643, 5456.372517160577, 5505.9724701376235, 5536.916946245809, 5557.221988921554, 5068.214426763784, 5107.259447380109, 5121.539061484485, 5128.025745067926, 5138.563222126011, 5406.405295417422, 5448.583368324185, 5454.754536045808, 5456.399796022355, 5466.234727138283, 5029.5221953914315, 5275.762590683352, 5343.145096784496, 5346.893062138814, 5352.9732351338, 5157.086246270845, 5168.534831864999, 5174.4566820484815, 5185.455527169744, 5203.19350500673, 3769.509963704701, 3805.105800137021, 3805.7906815125434, 3809.9522631276623, 3814.5422549294262, 5089.0, 5298.145649022811, 5373.489518495737, 5513.338399392099, 5514.393416724077, 5239.554637855673, 5261.736913154404, 5267.604929630216, 5281.392639846466, 5281.735913204401, 5244.213367994831, 5292.306461932145, 5301.522862942354, 5308.389535203347, 5333.226682131147, 5058.215976523645, 5118.513741194581, 5151.433342332415, 5177.378714554277, 5182.8079541704865, 5012.47369026247, 5111.693298402108, 5279.0, 5290.867728306669, 5306.336707911511, 5100.566451851634, 5107.872303192301, 5111.207762796773, 5126.871828204325, 5159.896802063862], "value": 3942.946844018773, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.2840199158022, 645.425162603248, 645.7191121861989, 728.0026363881483, 753.126373406848, 12485.313307768069, 13187.80218296724, 13196.802047969277, 13242.53651122211, 13280.136791108594, 12999.090063695545, 13017.479300827956, 13020.674483137926, 13047.804282935764, 13108.541201057966, 627.8901192291354, 750.0586763611674, 754.8226166850814, 770.7418014964993, 778.4122987144698, 765.4794739577086, 766.0386215299791, 766.3486036868672, 766.9923300767005, 767.9846403071936, 813.1746277528314, 815.7267315449332, 818.2717381530442, 819.4223072733708, 823.5717426938019, 807.8263173417685, 810.2019510781904, 810.440795850864, 810.9107998120202, 811.8416908702806, 597.5846786483396, 597.671280795565, 599.8830228105521, 600.2047287344243, 601.7502736364404, 12749.936250318782, 12767.42546585406, 12808.423620937081, 12829.0, 12829.101962862604, 13111.934440327832, 13218.933905330412, 13283.402246898913, 13528.458861645522, 13849.723005539832, 10339.379637221715, 10450.425226612533, 10602.787944241072, 10631.229235880332, 10659.626913058006, 3237.2068843133584, 3268.1339445047083, 3272.8363581820813, 3321.0701003718996, 3341.248219150696, 58647.0, 60800.695996520175, 61123.69438152781, 62511.68744156296, 66581.334186658, 9152.771180720536, 9384.0, 9617.807643847224, 9631.9036809631, 9794.608215671293, 17242.396516121877, 17246.65506689859, 17386.21762020712, 17603.0, 17608.295668173385, 6690.29751876046, 6846.246912839583, 6851.417629501449, 6981.406580440618, 7005.334493223136, 3768.4347347898033, 3816.732828701964, 3830.272248272819, 3860.0542866997766, 3884.8446062157764, 2908.840013799261, 3000.294930691286, 3027.5610036545017, 3032.3935212957495, 3037.240689827543, 519.9038177937093, 520.7422325948679, 523.2595876834313, 523.9056969745407, 528.3712382265169, 497.5471622861254, 565.7623798004848, 586.9999999999915, 605.4157737783061, 616.6331033035336, 7832.530048197126, 8078.555679437687, 8097.311728503143, 8288.958555207186, 8490.108538603357, 553.8975289571442, 564.0298686259626, 601.3986013986014, 602.1148911100674, 603.7494439807431, 3626.075350785533, 3689.8524059037336, 3863.265979463893, 3971.582983786661, 4031.113155105872, 57914.93843243567, 60547.69726151341, 96907.0, 105428.0, 108345.0, 85036.57481712676, 86231.5688421554, 90300.0, 92214.0, 92856.0, 54466.72766636221, 75617.62191189009, 82086.58956705297, 82205.17794821975, 83230.58384707916, 7270.418366530559, 7403.740869069772, 7435.194441420224, 7538.585377804054, 7635.694572217049, 45428.77285613551, 46423.76788116038, 47644.7617761909, 48169.5183048179, 49348.25977610267, 60597.0, 62014.0, 68546.31453685599, 70938.64530677313, 71079.0, 9041.59312830911, 9092.59083341238, 9273.53632318395, 9468.715938521855, 9930.652427165014, 11137.554497819996, 11246.7750644985, 11370.488328025423, 11492.080633549464, 11891.46488408041, 9986.650467233612, 10221.131203847755, 10274.486275686037, 10477.842832357368, 10772.569097236335, 9451.102145296185, 9498.287628428034, 9500.524973751146, 9578.521073946136, 9699.272554558294, 9845.360051596623, 9852.211823054282, 10016.499175041074, 10190.490475476048, 10555.0, 8154.83690326202, 8164.714235001747, 8201.876971845546, 8582.957085214533, 8730.17063378978, 8827.602757875782, 9117.77205569866, 9122.133397327243, 9164.404313719588, 9164.541772911194], "value": 6342.713254108655, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 109.0, 115.0, 117.0, 115.0, 120.0, 113.0, 114.0, 116.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 147.0, 181.0, 127.0, 155.0, 151.0, 129.0, 198.0, 127.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 170.0, 163.0, 163.0, 164.0, 164.0, 164.0, 169.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 177.0, 78.0, 75.0, 76.0, 77.0, 158.0, 78.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 139.0, 87.0, 86.0, 87.0, 137.0, 87.0, 86.0, 141.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 148.0, 148.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 100.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 70.0, 66.0, 66.0, 77.0, 66.0, 66.0, 70.0, 69.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 67.0, 66.0, 65.0, 66.0, 67.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 86.0, 83.0, 83.0, 82.0, 88.0, 84.0, 83.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 144.0, 142.0, 133.0, 135.0, 148.0, 142.0, 161.0, 137.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 178.0, 176.0, 172.0, 172.0, 173.0, 178.0, 172.0, 172.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 70.0, 71.0, 71.0, 69.0, 68.0, 68.0, 68.0, 70.0], "value": 69.6, "unit": "score"}]}]} 14:35:58 INFO - Return code: 0 14:35:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:35:58 ERROR - # TBPL SUCCESS # 14:35:58 INFO - Running post-action listener: _resource_record_post_action 14:35:58 INFO - [mozharness: 2016-08-18 21:35:58.292620Z] Finished run-tests step (success) 14:35:58 INFO - Running post-run listener: _resource_record_post_run 14:35:58 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282152960; Read time: 20; Write time: 154884 14:35:58 INFO - TinderboxPrint: CPU usage
13.3% 14:35:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 14:35:58 INFO - TinderboxPrint: I/O write bytes / time
282,152,960 / 154,884 14:35:58 INFO - TinderboxPrint: CPU idle
8,282.4 (86.6%) 14:35:58 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 14:35:58 INFO - TinderboxPrint: Swap in / out
0 / 0 14:35:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 475136; Read time: 0; Write time: 36 14:35:58 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281677824; Read time: 8; Write time: 154848 14:35:58 INFO - Running post-run listener: _upload_blobber_files 14:35:58 INFO - Blob upload gear active. 14:35:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:58 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 14:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:35:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:00 INFO - (blobuploader) - INFO - Done attempting. 14:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:36:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:05 INFO - (blobuploader) - INFO - Done attempting. 14:36:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:36:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:36:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:36:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:05 INFO - (blobuploader) - INFO - Done attempting. 14:36:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:05 INFO - Return code: 0 14:36:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0811d2bacf4821c3445938115c35864cf21cca495599fc1240a15cd6a9cd4894e24ab504117e8b79441f7702a89afa887c8ca9196dec9673964cf00d8e45d8c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/40390adea56faab3caa16821cf69e6af6ba30da628f409175f8a789441d848014356c9c5b11802f1b3de5700babe4b33a4d758340db55ebd74f218e6d6852be1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c9e7dd244d4f416c7d4c745ddcc2d163790b008d34b5ef0e88598c4cdd4a8f67c36ced2b91bcfe531b537094267224e08e25074e397e2b42d9fbb8a1fa367d"} 14:36:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:05 INFO - Contents: 14:36:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0811d2bacf4821c3445938115c35864cf21cca495599fc1240a15cd6a9cd4894e24ab504117e8b79441f7702a89afa887c8ca9196dec9673964cf00d8e45d8c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/40390adea56faab3caa16821cf69e6af6ba30da628f409175f8a789441d848014356c9c5b11802f1b3de5700babe4b33a4d758340db55ebd74f218e6d6852be1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c9e7dd244d4f416c7d4c745ddcc2d163790b008d34b5ef0e88598c4cdd4a8f67c36ced2b91bcfe531b537094267224e08e25074e397e2b42d9fbb8a1fa367d"} 14:36:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:05 INFO - Copying logs to upload dir... 14:36:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1423.879115 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 43 secs) (at 2016-08-18 14:36:05.861021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 14:36:05.865089) ========= 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=6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0811d2bacf4821c3445938115c35864cf21cca495599fc1240a15cd6a9cd4894e24ab504117e8b79441f7702a89afa887c8ca9196dec9673964cf00d8e45d8c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/40390adea56faab3caa16821cf69e6af6ba30da628f409175f8a789441d848014356c9c5b11802f1b3de5700babe4b33a4d758340db55ebd74f218e6d6852be1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c9e7dd244d4f416c7d4c745ddcc2d163790b008d34b5ef0e88598c4cdd4a8f67c36ced2b91bcfe531b537094267224e08e25074e397e2b42d9fbb8a1fa367d"} build_url:https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/S-ImQjIxQYG-M2lJ--yjOA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0811d2bacf4821c3445938115c35864cf21cca495599fc1240a15cd6a9cd4894e24ab504117e8b79441f7702a89afa887c8ca9196dec9673964cf00d8e45d8c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/40390adea56faab3caa16821cf69e6af6ba30da628f409175f8a789441d848014356c9c5b11802f1b3de5700babe4b33a4d758340db55ebd74f218e6d6852be1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a7c9e7dd244d4f416c7d4c745ddcc2d163790b008d34b5ef0e88598c4cdd4a8f67c36ced2b91bcfe531b537094267224e08e25074e397e2b42d9fbb8a1fa367d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 14:36:05.890008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:36:05.890317) ========= 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=6dbc10da6d83fee962c624be000001a8-1471554739.490573-1213588750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 14:36:05.973195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 14:36:05.973503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 14:36:05.973816) ========= ========= Total master_lag: 0.15 =========