builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1464019235.75 results: success (0) buildid: 20160523061540 builduid: b048b1a6c3734084a413d294d4b3e02a revision: 641d8d468d540ede408c427b1840e35217e44e76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.755578) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.756094) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.756415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.773796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.774220) ========= 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=33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 09:00:36-- 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% 223M=0s 2016-05-23 09:00:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095367 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.884184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.884563) ========= 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=33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017010 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.935027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:35.935439) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 641d8d468d540ede408c427b1840e35217e44e76 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 641d8d468d540ede408c427b1840e35217e44e76 --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=33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 09:00:36,498 truncating revision to first 12 chars 2016-05-23 09:00:36,498 Setting DEBUG logging. 2016-05-23 09:00:36,498 attempt 1/10 2016-05-23 09:00:36,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/641d8d468d54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 09:00:36,763 unpacking tar archive at: mozilla-aurora-641d8d468d54/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520685 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:36.470553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:36.470931) ========= script_repo_revision: 641d8d468d540ede408c427b1840e35217e44e76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:36.471390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:36.471726) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 09:00:36.480936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-23 09:00:36.481251) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:00:37 INFO - MultiFileLogger online at 20160523 09:00:37 in /builds/slave/test 09:00:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:00:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:00:37 INFO - {'append_to_log': False, 09:00:37 INFO - 'base_work_dir': '/builds/slave/test', 09:00:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:00:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:00:37 INFO - 'branch': 'Mozilla-Aurora', 09:00:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:00:37 INFO - 'config_files': ('talos/linux_config.py',), 09:00:37 INFO - 'default_actions': ('clobber', 09:00:37 INFO - 'read-buildbot-config', 09:00:37 INFO - 'download-and-extract', 09:00:37 INFO - 'populate-webroot', 09:00:37 INFO - 'create-virtualenv', 09:00:37 INFO - 'install', 09:00:37 INFO - 'run-tests'), 09:00:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:00:37 INFO - 'download_minidump_stackwalk': True, 09:00:37 INFO - 'download_symbols': 'ondemand', 09:00:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:00:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:00:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:00:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:00:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:00:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:00:37 INFO - 'installer_path': 'installer.exe', 09:00:37 INFO - 'log_level': 'info', 09:00:37 INFO - 'log_name': 'talos', 09:00:37 INFO - 'log_to_console': True, 09:00:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:00:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:00:37 INFO - 'opt_config_files': (), 09:00:37 INFO - 'pip_index': False, 09:00:37 INFO - 'sps_profile': False, 09:00:37 INFO - 'sps_profile_interval': 0, 09:00:37 INFO - 'suite': 'dromaeojs-e10s', 09:00:37 INFO - 'system_bits': '32', 09:00:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:00:37 INFO - 'title': 'talos-linux64-ix-063', 09:00:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:00:37 INFO - 'use_talos_json': True, 09:00:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:00:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:00:37 INFO - 'work_dir': 'build'} 09:00:37 INFO - ##### 09:00:37 INFO - ##### Running clobber step. 09:00:37 INFO - ##### 09:00:37 INFO - Running pre-action listener: _resource_record_pre_action 09:00:37 INFO - Running main action method: clobber 09:00:37 INFO - rmtree: /builds/slave/test/build 09:00:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:00:37 INFO - Running post-action listener: _resource_record_post_action 09:00:37 INFO - ##### 09:00:37 INFO - ##### Running read-buildbot-config step. 09:00:37 INFO - ##### 09:00:37 INFO - Running pre-action listener: _resource_record_pre_action 09:00:37 INFO - Running main action method: read_buildbot_config 09:00:37 INFO - Using buildbot properties: 09:00:37 INFO - { 09:00:37 INFO - "project": "", 09:00:37 INFO - "product": "firefox", 09:00:37 INFO - "script_repo_revision": "production", 09:00:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:00:37 INFO - "repository": "", 09:00:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:00:37 INFO - "buildid": "20160523061540", 09:00:37 INFO - "pgo_build": "True", 09:00:37 INFO - "basedir": "/builds/slave/test", 09:00:37 INFO - "buildnumber": 282, 09:00:37 INFO - "slavename": "talos-linux64-ix-063", 09:00:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:00:37 INFO - "platform": "ubuntu64_hw", 09:00:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:00:37 INFO - "branch": "mozilla-aurora", 09:00:37 INFO - "repo_path": "releases/mozilla-aurora", 09:00:37 INFO - "revision": "641d8d468d540ede408c427b1840e35217e44e76", 09:00:37 INFO - "stage_platform": "linux64-pgo", 09:00:37 INFO - "builduid": "b048b1a6c3734084a413d294d4b3e02a", 09:00:37 INFO - "slavebuilddir": "test" 09:00:37 INFO - } 09:00:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 09:00:37 INFO - Running post-action listener: _resource_record_post_action 09:00:37 INFO - ##### 09:00:37 INFO - ##### Running download-and-extract step. 09:00:37 INFO - ##### 09:00:37 INFO - Running pre-action listener: _resource_record_pre_action 09:00:37 INFO - Running main action method: download_and_extract 09:00:37 INFO - mkdir: /builds/slave/test/build/tests 09:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:37 INFO - https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:00:42 INFO - Downloaded 1361 bytes. 09:00:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:00:42 INFO - Using the following test package requirements: 09:00:42 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:42 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:00:42 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:00:42 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'jsshell-linux-x86_64.zip'], 09:00:42 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:00:42 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:42 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:00:42 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:00:42 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:00:42 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:00:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:42 INFO - https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:00:54 INFO - Downloaded 23813419 bytes. 09:00:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:00:55 INFO - Return code: 0 09:00:55 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:55 INFO - https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:00:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:00:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:00:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:00:56 INFO - Downloaded 23813419 bytes. 09:00:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:00:58 INFO - Return code: 0 09:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:58 INFO - https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:00:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:00:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:00:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:00:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:00:59 INFO - Downloaded 10840145 bytes. 09:00:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:00:59 INFO - Return code: 0 09:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:59 INFO - https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:00:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:00:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:00:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:00:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:01:01 INFO - Downloaded 62732688 bytes. 09:01:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:01:01 INFO - mkdir: /builds/slave/test/properties 09:01:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:01 INFO - Contents: 09:01:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:01:01 INFO - Running post-action listener: _resource_record_post_action 09:01:01 INFO - Running post-action listener: set_extra_try_arguments 09:01:01 INFO - ##### 09:01:01 INFO - ##### Running populate-webroot step. 09:01:01 INFO - ##### 09:01:01 INFO - Running pre-action listener: _resource_record_pre_action 09:01:01 INFO - Running main action method: populate_webroot 09:01:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:01 INFO - '--tppagecycles', 09:01:01 INFO - '7'], 09:01:01 INFO - 'tests': ['tsvgm']}}, 09:01:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:01:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:01:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:01:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['damp', 'tps']}, 09:01:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'tests': ['damp', 'tps']}, 09:01:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['dromaeo_dom']}, 09:01:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['a11yr', 09:01:01 INFO - 'ts_paint', 09:01:01 INFO - 'tpaint', 09:01:01 INFO - 'sessionrestore', 09:01:01 INFO - 'sessionrestore_no_auto_restore', 09:01:01 INFO - 'tabpaint']}, 09:01:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tsvgx', 09:01:01 INFO - 'tsvgr_opacity', 09:01:01 INFO - 'tart', 09:01:01 INFO - 'tscrollx', 09:01:01 INFO - 'cart']}, 09:01:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:01:01 INFO - 'tsvgr_opacity', 09:01:01 INFO - 'tart', 09:01:01 INFO - 'tscrollx', 09:01:01 INFO - 'cart']}, 09:01:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s'], 09:01:01 INFO - 'tests': ['tp5o']}, 09:01:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'tests': ['tp5o']}, 09:01:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--disable-e10s', 09:01:01 INFO - '--xperf_path', 09:01:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:01 INFO - 'tests': ['tp5n']}, 09:01:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:01 INFO - 'talos_options': ['--xperf_path', 09:01:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:01 INFO - 'tests': ['tp5n']}}, 09:01:01 INFO - 'talos.zip': {'path': '', 09:01:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:01 INFO - Running post-action listener: _resource_record_post_action 09:01:01 INFO - ##### 09:01:01 INFO - ##### Running create-virtualenv step. 09:01:01 INFO - ##### 09:01:01 INFO - Running pre-action listener: _resource_record_pre_action 09:01:01 INFO - Running main action method: create_virtualenv 09:01:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:01:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:01 INFO - Using real prefix '/usr' 09:01:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:04 INFO - Installing pip.................done. 09:01:04 INFO - Return code: 0 09:01:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:01:04 INFO - Using env: {'DISPLAY': ':0', 09:01:04 INFO - 'HOME': '/home/cltbld', 09:01:04 INFO - 'LANG': 'en_US.UTF-8', 09:01:04 INFO - 'LANGUAGE': 'en_US:en', 09:01:04 INFO - 'LOGNAME': 'cltbld', 09:01:04 INFO - 'MAIL': '/var/mail/cltbld', 09:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:04 INFO - 'MOZ_NO_REMOTE': '1', 09:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:04 INFO - 'NO_EM_RESTART': '1', 09:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:04 INFO - 'PWD': '/builds/slave/test', 09:01:04 INFO - 'SHELL': '/bin/bash', 09:01:04 INFO - 'SHLVL': '1', 09:01:04 INFO - 'TERM': 'linux', 09:01:04 INFO - 'TMOUT': '86400', 09:01:04 INFO - 'USER': 'cltbld', 09:01:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:04 INFO - '_': '/tools/buildbot/bin/python'} 09:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:01:04 INFO - Cleaning up... 09:01:04 INFO - Return code: 0 09:01:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:01:04 INFO - Using env: {'DISPLAY': ':0', 09:01:04 INFO - 'HOME': '/home/cltbld', 09:01:04 INFO - 'LANG': 'en_US.UTF-8', 09:01:04 INFO - 'LANGUAGE': 'en_US:en', 09:01:04 INFO - 'LOGNAME': 'cltbld', 09:01:04 INFO - 'MAIL': '/var/mail/cltbld', 09:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:04 INFO - 'MOZ_NO_REMOTE': '1', 09:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:04 INFO - 'NO_EM_RESTART': '1', 09:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:04 INFO - 'PWD': '/builds/slave/test', 09:01:04 INFO - 'SHELL': '/bin/bash', 09:01:04 INFO - 'SHLVL': '1', 09:01:04 INFO - 'TERM': 'linux', 09:01:04 INFO - 'TMOUT': '86400', 09:01:04 INFO - 'USER': 'cltbld', 09:01:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:04 INFO - '_': '/tools/buildbot/bin/python'} 09:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:04 INFO - Downloading/unpacking psutil>=0.7.1 09:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:06 INFO - Installing collected packages: psutil 09:01:06 INFO - Running setup.py install for psutil 09:01:06 INFO - building 'psutil._psutil_linux' extension 09:01:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:01:07 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 09:01:07 INFO - building 'psutil._psutil_posix' extension 09:01:07 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 09:01:07 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 09:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:07 INFO - Successfully installed psutil 09:01:07 INFO - Cleaning up... 09:01:07 INFO - Return code: 0 09:01:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:01:07 INFO - Using env: {'DISPLAY': ':0', 09:01:07 INFO - 'HOME': '/home/cltbld', 09:01:07 INFO - 'LANG': 'en_US.UTF-8', 09:01:07 INFO - 'LANGUAGE': 'en_US:en', 09:01:07 INFO - 'LOGNAME': 'cltbld', 09:01:07 INFO - 'MAIL': '/var/mail/cltbld', 09:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:07 INFO - 'MOZ_NO_REMOTE': '1', 09:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:07 INFO - 'NO_EM_RESTART': '1', 09:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:07 INFO - 'PWD': '/builds/slave/test', 09:01:07 INFO - 'SHELL': '/bin/bash', 09:01:07 INFO - 'SHLVL': '1', 09:01:07 INFO - 'TERM': 'linux', 09:01:07 INFO - 'TMOUT': '86400', 09:01:07 INFO - 'USER': 'cltbld', 09:01:07 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:07 INFO - '_': '/tools/buildbot/bin/python'} 09:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:01:09 INFO - Installing collected packages: mozsystemmonitor 09:01:09 INFO - Running setup.py install for mozsystemmonitor 09:01:09 INFO - Successfully installed mozsystemmonitor 09:01:09 INFO - Cleaning up... 09:01:09 INFO - Return code: 0 09:01:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:01:09 INFO - Using env: {'DISPLAY': ':0', 09:01:09 INFO - 'HOME': '/home/cltbld', 09:01:09 INFO - 'LANG': 'en_US.UTF-8', 09:01:09 INFO - 'LANGUAGE': 'en_US:en', 09:01:09 INFO - 'LOGNAME': 'cltbld', 09:01:09 INFO - 'MAIL': '/var/mail/cltbld', 09:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:09 INFO - 'MOZ_NO_REMOTE': '1', 09:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:09 INFO - 'NO_EM_RESTART': '1', 09:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:09 INFO - 'PWD': '/builds/slave/test', 09:01:09 INFO - 'SHELL': '/bin/bash', 09:01:09 INFO - 'SHLVL': '1', 09:01:09 INFO - 'TERM': 'linux', 09:01:09 INFO - 'TMOUT': '86400', 09:01:09 INFO - 'USER': 'cltbld', 09:01:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:09 INFO - '_': '/tools/buildbot/bin/python'} 09:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:12 INFO - Downloading docopt-0.6.1.tar.gz 09:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:12 INFO - Running setup.py install for blobuploader 09:01:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:12 INFO - Running setup.py install for requests 09:01:13 INFO - Running setup.py install for docopt 09:01:13 INFO - Successfully installed blobuploader requests docopt 09:01:13 INFO - Cleaning up... 09:01:13 INFO - Return code: 0 09:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:13 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 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:13 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 09:01:13 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 09:01:13 INFO - Using env: {'DISPLAY': ':0', 09:01:13 INFO - 'HOME': '/home/cltbld', 09:01:13 INFO - 'LANG': 'en_US.UTF-8', 09:01:13 INFO - 'LANGUAGE': 'en_US:en', 09:01:13 INFO - 'LOGNAME': 'cltbld', 09:01:13 INFO - 'MAIL': '/var/mail/cltbld', 09:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:13 INFO - 'MOZ_NO_REMOTE': '1', 09:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:13 INFO - 'NO_EM_RESTART': '1', 09:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:13 INFO - 'PWD': '/builds/slave/test', 09:01:13 INFO - 'SHELL': '/bin/bash', 09:01:13 INFO - 'SHLVL': '1', 09:01:13 INFO - 'TERM': 'linux', 09:01:13 INFO - 'TMOUT': '86400', 09:01:13 INFO - 'USER': 'cltbld', 09:01:13 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:13 INFO - '_': '/tools/buildbot/bin/python'} 09:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:13 INFO - Running setup.py (path:/tmp/pip-AYjkIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:13 INFO - Running setup.py (path:/tmp/pip-e2Vofz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:13 INFO - Running setup.py (path:/tmp/pip-P3brXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:13 INFO - Running setup.py (path:/tmp/pip-HmCUTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:13 INFO - Running setup.py (path:/tmp/pip-Jbr2Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:13 INFO - Running setup.py (path:/tmp/pip-266Isb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:13 INFO - Running setup.py (path:/tmp/pip-KjFtA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:13 INFO - Running setup.py (path:/tmp/pip-lS8W0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:13 INFO - Running setup.py (path:/tmp/pip-zE64ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:14 INFO - Running setup.py (path:/tmp/pip-8WO_OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:14 INFO - Running setup.py (path:/tmp/pip-H5yxPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:14 INFO - Running setup.py (path:/tmp/pip-fzUZdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:14 INFO - Running setup.py (path:/tmp/pip-DpazOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:14 INFO - Running setup.py (path:/tmp/pip-8H_Beo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:14 INFO - Running setup.py (path:/tmp/pip-PvuKIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:14 INFO - Running setup.py (path:/tmp/pip-pTg__m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:14 INFO - Running setup.py (path:/tmp/pip-2uSnGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:14 INFO - Running setup.py install for manifestparser 09:01:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:14 INFO - Running setup.py install for mozcrash 09:01:14 INFO - Running setup.py install for mozdebug 09:01:14 INFO - Running setup.py install for mozdevice 09:01:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Running setup.py install for mozfile 09:01:15 INFO - Running setup.py install for mozhttpd 09:01:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Running setup.py install for mozinfo 09:01:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Running setup.py install for mozInstall 09:01:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Running setup.py install for mozleak 09:01:15 INFO - Running setup.py install for mozlog 09:01:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Running setup.py install for moznetwork 09:01:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Running setup.py install for mozprocess 09:01:15 INFO - Running setup.py install for mozprofile 09:01:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:16 INFO - Running setup.py install for mozrunner 09:01:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:16 INFO - Running setup.py install for mozscreenshot 09:01:16 INFO - Running setup.py install for moztest 09:01:16 INFO - Running setup.py install for mozversion 09:01:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:16 INFO - Cleaning up... 09:01:16 INFO - Return code: 0 09:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:16 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 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:16 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 09:01:16 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 09:01:16 INFO - Using env: {'DISPLAY': ':0', 09:01:16 INFO - 'HOME': '/home/cltbld', 09:01:16 INFO - 'LANG': 'en_US.UTF-8', 09:01:16 INFO - 'LANGUAGE': 'en_US:en', 09:01:16 INFO - 'LOGNAME': 'cltbld', 09:01:16 INFO - 'MAIL': '/var/mail/cltbld', 09:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:16 INFO - 'MOZ_NO_REMOTE': '1', 09:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:16 INFO - 'NO_EM_RESTART': '1', 09:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:16 INFO - 'PWD': '/builds/slave/test', 09:01:16 INFO - 'SHELL': '/bin/bash', 09:01:16 INFO - 'SHLVL': '1', 09:01:16 INFO - 'TERM': 'linux', 09:01:16 INFO - 'TMOUT': '86400', 09:01:16 INFO - 'USER': 'cltbld', 09:01:16 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:16 INFO - '_': '/tools/buildbot/bin/python'} 09:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:17 INFO - Running setup.py (path:/tmp/pip-sqIoTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:17 INFO - Running setup.py (path:/tmp/pip-op1kI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:17 INFO - Running setup.py (path:/tmp/pip-yjBfz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:17 INFO - Running setup.py (path:/tmp/pip-FwD8Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:17 INFO - Running setup.py (path:/tmp/pip-4NDvMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:17 INFO - Running setup.py (path:/tmp/pip-V77YNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:17 INFO - Running setup.py (path:/tmp/pip-IwBYtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:17 INFO - Running setup.py (path:/tmp/pip-8VQiXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:17 INFO - Running setup.py (path:/tmp/pip-GfdbeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:17 INFO - Running setup.py (path:/tmp/pip-0_70nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:17 INFO - Running setup.py (path:/tmp/pip-DWG4lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:17 INFO - Running setup.py (path:/tmp/pip-vcONJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:17 INFO - Running setup.py (path:/tmp/pip-Tp0Dt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:17 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)) 09:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:18 INFO - Running setup.py (path:/tmp/pip-jKmRu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:18 INFO - Running setup.py (path:/tmp/pip-4AxpBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:18 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)) 09:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:18 INFO - Running setup.py (path:/tmp/pip-PttNwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:18 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)) 09:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:18 INFO - Running setup.py (path:/tmp/pip-fHZLRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:18 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)) 09:01:18 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)) 09:01:18 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)) 09:01:18 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)) 09:01:18 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)) 09:01:18 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)) 09:01:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:18 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 09:01:18 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 09:01:18 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 09:01:18 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 09:01:18 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 09:01:18 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 09:01:20 INFO - Downloading blessings-1.6.tar.gz 09:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:20 INFO - Installing collected packages: blessings 09:01:20 INFO - Running setup.py install for blessings 09:01:20 INFO - Successfully installed blessings 09:01:20 INFO - Cleaning up... 09:01:20 INFO - Return code: 0 09:01:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:20 INFO - Reading from file tmpfile_stdout 09:01:20 INFO - Current package versions: 09:01:20 INFO - argparse == 1.2.1 09:01:20 INFO - blessings == 1.6 09:01:20 INFO - blobuploader == 1.2.4 09:01:20 INFO - docopt == 0.6.1 09:01:20 INFO - manifestparser == 1.1 09:01:20 INFO - mozInstall == 1.12 09:01:20 INFO - mozcrash == 0.17 09:01:20 INFO - mozdebug == 0.1 09:01:20 INFO - mozdevice == 0.48 09:01:20 INFO - mozfile == 1.2 09:01:20 INFO - mozhttpd == 0.7 09:01:20 INFO - mozinfo == 0.9 09:01:20 INFO - mozleak == 0.1 09:01:20 INFO - mozlog == 3.1 09:01:20 INFO - moznetwork == 0.27 09:01:20 INFO - mozprocess == 0.22 09:01:20 INFO - mozprofile == 0.28 09:01:20 INFO - mozrunner == 6.11 09:01:20 INFO - mozscreenshot == 0.1 09:01:20 INFO - mozsystemmonitor == 0.0 09:01:20 INFO - moztest == 0.7 09:01:20 INFO - mozversion == 1.4 09:01:20 INFO - psutil == 3.1.1 09:01:20 INFO - requests == 1.2.3 09:01:20 INFO - wsgiref == 0.1.2 09:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 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 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:20 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 09:01:20 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 09:01:20 INFO - Using env: {'DISPLAY': ':0', 09:01:20 INFO - 'HOME': '/home/cltbld', 09:01:20 INFO - 'LANG': 'en_US.UTF-8', 09:01:20 INFO - 'LANGUAGE': 'en_US:en', 09:01:20 INFO - 'LOGNAME': 'cltbld', 09:01:20 INFO - 'MAIL': '/var/mail/cltbld', 09:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:20 INFO - 'MOZ_NO_REMOTE': '1', 09:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:20 INFO - 'NO_EM_RESTART': '1', 09:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:20 INFO - 'PWD': '/builds/slave/test', 09:01:20 INFO - 'SHELL': '/bin/bash', 09:01:20 INFO - 'SHLVL': '1', 09:01:20 INFO - 'TERM': 'linux', 09:01:20 INFO - 'TMOUT': '86400', 09:01:20 INFO - 'USER': 'cltbld', 09:01:20 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:20 INFO - '_': '/tools/buildbot/bin/python'} 09:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 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)) 09:01:20 INFO - Cleaning up... 09:01:20 INFO - Return code: 0 09:01:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:20 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 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:20 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 09:01:20 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 09:01:20 INFO - Using env: {'DISPLAY': ':0', 09:01:20 INFO - 'HOME': '/home/cltbld', 09:01:20 INFO - 'LANG': 'en_US.UTF-8', 09:01:20 INFO - 'LANGUAGE': 'en_US:en', 09:01:20 INFO - 'LOGNAME': 'cltbld', 09:01:20 INFO - 'MAIL': '/var/mail/cltbld', 09:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:20 INFO - 'MOZ_NO_REMOTE': '1', 09:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:20 INFO - 'NO_EM_RESTART': '1', 09:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:20 INFO - 'PWD': '/builds/slave/test', 09:01:20 INFO - 'SHELL': '/bin/bash', 09:01:20 INFO - 'SHLVL': '1', 09:01:20 INFO - 'TERM': 'linux', 09:01:20 INFO - 'TMOUT': '86400', 09:01:20 INFO - 'USER': 'cltbld', 09:01:20 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:20 INFO - '_': '/tools/buildbot/bin/python'} 09:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:21 INFO - Downloading/unpacking jsonschema 09:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:22 INFO - Downloading/unpacking functools32 (from jsonschema) 09:01:22 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 09:01:22 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 09:01:22 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 09:01:22 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 09:01:22 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 09:01:22 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 09:01:23 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:23 INFO - warning: no files found matching '*.txt' 09:01:23 INFO - no previously-included directories found matching 'build' 09:01:23 INFO - no previously-included directories found matching 'dist' 09:01:23 INFO - no previously-included directories found matching '.git*' 09:01:23 INFO - Installing collected packages: jsonschema, functools32 09:01:23 INFO - Running setup.py install for functools32 09:01:23 INFO - warning: no files found matching '*.txt' 09:01:23 INFO - no previously-included directories found matching 'build' 09:01:23 INFO - no previously-included directories found matching 'dist' 09:01:23 INFO - no previously-included directories found matching '.git*' 09:01:23 INFO - Successfully installed jsonschema functools32 09:01:23 INFO - Cleaning up... 09:01:23 INFO - Return code: 0 09:01:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f6b367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, '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': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', '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 09:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:01:23 INFO - Using env: {'DISPLAY': ':0', 09:01:23 INFO - 'HOME': '/home/cltbld', 09:01:23 INFO - 'LANG': 'en_US.UTF-8', 09:01:23 INFO - 'LANGUAGE': 'en_US:en', 09:01:23 INFO - 'LOGNAME': 'cltbld', 09:01:23 INFO - 'MAIL': '/var/mail/cltbld', 09:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:23 INFO - 'MOZ_NO_REMOTE': '1', 09:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:23 INFO - 'NO_EM_RESTART': '1', 09:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:23 INFO - 'PWD': '/builds/slave/test', 09:01:23 INFO - 'SHELL': '/bin/bash', 09:01:23 INFO - 'SHLVL': '1', 09:01:23 INFO - 'TERM': 'linux', 09:01:23 INFO - 'TMOUT': '86400', 09:01:23 INFO - 'USER': 'cltbld', 09:01:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:23 INFO - '_': '/tools/buildbot/bin/python'} 09:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:23 INFO - Downloading/unpacking flake8 09:01:23 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 09:01:23 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 09:01:23 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 09:01:23 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 09:01:23 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 09:01:23 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 09:01:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:01:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:01:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:25 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 09:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:26 INFO - no previously-included directories found matching 'docs/_build' 09:01:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:01:26 INFO - Running setup.py install for pep8 09:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:26 INFO - no previously-included directories found matching 'docs/_build' 09:01:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:01:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:01:26 INFO - Cleaning up... 09:01:26 INFO - Return code: 0 09:01:26 INFO - Running post-action listener: _resource_record_post_action 09:01:26 INFO - Running post-action listener: _start_resource_monitoring 09:01:26 INFO - Starting resource monitoring. 09:01:26 INFO - ##### 09:01:26 INFO - ##### Running install step. 09:01:26 INFO - ##### 09:01:26 INFO - Running pre-action listener: _resource_record_pre_action 09:01:26 INFO - Running main action method: install 09:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:26 INFO - Reading from file tmpfile_stdout 09:01:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:26 INFO - Reading from file tmpfile_stdout 09:01:26 INFO - Output received: 09:01:26 INFO - Usage: mozinstall [options] installer 09:01:26 INFO - Options: 09:01:26 INFO - -h, --help show this help message and exit 09:01:26 INFO - -d DEST, --destination=DEST 09:01:26 INFO - Directory to install application into. [default: 09:01:26 INFO - "/builds/slave/test"] 09:01:26 INFO - --app=APP Application being installed. [default: firefox] 09:01:26 INFO - mkdir: /builds/slave/test/build/application 09:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:01:48 INFO - Reading from file tmpfile_stdout 09:01:48 INFO - Output received: 09:01:48 INFO - /builds/slave/test/build/application/firefox/firefox 09:01:48 INFO - Running post-action listener: _resource_record_post_action 09:01:48 INFO - ##### 09:01:48 INFO - ##### Running run-tests step. 09:01:48 INFO - ##### 09:01:48 INFO - Running pre-action listener: _resource_record_pre_action 09:01:48 INFO - Running main action method: run_tests 09:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:48 INFO - Python 2.7.3 09:01:48 INFO - Return code: 0 09:01:48 INFO - grabbing minidump binary from tooltool 09:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:48 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb410>, '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 0x14bc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:48 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 09:01:48 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 09:01:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:48 INFO - Return code: 0 09:01:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:01:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:01:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:01:54 INFO - Return code: 0 09:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 09:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 09:01:54 INFO - Using env: {'DISPLAY': ':0', 09:01:54 INFO - 'HOME': '/home/cltbld', 09:01:54 INFO - 'LANG': 'en_US.UTF-8', 09:01:54 INFO - 'LANGUAGE': 'en_US:en', 09:01:54 INFO - 'LOGNAME': 'cltbld', 09:01:54 INFO - 'MAIL': '/var/mail/cltbld', 09:01:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:54 INFO - 'MOZ_NO_REMOTE': '1', 09:01:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:54 INFO - 'NO_EM_RESTART': '1', 09:01:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:54 INFO - 'PWD': '/builds/slave/test', 09:01:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:54 INFO - 'SHELL': '/bin/bash', 09:01:54 INFO - 'SHLVL': '1', 09:01:54 INFO - 'TERM': 'linux', 09:01:54 INFO - 'TMOUT': '86400', 09:01:54 INFO - 'USER': 'cltbld', 09:01:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747', 09:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:54 INFO - '_': '/tools/buildbot/bin/python'} 09:01:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 09:01:55 INFO - mozversion application_buildid: 20160523061540 09:01:55 INFO - mozversion application_changeset: 641d8d468d540ede408c427b1840e35217e44e76 09:01:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:01:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:55 INFO - mozversion application_name: Firefox 09:01:55 INFO - mozversion application_remotingname: firefox-dev 09:01:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:55 INFO - mozversion application_vendor: Mozilla 09:01:55 INFO - mozversion application_version: 48.0a2 09:01:55 INFO - mozversion platform_buildid: 20160523061540 09:01:55 INFO - mozversion platform_changeset: 641d8d468d540ede408c427b1840e35217e44e76 09:01:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:01:55 INFO - mozversion platform_version: 48.0a2 09:01:55 INFO - using testdate: 1464019315 09:01:55 INFO - actual date: 1464019315 09:01:55 INFO - starting webserver on 'localhost:54041' 09:01:55 INFO - SUITE-START | Running 2 tests 09:01:55 INFO - TEST-START | dromaeo_css 09:01:55 INFO - operating with platform_type : linux_ 09:01:55 INFO - Initialising browser for dromaeo_css test... 09:01:55 INFO - TEST-INFO | started process 20351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdZylyc/profile http://localhost:54041/getInfo.html) 09:02:00 INFO - PROCESS | 20351 | 09:02:00 INFO - PROCESS | 20351 | (process:20434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:01 INFO - PROCESS | 20351 | __metrics Screen width/height:1600/1200 09:02:01 INFO - PROCESS | 20351 | colorDepth:24 09:02:01 INFO - PROCESS | 20351 | Browser inner width/height: 1024/697 09:02:01 INFO - PROCESS | 20351 | __metrics 09:02:02 ERROR - PROCESS | 20351 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:02:03 INFO - TEST-INFO | 20351: exit 0 09:02:03 INFO - Browser initialized. 09:02:03 INFO - Running cycle 1/1 for dromaeo_css test... 09:02:03 INFO - TEST-INFO | started process 20485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdZylyc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:05 INFO - PROCESS | 20485 | 09:02:05 INFO - PROCESS | 20485 | (process:20555): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:15 INFO - PROCESS | 20485 | RSS: Main: 152498176 09:02:15 INFO - PROCESS | 20485 | 09:03:05 INFO - PROCESS | 20485 | 1464019385250 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] 09:05:12 INFO - PROCESS | 20485 | Cycle 1(1): loaded http://localhost:54041/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54041/tests/dromaeo/cssquery-ext.html) 09:05:13 INFO - PROCESS | 20485 | RSS: Main: 155426816 09:05:13 INFO - PROCESS | 20485 | 09:08:15 INFO - PROCESS | 20485 | Cycle 1(1): loaded http://localhost:54041/tests/dromaeo/cssquery-ext.html (next: http://localhost:54041/tests/dromaeo/cssquery-jquery.html) 09:08:16 INFO - PROCESS | 20485 | RSS: Main: 153399296 09:08:16 INFO - PROCESS | 20485 | 09:11:17 INFO - PROCESS | 20485 | Cycle 1(1): loaded http://localhost:54041/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54041/tests/dromaeo/cssquery-mootools.html) 09:11:18 INFO - PROCESS | 20485 | RSS: Main: 152727552 09:11:18 INFO - PROCESS | 20485 | 09:14:19 INFO - PROCESS | 20485 | Cycle 1(1): loaded http://localhost:54041/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54041/tests/dromaeo/cssquery-prototype.html) 09:14:20 INFO - PROCESS | 20485 | RSS: Main: 152989696 09:14:20 INFO - PROCESS | 20485 | 09:17:22 INFO - PROCESS | 20485 | Cycle 1(1): loaded http://localhost:54041/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54041/tests/dromaeo/cssquery-yui.html) 09:17:23 INFO - PROCESS | 20485 | RSS: Main: 154533888 09:17:23 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | Cycle 1(1): loaded http://localhost:54041/tests/dromaeo/cssquery-yui.html (next: http://localhost:54041/tests/dromaeo/cssquery-dojo.html) 09:20:25 INFO - PROCESS | 20485 | RSS: Main: 156356608 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | __start_tp_report 09:20:25 INFO - PROCESS | 20485 | _x_x_mozilla_page_load 09:20:25 INFO - PROCESS | 20485 | _x_x_mozilla_page_load_details 09:20:25 INFO - PROCESS | 20485 | |i|pagename|runs| 09:20:25 INFO - PROCESS | 20485 | |0;dojo.html;3317.98341008295;3394.9151271218234;3400.268942177432;3418.8119653419067;3435.8146439478387;5475.3977062523145;5508.531774799147;5522.282103326572;5527.723613819303;5549.334079910412;5502.752376143073;5522.337319521653;5532.75102620382;5533.363663178726;5533.861653458665;5011.123053465629;5012.949870501294;5064.290999260088;5070.84787456375;5076.517730815566;4976.576990955773;5066.923996140061;5085.79656813727;5148.485151484859;5180.870478238036;5007.84976450707;5023.2214006829;5050.242463630448;5146.099432599299;5149.562287205592;5044.646874718771;5051.444341122474;5052.9242061369105;5059.696418214919;5086.949130508685;4807.759612019385;4966.652334336598;4967.279744437073;5020.874478138039;5027.949720502785;5248.71132087735;5318.282031925679;5339.813106541253;5349.43830897754;5403.648762830403;5892.970535147339;5916.349201587822;5925.051991681354;5940.61386009908;5942.494887934531;5860.677662728548;5979.940200597982;5982.790602328898;5994.610350327258;6024.48791852693;5493.587980901449;5553.16702494625;5554.389017208104;5556.194351819004;5591.161325801122;6002.609830361012;6010.519158467312;6026.668533230714;6034.818955431257;6050.30421501533;5765.913511297334;5817.272840894888;5819.796307129315;5831.620944638585;5906.616069955439;5761.308642962871;5825.0679891217205;5828.388019258002;5833.679147646835;5857.531397488191;5747.39652336507;5785.508231800344;5793.131030345482;5794.768209271666;5803.88392232153;5701.059325211294;5745.798897038583;5759.510441612426;5818.44724751148;5826.300843898674;4446.5331140230455;4453.821847126143;4463.486699029653;4466.486354069259;4474.261746811805;3980.9402858957137;4001.199760048002;4023.798810059544;4037.7779222142476;4040.878773636796;5489;5589.441055894459;5675.460831221028;5735.77056917727;5736.713164341766;5891.617044892068;5975.342712301644;6008.939910600925;6016.278046634432;6037.034074548052;5556.77772889088;5561.110222364402;5578.693171875505;5646.858828529237;5650.5479561634975;5014;5097.286379906816;5152.227165925141;5156.948430515722;5175.146100893386;6061.818145455643;6080.908786368208;6091.969540152271;6092.1775560299675;6095.451409373178;5859.44335288147;5876.676782776903;5901.616394934315;5914.674692891932;5920.496757775465;6127.006280530498;6139.508839292756;6160.7535698571555;6170.352113028068;6171.13604095418;5792.420757924174;5807.419258074159;5822.475977162076;5829.854253643523;5848.298204215522;5890.234269545103;5923.052311630118;5923.229980102559;5971.104334349709;5981.282246130492;5833.854153646193;5853.1805547222575;5858.8242352729485;5874.647521148745;5897.115432685132;5766.163906233656;5781.103928891029;5815.621984570989;5839.182514448065;5851.414858514285;5484.478974497416;5670.659760414388;5714.085746280575;5724.885502290014;5732.025555655632;5781.971090144522;5782.10377391505;5822.427944455058;5829.5336373090895;5857.502112320501;5701.800436984686;5717.228174196596;5721.742521586455;5726.112452569859;5736.996025695403 09:20:25 INFO - PROCESS | 20485 | |1;ext.html;619.8853212155751;653.869226154769;662.996685016575;681.3118750062441;683.6650041479677;38799;39673.60326396735;39817.40273895887;39821.20357592846;39862.601373986254;36618.63381366186;36910.26179476409;37090.814545927235;37109.62890371095;37231.627683723156;8820.470771753699;9073.319501037415;9084.227840633554;9098.545072746336;9119.407238529475;8801.95599022004;8974.955125224365;8988.370814043019;8989.190972812445;9001.459912405277;9000.819983600324;9047.23098536622;9113.68102116426;9123.315751318645;9131.543422828865;8922.643094276222;9004.369694121415;9004.369694121448;9025.097490250922;9074.68238611652;8969.058248883905;9034.909650903473;9037.819243615157;9055.094490550959;9074.68238611652;43253.35119973203;43364;43658;43666.78166609178;43847.34228986568;3762.0970966968002;3999.8600048998437;4152.273352163359;4218.514870789868;4543.931841022388;32995.505067424005;33128;33674.83162584171;33731.83134084338;33988.83005584956;4408.338749187647;4476.731396116244;4504.639628829718;4511.413516242867;4533.591976722111;307874;307995;308893;309089;309137;37828.243435131146;59341;60009.39990600126;60199;60441;36901.815490922374;37153.628463715555;37201.25597488089;37304.813475932446;37414.25171496609;15691.843081569266;16053.438129665406;16062.196890155445;16063.196840157945;16065.678686426207;12974.80537791934;12982.026348023935;12998.155119917365;13001.869981300255;13087.345632718327;9149.679761208326;9198.126178013077;9239;9270.675526356545;9281.62873485053;3395.966040339614;3418.0942050356675;3422.640622734627;3426.554547908806;3427.4687423449404;1107.7064577886867;1146.3064845768356;1164.2257898497573;1172.536847945057;1269.02919266761;32642;33300.83349583237;33446.331073378395;33606.66393336084;33844.49233261503;1190.6011486152063;1196.8683444821063;1207.486818102303;1210.6791700199453;1306.764782339188;17225.31098756036;17346.82653173452;17555;17630.955096858695;17660;491637;500393;506738;520878;523611;46899;47160;47292.29061564079;47322.290165647544;47441.52558474371;1360.5782207515701;1472.5214305350803;1488.047649504318;1495.0506428417816;1495.6186172525936;29062.709372906847;30602.234944126576;31396.372072557962;31426.52860207053;31720;52360;52592.737036314575;52965.20552191643;53174.734126329124;53223.46776532185;438919;440944;442334;442611;442782;29632.407351853275;29753.851230744574;29777.702222978358;30099.247518812204;30485.390292193588;48402;48548.2717759241;48599;49364;49505.50494495009;41420.23647316502;41908;42070;42159.7892010538;42630;40787.98030049272;41001.79499102605;41034.589654103074;41401;42145.36781948212;42422;44294;44671.329930051725;44974;45010.77494612506;33238.5014224782;35189.64810351864;35564.28871422609;35979.28041439209;36147.0963225911;26077.217683469527;26385.73614263833;26424.045911618054;26621.467570648867;26754.464910702067 09:20:25 INFO - PROCESS | 20485 | |2;jquery.html;427.91227798301344;430.7264886796887;434.1209051670368;438.7981528496889;442.79188781272813;18392.080395980196;18982.71525927112;19147.138378772954;20330.186792528282;20967.580648387062;19650.312239071634;19670;19671.5082122947;20022.1991120355;20024.49938751532;5768.538516918637;5847.093700476433;5911.172435858984;5914.1128830675525;5924.614900031505;5291.947080529184;5543.279373681436;5547.33431988162;5863.58954873159;5881.3530511643685;5489.286392768934;5521.116621340586;5525.392206857243;5552.500274975251;5557.416471270519;5958.672273024982;5979.133025711291;5980.820575382702;6010.218671572711;6020.0367941129425;5403.864903377408;5835.883282334372;5849.268841394825;5864.736086876101;5866.20806191163;13365.732685346336;13527.797083043763;13659.590212293548;13704.725905481935;13719.45122195111;2398.796102331304;2429.9392515187087;2586.0043883104954;2623.34416395901;2772.819766715177;9952.303338766289;11147.777044459066;14209.431622735077;14294.285285735672;15047.247637618184;2043.6832290994919;2071.979280207194;2073.3572592496225;2116.968245476319;2136.060133541237;72263;74752.25247747508;76382.23617763807;77626.22373776247;78961.60519197368;11367.147463940237;11628.88371116295;11712.180147389772;11719.648410547697;12017.579384721494;16606.50180494587;16634.417795377103;16684.249208785634;16701.91649041747;16780.916095419445;8461.430827353284;8606.139386061344;8615.913840861636;8687.131286871389;8767.693130740394;8260.669573217005;8288.627011784483;8294.502329860106;8302.128276530999;8392.076871544125;5096.261042148868;5146.768395422215;5163.690178589297;5174.741262936838;5176.094183517945;1930.2086144680895;2046.0281366350864;2123.1507397041305;2124.4370241885913;2134.903929323184;1026.810040142576;1077.7575045614674;1085.0776839686202;1138.527511082908;1191.9284842909453;16593.6681266374;17446.651066978844;17672.028038458007;18754.81245187558;19255.22979080849;1086.760912599227;1095.3756358875364;1134.625573560723;1137.7440075982838;1157.8205378166397;10414.323069000491;10697.358158510515;10727.78544429107;10773.192010599236;10830.837537436944;492603.6109458361;498593;503356;503374;508884;97492;100978.495107524;101158.49420752996;101438;102497;1058.5659879449543;1074.8119079161115;1141.0814294493014;1161.2335858333458;1162.5175552145934;15913;15996.68006639884;16156.757648635044;16402.753958690868;16529.25618347153;39619.2076158481;40035.59964400319;40139.397909030806;40315;40468;52026;56453.71773141108;57046.7147664259;57361.13958290545;57693.71153144207;8625.91374086251;8643.783905402415;8798.208161265517;8840.602172902363;9108;13338.19970801755;13431.529896453578;13769.31153442344;13775.586732398044;13823;11574.942125289319;11717.238379505305;11728.472218750007;11884.346360949885;12545.623631291075;11401.600943966921;11567.248128871934;11653;11724.531018759495;11982.58060967862;11834.940825295818;11839.408029598659;11903.523859045541;11957.342346171044;12240.510379584717;8946.552672366486;9015.233705135137;9044.683436079706;9091.636334546543;9114.27085833145;10277.53751081218;11533.942330288295;11914.106442017057;11975.64073077809;12259.325737084546 09:20:25 INFO - PROCESS | 20485 | |3;mootools.html;1412.0468683638544;1426.2939844776836;1592.8327525609811;1857.7677790276216;1860.069965017492;7700.4224683148705;7930.206979302067;8603.526806025666;8897.377183597142;8924.375293729441;8548.871766923501;8597.828043439127;8761.780955476117;8921.821563568725;8941.91058089419;2285.1430713482487;2301.7813307735737;2314.7916687498123;2316.930492085232;2321.802646775018;2381.845180063299;2420.491696743677;2474.492728990562;2477.1453848422266;2480.7891329236945;2402.531506356261;2420.1287536486852;2423.212455951823;2424.5150969806023;2447.608382658775;2394.162043284854;2411.46947671512;2421.9515609687883;2423.745506721795;2439.1097249503982;2446.8409553378974;2460.052879641333;2470.9505809883703;2477;2493.2644869763462;8851.291896648318;8938.821223575493;8955.776105597348;8958.417702849294;8959.5968181432;5309.7610607522365;5386.111291636876;5415.729213539307;5415.783368665248;5419.5393391561765;3355.7147642450423;3410.1645096951406;3418.1112910643164;3540.716742660581;3569.9107522311892;1191.8033524468453;1207.420438189665;1238.207547169812;1253.874612538748;1262.0786825617351;11985.28088314704;12084.939575302154;12116.21244619097;12119.697007574881;12146.757064858653;4435.800388982503;4483.932741008887;4580.71739912825;4580.97709511457;4606.631469482433;10464.63373781914;10477.423741694127;10485.213608979204;10518.263721539572;10519.211059170593;5371.060064488699;5381.704006279692;5383.7846486140115;5397.8380648580605;5424.484673955968;4642.814287428465;4826.107170173529;4842;4861.29511220871;4941.258811178352;3825.387937929918;3857.209272099269;3881.1073453105378;3913.4325522799036;3942.3692209246383;1173.3194747046693;1182.5210789630214;1185.6087491127907;1200.6218041316956;1238.1766125526603;1067.594314160614;1071.6677829872765;1079.865016872891;1082.658962426833;1084.7450849050467;6127.417895299939;6200.224971878515;6238.157848690459;6272.671856419056;6322.241331040304;412.3505478870791;414.991700166001;419.23908106786087;1091.4324551233315;1116.1963386361806;3972.980135099306;4131.380292956021;4144.005438694752;4209.389638502461;4290.249206388869;10459.529321180566;10683.626073087406;10876.945615271872;10925.399103049249;10942.17933654963;10633.308834925705;10691.83962240567;10702.892971070345;10725.14198864089;10725.195610329256;8061.959690201512;8180.7954801130445;8323.5005899645;8342.499450033018;8382.538960357238;6068.4841788448475;6080.787172448943;6088.117223002551;6095.116208149882;6162.7534898605345;9740.805183896424;9801.50992450389;9856.359336643096;9884;9936.403815771077;9286.62853485853;9641.566129524048;9679.564419601276;9723.367981081206;9813.950930245303;6792.96603516999;7588.127365353055;7639.809004774925;7712.267334603203;7895.289423951872;8351.498910065415;8365.24712775853;8407.738839174173;8414.453060551044;8462.19609137131;7334;7620.504667196615;7656.885146722692;7667.884981725167;7787.96106019489;7420.740274090381;7617.733379331697;7631.503952243309;7641.312281894656;7722.613869306625;7207.1711753146965;7280.781576552712;7372.410207183305;7460.888086678813;7461.95532625422;5364.30264065669;5468;5532.612717109763;5613.859653508695;5660.773569057192;5364.436734142859;5382.703951282717;5419.972900135474;5519.917201242065;5570.136628822539 09:20:25 INFO - PROCESS | 20485 | |4;prototype.html;329.49916127486205;335.163766402825;335.65930580460827;340.0902585583563;346.34540718042894;6484.351564843513;6565.376289252526;6566.179227596551;6668.366505182012;6707.19513658361;6527.706253218605;6543.149390579218;6555.934440655592;6608.801735947929;6630.801075967716;4912.484189160132;4952.9257061143935;4967.850964471072;4975.4527002029745;4987.102321582114;4979.526944940243;4983.426905905831;4989.575886049672;4996.675216110959;5005.399352077756;4890.193118135521;4946;4952.603791696673;4953.1579631462555;4959.60323174147;4693;4867.099586576494;4939.876503087434;4939.950600494003;4955.058538877602;4138.586141385867;4159.584041595846;4173.91652166958;4181.226473102486;4187.994881228514;6253.343398943137;6306.369363063703;6310.779122730728;6315.905261421082;6317.305096439434;5674;5680.0627896397045;5685.630434021817;5687.061634830248;5707.885842283131;6945.201301850251;6946.6179360135175;6946.861062778767;6960.060391847137;6963.79108626742;4509.120721459317;4626.83806066786;4655.4180727409075;4660.1145782301255;4676.8363107291425;7131.429485641136;7267.946147808538;7307.634618269065;7315.268473152695;7316.085489313836;4740.834070807505;4747.192977193886;4750.453697824725;4754.952450475451;4757.9048419032115;4779.402574678165;4814.855554333376;4822.324874517571;4822.541858523435;4831.782569784368;5677.858053548694;5681.176229446707;5681.886362272731;5690.118031705092;5690.430956904276;6891.483138764613;7006.334398232159;7025;7028;7035.401990830735;1647.0858673436358;1651.1579094661809;1654.8427899349542;1661.7839680841414;1664.0847533856572;1054.1619412566874;1068.2468859454066;1072.6996440996534;1088.918331125153;1096.0957210301533;6689.76585819494;6806.285340039224;6807.421369183675;6808.421284190899;6829.795106146824;7138.393236574845;7189.352958233784;7193.352598266181;7200;7222.819429514304;6784.3554862288;6791.4906382021545;6792.743342481656;6794.014867844135;6804.149481314836;3833.8466461341236;3848.1726428817938;3874.2445223181207;3897.0647044709067;3906.4921560196995;7344.466159175076;7674.731384401519;7683.231676832272;7684;7705.190954949761;7404.370628496638;7414.888776668355;7488.4009279257525;7491.775246742606;7517.285857843496;7627.0847498299445;7658.425618078666;7663.578503182379;7673.731419400406;7692.346150577152;7204.675789589586;7259;7286.927130728624;7314.743983960536;7350.448716346188;7228.060352154396;7243;7249.710011599477;7251.093613298338;7255.891161632685;7624.199459056719;7630.7329243476215;7640.770776876702;7654.387648988179;7661.387089032753;4756.334113224082;4802.327674125695;4805.063012712488;4812.422509298766;4817.494163112823;7017.508774385744;7294.1247050354295;7312.19565847767;7319.5242309249725;7328.926710732824;7115.181754098345;7136;7139.785806425815;7141.785746427616;7156.785296441115;7060.117485314336;7087.397571206505;7097.503174777716;7106;7109.253528379652;6914.481413893877;6943.27095654949;6949.478789090737;6962.512624116263;6981.8254543634785;6911.412529935012;7013.211631034053;7133.322334378226;7137.607431591312;7138.428925686037;6735.932640673726;6976.5814051157095;6982.33667801558;6990.671772363438;6993.300669932966 09:20:25 INFO - PROCESS | 20485 | |5;yui.html;852.4459101583969;898.8966268879078;931.4132096779028;934.8083642853215;940.6895724410945;14943.925280373596;15313.0812151271;15357.078575285477;15361.30874110665;15362.231888405591;12720.300383478905;14682.55952321432;14846.257687115654;14858.182799945998;14921.925390373033;865.7532603208087;902.3953950852945;903.9186473217409;904.2449554621866;904.995475022624;886.685226744506;889.6574818694785;896.4128495835206;896.5830888636783;897.277691458379;929.159111004542;930.2325581395343;934.8784657994452;936.1574582875398;939.065629698451;937.610891480035;939.4269495607674;939.6992962252082;941.6327632223438;942.505184777997;684.1345697692423;690.5752961928428;690.7099018412279;693.3240090911371;693.5006795107514;14918.477853275082;14966;14996.250187490581;15015.774763378558;15110.471133510275;14574.417023319054;14608.488702895347;14725;14745.262736863115;14857.554273371816;12253;12294.385280735927;12320.322382268972;12390;12532.185407948455;4043.1711499142607;4106.404571337169;4117.176564687044;4132.524759652649;4165.958340416618;52702.47297527014;52950;53363.73318133423;53409;53419;11062.170337224741;11387.829182562267;11747.295162290118;11969.700757481132;12053.975412089896;21192.682109768364;21201.15195392167;21206.15175392967;21207.68188477174;21228.363149105553;8162.714304999416;8432.156784321518;8467.618957146944;8532.57337133141;8710.21608055278;4660.6970546914345;4741.881452963704;4761.9047619048115;5006.324146240211;5105.617078719111;3484.5992710838073;3542.2384187399834;3542.71658267338;3546.840392182358;3569.39320315547;650.869826034795;656.5601047298321;666.2970566052861;669.347386298365;669.8158006548239;674.6963866260203;742.4988133010196;791.3313250303485;794.0947320055142;821.1870248453988;8681.262092722189;9324.627014919462;9591.328606997444;9622.326437149331;9629.374090684083;780.9648565814553;804.3082948664144;827.7227128911882;830.8006078541107;853.6329378367361;4149.502059752849;4261.978690106592;4362.541933097043;4397.582229688174;4409.338599210144;66002.66998664977;66524.33475665182;68031.65984170047;68114;68245.65877170583;59036.7048164765;59305.40694593085;59763.70118149468;59915.400845991855;60626.39373606296;52794.47205527972;53536.46463535393;54536;54614;55846.16230756542;8445.113263107285;8552.828943420973;8575.742727718178;8632;8677.1756683115;40365.59634403736;40521.1895762089;41434.58565414307;41656.375154373316;42772.358414624425;53531;53857.730711346194;54313.45686543084;54970;55217;11109.666709998713;11189.272697274651;11241.494132764208;11246.437678116225;11279.548818047186;12917.22496650204;13194.934025329812;13223.338833058117;13274.203547787163;13293.26887021223;12218.694532636755;12287.262764234174;12290.692732681755;12307.876921230672;12421.316827574208;11823.527058917547;11929.582464613697;11941.76116477683;11970.341631210018;12032.217905836093;12127.151099422956;12404.689882753004;12553.560625378068;12565.811512827499;12955.740885182433;9987.650432234837;10998.34009959405;11050.33697978124;11108.944455277671;11264.887351126385;10933.234673573092;10949.616763413242;11037;11182.217244793112;11236.775264494829 09:20:25 INFO - PROCESS | 20485 | __end_tp_report 09:20:25 INFO - PROCESS | 20485 | __start_cc_report 09:20:25 INFO - PROCESS | 20485 | _x_x_mozilla_cycle_collect,331 09:20:25 INFO - PROCESS | 20485 | __end_cc_report 09:20:25 INFO - PROCESS | 20485 | __startTimestamp1464020425714__endTimestamp 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | ------- Summary: start ------- 09:20:25 INFO - PROCESS | 20485 | Number of tests: 6 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | [#0] dojo.html Cycles:165 Average:5492.80 Median:5732.03 stddev:602.91 (10.5%) stddev-sans-first:580.12 09:20:25 INFO - PROCESS | 20485 | Values: 3318.0 3394.9 3400.3 3418.8 3435.8 5475.4 5508.5 5522.3 5527.7 5549.3 5502.8 5522.3 5532.8 5533.4 5533.9 5011.1 5012.9 5064.3 5070.8 5076.5 4976.6 5066.9 5085.8 5148.5 5180.9 5007.8 5023.2 5050.2 5146.1 5149.6 5044.6 5051.4 5052.9 5059.7 5086.9 4807.8 4966.7 4967.3 5020.9 5027.9 5248.7 5318.3 5339.8 5349.4 5403.6 5893.0 5916.3 5925.1 5940.6 5942.5 5860.7 5979.9 5982.8 5994.6 6024.5 5493.6 5553.2 5554.4 5556.2 5591.2 6002.6 6010.5 6026.7 6034.8 6050.3 5765.9 5817.3 5819.8 5831.6 5906.6 5761.3 5825.1 5828.4 5833.7 5857.5 5747.4 5785.5 5793.1 5794.8 5803.9 5701.1 5745.8 5759.5 5818.4 5826.3 4446.5 4453.8 4463.5 4466.5 4474.3 3980.9 4001.2 4023.8 4037.8 4040.9 5489.0 5589.4 5675.5 5735.8 5736.7 5891.6 5975.3 6008.9 6016.3 6037.0 5556.8 5561.1 5578.7 5646.9 5650.5 5014.0 5097.3 5152.2 5156.9 5175.1 6061.8 6080.9 6092.0 6092.2 6095.5 5859.4 5876.7 5901.6 5914.7 5920.5 6127.0 6139.5 6160.8 6170.4 6171.1 5792.4 5807.4 5822.5 5829.9 5848.3 5890.2 5923.1 5923.2 5971.1 5981.3 5833.9 5853.2 5858.8 5874.6 5897.1 5766.2 5781.1 5815.6 5839.2 5851.4 5484.5 5670.7 5714.1 5724.9 5732.0 5782.0 5782.1 5822.4 5829.5 5857.5 5701.8 5717.2 5721.7 5726.1 5737.0 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | [#1] ext.html Cycles:180 Average:57081.83 Median:41217.79 stddev:113511.81 (275.4%) stddev-sans-first:113751.08 09:20:25 INFO - PROCESS | 20485 | Values: 619.9 653.9 663.0 681.3 683.7 38799.0 39673.6 39817.4 39821.2 39862.6 36618.6 36910.3 37090.8 37109.6 37231.6 8820.5 9073.3 9084.2 9098.5 9119.4 8802.0 8975.0 8988.4 8989.2 9001.5 9000.8 9047.2 9113.7 9123.3 9131.5 8922.6 9004.4 9004.4 9025.1 9074.7 8969.1 9034.9 9037.8 9055.1 9074.7 43253.4 43364.0 43658.0 43666.8 43847.3 3762.1 3999.9 4152.3 4218.5 4543.9 32995.5 33128.0 33674.8 33731.8 33988.8 4408.3 4476.7 4504.6 4511.4 4533.6 307874.0 307995.0 308893.0 309089.0 309137.0 37828.2 59341.0 60009.4 60199.0 60441.0 36901.8 37153.6 37201.3 37304.8 37414.3 15691.8 16053.4 16062.2 16063.2 16065.7 12974.8 12982.0 12998.2 13001.9 13087.3 9149.7 9198.1 9239.0 9270.7 9281.6 3396.0 3418.1 3422.6 3426.6 3427.5 1107.7 1146.3 1164.2 1172.5 1269.0 32642.0 33300.8 33446.3 33606.7 33844.5 1190.6 1196.9 1207.5 1210.7 1306.8 17225.3 17346.8 17555.0 17631.0 17660.0 491637.0 500393.0 506738.0 520878.0 523611.0 46899.0 47160.0 47292.3 47322.3 47441.5 1360.6 1472.5 1488.0 1495.1 1495.6 29062.7 30602.2 31396.4 31426.5 31720.0 52360.0 52592.7 52965.2 53174.7 53223.5 438919.0 440944.0 442334.0 442611.0 442782.0 29632.4 29753.9 29777.7 30099.2 30485.4 48402.0 48548.3 48599.0 49364.0 49505.5 41420.2 41908.0 42070.0 42159.8 42630.0 40788.0 41001.8 41034.6 41401.0 42145.4 42422.0 44294.0 44671.3 44974.0 45010.8 33238.5 35189.6 35564.3 35979.3 36147.1 26077.2 26385.7 26424.0 26621.5 26754.5 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | [#2] jquery.html Cycles:180 Average:29259.80 Median:2072.67 stddev:82686.18 (3989.4%) stddev-sans-first:82889.79 09:20:25 INFO - PROCESS | 20485 | Values: 427.9 430.7 434.1 438.8 442.8 18392.1 18982.7 19147.1 20330.2 20967.6 19650.3 19670.0 19671.5 20022.2 20024.5 5768.5 5847.1 5911.2 5914.1 5924.6 5291.9 5543.3 5547.3 5863.6 5881.4 5489.3 5521.1 5525.4 5552.5 5557.4 5958.7 5979.1 5980.8 6010.2 6020.0 5403.9 5835.9 5849.3 5864.7 5866.2 13365.7 13527.8 13659.6 13704.7 13719.5 2398.8 2429.9 2586.0 2623.3 2772.8 9952.3 11147.8 14209.4 14294.3 15047.2 2043.7 2072.0 2073.4 2117.0 2136.1 72263.0 74752.3 76382.2 77626.2 78961.6 11367.1 11628.9 11712.2 11719.6 12017.6 16606.5 16634.4 16684.2 16701.9 16780.9 8461.4 8606.1 8615.9 8687.1 8767.7 8260.7 8288.6 8294.5 8302.1 8392.1 5096.3 5146.8 5163.7 5174.7 5176.1 1930.2 2046.0 2123.2 2124.4 2134.9 1026.8 1077.8 1085.1 1138.5 1191.9 16593.7 17446.7 17672.0 18754.8 19255.2 1086.8 1095.4 1134.6 1137.7 1157.8 10414.3 10697.4 10727.8 10773.2 10830.8 492603.6 498593.0 503356.0 503374.0 508884.0 97492.0 100978.5 101158.5 101438.0 102497.0 1058.6 1074.8 1141.1 1161.2 1162.5 15913.0 15996.7 16156.8 16402.8 16529.3 39619.2 40035.6 40139.4 40315.0 40468.0 52026.0 56453.7 57046.7 57361.1 57693.7 8625.9 8643.8 8798.2 8840.6 9108.0 13338.2 13431.5 13769.3 13775.6 13823.0 11574.9 11717.2 11728.5 11884.3 12545.6 11401.6 11567.2 11653.0 11724.5 11982.6 11834.9 11839.4 11903.5 11957.3 12240.5 8946.6 9015.2 9044.7 9091.6 9114.3 10277.5 11533.9 11914.1 11975.6 12259.3 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | [#3] mootools.html Cycles:180 Average:5811.79 Median:4734.46 stddev:3226.61 (68.2%) stddev-sans-first:3218.71 09:20:25 INFO - PROCESS | 20485 | Values: 1412.0 1426.3 1592.8 1857.8 1860.1 7700.4 7930.2 8603.5 8897.4 8924.4 8548.9 8597.8 8761.8 8921.8 8941.9 2285.1 2301.8 2314.8 2316.9 2321.8 2381.8 2420.5 2474.5 2477.1 2480.8 2402.5 2420.1 2423.2 2424.5 2447.6 2394.2 2411.5 2422.0 2423.7 2439.1 2446.8 2460.1 2471.0 2477.0 2493.3 8851.3 8938.8 8955.8 8958.4 8959.6 5309.8 5386.1 5415.7 5415.8 5419.5 3355.7 3410.2 3418.1 3540.7 3569.9 1191.8 1207.4 1238.2 1253.9 1262.1 11985.3 12084.9 12116.2 12119.7 12146.8 4435.8 4483.9 4580.7 4581.0 4606.6 10464.6 10477.4 10485.2 10518.3 10519.2 5371.1 5381.7 5383.8 5397.8 5424.5 4642.8 4826.1 4842.0 4861.3 4941.3 3825.4 3857.2 3881.1 3913.4 3942.4 1173.3 1182.5 1185.6 1200.6 1238.2 1067.6 1071.7 1079.9 1082.7 1084.7 6127.4 6200.2 6238.2 6272.7 6322.2 412.4 415.0 419.2 1091.4 1116.2 3973.0 4131.4 4144.0 4209.4 4290.2 10459.5 10683.6 10876.9 10925.4 10942.2 10633.3 10691.8 10702.9 10725.1 10725.2 8062.0 8180.8 8323.5 8342.5 8382.5 6068.5 6080.8 6088.1 6095.1 6162.8 9740.8 9801.5 9856.4 9884.0 9936.4 9286.6 9641.6 9679.6 9723.4 9814.0 6793.0 7588.1 7639.8 7712.3 7895.3 8351.5 8365.2 8407.7 8414.5 8462.2 7334.0 7620.5 7656.9 7667.9 7788.0 7420.7 7617.7 7631.5 7641.3 7722.6 7207.2 7280.8 7372.4 7460.9 7462.0 5364.3 5468.0 5532.6 5613.9 5660.8 5364.4 5382.7 5420.0 5519.9 5570.1 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | [#4] prototype.html Cycles:180 Average:5834.78 Median:6721.56 stddev:1834.69 (27.3%) stddev-sans-first:1792.70 09:20:25 INFO - PROCESS | 20485 | Values: 329.5 335.2 335.7 340.1 346.3 6484.4 6565.4 6566.2 6668.4 6707.2 6527.7 6543.1 6555.9 6608.8 6630.8 4912.5 4952.9 4967.9 4975.5 4987.1 4979.5 4983.4 4989.6 4996.7 5005.4 4890.2 4946.0 4952.6 4953.2 4959.6 4693.0 4867.1 4939.9 4940.0 4955.1 4138.6 4159.6 4173.9 4181.2 4188.0 6253.3 6306.4 6310.8 6315.9 6317.3 5674.0 5680.1 5685.6 5687.1 5707.9 6945.2 6946.6 6946.9 6960.1 6963.8 4509.1 4626.8 4655.4 4660.1 4676.8 7131.4 7267.9 7307.6 7315.3 7316.1 4740.8 4747.2 4750.5 4755.0 4757.9 4779.4 4814.9 4822.3 4822.5 4831.8 5677.9 5681.2 5681.9 5690.1 5690.4 6891.5 7006.3 7025.0 7028.0 7035.4 1647.1 1651.2 1654.8 1661.8 1664.1 1054.2 1068.2 1072.7 1088.9 1096.1 6689.8 6806.3 6807.4 6808.4 6829.8 7138.4 7189.4 7193.4 7200.0 7222.8 6784.4 6791.5 6792.7 6794.0 6804.1 3833.8 3848.2 3874.2 3897.1 3906.5 7344.5 7674.7 7683.2 7684.0 7705.2 7404.4 7414.9 7488.4 7491.8 7517.3 7627.1 7658.4 7663.6 7673.7 7692.3 7204.7 7259.0 7286.9 7314.7 7350.4 7228.1 7243.0 7249.7 7251.1 7255.9 7624.2 7630.7 7640.8 7654.4 7661.4 4756.3 4802.3 4805.1 4812.4 4817.5 7017.5 7294.1 7312.2 7319.5 7328.9 7115.2 7136.0 7139.8 7141.8 7156.8 7060.1 7087.4 7097.5 7106.0 7109.3 6914.5 6943.3 6949.5 6962.5 6981.8 6911.4 7013.2 7133.3 7137.6 7138.4 6735.9 6976.6 6982.3 6990.7 6993.3 09:20:25 INFO - PROCESS | 20485 | 09:20:25 INFO - PROCESS | 20485 | [#5] yui.html Cycles:180 Average:15797.58 Median:4751.89 stddev:18677.80 (393.1%) stddev-sans-first:18696.48 09:20:25 INFO - PROCESS | 20485 | Values: 852.4 898.9 931.4 934.8 940.7 14943.9 15313.1 15357.1 15361.3 15362.2 12720.3 14682.6 14846.3 14858.2 14921.9 865.8 902.4 903.9 904.2 905.0 886.7 889.7 896.4 896.6 897.3 929.2 930.2 934.9 936.2 939.1 937.6 939.4 939.7 941.6 942.5 684.1 690.6 690.7 693.3 693.5 14918.5 14966.0 14996.3 15015.8 15110.5 14574.4 14608.5 14725.0 14745.3 14857.6 12253.0 12294.4 12320.3 12390.0 12532.2 4043.2 4106.4 4117.2 4132.5 4166.0 52702.5 52950.0 53363.7 53409.0 53419.0 11062.2 11387.8 11747.3 11969.7 12054.0 21192.7 21201.2 21206.2 21207.7 21228.4 8162.7 8432.2 8467.6 8532.6 8710.2 4660.7 4741.9 4761.9 5006.3 5105.6 3484.6 3542.2 3542.7 3546.8 3569.4 650.9 656.6 666.3 669.3 669.8 674.7 742.5 791.3 794.1 821.2 8681.3 9324.6 9591.3 9622.3 9629.4 781.0 804.3 827.7 830.8 853.6 4149.5 4262.0 4362.5 4397.6 4409.3 66002.7 66524.3 68031.7 68114.0 68245.7 59036.7 59305.4 59763.7 59915.4 60626.4 52794.5 53536.5 54536.0 54614.0 55846.2 8445.1 8552.8 8575.7 8632.0 8677.2 40365.6 40521.2 41434.6 41656.4 42772.4 53531.0 53857.7 54313.5 54970.0 55217.0 11109.7 11189.3 11241.5 11246.4 11279.5 12917.2 13194.9 13223.3 13274.2 13293.3 12218.7 12287.3 12290.7 12307.9 12421.3 11823.5 11929.6 11941.8 11970.3 12032.2 12127.2 12404.7 12553.6 12565.8 12955.7 9987.7 10998.3 11050.3 11108.9 11264.9 10933.2 10949.6 11037.0 11182.2 11236.8 09:20:25 INFO - PROCESS | 20485 | -------- Summary: end -------- 09:20:25 INFO - PROCESS | 20485 | 09:20:26 INFO - TEST-INFO | 20485: exit 0 09:20:26 INFO - TEST-OK | dromaeo_css | took 1111531ms 09:20:26 INFO - TEST-START | kraken 09:20:26 INFO - operating with platform_type : linux_ 09:20:26 INFO - Initialising browser for kraken test... 09:20:26 INFO - TEST-INFO | started process 20727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYiw0ri/profile http://localhost:54041/getInfo.html) 09:20:31 INFO - PROCESS | 20727 | 09:20:31 INFO - PROCESS | 20727 | (process:20806): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:20:33 INFO - PROCESS | 20727 | __metrics Screen width/height:1600/1200 09:20:33 INFO - PROCESS | 20727 | colorDepth:24 09:20:33 INFO - PROCESS | 20727 | Browser inner width/height: 1024/697 09:20:33 INFO - PROCESS | 20727 | __metrics 09:20:34 ERROR - PROCESS | 20727 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 09:20:35 INFO - TEST-INFO | 20727: exit 0 09:20:35 INFO - Browser initialized. 09:20:35 INFO - Running cycle 1/1 for kraken test... 09:20:35 INFO - TEST-INFO | started process 20857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYiw0ri/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:37 INFO - PROCESS | 20857 | 09:20:37 INFO - PROCESS | 20857 | (process:20921): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:20:47 INFO - PROCESS | 20857 | RSS: Main: 152211456 09:20:47 INFO - PROCESS | 20857 | 09:20:49 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54041/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:50 INFO - PROCESS | 20857 | RSS: Main: 157159424 09:20:50 INFO - PROCESS | 20857 | 09:20:53 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54041/tests/kraken/driver.html?testName=audio-dft) 09:20:53 INFO - PROCESS | 20857 | RSS: Main: 157057024 09:20:53 INFO - PROCESS | 20857 | 09:20:56 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54041/tests/kraken/driver.html?testName=audio-fft) 09:20:57 INFO - PROCESS | 20857 | RSS: Main: 156979200 09:20:57 INFO - PROCESS | 20857 | 09:20:59 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54041/tests/kraken/driver.html?testName=audio-oscillator) 09:20:59 INFO - PROCESS | 20857 | RSS: Main: 157032448 09:20:59 INFO - PROCESS | 20857 | 09:21:02 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54041/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:02 INFO - PROCESS | 20857 | RSS: Main: 156905472 09:21:02 INFO - PROCESS | 20857 | 09:21:05 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54041/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:06 INFO - PROCESS | 20857 | RSS: Main: 157532160 09:21:06 INFO - PROCESS | 20857 | 09:21:09 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54041/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:10 INFO - PROCESS | 20857 | RSS: Main: 156717056 09:21:10 INFO - PROCESS | 20857 | 09:21:13 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54041/tests/kraken/driver.html?testName=json-parse-financial) 09:21:13 INFO - PROCESS | 20857 | RSS: Main: 156954624 09:21:13 INFO - PROCESS | 20857 | 09:21:15 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54041/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:15 INFO - PROCESS | 20857 | RSS: Main: 156889088 09:21:15 INFO - PROCESS | 20857 | 09:21:17 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:18 INFO - PROCESS | 20857 | RSS: Main: 157548544 09:21:18 INFO - PROCESS | 20857 | 09:21:20 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:20 INFO - PROCESS | 20857 | RSS: Main: 157605888 09:21:20 INFO - PROCESS | 20857 | 09:21:23 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:23 INFO - PROCESS | 20857 | RSS: Main: 157982720 09:21:23 INFO - PROCESS | 20857 | 09:21:26 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:27 INFO - PROCESS | 20857 | RSS: Main: 157413376 09:21:27 INFO - PROCESS | 20857 | 09:21:28 INFO - PROCESS | 20857 | Cycle 1(1): loaded http://localhost:54041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54041/tests/kraken/driver.html?testName=ai-astar) 09:21:29 INFO - PROCESS | 20857 | RSS: Main: 159051776 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | __start_tp_report 09:21:29 INFO - PROCESS | 20857 | _x_x_mozilla_page_load 09:21:29 INFO - PROCESS | 20857 | _x_x_mozilla_page_load_details 09:21:29 INFO - PROCESS | 20857 | |i|pagename|runs| 09:21:29 INFO - PROCESS | 20857 | |0;ai-astar;108;112;104;112;111;112;101;109;111;109 09:21:29 INFO - PROCESS | 20857 | |1;audio-beat-detection;155;129;152;169;128;154;153;129;181;127 09:21:29 INFO - PROCESS | 20857 | |2;audio-dft;162;162;162;163;164;162;162;161;162;162 09:21:29 INFO - PROCESS | 20857 | |3;audio-fft;76;75;77;180;74;74;77;76;158;76 09:21:29 INFO - PROCESS | 20857 | |4;audio-oscillator;94;93;156;92;93;92;161;91;93;145 09:21:29 INFO - PROCESS | 20857 | |5;imaging-gaussian-blur;117;117;117;118;118;119;117;118;117;117 09:21:29 INFO - PROCESS | 20857 | |6;imaging-darkroom;146;147;148;147;146;147;148;147;147;147 09:21:29 INFO - PROCESS | 20857 | |7;imaging-desaturate;95;95;96;96;96;95;100;95;95;96 09:21:29 INFO - PROCESS | 20857 | |8;json-parse-financial;65;56;58;56;64;58;58;81;61;55 09:21:29 INFO - PROCESS | 20857 | |9;json-stringify-tinderbox;57;58;58;57;58;60;57;58;58;58 09:21:29 INFO - PROCESS | 20857 | |10;stanford-crypto-aes;73;72;71;72;73;83;75;81;73;73 09:21:29 INFO - PROCESS | 20857 | |11;stanford-crypto-ccm;123;114;112;114;112;113;119;113;127;129 09:21:29 INFO - PROCESS | 20857 | |12;stanford-crypto-pbkdf2;165;165;156;167;167;161;160;166;159;156 09:21:29 INFO - PROCESS | 20857 | |13;stanford-crypto-sha256-iterative;73;66;65;67;66;67;66;66;66;71 09:21:29 INFO - PROCESS | 20857 | __end_tp_report 09:21:29 INFO - PROCESS | 20857 | __start_cc_report 09:21:29 INFO - PROCESS | 20857 | _x_x_mozilla_cycle_collect,831 09:21:29 INFO - PROCESS | 20857 | __end_cc_report 09:21:29 INFO - PROCESS | 20857 | __startTimestamp1464020489165__endTimestamp 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | ------- Summary: start ------- 09:21:29 INFO - PROCESS | 20857 | Number of tests: 14 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.73 (3.4%) stddev-sans-first:3.94 09:21:29 INFO - PROCESS | 20857 | Values: 108.0 112.0 104.0 112.0 111.0 112.0 101.0 109.0 111.0 109.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:153.50 stddev:18.91 (12.3%) stddev-sans-first:19.87 09:21:29 INFO - PROCESS | 20857 | Values: 155.0 129.0 152.0 169.0 128.0 154.0 153.0 129.0 181.0 127.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:21:29 INFO - PROCESS | 20857 | Values: 162.0 162.0 162.0 163.0 164.0 162.0 162.0 161.0 162.0 162.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:39.72 (52.3%) stddev-sans-first:41.58 09:21:29 INFO - PROCESS | 20857 | Values: 76.0 75.0 77.0 180.0 74.0 74.0 77.0 76.0 158.0 76.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.50 stddev:29.93 (32.4%) stddev-sans-first:31.11 09:21:29 INFO - PROCESS | 20857 | Values: 94.0 93.0 156.0 92.0 93.0 92.0 161.0 91.0 93.0 145.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 09:21:29 INFO - PROCESS | 20857 | Values: 117.0 117.0 117.0 118.0 118.0 119.0 117.0 118.0 117.0 117.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 09:21:29 INFO - PROCESS | 20857 | Values: 146.0 147.0 148.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:1.58 09:21:29 INFO - PROCESS | 20857 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 100.0 95.0 95.0 96.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:59.50 stddev:7.73 (13.0%) stddev-sans-first:8.07 09:21:29 INFO - PROCESS | 20857 | Values: 65.0 56.0 58.0 56.0 64.0 58.0 58.0 81.0 61.0 55.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.88 (1.5%) stddev-sans-first:0.87 09:21:29 INFO - PROCESS | 20857 | Values: 57.0 58.0 58.0 57.0 58.0 60.0 57.0 58.0 58.0 58.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:73.00 stddev:4.06 (5.6%) stddev-sans-first:4.27 09:21:29 INFO - PROCESS | 20857 | Values: 73.0 72.0 71.0 72.0 73.0 83.0 75.0 81.0 73.0 73.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:116.50 stddev:6.50 (5.6%) stddev-sans-first:6.60 09:21:29 INFO - PROCESS | 20857 | Values: 123.0 114.0 112.0 114.0 112.0 113.0 119.0 113.0 127.0 129.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:165.00 stddev:4.34 (2.6%) stddev-sans-first:4.48 09:21:29 INFO - PROCESS | 20857 | Values: 165.0 165.0 156.0 167.0 167.0 161.0 160.0 166.0 159.0 156.0 09:21:29 INFO - PROCESS | 20857 | 09:21:29 INFO - PROCESS | 20857 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.50 stddev:2.58 (3.9%) stddev-sans-first:1.73 09:21:29 INFO - PROCESS | 20857 | Values: 73.0 66.0 65.0 67.0 66.0 67.0 66.0 66.0 66.0 71.0 09:21:29 INFO - PROCESS | 20857 | -------- Summary: end -------- 09:21:29 INFO - PROCESS | 20857 | 09:21:30 INFO - TEST-INFO | 20857: exit 0 09:21:30 INFO - TEST-OK | kraken | took 63598ms 09:21:30 INFO - SUITE-END | took 1175s 09:21:30 INFO - Completed test suite (00:19:35) 09:21:30 INFO - javascript benchmark 09:21:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.98341008295, 3394.9151271218234, 3400.268942177432, 3418.8119653419067, 3435.8146439478387, 5475.3977062523145, 5508.531774799147, 5522.282103326572, 5527.723613819303, 5549.334079910412, 5502.752376143073, 5522.337319521653, 5532.75102620382, 5533.363663178726, 5533.861653458665, 5011.123053465629, 5012.949870501294, 5064.290999260088, 5070.84787456375, 5076.517730815566, 4976.576990955773, 5066.923996140061, 5085.79656813727, 5148.485151484859, 5180.870478238036, 5007.84976450707, 5023.2214006829, 5050.242463630448, 5146.099432599299, 5149.562287205592, 5044.646874718771, 5051.444341122474, 5052.9242061369105, 5059.696418214919, 5086.949130508685, 4807.759612019385, 4966.652334336598, 4967.279744437073, 5020.874478138039, 5027.949720502785, 5248.71132087735, 5318.282031925679, 5339.813106541253, 5349.43830897754, 5403.648762830403, 5892.970535147339, 5916.349201587822, 5925.051991681354, 5940.61386009908, 5942.494887934531, 5860.677662728548, 5979.940200597982, 5982.790602328898, 5994.610350327258, 6024.48791852693, 5493.587980901449, 5553.16702494625, 5554.389017208104, 5556.194351819004, 5591.161325801122, 6002.609830361012, 6010.519158467312, 6026.668533230714, 6034.818955431257, 6050.30421501533, 5765.913511297334, 5817.272840894888, 5819.796307129315, 5831.620944638585, 5906.616069955439, 5761.308642962871, 5825.0679891217205, 5828.388019258002, 5833.679147646835, 5857.531397488191, 5747.39652336507, 5785.508231800344, 5793.131030345482, 5794.768209271666, 5803.88392232153, 5701.059325211294, 5745.798897038583, 5759.510441612426, 5818.44724751148, 5826.300843898674, 4446.5331140230455, 4453.821847126143, 4463.486699029653, 4466.486354069259, 4474.261746811805, 3980.9402858957137, 4001.199760048002, 4023.798810059544, 4037.7779222142476, 4040.878773636796, 5489.0, 5589.441055894459, 5675.460831221028, 5735.77056917727, 5736.713164341766, 5891.617044892068, 5975.342712301644, 6008.939910600925, 6016.278046634432, 6037.034074548052, 5556.77772889088, 5561.110222364402, 5578.693171875505, 5646.858828529237, 5650.5479561634975, 5014.0, 5097.286379906816, 5152.227165925141, 5156.948430515722, 5175.146100893386, 6061.818145455643, 6080.908786368208, 6091.969540152271, 6092.1775560299675, 6095.451409373178, 5859.44335288147, 5876.676782776903, 5901.616394934315, 5914.674692891932, 5920.496757775465, 6127.006280530498, 6139.508839292756, 6160.7535698571555, 6170.352113028068, 6171.13604095418, 5792.420757924174, 5807.419258074159, 5822.475977162076, 5829.854253643523, 5848.298204215522, 5890.234269545103, 5923.052311630118, 5923.229980102559, 5971.104334349709, 5981.282246130492, 5833.854153646193, 5853.1805547222575, 5858.8242352729485, 5874.647521148745, 5897.115432685132, 5766.163906233656, 5781.103928891029, 5815.621984570989, 5839.182514448065, 5851.414858514285, 5484.478974497416, 5670.659760414388, 5714.085746280575, 5724.885502290014, 5732.025555655632, 5781.971090144522, 5782.10377391505, 5822.427944455058, 5829.5336373090895, 5857.502112320501, 5701.800436984686, 5717.228174196596, 5721.742521586455, 5726.112452569859, 5736.996025695403], "value": 5454.317021543739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.8853212155751, 653.869226154769, 662.996685016575, 681.3118750062441, 683.6650041479677, 38799.0, 39673.60326396735, 39817.40273895887, 39821.20357592846, 39862.601373986254, 36618.63381366186, 36910.26179476409, 37090.814545927235, 37109.62890371095, 37231.627683723156, 8820.470771753699, 9073.319501037415, 9084.227840633554, 9098.545072746336, 9119.407238529475, 8801.95599022004, 8974.955125224365, 8988.370814043019, 8989.190972812445, 9001.459912405277, 9000.819983600324, 9047.23098536622, 9113.68102116426, 9123.315751318645, 9131.543422828865, 8922.643094276222, 9004.369694121415, 9004.369694121448, 9025.097490250922, 9074.68238611652, 8969.058248883905, 9034.909650903473, 9037.819243615157, 9055.094490550959, 9074.68238611652, 43253.35119973203, 43364.0, 43658.0, 43666.78166609178, 43847.34228986568, 3762.0970966968002, 3999.8600048998437, 4152.273352163359, 4218.514870789868, 4543.931841022388, 32995.505067424005, 33128.0, 33674.83162584171, 33731.83134084338, 33988.83005584956, 4408.338749187647, 4476.731396116244, 4504.639628829718, 4511.413516242867, 4533.591976722111, 307874.0, 307995.0, 308893.0, 309089.0, 309137.0, 37828.243435131146, 59341.0, 60009.39990600126, 60199.0, 60441.0, 36901.815490922374, 37153.628463715555, 37201.25597488089, 37304.813475932446, 37414.25171496609, 15691.843081569266, 16053.438129665406, 16062.196890155445, 16063.196840157945, 16065.678686426207, 12974.80537791934, 12982.026348023935, 12998.155119917365, 13001.869981300255, 13087.345632718327, 9149.679761208326, 9198.126178013077, 9239.0, 9270.675526356545, 9281.62873485053, 3395.966040339614, 3418.0942050356675, 3422.640622734627, 3426.554547908806, 3427.4687423449404, 1107.7064577886867, 1146.3064845768356, 1164.2257898497573, 1172.536847945057, 1269.02919266761, 32642.0, 33300.83349583237, 33446.331073378395, 33606.66393336084, 33844.49233261503, 1190.6011486152063, 1196.8683444821063, 1207.486818102303, 1210.6791700199453, 1306.764782339188, 17225.31098756036, 17346.82653173452, 17555.0, 17630.955096858695, 17660.0, 491637.0, 500393.0, 506738.0, 520878.0, 523611.0, 46899.0, 47160.0, 47292.29061564079, 47322.290165647544, 47441.52558474371, 1360.5782207515701, 1472.5214305350803, 1488.047649504318, 1495.0506428417816, 1495.6186172525936, 29062.709372906847, 30602.234944126576, 31396.372072557962, 31426.52860207053, 31720.0, 52360.0, 52592.737036314575, 52965.20552191643, 53174.734126329124, 53223.46776532185, 438919.0, 440944.0, 442334.0, 442611.0, 442782.0, 29632.407351853275, 29753.851230744574, 29777.702222978358, 30099.247518812204, 30485.390292193588, 48402.0, 48548.2717759241, 48599.0, 49364.0, 49505.50494495009, 41420.23647316502, 41908.0, 42070.0, 42159.7892010538, 42630.0, 40787.98030049272, 41001.79499102605, 41034.589654103074, 41401.0, 42145.36781948212, 42422.0, 44294.0, 44671.329930051725, 44974.0, 45010.77494612506, 33238.5014224782, 35189.64810351864, 35564.28871422609, 35979.28041439209, 36147.0963225911, 26077.217683469527, 26385.73614263833, 26424.045911618054, 26621.467570648867, 26754.464910702067], "value": 19156.624759380364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.91227798301344, 430.7264886796887, 434.1209051670368, 438.7981528496889, 442.79188781272813, 18392.080395980196, 18982.71525927112, 19147.138378772954, 20330.186792528282, 20967.580648387062, 19650.312239071634, 19670.0, 19671.5082122947, 20022.1991120355, 20024.49938751532, 5768.538516918637, 5847.093700476433, 5911.172435858984, 5914.1128830675525, 5924.614900031505, 5291.947080529184, 5543.279373681436, 5547.33431988162, 5863.58954873159, 5881.3530511643685, 5489.286392768934, 5521.116621340586, 5525.392206857243, 5552.500274975251, 5557.416471270519, 5958.672273024982, 5979.133025711291, 5980.820575382702, 6010.218671572711, 6020.0367941129425, 5403.864903377408, 5835.883282334372, 5849.268841394825, 5864.736086876101, 5866.20806191163, 13365.732685346336, 13527.797083043763, 13659.590212293548, 13704.725905481935, 13719.45122195111, 2398.796102331304, 2429.9392515187087, 2586.0043883104954, 2623.34416395901, 2772.819766715177, 9952.303338766289, 11147.777044459066, 14209.431622735077, 14294.285285735672, 15047.247637618184, 2043.6832290994919, 2071.979280207194, 2073.3572592496225, 2116.968245476319, 2136.060133541237, 72263.0, 74752.25247747508, 76382.23617763807, 77626.22373776247, 78961.60519197368, 11367.147463940237, 11628.88371116295, 11712.180147389772, 11719.648410547697, 12017.579384721494, 16606.50180494587, 16634.417795377103, 16684.249208785634, 16701.91649041747, 16780.916095419445, 8461.430827353284, 8606.139386061344, 8615.913840861636, 8687.131286871389, 8767.693130740394, 8260.669573217005, 8288.627011784483, 8294.502329860106, 8302.128276530999, 8392.076871544125, 5096.261042148868, 5146.768395422215, 5163.690178589297, 5174.741262936838, 5176.094183517945, 1930.2086144680895, 2046.0281366350864, 2123.1507397041305, 2124.4370241885913, 2134.903929323184, 1026.810040142576, 1077.7575045614674, 1085.0776839686202, 1138.527511082908, 1191.9284842909453, 16593.6681266374, 17446.651066978844, 17672.028038458007, 18754.81245187558, 19255.22979080849, 1086.760912599227, 1095.3756358875364, 1134.625573560723, 1137.7440075982838, 1157.8205378166397, 10414.323069000491, 10697.358158510515, 10727.78544429107, 10773.192010599236, 10830.837537436944, 492603.6109458361, 498593.0, 503356.0, 503374.0, 508884.0, 97492.0, 100978.495107524, 101158.49420752996, 101438.0, 102497.0, 1058.5659879449543, 1074.8119079161115, 1141.0814294493014, 1161.2335858333458, 1162.5175552145934, 15913.0, 15996.68006639884, 16156.757648635044, 16402.753958690868, 16529.25618347153, 39619.2076158481, 40035.59964400319, 40139.397909030806, 40315.0, 40468.0, 52026.0, 56453.71773141108, 57046.7147664259, 57361.13958290545, 57693.71153144207, 8625.91374086251, 8643.783905402415, 8798.208161265517, 8840.602172902363, 9108.0, 13338.19970801755, 13431.529896453578, 13769.31153442344, 13775.586732398044, 13823.0, 11574.942125289319, 11717.238379505305, 11728.472218750007, 11884.346360949885, 12545.623631291075, 11401.600943966921, 11567.248128871934, 11653.0, 11724.531018759495, 11982.58060967862, 11834.940825295818, 11839.408029598659, 11903.523859045541, 11957.342346171044, 12240.510379584717, 8946.552672366486, 9015.233705135137, 9044.683436079706, 9091.636334546543, 9114.27085833145, 10277.53751081218, 11533.942330288295, 11914.106442017057, 11975.64073077809, 12259.325737084546], "value": 9420.0852936969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.0468683638544, 1426.2939844776836, 1592.8327525609811, 1857.7677790276216, 1860.069965017492, 7700.4224683148705, 7930.206979302067, 8603.526806025666, 8897.377183597142, 8924.375293729441, 8548.871766923501, 8597.828043439127, 8761.780955476117, 8921.821563568725, 8941.91058089419, 2285.1430713482487, 2301.7813307735737, 2314.7916687498123, 2316.930492085232, 2321.802646775018, 2381.845180063299, 2420.491696743677, 2474.492728990562, 2477.1453848422266, 2480.7891329236945, 2402.531506356261, 2420.1287536486852, 2423.212455951823, 2424.5150969806023, 2447.608382658775, 2394.162043284854, 2411.46947671512, 2421.9515609687883, 2423.745506721795, 2439.1097249503982, 2446.8409553378974, 2460.052879641333, 2470.9505809883703, 2477.0, 2493.2644869763462, 8851.291896648318, 8938.821223575493, 8955.776105597348, 8958.417702849294, 8959.5968181432, 5309.7610607522365, 5386.111291636876, 5415.729213539307, 5415.783368665248, 5419.5393391561765, 3355.7147642450423, 3410.1645096951406, 3418.1112910643164, 3540.716742660581, 3569.9107522311892, 1191.8033524468453, 1207.420438189665, 1238.207547169812, 1253.874612538748, 1262.0786825617351, 11985.28088314704, 12084.939575302154, 12116.21244619097, 12119.697007574881, 12146.757064858653, 4435.800388982503, 4483.932741008887, 4580.71739912825, 4580.97709511457, 4606.631469482433, 10464.63373781914, 10477.423741694127, 10485.213608979204, 10518.263721539572, 10519.211059170593, 5371.060064488699, 5381.704006279692, 5383.7846486140115, 5397.8380648580605, 5424.484673955968, 4642.814287428465, 4826.107170173529, 4842.0, 4861.29511220871, 4941.258811178352, 3825.387937929918, 3857.209272099269, 3881.1073453105378, 3913.4325522799036, 3942.3692209246383, 1173.3194747046693, 1182.5210789630214, 1185.6087491127907, 1200.6218041316956, 1238.1766125526603, 1067.594314160614, 1071.6677829872765, 1079.865016872891, 1082.658962426833, 1084.7450849050467, 6127.417895299939, 6200.224971878515, 6238.157848690459, 6272.671856419056, 6322.241331040304, 412.3505478870791, 414.991700166001, 419.23908106786087, 1091.4324551233315, 1116.1963386361806, 3972.980135099306, 4131.380292956021, 4144.005438694752, 4209.389638502461, 4290.249206388869, 10459.529321180566, 10683.626073087406, 10876.945615271872, 10925.399103049249, 10942.17933654963, 10633.308834925705, 10691.83962240567, 10702.892971070345, 10725.14198864089, 10725.195610329256, 8061.959690201512, 8180.7954801130445, 8323.5005899645, 8342.499450033018, 8382.538960357238, 6068.4841788448475, 6080.787172448943, 6088.117223002551, 6095.116208149882, 6162.7534898605345, 9740.805183896424, 9801.50992450389, 9856.359336643096, 9884.0, 9936.403815771077, 9286.62853485853, 9641.566129524048, 9679.564419601276, 9723.367981081206, 9813.950930245303, 6792.96603516999, 7588.127365353055, 7639.809004774925, 7712.267334603203, 7895.289423951872, 8351.498910065415, 8365.24712775853, 8407.738839174173, 8414.453060551044, 8462.19609137131, 7334.0, 7620.504667196615, 7656.885146722692, 7667.884981725167, 7787.96106019489, 7420.740274090381, 7617.733379331697, 7631.503952243309, 7641.312281894656, 7722.613869306625, 7207.1711753146965, 7280.781576552712, 7372.410207183305, 7460.888086678813, 7461.95532625422, 5364.30264065669, 5468.0, 5532.612717109763, 5613.859653508695, 5660.773569057192, 5364.436734142859, 5382.703951282717, 5419.972900135474, 5519.917201242065, 5570.136628822539], "value": 4665.735249991763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.49916127486205, 335.163766402825, 335.65930580460827, 340.0902585583563, 346.34540718042894, 6484.351564843513, 6565.376289252526, 6566.179227596551, 6668.366505182012, 6707.19513658361, 6527.706253218605, 6543.149390579218, 6555.934440655592, 6608.801735947929, 6630.801075967716, 4912.484189160132, 4952.9257061143935, 4967.850964471072, 4975.4527002029745, 4987.102321582114, 4979.526944940243, 4983.426905905831, 4989.575886049672, 4996.675216110959, 5005.399352077756, 4890.193118135521, 4946.0, 4952.603791696673, 4953.1579631462555, 4959.60323174147, 4693.0, 4867.099586576494, 4939.876503087434, 4939.950600494003, 4955.058538877602, 4138.586141385867, 4159.584041595846, 4173.91652166958, 4181.226473102486, 4187.994881228514, 6253.343398943137, 6306.369363063703, 6310.779122730728, 6315.905261421082, 6317.305096439434, 5674.0, 5680.0627896397045, 5685.630434021817, 5687.061634830248, 5707.885842283131, 6945.201301850251, 6946.6179360135175, 6946.861062778767, 6960.060391847137, 6963.79108626742, 4509.120721459317, 4626.83806066786, 4655.4180727409075, 4660.1145782301255, 4676.8363107291425, 7131.429485641136, 7267.946147808538, 7307.634618269065, 7315.268473152695, 7316.085489313836, 4740.834070807505, 4747.192977193886, 4750.453697824725, 4754.952450475451, 4757.9048419032115, 4779.402574678165, 4814.855554333376, 4822.324874517571, 4822.541858523435, 4831.782569784368, 5677.858053548694, 5681.176229446707, 5681.886362272731, 5690.118031705092, 5690.430956904276, 6891.483138764613, 7006.334398232159, 7025.0, 7028.0, 7035.401990830735, 1647.0858673436358, 1651.1579094661809, 1654.8427899349542, 1661.7839680841414, 1664.0847533856572, 1054.1619412566874, 1068.2468859454066, 1072.6996440996534, 1088.918331125153, 1096.0957210301533, 6689.76585819494, 6806.285340039224, 6807.421369183675, 6808.421284190899, 6829.795106146824, 7138.393236574845, 7189.352958233784, 7193.352598266181, 7200.0, 7222.819429514304, 6784.3554862288, 6791.4906382021545, 6792.743342481656, 6794.014867844135, 6804.149481314836, 3833.8466461341236, 3848.1726428817938, 3874.2445223181207, 3897.0647044709067, 3906.4921560196995, 7344.466159175076, 7674.731384401519, 7683.231676832272, 7684.0, 7705.190954949761, 7404.370628496638, 7414.888776668355, 7488.4009279257525, 7491.775246742606, 7517.285857843496, 7627.0847498299445, 7658.425618078666, 7663.578503182379, 7673.731419400406, 7692.346150577152, 7204.675789589586, 7259.0, 7286.927130728624, 7314.743983960536, 7350.448716346188, 7228.060352154396, 7243.0, 7249.710011599477, 7251.093613298338, 7255.891161632685, 7624.199459056719, 7630.7329243476215, 7640.770776876702, 7654.387648988179, 7661.387089032753, 4756.334113224082, 4802.327674125695, 4805.063012712488, 4812.422509298766, 4817.494163112823, 7017.508774385744, 7294.1247050354295, 7312.19565847767, 7319.5242309249725, 7328.926710732824, 7115.181754098345, 7136.0, 7139.785806425815, 7141.785746427616, 7156.785296441115, 7060.117485314336, 7087.397571206505, 7097.503174777716, 7106.0, 7109.253528379652, 6914.481413893877, 6943.27095654949, 6949.478789090737, 6962.512624116263, 6981.8254543634785, 6911.412529935012, 7013.211631034053, 7133.322334378226, 7137.607431591312, 7138.428925686037, 6735.932640673726, 6976.5814051157095, 6982.33667801558, 6990.671772363438, 6993.300669932966], "value": 5216.798680572154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.4459101583969, 898.8966268879078, 931.4132096779028, 934.8083642853215, 940.6895724410945, 14943.925280373596, 15313.0812151271, 15357.078575285477, 15361.30874110665, 15362.231888405591, 12720.300383478905, 14682.55952321432, 14846.257687115654, 14858.182799945998, 14921.925390373033, 865.7532603208087, 902.3953950852945, 903.9186473217409, 904.2449554621866, 904.995475022624, 886.685226744506, 889.6574818694785, 896.4128495835206, 896.5830888636783, 897.277691458379, 929.159111004542, 930.2325581395343, 934.8784657994452, 936.1574582875398, 939.065629698451, 937.610891480035, 939.4269495607674, 939.6992962252082, 941.6327632223438, 942.505184777997, 684.1345697692423, 690.5752961928428, 690.7099018412279, 693.3240090911371, 693.5006795107514, 14918.477853275082, 14966.0, 14996.250187490581, 15015.774763378558, 15110.471133510275, 14574.417023319054, 14608.488702895347, 14725.0, 14745.262736863115, 14857.554273371816, 12253.0, 12294.385280735927, 12320.322382268972, 12390.0, 12532.185407948455, 4043.1711499142607, 4106.404571337169, 4117.176564687044, 4132.524759652649, 4165.958340416618, 52702.47297527014, 52950.0, 53363.73318133423, 53409.0, 53419.0, 11062.170337224741, 11387.829182562267, 11747.295162290118, 11969.700757481132, 12053.975412089896, 21192.682109768364, 21201.15195392167, 21206.15175392967, 21207.68188477174, 21228.363149105553, 8162.714304999416, 8432.156784321518, 8467.618957146944, 8532.57337133141, 8710.21608055278, 4660.6970546914345, 4741.881452963704, 4761.9047619048115, 5006.324146240211, 5105.617078719111, 3484.5992710838073, 3542.2384187399834, 3542.71658267338, 3546.840392182358, 3569.39320315547, 650.869826034795, 656.5601047298321, 666.2970566052861, 669.347386298365, 669.8158006548239, 674.6963866260203, 742.4988133010196, 791.3313250303485, 794.0947320055142, 821.1870248453988, 8681.262092722189, 9324.627014919462, 9591.328606997444, 9622.326437149331, 9629.374090684083, 780.9648565814553, 804.3082948664144, 827.7227128911882, 830.8006078541107, 853.6329378367361, 4149.502059752849, 4261.978690106592, 4362.541933097043, 4397.582229688174, 4409.338599210144, 66002.66998664977, 66524.33475665182, 68031.65984170047, 68114.0, 68245.65877170583, 59036.7048164765, 59305.40694593085, 59763.70118149468, 59915.400845991855, 60626.39373606296, 52794.47205527972, 53536.46463535393, 54536.0, 54614.0, 55846.16230756542, 8445.113263107285, 8552.828943420973, 8575.742727718178, 8632.0, 8677.1756683115, 40365.59634403736, 40521.1895762089, 41434.58565414307, 41656.375154373316, 42772.358414624425, 53531.0, 53857.730711346194, 54313.45686543084, 54970.0, 55217.0, 11109.666709998713, 11189.272697274651, 11241.494132764208, 11246.437678116225, 11279.548818047186, 12917.22496650204, 13194.934025329812, 13223.338833058117, 13274.203547787163, 13293.26887021223, 12218.694532636755, 12287.262764234174, 12290.692732681755, 12307.876921230672, 12421.316827574208, 11823.527058917547, 11929.582464613697, 11941.76116477683, 11970.341631210018, 12032.217905836093, 12127.151099422956, 12404.689882753004, 12553.560625378068, 12565.811512827499, 12955.740885182433, 9987.650432234837, 10998.34009959405, 11050.33697978124, 11108.944455277671, 11264.887351126385, 10933.234673573092, 10949.616763413242, 11037.0, 11182.217244793112, 11236.775264494829], "value": 7118.871985391328, "unit": "score"}], "name": "dromaeo_css", "value": 7446.992142929145, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 104.0, 112.0, 111.0, 112.0, 101.0, 109.0, 111.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 152.0, 169.0, 128.0, 154.0, 153.0, 129.0, 181.0, 127.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 164.0, 162.0, 162.0, 161.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 180.0, 74.0, 74.0, 77.0, 76.0, 158.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 156.0, 92.0, 93.0, 92.0, 161.0, 91.0, 93.0, 145.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 117.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 100.0, 95.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 56.0, 58.0, 56.0, 64.0, 58.0, 58.0, 81.0, 61.0, 55.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 58.0, 60.0, 57.0, 58.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 72.0, 73.0, 83.0, 75.0, 81.0, 73.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 114.0, 112.0, 114.0, 112.0, 113.0, 119.0, 113.0, 127.0, 129.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 156.0, 167.0, 167.0, 161.0, 160.0, 166.0, 159.0, 156.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 71.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1525.3, "alertThreshold": 2.0}]} 09:21:30 INFO - Return code: 0 09:21:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:21:30 ERROR - # TBPL SUCCESS # 09:21:30 INFO - Running post-action listener: _resource_record_post_action 09:21:30 INFO - Running post-run listener: _resource_record_post_run 09:21:31 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 493940736; Read time: 352; Write time: 4029472 09:21:31 INFO - install - Wall time: 22s; CPU: 22.0%; Read bytes: 0; Write bytes: 182484992; Read time: 0; Write time: 1480384 09:21:31 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301494272; Read time: 352; Write time: 2355096 09:21:31 INFO - Running post-run listener: _upload_blobber_files 09:21:31 INFO - Blob upload gear active. 09:21:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:31 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 09:21:31 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:21:31 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:21:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:21:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:21:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:33 INFO - (blobuploader) - INFO - Done attempting. 09:21:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:21:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:21:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:34 INFO - (blobuploader) - INFO - Done attempting. 09:21:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:34 INFO - Return code: 0 09:21:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4a844bcf593c9eed2e6b6c67d378360b0f0edfb41b8afeca2e5db18579bd51d3c9561ec16663df0681e199c2a1ef8e542ad355d0f66979c6716752bd7ab8bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecd96b296b4f218e8b3c0163e39008f45ee074e829f92bf9a17f258fa290be7e26b4f642ad36b9539e1de8cf0bc2800acaac0c6bc33d1a94fa865ab336e4d221"} 09:21:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:34 INFO - Contents: 09:21:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4a844bcf593c9eed2e6b6c67d378360b0f0edfb41b8afeca2e5db18579bd51d3c9561ec16663df0681e199c2a1ef8e542ad355d0f66979c6716752bd7ab8bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecd96b296b4f218e8b3c0163e39008f45ee074e829f92bf9a17f258fa290be7e26b4f642ad36b9539e1de8cf0bc2800acaac0c6bc33d1a94fa865ab336e4d221"} 09:21:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:34 INFO - Copying logs to upload dir... 09:21:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.580268 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-23 09:21:34.085396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 09:21:34.088904) ========= 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=33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747 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/Mozilla-Aurora/sha512/b4a844bcf593c9eed2e6b6c67d378360b0f0edfb41b8afeca2e5db18579bd51d3c9561ec16663df0681e199c2a1ef8e542ad355d0f66979c6716752bd7ab8bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecd96b296b4f218e8b3c0163e39008f45ee074e829f92bf9a17f258fa290be7e26b4f642ad36b9539e1de8cf0bc2800acaac0c6bc33d1a94fa865ab336e4d221"} build_url:https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009880 build_url: 'https://queue.taskcluster.net/v1/task/JEGWcK-xQt2K-cj6Ur8Uxg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4a844bcf593c9eed2e6b6c67d378360b0f0edfb41b8afeca2e5db18579bd51d3c9561ec16663df0681e199c2a1ef8e542ad355d0f66979c6716752bd7ab8bad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ecd96b296b4f218e8b3c0163e39008f45ee074e829f92bf9a17f258fa290be7e26b4f642ad36b9539e1de8cf0bc2800acaac0c6bc33d1a94fa865ab336e4d221"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 09:21:34.111669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:21:34.111988) ========= 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=33d5923976266a1c518c4bf7000001ab-1464017823.645604-2020796747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004194 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 09:21:34.195584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 09:21:34.195893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 09:21:34.196186) ========= ========= Total master_lag: 0.18 =========