builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1462098512.74 results: success (0) buildid: 20160501004106 builduid: e2f3cd821e7544668a80ddbdae6e1bcf revision: 3f169c95e542f059b6b07d11e7f73533bdbf03d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.735878) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.736579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.736950) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.770750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.771258) ========= 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=cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-01 03:28:34-- 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-01 03:28:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075177 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.871607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.871976) ========= 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=cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019184 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.945220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:32.945620) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3f169c95e542f059b6b07d11e7f73533bdbf03d6 --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 3f169c95e542f059b6b07d11e7f73533bdbf03d6 --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=cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-01 03:28:34,956 truncating revision to first 12 chars 2016-05-01 03:28:34,956 Setting DEBUG logging. 2016-05-01 03:28:34,956 attempt 1/10 2016-05-01 03:28:34,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3f169c95e542?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-01 03:28:35,568 unpacking tar archive at: mozilla-aurora-3f169c95e542/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916901 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:33.887779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:33.888218) ========= script_repo_revision: 3f169c95e542f059b6b07d11e7f73533bdbf03d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:33.888851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:33.889184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 03:28:33.944505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-01 03:28:33.944842) ========= /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=cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:36 INFO - MultiFileLogger online at 20160501 03:28:36 in /builds/slave/test 03:28:36 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 03:28:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:36 INFO - {'append_to_log': False, 03:28:36 INFO - 'base_work_dir': '/builds/slave/test', 03:28:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:28:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:36 INFO - 'branch': 'Mozilla-Aurora', 03:28:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:36 INFO - 'config_files': ('talos/linux_config.py',), 03:28:36 INFO - 'default_actions': ('clobber', 03:28:36 INFO - 'read-buildbot-config', 03:28:36 INFO - 'download-and-extract', 03:28:36 INFO - 'populate-webroot', 03:28:36 INFO - 'create-virtualenv', 03:28:36 INFO - 'install', 03:28:36 INFO - 'run-tests'), 03:28:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:36 INFO - 'download_minidump_stackwalk': True, 03:28:36 INFO - 'download_symbols': 'ondemand', 03:28:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:36 INFO - 'installer_path': 'installer.exe', 03:28:36 INFO - 'log_level': 'info', 03:28:36 INFO - 'log_name': 'talos', 03:28:36 INFO - 'log_to_console': True, 03:28:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:36 INFO - 'opt_config_files': (), 03:28:36 INFO - 'pip_index': False, 03:28:36 INFO - 'sps_profile': False, 03:28:36 INFO - 'sps_profile_interval': 0, 03:28:36 INFO - 'suite': 'dromaeojs-e10s', 03:28:36 INFO - 'system_bits': '32', 03:28:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:36 INFO - 'title': 'talos-linux64-ix-054', 03:28:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:36 INFO - 'use_talos_json': True, 03:28:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:36 INFO - 'work_dir': 'build'} 03:28:36 INFO - ##### 03:28:36 INFO - ##### Running clobber step. 03:28:36 INFO - ##### 03:28:36 INFO - Running pre-action listener: _resource_record_pre_action 03:28:36 INFO - Running main action method: clobber 03:28:36 INFO - rmtree: /builds/slave/test/build 03:28:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:37 INFO - Running post-action listener: _resource_record_post_action 03:28:37 INFO - ##### 03:28:37 INFO - ##### Running read-buildbot-config step. 03:28:37 INFO - ##### 03:28:37 INFO - Running pre-action listener: _resource_record_pre_action 03:28:37 INFO - Running main action method: read_buildbot_config 03:28:37 INFO - Using buildbot properties: 03:28:37 INFO - { 03:28:37 INFO - "project": "", 03:28:37 INFO - "product": "firefox", 03:28:37 INFO - "script_repo_revision": "production", 03:28:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:28:37 INFO - "repository": "", 03:28:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:28:37 INFO - "buildid": "20160501004106", 03:28:37 INFO - "stage_platform": "linux64-pgo", 03:28:37 INFO - "basedir": "/builds/slave/test", 03:28:37 INFO - "nightly_build": "True", 03:28:37 INFO - "buildnumber": 273, 03:28:37 INFO - "slavename": "talos-linux64-ix-054", 03:28:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:28:37 INFO - "platform": "ubuntu64_hw", 03:28:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:28:37 INFO - "branch": "mozilla-aurora", 03:28:37 INFO - "repo_path": "releases/mozilla-aurora", 03:28:37 INFO - "revision": "3f169c95e542f059b6b07d11e7f73533bdbf03d6", 03:28:37 INFO - "pgo_build": "True", 03:28:37 INFO - "builduid": "e2f3cd821e7544668a80ddbdae6e1bcf", 03:28:37 INFO - "slavebuilddir": "test" 03:28:37 INFO - } 03:28:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:28:37 INFO - Running post-action listener: _resource_record_post_action 03:28:37 INFO - ##### 03:28:37 INFO - ##### Running download-and-extract step. 03:28:37 INFO - ##### 03:28:37 INFO - Running pre-action listener: _resource_record_pre_action 03:28:37 INFO - Running main action method: download_and_extract 03:28:37 INFO - mkdir: /builds/slave/test/build/tests 03:28: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')]} 03:28:37 INFO - https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:28:43 INFO - Downloaded 1361 bytes. 03:28:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:28:43 INFO - Using the following test package requirements: 03:28:43 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:28:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'jsshell-linux-x86_64.zip'], 03:28:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:28:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:28:43 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:28:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:28:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:43 INFO - https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:28:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:28:55 INFO - Downloaded 23821271 bytes. 03:28:55 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'] 03:28:55 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 03:28:57 INFO - Return code: 0 03:28:57 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 03:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:57 INFO - https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:28:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:28:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:29:01 INFO - Downloaded 23821271 bytes. 03:29:01 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'] 03:29:01 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 03:29:02 INFO - Return code: 0 03:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:02 INFO - https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:29:03 INFO - Downloaded 10840145 bytes. 03:29:03 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'] 03:29:03 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 03:29:03 INFO - Return code: 0 03:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:03 INFO - https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:29:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:29:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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 03:29:05 INFO - Downloaded 62692819 bytes. 03:29:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:05 INFO - mkdir: /builds/slave/test/properties 03:29:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:05 INFO - Contents: 03:29:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:29:05 INFO - Running post-action listener: _resource_record_post_action 03:29:05 INFO - Running post-action listener: set_extra_try_arguments 03:29:05 INFO - ##### 03:29:05 INFO - ##### Running populate-webroot step. 03:29:05 INFO - ##### 03:29:05 INFO - Running pre-action listener: _resource_record_pre_action 03:29:05 INFO - Running main action method: populate_webroot 03:29:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:05 INFO - '--tppagecycles', 03:29:05 INFO - '7'], 03:29:05 INFO - 'tests': ['tsvgm']}}, 03:29:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['damp', 'tps']}, 03:29:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'tests': ['damp', 'tps']}, 03:29:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['dromaeo_dom']}, 03:29:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['a11yr', 03:29:05 INFO - 'ts_paint', 03:29:05 INFO - 'tpaint', 03:29:05 INFO - 'sessionrestore', 03:29:05 INFO - 'sessionrestore_no_auto_restore', 03:29:05 INFO - 'tabpaint']}, 03:29:05 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:05 INFO - 'ts_paint', 03:29:05 INFO - 'tpaint', 03:29:05 INFO - 'sessionrestore', 03:29:05 INFO - 'sessionrestore_no_auto_restore', 03:29:05 INFO - 'tabpaint']}, 03:29:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:29:05 INFO - 'ts_paint', 03:29:05 INFO - 'tpaint', 03:29:05 INFO - 'sessionrestore', 03:29:05 INFO - 'sessionrestore_no_auto_restore', 03:29:05 INFO - 'tabpaint']}, 03:29:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:29:05 INFO - 'ts_paint', 03:29:05 INFO - 'tpaint', 03:29:05 INFO - 'sessionrestore', 03:29:05 INFO - 'sessionrestore_no_auto_restore', 03:29:05 INFO - 'tabpaint']}, 03:29:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['a11yr', 03:29:05 INFO - 'ts_paint', 03:29:05 INFO - 'tpaint', 03:29:05 INFO - 'sessionrestore', 03:29:05 INFO - 'sessionrestore_no_auto_restore', 03:29:05 INFO - 'tabpaint']}, 03:29:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['a11yr', 03:29:05 INFO - 'ts_paint', 03:29:05 INFO - 'tpaint', 03:29:05 INFO - 'sessionrestore', 03:29:05 INFO - 'sessionrestore_no_auto_restore', 03:29:05 INFO - 'tabpaint']}, 03:29:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['tsvgx', 03:29:05 INFO - 'tsvgr_opacity', 03:29:05 INFO - 'tart', 03:29:05 INFO - 'tscrollx', 03:29:05 INFO - 'cart']}, 03:29:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:05 INFO - 'tsvgr_opacity', 03:29:05 INFO - 'tart', 03:29:05 INFO - 'tscrollx', 03:29:05 INFO - 'cart']}, 03:29:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'talos_options': ['--disable-e10s'], 03:29:05 INFO - 'tests': ['tp5o']}, 03:29:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'tests': ['tp5o']}, 03:29:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'talos_options': ['--disable-e10s', 03:29:05 INFO - '--xperf_path', 03:29:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:05 INFO - 'tests': ['tp5n']}, 03:29:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:05 INFO - 'talos_options': ['--xperf_path', 03:29:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:05 INFO - 'tests': ['tp5n']}}, 03:29:05 INFO - 'talos.zip': {'path': '', 03:29:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:05 INFO - Running post-action listener: _resource_record_post_action 03:29:05 INFO - ##### 03:29:05 INFO - ##### Running create-virtualenv step. 03:29:05 INFO - ##### 03:29:05 INFO - Running pre-action listener: _resource_record_pre_action 03:29:05 INFO - Running main action method: create_virtualenv 03:29:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:06 INFO - Using real prefix '/usr' 03:29:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:08 INFO - Installing pip.................done. 03:29:08 INFO - Return code: 0 03:29:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:08 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 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:29:08 INFO - Using env: {'DISPLAY': ':0', 03:29:08 INFO - 'HOME': '/home/cltbld', 03:29:08 INFO - 'LANG': 'en_US.UTF-8', 03:29:08 INFO - 'LANGUAGE': 'en_US:en', 03:29:08 INFO - 'LOGNAME': 'cltbld', 03:29:08 INFO - 'MAIL': '/var/mail/cltbld', 03:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:08 INFO - 'MOZ_NO_REMOTE': '1', 03:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:08 INFO - 'NO_EM_RESTART': '1', 03:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:08 INFO - 'PWD': '/builds/slave/test', 03:29:08 INFO - 'SHELL': '/bin/bash', 03:29:08 INFO - 'SHLVL': '1', 03:29:08 INFO - 'TERM': 'linux', 03:29:08 INFO - 'TMOUT': '86400', 03:29:08 INFO - 'USER': 'cltbld', 03:29:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:08 INFO - '_': '/tools/buildbot/bin/python'} 03:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:29:08 INFO - Cleaning up... 03:29:08 INFO - Return code: 0 03:29:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:08 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 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:08 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 03:29:08 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 03:29:08 INFO - Using env: {'DISPLAY': ':0', 03:29:08 INFO - 'HOME': '/home/cltbld', 03:29:08 INFO - 'LANG': 'en_US.UTF-8', 03:29:08 INFO - 'LANGUAGE': 'en_US:en', 03:29:08 INFO - 'LOGNAME': 'cltbld', 03:29:08 INFO - 'MAIL': '/var/mail/cltbld', 03:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:08 INFO - 'MOZ_NO_REMOTE': '1', 03:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:08 INFO - 'NO_EM_RESTART': '1', 03:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:08 INFO - 'PWD': '/builds/slave/test', 03:29:08 INFO - 'SHELL': '/bin/bash', 03:29:08 INFO - 'SHLVL': '1', 03:29:08 INFO - 'TERM': 'linux', 03:29:08 INFO - 'TMOUT': '86400', 03:29:08 INFO - 'USER': 'cltbld', 03:29:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:08 INFO - '_': '/tools/buildbot/bin/python'} 03:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:08 INFO - Downloading/unpacking psutil>=0.7.1 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:10 INFO - Installing collected packages: psutil 03:29:10 INFO - Running setup.py install for psutil 03:29:10 INFO - building 'psutil._psutil_linux' extension 03:29:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:29:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:29:11 INFO - building 'psutil._psutil_posix' extension 03:29:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:29:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:29:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:11 INFO - Successfully installed psutil 03:29:11 INFO - Cleaning up... 03:29:11 INFO - Return code: 0 03:29:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:11 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 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:11 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 03:29:11 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 03:29:11 INFO - Using env: {'DISPLAY': ':0', 03:29:11 INFO - 'HOME': '/home/cltbld', 03:29:11 INFO - 'LANG': 'en_US.UTF-8', 03:29:11 INFO - 'LANGUAGE': 'en_US:en', 03:29:11 INFO - 'LOGNAME': 'cltbld', 03:29:11 INFO - 'MAIL': '/var/mail/cltbld', 03:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:11 INFO - 'MOZ_NO_REMOTE': '1', 03:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:11 INFO - 'NO_EM_RESTART': '1', 03:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:11 INFO - 'PWD': '/builds/slave/test', 03:29:11 INFO - 'SHELL': '/bin/bash', 03:29:11 INFO - 'SHLVL': '1', 03:29:11 INFO - 'TERM': 'linux', 03:29:11 INFO - 'TMOUT': '86400', 03:29:11 INFO - 'USER': 'cltbld', 03:29:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:11 INFO - '_': '/tools/buildbot/bin/python'} 03:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:29:13 INFO - Installing collected packages: mozsystemmonitor 03:29:13 INFO - Running setup.py install for mozsystemmonitor 03:29:13 INFO - Successfully installed mozsystemmonitor 03:29:13 INFO - Cleaning up... 03:29:13 INFO - Return code: 0 03:29:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:13 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 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:13 INFO - Using env: {'DISPLAY': ':0', 03:29:13 INFO - 'HOME': '/home/cltbld', 03:29:13 INFO - 'LANG': 'en_US.UTF-8', 03:29:13 INFO - 'LANGUAGE': 'en_US:en', 03:29:13 INFO - 'LOGNAME': 'cltbld', 03:29:13 INFO - 'MAIL': '/var/mail/cltbld', 03:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:13 INFO - 'MOZ_NO_REMOTE': '1', 03:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:13 INFO - 'NO_EM_RESTART': '1', 03:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:13 INFO - 'PWD': '/builds/slave/test', 03:29:13 INFO - 'SHELL': '/bin/bash', 03:29:13 INFO - 'SHLVL': '1', 03:29:13 INFO - 'TERM': 'linux', 03:29:13 INFO - 'TMOUT': '86400', 03:29:13 INFO - 'USER': 'cltbld', 03:29:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:13 INFO - '_': '/tools/buildbot/bin/python'} 03:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:16 INFO - Downloading docopt-0.6.1.tar.gz 03:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:16 INFO - Running setup.py install for blobuploader 03:29:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:16 INFO - Running setup.py install for requests 03:29:17 INFO - Running setup.py install for docopt 03:29:17 INFO - Successfully installed blobuploader requests docopt 03:29:17 INFO - Cleaning up... 03:29:17 INFO - Return code: 0 03:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:17 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 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:17 INFO - Using env: {'DISPLAY': ':0', 03:29:17 INFO - 'HOME': '/home/cltbld', 03:29:17 INFO - 'LANG': 'en_US.UTF-8', 03:29:17 INFO - 'LANGUAGE': 'en_US:en', 03:29:17 INFO - 'LOGNAME': 'cltbld', 03:29:17 INFO - 'MAIL': '/var/mail/cltbld', 03:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:17 INFO - 'MOZ_NO_REMOTE': '1', 03:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:17 INFO - 'NO_EM_RESTART': '1', 03:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:17 INFO - 'PWD': '/builds/slave/test', 03:29:17 INFO - 'SHELL': '/bin/bash', 03:29:17 INFO - 'SHLVL': '1', 03:29:17 INFO - 'TERM': 'linux', 03:29:17 INFO - 'TMOUT': '86400', 03:29:17 INFO - 'USER': 'cltbld', 03:29:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:17 INFO - '_': '/tools/buildbot/bin/python'} 03:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:17 INFO - Running setup.py (path:/tmp/pip-oU0lEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:17 INFO - Running setup.py (path:/tmp/pip-ni69Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:17 INFO - Running setup.py (path:/tmp/pip-eilKeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:17 INFO - Running setup.py (path:/tmp/pip-zzQztw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:17 INFO - Running setup.py (path:/tmp/pip-Pecdj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:17 INFO - Running setup.py (path:/tmp/pip-VDo3o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:17 INFO - Running setup.py (path:/tmp/pip-AhOpiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:17 INFO - Running setup.py (path:/tmp/pip-9ibIoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:17 INFO - Running setup.py (path:/tmp/pip-NaKhiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:17 INFO - Running setup.py (path:/tmp/pip-WrR0Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:18 INFO - Running setup.py (path:/tmp/pip-NtmicU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:18 INFO - Running setup.py (path:/tmp/pip-fiuDP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:18 INFO - Running setup.py (path:/tmp/pip-EFgbUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:18 INFO - Running setup.py (path:/tmp/pip-BFP7mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:18 INFO - Running setup.py (path:/tmp/pip-SLmuBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:18 INFO - Running setup.py (path:/tmp/pip-7aAvxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:18 INFO - Running setup.py (path:/tmp/pip-0B3jmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:18 INFO - Running setup.py install for manifestparser 03:29:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for mozcrash 03:29:18 INFO - Running setup.py install for mozdebug 03:29:18 INFO - Running setup.py install for mozdevice 03:29:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for mozfile 03:29:19 INFO - Running setup.py install for mozhttpd 03:29:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Running setup.py install for mozinfo 03:29:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Running setup.py install for mozInstall 03:29:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Running setup.py install for mozleak 03:29:19 INFO - Running setup.py install for mozlog 03:29:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Running setup.py install for moznetwork 03:29:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Running setup.py install for mozprocess 03:29:19 INFO - Running setup.py install for mozprofile 03:29:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Running setup.py install for mozrunner 03:29:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:20 INFO - Running setup.py install for mozscreenshot 03:29:20 INFO - Running setup.py install for moztest 03:29:20 INFO - Running setup.py install for mozversion 03:29:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:20 INFO - Cleaning up... 03:29:20 INFO - Return code: 0 03:29:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:20 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 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:20 INFO - Using env: {'DISPLAY': ':0', 03:29:20 INFO - 'HOME': '/home/cltbld', 03:29:20 INFO - 'LANG': 'en_US.UTF-8', 03:29:20 INFO - 'LANGUAGE': 'en_US:en', 03:29:20 INFO - 'LOGNAME': 'cltbld', 03:29:20 INFO - 'MAIL': '/var/mail/cltbld', 03:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:20 INFO - 'MOZ_NO_REMOTE': '1', 03:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:20 INFO - 'NO_EM_RESTART': '1', 03:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:20 INFO - 'PWD': '/builds/slave/test', 03:29:20 INFO - 'SHELL': '/bin/bash', 03:29:20 INFO - 'SHLVL': '1', 03:29:20 INFO - 'TERM': 'linux', 03:29:20 INFO - 'TMOUT': '86400', 03:29:20 INFO - 'USER': 'cltbld', 03:29:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:20 INFO - '_': '/tools/buildbot/bin/python'} 03:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:20 INFO - Running setup.py (path:/tmp/pip-bVS0cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:20 INFO - Running setup.py (path:/tmp/pip-MBct8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:20 INFO - Running setup.py (path:/tmp/pip-cLjWYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:20 INFO - Running setup.py (path:/tmp/pip-HtE8xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:20 INFO - Running setup.py (path:/tmp/pip-QF2bkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:20 INFO - Running setup.py (path:/tmp/pip-b17LI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:21 INFO - Running setup.py (path:/tmp/pip-b0GTc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:21 INFO - Running setup.py (path:/tmp/pip-IcbcvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:21 INFO - Running setup.py (path:/tmp/pip-f6feSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:21 INFO - Running setup.py (path:/tmp/pip-RdSPjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:21 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)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:21 INFO - Running setup.py (path:/tmp/pip-ktIzVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:21 INFO - Running setup.py (path:/tmp/pip-4AwbnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:21 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)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:21 INFO - Running setup.py (path:/tmp/pip-jcyeve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:21 INFO - Running setup.py (path:/tmp/pip-B780AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:21 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)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:21 INFO - Running setup.py (path:/tmp/pip-mk0N12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:21 INFO - Running setup.py (path:/tmp/pip-pcPM0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:21 INFO - Running setup.py (path:/tmp/pip-GCSuxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:23 INFO - Downloading blessings-1.6.tar.gz 03:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:23 INFO - Installing collected packages: blessings 03:29:23 INFO - Running setup.py install for blessings 03:29:23 INFO - Successfully installed blessings 03:29:23 INFO - Cleaning up... 03:29:23 INFO - Return code: 0 03:29:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:24 INFO - Reading from file tmpfile_stdout 03:29:24 INFO - Current package versions: 03:29:24 INFO - argparse == 1.2.1 03:29:24 INFO - blessings == 1.6 03:29:24 INFO - blobuploader == 1.2.4 03:29:24 INFO - docopt == 0.6.1 03:29:24 INFO - manifestparser == 1.1 03:29:24 INFO - mozInstall == 1.12 03:29:24 INFO - mozcrash == 0.17 03:29:24 INFO - mozdebug == 0.1 03:29:24 INFO - mozdevice == 0.48 03:29:24 INFO - mozfile == 1.2 03:29:24 INFO - mozhttpd == 0.7 03:29:24 INFO - mozinfo == 0.9 03:29:24 INFO - mozleak == 0.1 03:29:24 INFO - mozlog == 3.1 03:29:24 INFO - moznetwork == 0.27 03:29:24 INFO - mozprocess == 0.22 03:29:24 INFO - mozprofile == 0.28 03:29:24 INFO - mozrunner == 6.11 03:29:24 INFO - mozscreenshot == 0.1 03:29:24 INFO - mozsystemmonitor == 0.0 03:29:24 INFO - moztest == 0.7 03:29:24 INFO - mozversion == 1.4 03:29:24 INFO - psutil == 3.1.1 03:29:24 INFO - requests == 1.2.3 03:29:24 INFO - wsgiref == 0.1.2 03:29:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:24 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 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:24 INFO - Using env: {'DISPLAY': ':0', 03:29:24 INFO - 'HOME': '/home/cltbld', 03:29:24 INFO - 'LANG': 'en_US.UTF-8', 03:29:24 INFO - 'LANGUAGE': 'en_US:en', 03:29:24 INFO - 'LOGNAME': 'cltbld', 03:29:24 INFO - 'MAIL': '/var/mail/cltbld', 03:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:24 INFO - 'MOZ_NO_REMOTE': '1', 03:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:24 INFO - 'NO_EM_RESTART': '1', 03:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:24 INFO - 'PWD': '/builds/slave/test', 03:29:24 INFO - 'SHELL': '/bin/bash', 03:29:24 INFO - 'SHLVL': '1', 03:29:24 INFO - 'TERM': 'linux', 03:29:24 INFO - 'TMOUT': '86400', 03:29:24 INFO - 'USER': 'cltbld', 03:29:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:24 INFO - '_': '/tools/buildbot/bin/python'} 03:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:24 INFO - Cleaning up... 03:29:24 INFO - Return code: 0 03:29:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:24 INFO - Using env: {'DISPLAY': ':0', 03:29:24 INFO - 'HOME': '/home/cltbld', 03:29:24 INFO - 'LANG': 'en_US.UTF-8', 03:29:24 INFO - 'LANGUAGE': 'en_US:en', 03:29:24 INFO - 'LOGNAME': 'cltbld', 03:29:24 INFO - 'MAIL': '/var/mail/cltbld', 03:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:24 INFO - 'MOZ_NO_REMOTE': '1', 03:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:24 INFO - 'NO_EM_RESTART': '1', 03:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:24 INFO - 'PWD': '/builds/slave/test', 03:29:24 INFO - 'SHELL': '/bin/bash', 03:29:24 INFO - 'SHLVL': '1', 03:29:24 INFO - 'TERM': 'linux', 03:29:24 INFO - 'TMOUT': '86400', 03:29:24 INFO - 'USER': 'cltbld', 03:29:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:24 INFO - '_': '/tools/buildbot/bin/python'} 03:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:24 INFO - Downloading/unpacking jsonschema 03:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:26 INFO - Downloading/unpacking functools32 (from jsonschema) 03:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:26 INFO - warning: no files found matching '*.txt' 03:29:26 INFO - no previously-included directories found matching 'build' 03:29:26 INFO - no previously-included directories found matching 'dist' 03:29:26 INFO - no previously-included directories found matching '.git*' 03:29:26 INFO - Installing collected packages: jsonschema, functools32 03:29:26 INFO - Running setup.py install for functools32 03:29:26 INFO - warning: no files found matching '*.txt' 03:29:26 INFO - no previously-included directories found matching 'build' 03:29:26 INFO - no previously-included directories found matching 'dist' 03:29:26 INFO - no previously-included directories found matching '.git*' 03:29:26 INFO - Successfully installed jsonschema functools32 03:29:26 INFO - Cleaning up... 03:29:26 INFO - Return code: 0 03:29:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4e8e9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:29:26 INFO - Using env: {'DISPLAY': ':0', 03:29:26 INFO - 'HOME': '/home/cltbld', 03:29:26 INFO - 'LANG': 'en_US.UTF-8', 03:29:26 INFO - 'LANGUAGE': 'en_US:en', 03:29:26 INFO - 'LOGNAME': 'cltbld', 03:29:26 INFO - 'MAIL': '/var/mail/cltbld', 03:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:26 INFO - 'MOZ_NO_REMOTE': '1', 03:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:26 INFO - 'NO_EM_RESTART': '1', 03:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:26 INFO - 'PWD': '/builds/slave/test', 03:29:26 INFO - 'SHELL': '/bin/bash', 03:29:26 INFO - 'SHLVL': '1', 03:29:26 INFO - 'TERM': 'linux', 03:29:26 INFO - 'TMOUT': '86400', 03:29:26 INFO - 'USER': 'cltbld', 03:29:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:26 INFO - '_': '/tools/buildbot/bin/python'} 03:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:27 INFO - Downloading/unpacking flake8 03:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:29:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:29:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:29 INFO - no previously-included directories found matching 'docs/_build' 03:29:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:29:29 INFO - Running setup.py install for pep8 03:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:29 INFO - no previously-included directories found matching 'docs/_build' 03:29:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:29:29 INFO - Cleaning up... 03:29:29 INFO - Return code: 0 03:29:29 INFO - Running post-action listener: _resource_record_post_action 03:29:29 INFO - Running post-action listener: _start_resource_monitoring 03:29:29 INFO - Starting resource monitoring. 03:29:29 INFO - ##### 03:29:29 INFO - ##### Running install step. 03:29:29 INFO - ##### 03:29:29 INFO - Running pre-action listener: _resource_record_pre_action 03:29:29 INFO - Running main action method: install 03:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:30 INFO - Reading from file tmpfile_stdout 03:29:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:30 INFO - Reading from file tmpfile_stdout 03:29:30 INFO - Output received: 03:29:30 INFO - Usage: mozinstall [options] installer 03:29:30 INFO - Options: 03:29:30 INFO - -h, --help show this help message and exit 03:29:30 INFO - -d DEST, --destination=DEST 03:29:30 INFO - Directory to install application into. [default: 03:29:30 INFO - "/builds/slave/test"] 03:29:30 INFO - --app=APP Application being installed. [default: firefox] 03:29:30 INFO - mkdir: /builds/slave/test/build/application 03:29:30 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'] 03:29:30 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 03:29:45 INFO - Reading from file tmpfile_stdout 03:29:45 INFO - Output received: 03:29:45 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:45 INFO - Running post-action listener: _resource_record_post_action 03:29:45 INFO - ##### 03:29:45 INFO - ##### Running run-tests step. 03:29:45 INFO - ##### 03:29:45 INFO - Running pre-action listener: _resource_record_pre_action 03:29:45 INFO - Running main action method: run_tests 03:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:45 INFO - Python 2.7.3 03:29:45 INFO - Return code: 0 03:29:45 INFO - grabbing minidump binary from tooltool 03:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:45 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 0x19f7410>, '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 0x19f8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:29:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:29:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:45 INFO - Return code: 0 03:29:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:29:46 INFO - Return code: 0 03:29:46 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/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:29:46 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/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 03:29:46 INFO - Using env: {'DISPLAY': ':0', 03:29:46 INFO - 'HOME': '/home/cltbld', 03:29:46 INFO - 'LANG': 'en_US.UTF-8', 03:29:46 INFO - 'LANGUAGE': 'en_US:en', 03:29:46 INFO - 'LOGNAME': 'cltbld', 03:29:46 INFO - 'MAIL': '/var/mail/cltbld', 03:29:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:46 INFO - 'MOZ_NO_REMOTE': '1', 03:29:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:46 INFO - 'NO_EM_RESTART': '1', 03:29:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:46 INFO - 'PWD': '/builds/slave/test', 03:29:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:46 INFO - 'SHELL': '/bin/bash', 03:29:46 INFO - 'SHLVL': '1', 03:29:46 INFO - 'TERM': 'linux', 03:29:46 INFO - 'TMOUT': '86400', 03:29:46 INFO - 'USER': 'cltbld', 03:29:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290', 03:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:46 INFO - '_': '/tools/buildbot/bin/python'} 03:29:46 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/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:29:47 INFO - mozversion application_buildid: 20160501004106 03:29:47 INFO - mozversion application_changeset: 3f169c95e542f059b6b07d11e7f73533bdbf03d6 03:29:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:29:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:47 INFO - mozversion application_name: Firefox 03:29:47 INFO - mozversion application_remotingname: firefox-dev 03:29:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:47 INFO - mozversion application_vendor: Mozilla 03:29:47 INFO - mozversion application_version: 48.0a2 03:29:47 INFO - mozversion platform_buildid: 20160501004106 03:29:47 INFO - mozversion platform_changeset: 3f169c95e542f059b6b07d11e7f73533bdbf03d6 03:29:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:47 INFO - mozversion platform_version: 48.0a2 03:29:47 INFO - using testdate: 1462098587 03:29:47 INFO - actual date: 1462098587 03:29:47 INFO - starting webserver on 'localhost:47090' 03:29:47 INFO - SUITE-START | Running 2 tests 03:29:47 INFO - TEST-START | dromaeo_css 03:29:47 INFO - operating with platform_type : linux_ 03:29:47 INFO - Initialising browser for dromaeo_css test... 03:29:47 INFO - TEST-INFO | started process 25766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOh4ctO/profile http://localhost:47090/getInfo.html) 03:29:50 INFO - PROCESS | 25766 | 03:29:50 INFO - PROCESS | 25766 | (process:25841): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:29:51 INFO - PROCESS | 25766 | __metrics Screen width/height:1600/1200 03:29:51 INFO - PROCESS | 25766 | colorDepth:24 03:29:51 INFO - PROCESS | 25766 | Browser inner width/height: 1024/697 03:29:51 INFO - PROCESS | 25766 | __metrics 03:29:52 ERROR - PROCESS | 25766 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:29:53 INFO - TEST-INFO | 25766: exit 0 03:29:53 INFO - Browser initialized. 03:29:53 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:53 INFO - TEST-INFO | started process 25892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOh4ctO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:55 INFO - PROCESS | 25892 | 03:29:55 INFO - PROCESS | 25892 | (process:25963): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:30:05 INFO - PROCESS | 25892 | RSS: Main: 152653824 03:30:05 INFO - PROCESS | 25892 | 03:30:54 INFO - PROCESS | 25892 | 1462098654634 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:33:01 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47090/tests/dromaeo/cssquery-ext.html) 03:33:02 INFO - PROCESS | 25892 | RSS: Main: 156135424 03:33:02 INFO - PROCESS | 25892 | 03:36:04 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-ext.html (next: http://localhost:47090/tests/dromaeo/cssquery-jquery.html) 03:36:05 INFO - PROCESS | 25892 | RSS: Main: 154710016 03:36:05 INFO - PROCESS | 25892 | 03:39:07 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47090/tests/dromaeo/cssquery-mootools.html) 03:39:08 INFO - PROCESS | 25892 | RSS: Main: 153587712 03:39:08 INFO - PROCESS | 25892 | 03:42:09 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47090/tests/dromaeo/cssquery-prototype.html) 03:42:10 INFO - PROCESS | 25892 | RSS: Main: 153841664 03:42:10 INFO - PROCESS | 25892 | 03:45:12 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47090/tests/dromaeo/cssquery-yui.html) 03:45:13 INFO - PROCESS | 25892 | RSS: Main: 155369472 03:45:13 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | Cycle 1(1): loaded http://localhost:47090/tests/dromaeo/cssquery-yui.html (next: http://localhost:47090/tests/dromaeo/cssquery-dojo.html) 03:48:15 INFO - PROCESS | 25892 | RSS: Main: 156295168 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | __start_tp_report 03:48:15 INFO - PROCESS | 25892 | _x_x_mozilla_page_load 03:48:15 INFO - PROCESS | 25892 | _x_x_mozilla_page_load_details 03:48:15 INFO - PROCESS | 25892 | |i|pagename|runs| 03:48:15 INFO - PROCESS | 25892 | |0;dojo.html;3343.6990670839627;3404.2340473393506;3417.367786959412;3444.500547420624;3447.982845060707;5604.327480702316;5642.407547207546;5651.632643878145;5660.8301750947485;5667.149927510865;5588.4411558844195;5661.5187709044785;5662.716864156796;5667.0932650775885;5674.035413979623;5127.923081153795;5169.431362550116;5180.222966555009;5210.661307015051;5217.113090774577;5008.39899212095;5155.7679904404395;5306.548943339821;5311.123664595337;5329.173978033392;5182.792688292464;5233.607479439038;5236.266922630834;5313.707746073965;5343.786248550054;5230.953809238149;5233.136532472137;5243.292155558989;5249.1076516991825;5298.576113910916;5018.598512119058;5094;5145.716985565829;5199.974000129975;5217.2695822584865;5461.863453413696;5509.311336082989;5568.777248910079;5600.467955544257;5656.575756818214;5995.550333724945;6036.9396306036815;6039.184710064173;6051.062085376773;6053.848653783647;6096.085587161917;6099.48154406876;6104.481119104881;6108.5418593605655;6123.357047509992;5512.862178445531;5650.0959846424785;5695.829125126253;5720.113382425689;5751.309842818847;6174.197354343996;6178.320384757673;6195.659238741822;6206.751729930752;6215.595986260969;5856.267966504187;5871.4128587141795;5939.554533410012;5942.821715348547;5944.940550594525;6015.909761353583;6074.908876366858;6081.756729730761;6086.482648974798;6110.266767987781;5997.910031349533;6105.572609917263;6126.601770884968;6143.078538219303;6144.5084393248435;5778.739956701958;6072.271327440735;6112.327643959161;6125.448709616156;6131.601445906002;4545.977270113694;4558.9772051139535;4592.67851250416;4614.884627884329;4617.607503362185;4104;4113.354184437549;4120.793960301973;4128.504579450425;4142.150859073882;5663.065594176915;5763.452472015152;5834.737436815353;5848.590598658053;5851.912221316684;5850.47345738877;6084.026555751058;6106.389361063858;6168.784092556739;6168.8766224675255;5873.941260587425;5876.030454974967;5891.617044892068;5898.616589921728;5903.793367232126;5064.316317297192;5229.320188375486;5231.163013917755;5257.737113144328;5283.762230699628;6307.180066591405;6319.399657032574;6324.3043265240785;6335.809925702236;6337.239531256187;6104.603200791934;6109.69451527413;6110.938890611037;6116.694165291628;6118;6121.87979361315;6281.937180628318;6315.463185629273;6352.745890164341;6365.4589359903075;5998.760049598141;6029.638221706711;6043;6045.365236650088;6062.211912451353;6137.3862613738265;6139.29398119222;6143.139960405636;6147.692615369303;6152.169457123231;5657.405972373006;5935.614185077956;6021.2473440819895;6023.909641355471;6027.457528822427;5886.146508756292;5922.1412895130825;5927.585069045125;5953.255843019622;5958.106284057426;5681.261436013292;5821.505172060253;5859.062549991981;5865.706714664165;5882.882342353215;5943.316518600243;6001.699915004145;6005.849853753691;6006.159137720635;6009;5874.353821079763;5885.764569417347;5889.970550147222;5899.852503687443;5912.733926973383 03:48:15 INFO - PROCESS | 25892 | |1;ext.html;657.9934200657995;670.3999920071536;681.7409384433915;694.6735034533767;779.6179871862789;39306.803465982666;40204.19591608166;40224.19551608966;40371.59628403715;40399.79800100999;43448.348274775904;44054.33918491225;44379;44527.77736111315;44566.331505027454;8806.603702833372;8990.59542320594;8991.775205619879;9036.68371606994;9041.141091596288;8890.199882010618;8916.73249802507;8935.55322233889;8940.910590894073;8974.820503589925;8957;8997.910020899806;9077.45535267886;9078.909210907905;9080.137386948229;8928.285737141046;9004.59479323432;9019.098090190993;9040.050794666531;9045.592948317342;8839.24866386358;8897.199252067345;8946.597403116875;8951.462912225223;8977.461352318816;33724.325513489835;39963.001849907385;40467.59532404668;40946.590534094576;41110.58889411127;3373.4939759036097;3751.268502641986;3760.755550889211;3887.8250478728523;3901.2782635212293;28145;29462.944509719342;29793.404131917458;31772.841135794173;32606.510902336486;4405.933910991338;4415.241792976437;4461.397711308964;4514.841980530666;4589.426321709786;248190;248913;249988;250464;252261;36307.27385452329;38205.23589528194;38473.807630961666;38487.422688659695;38528.80735596304;38165.42751858725;38215;38225;38245.23509529849;38246.617533824305;13381.264030478222;13798.448062077605;13814.861851381558;13882.722345553033;13896.305184740722;11416.600418985296;11479.885201147881;11544.365059921785;11545;11578.015868651259;9412.67055653049;9476.668316608886;9521.190698790542;9527.38072025316;9582.66460673887;3558.5907620623443;3610.548681414823;3615.385384484644;3675.5956844747056;3679.448082787603;1024.71820249432;1121.52895783771;1193.4271549656214;1199.4782269712703;1211.8850657395217;33232.83383583115;33503;33792.49311260333;33820.735479892115;33874.96750194996;1149.1151813103863;1191.237607930925;1230;1241.8633950265464;1248.375812093953;15881.682366352608;16087.356505739639;16220.107894065939;16304.429344972868;16626.25181866819;321498;324707;327982;329023;487445;57423.13865292024;58603.70698146482;58608.70695646494;58624.4137558619;58703.41296586979;1490.4410845932775;1514.8485151484983;1536.6926614677109;1539.1150088698819;1546.5824227458522;33675;33741.66258337483;34230.82884585561;34475.31049378948;34592.82703586466;55572.44427555673;56722;56738.446769896276;56925.71537142288;57057;449553;455239;458694;459077;459801;31569.526457102704;32286.677133228368;32296;32296.515552267203;32385.838070809496;52355.73822130865;53403.19895201653;53671.46328536665;54032.820880940126;54191.72904135454;43370.78314608407;43916.341254880565;44778.3283250745;44828.32757508575;45642.63072107842;44038.339424909296;44181;44676.32985505155;45492.09015819599;46149.30776038295;44141.33787993247;44307.11385772331;44508.77745611381;45160;45750.313745294516;37902;38001.23997519979;38301.42547861728;38948.221035578565;39006;29972.400551989274;30069.54895676523;30243.69756302409;30265.546016810207;30366.392672146874 03:48:15 INFO - PROCESS | 25892 | |2;jquery.html;426.95183324937284;438.93415987601867;444.12285735672043;447.1214064363525;457.04705688639206;18455.815441845578;19021.239150434;19119.904400477997;20980.16079356824;21032.789672103274;16923.730720196003;18409.81590184098;19207.519812004706;19261.036948152607;19517.316893908715;5307.469253074681;5426.21319908613;5437.483439073281;5452.83641490754;5456.0997435423105;5396.352437707461;5455.481729235736;5457.399686034553;5520.530754885839;5525.419830917756;5614.073677843151;5696.743646535895;5717.828465146053;5720.3135623725;5731.226284451608;5526.806561770339;6447.645379504125;6551.836204094888;6567.113439685653;6575.210974683021;5681.57388195887;5689.317281926195;5882.3529411764675;5910.290765108171;5922.170896074553;14187.574372768833;14271.215083170422;14323.283835808168;14443.350049247809;18591.53521161968;2364.775346342095;2483;2525.255049760325;2582.9095981640553;2846.9145925622265;10388.84416733742;10543.630972915988;10628.627998020032;10781.02970732638;13031.934840325832;2010.517475805796;2095.5704080663427;2128.638131517646;2167;2212.0930418528487;59990.70004649992;69655.65172174107;71092.6445367775;72882;79100.60449697773;10885.945570272099;11259.493322800494;11391.65825025234;11700.473478693479;11714.297142171326;16379.836201638069;16580.917095414687;16593.585160371087;16597.17014149312;16661;8007.559584222924;8031.718889838828;8080.757577272691;8082.959585202154;8145.592720364077;7509.774706758806;7567.281108294703;7652.426068044919;7699.422543309274;7772.106207786177;4855.223164293767;4995.950040499549;5005.89988200234;5020.221865610836;5054.342935418372;1998.7101870228735;2020.2121172742643;2024.210557882427;2061.6598261287018;2089.9268525601833;1012.5139932832282;1094.370736826328;1100.2353364411656;1178.452019810792;1192.4991503568522;17022.233999470052;19217.903910480636;19402.514937126685;19534;19657.901710491642;1037.2531777120462;1039.3815679670583;1040.3705758016442;1058.1799105692996;1062.198040479433;10508.737281568023;10811.513481893333;10830.945845270724;10879.945600272107;10935.726606834893;475503;480231;487522;495442;497770;87234.56382718046;95097.524512377;96116.51941740386;96231.51884240675;96256.51871740737;1062.2564205056337;1091.8034753744403;1104.3263609198382;1109.5672687651822;1109.9056580190613;16900.57748556296;17067.317307308065;17080.65838683244;17199.05405202726;17489;39808.2038359237;39878.40182397325;40248.597514025656;41422;41985.160296793285;54975.17537237025;55938.72030639821;58375.416245837;58802.11796823137;58851.4114858863;9019.143181397756;9053.366264361432;9083.818323633623;9281.164695177466;9334.25325973907;13310.46758129664;13614.863851361755;13672;13778;13791.10357826738;12130;12144.271343719405;12193.268403895794;12242.510299588273;12462;11756.529738810352;11835;11845;12149.210301330739;12161.939190303992;9605.423674579548;12414.565490207799;12535.93732031334;12582.844205518342;12644.431000605178;9220.400673956172;9228.538573071453;9303.834749358502;9359.251259899327;9376.062393760842;12062.577809776616;12199.939000304941;12268.87731122713;12327.137100403244;12348.135630506138 03:48:15 INFO - PROCESS | 25892 | |3;mootools.html;1575.1572908493958;1611.4359974009099;1827.8172182781716;1887.1979408751276;1920.8463322934158;7666.846663066735;8058.355331573474;8323.54220517872;8591.91408085919;8617.91382086179;8150.959245203766;8250.504969701822;8273.503589784617;8312.293455056328;8336.16638336166;2413.60175571031;2456.4227406559444;2463.458039231375;2466.839655422401;2471.147454128332;2353.5163070046833;2411.807055435561;2429.2712186344024;2430.173740928084;2435.2937648082125;2378.262738551046;2396.760323967598;2398.868062256584;2419.032387045187;2420.8547487150827;2349.5418393413293;2350.717913850332;2367.5738367094004;2368.4434157972864;2393.1623931623967;2316.698829152216;2325.5930212212966;2388.1283331584023;2398.2805158452393;2425.320910145162;8489.405741598091;8605.526696031715;8621.396502244845;8625.482471051757;8631.611577479029;5152.562032227265;5259.184826351921;5330.360356757175;5337.70642614656;5343;3323.1858194742445;3330.58367704037;3405.9489107663403;3425.486177073434;3450.6721861423125;1172.6775136837352;1185.8458400407978;1196.9880301196963;1249.6938250128685;1267.790814515613;11889.464974076187;12094.939525302318;12097.516099356015;12129;12161;4745.920009477972;4824.179889418807;4834.105690447279;4837.588804951619;4893.706377617284;10278.280520363653;10345.327553708985;10346.793064138676;10361.74095647615;10392.532336044746;5303.337082864642;5346.812861549827;5358.27663265462;5392.892142157135;5421.403645598981;4220.620144186976;4808.0383923215495;4880.072786170616;4957.355543779286;4965.702057876467;3965.385365268388;4110.116324990141;4151.294279972412;4217.97891010543;4220.451341325608;1280.5966120671958;1327.0644195841908;1330.9068365214341;1342.9059965802496;1348;1015.9898401016043;1019.7144799456164;1022.8005538919988;1048.16670746755;1056.630179437191;6012.368701286302;6019.127226552126;6059.666718330446;6126.264848218242;6158.568900177034;457.3551292677309;457.71164166574846;464.7165229210179;468.0054883372833;469.896622742996;4188.308929026676;4242.745435273893;4279.957200428018;4306.633936115465;4361.236783562864;10289.742756431;10563.577456901792;10685.305455145392;10811.675649730521;10862.72843178911;10498.527566259536;10558.472076396149;10573.682789516326;10600.204984626183;10648.893511064945;8154.347652187811;8160.959195203986;8258.628361723737;8376.455530390505;8379.62291696875;5864.794732184353;5874.441928016831;5934.258217722785;5984.1323008164445;6234.2830574482705;9462.243020558477;9842.901570984484;9959.502024898871;10012.949935250277;10134.746631334276;9710.465924373944;9844.409335439897;9892.950535247277;10012.449315287438;10060.647877324258;7012.4390048796995;7459.664315105942;7715.961420193088;7844.372450203856;7970.561619111005;8177.4684645497855;8219.219174178443;8256.215659512336;8285.461445006296;8288.958555207426;7386.778396648109;7545.098978288704;7610.315071643578;7626.084869815658;7928.127905930459;7538;7717.421193410404;7760.650770715444;7849.960750196213;7851.685932562634;7060.929390706027;7197.8920316196345;7205.495615306878;7214.386777124003;7224.458165637703;5156.716380598953;5163.122269214167;5274.973625132004;5275.683458992473;5328.813491527778;5167.250748641351;5202.297689811827;5207.92188117171;5208.557272631869;5284.497972692588 03:48:15 INFO - PROCESS | 25892 | |4;prototype.html;337.5426297367068;344.5159550831082;349.46706272933756;353.7519066333451;358.3531725235948;5659.4340565943385;5733.340665823426;5826.621269617477;5882.088276317167;5890.350701803502;5695.288088988877;5710.371859095496;5717.714114294279;5722.313322401307;5762.9135562966585;4295.463067116611;4491.865244042684;4515;4524.11779702958;4535.954640453603;4437.5562443755525;4437.800298986554;4445.622122119624;4450.799714012877;4455.665825063117;4386.254336762758;4389.3759309055695;4403.801828917691;4419.712718673292;4423.778811059434;4390.319500477431;4406.427164468614;4420.276092323997;4422.756748378838;4451.1097780443715;3670.5595328560476;3852.672522835562;3856.691464682847;3861.9613803861885;3879.2931110311656;5494.2582751328455;5525.563353528071;5526.751296191681;5547;5567;5039.344885164942;5067.265246539231;5083.567896728782;5093.617978651579;5113.440400677791;5706;6023.397660233942;6056.454919057306;6072.666003369813;6082.361352058058;4261.275583150872;4275.605660829945;4280.72175308604;4284.828606855722;4289.957100428987;5644;6213.4407903289375;6293.2762732285455;6296.527760417987;6306.936930630681;4325.502567204811;4334.634590104107;4345.891352716208;4349.282368409177;4364.978175109104;4405.942573782269;4407.647388208936;4411.779411029435;4415.448068991376;4418.403515525427;4914.92627610579;5044.823431179964;5050.898982020339;5084.618653600995;5087.796488140507;5991.172692328882;5998.550108741862;6040.64744067047;6045.304789949124;6046.969765151146;1545.6290490282252;1548.9922550387175;1550.937962481488;1554.7901033360579;1557.2914323982561;1036.9066783989476;1057.1014637558014;1063.3301020357126;1069.2996087562658;1076.9084627806567;6205.348438413902;6251.218597675291;6277.96861015692;6286.811395658137;6297.905531417033;6612.86774264512;6650.667466626649;6691.698873550702;6704.396604305636;6708.83227919306;5607.214989901417;5985.521158307325;6006.249218847644;6016.398360163948;6023.307319658208;3607.9098022549647;3613.403788374941;3615.7468977171347;3629.8185090745355;3633.7819730816236;6271.811845644638;6566.770163044271;6579.671016449159;6587.442780898357;6935.375816176467;6391.073294372383;6392.936070639327;6429.967850160813;6434.581752186093;6456.644884531302;6336.714847831859;6556.18047744032;6570.934290657128;6588.8023359299295;6610.140681711443;6294.073255936012;6346.587471814318;6372.394622510854;6376.458001069961;6398.400399900025;6124.295705993868;6225.657588832658;6227.314995350417;6295.276043255084;6295.307516173126;6499.837504062436;6539.11721917535;6552.901706474502;6556.868862622816;6564.901526477011;4366.388705581285;4435.693439411423;4447.399601053946;4455.376247325312;4457.219986502284;6114.266288045463;6308.463780578702;6345.46063584582;6348.587341822767;6350.650714210763;6040.516758659209;6128.63228206309;6131.96934015327;6146.754129834935;6154.323024467394;5890.882182356415;6081.300650425081;6118.60229085108;6122.632642041492;6126.039667306419;5984.431479009487;6005.249343832021;6008.939910600838;6012;6028.457438830526;6152.969235153795;6168.814935551941;6181.258249010148;6204.81385558434;6205.348438414082;5785.971070144791;5972.611780234271;6014.759409623566;6026.306974697965;6065.8180254592435 03:48:15 INFO - PROCESS | 25892 | |5;yui.html;844.0588743550938;851.4720873058704;861.0356400831071;871.0288028847837;913.8759326028983;13520.661983450407;14383.2808359582;14447.855521444782;14450.349734261958;14471.131732096082;14171.149731016147;14174.149551026945;14187.290635468236;14192.219427931486;14218;722.3607107709662;887.3344991256557;888.5290795878178;920.6041402197053;921.1801496667971;902.2646543067411;903.8373092843285;906.0576999920075;909.1272378516599;910.8588168833842;945.7966537194502;949.4588084791671;953.5708930981051;957.042957042957;961.8557216417523;939.1829108675428;943.8253923024193;944.5796620503878;944.7354740672623;949.1742184299669;700.6881937537797;702.0627462337785;703.1210986267166;703.6552089476171;707.508281744188;13617.795733064011;13857.307134643228;13871.4451421943;13921.651958701012;13954.441822327095;15018.624534386729;15104.848951510454;15268.389264429521;15372.538823835303;15560.533184004498;12450.377481125908;12450.75098498025;12566.246025238515;12569.937150314281;12854.67863303425;4107.794610269504;4154.563770804052;4155.854545090907;4193.266178418795;4195.853145139906;55961;57336.71331643315;57482.425175748125;57691.42308576903;57900.420995790344;11826.290422574673;11951.88048119525;12126.27242365461;12176.695582610506;12312.569060083033;19639.901800490905;20200.29298974529;20209.898950505154;20252.29116980928;20273.29043483471;8991.460512369278;9039.954800225956;9202.079792020744;9212.861807072899;9233.122853328923;5096.362954630671;5127.6410651254055;5184.222366644958;5226.843194704165;5319.28189694394;3640.2537479816574;3701.148735790783;3701.851925922933;3703.148275896559;3722.3113723961155;664.2825748191941;678.4267294136447;695.8886578147574;698.0785363320368;715.5670819154336;755.4324776089636;792.9048514178336;793.5754371411267;807.1565214351017;825.2943733108226;10266.794664106676;10281;10635.574577016832;10640.308379955279;10686.839697404544;684.5960883079007;794.364508393283;806.435495153395;826.9379796515165;845.7166849105496;4643.651726120487;4655.650826188049;4710.364100846342;4733.242681171065;4795.688280261772;68581.3141868585;70379.64810175916;70574.2942570578;71832.28167718361;71860.64069679618;59065.70467147637;60973.39026609766;61195;62728;63423.68288158529;51796.482035179164;55476.72261638666;56394.7180264096;56911.43088569144;57194.14208786871;9867.16129129032;9957.153641940517;10382.42896640692;10404.47977601132;10459.790804184026;36127.81936090303;36880.63119368772;36998;37509.81245093757;38082;46489.302660460795;51100;52062.73968630133;52347.21479177892;52427.47572524226;13157.868421316047;13299.80050299227;13321.800172997606;13495.865041349462;13780.242086685328;13920.303984800517;14421.92789036048;14535.636609084857;14669.413223471369;14738;14047.859521404655;14380.209088500233;14435.278236088363;14618.561443156723;14620.634484137981;12875.549355772877;13050.15174013686;13152.473901044234;13232.272225027331;14252.928735356258;13375.331233438095;13429.287476102143;13461.05043166744;13536.932315338361;13656.317184140555;10875.456227188768;10929.781404372026;10973.945130274298;11131.165162612675;11142.442877855912;11501.309921404743;11732.824007639721;11887.16789824704;11940.10449216295;12072.698182545155 03:48:15 INFO - PROCESS | 25892 | __end_tp_report 03:48:15 INFO - PROCESS | 25892 | __start_cc_report 03:48:15 INFO - PROCESS | 25892 | _x_x_mozilla_cycle_collect,335 03:48:15 INFO - PROCESS | 25892 | __end_cc_report 03:48:15 INFO - PROCESS | 25892 | __startTimestamp1462099695742__endTimestamp 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | ------- Summary: start ------- 03:48:15 INFO - PROCESS | 25892 | Number of tests: 6 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | [#0] dojo.html Cycles:165 Average:5654.70 Median:5882.88 stddev:632.77 (10.8%) stddev-sans-first:608.18 03:48:15 INFO - PROCESS | 25892 | Values: 3343.7 3404.2 3417.4 3444.5 3448.0 5604.3 5642.4 5651.6 5660.8 5667.1 5588.4 5661.5 5662.7 5667.1 5674.0 5127.9 5169.4 5180.2 5210.7 5217.1 5008.4 5155.8 5306.5 5311.1 5329.2 5182.8 5233.6 5236.3 5313.7 5343.8 5231.0 5233.1 5243.3 5249.1 5298.6 5018.6 5094.0 5145.7 5200.0 5217.3 5461.9 5509.3 5568.8 5600.5 5656.6 5995.6 6036.9 6039.2 6051.1 6053.8 6096.1 6099.5 6104.5 6108.5 6123.4 5512.9 5650.1 5695.8 5720.1 5751.3 6174.2 6178.3 6195.7 6206.8 6215.6 5856.3 5871.4 5939.6 5942.8 5944.9 6015.9 6074.9 6081.8 6086.5 6110.3 5997.9 6105.6 6126.6 6143.1 6144.5 5778.7 6072.3 6112.3 6125.4 6131.6 4546.0 4559.0 4592.7 4614.9 4617.6 4104.0 4113.4 4120.8 4128.5 4142.2 5663.1 5763.5 5834.7 5848.6 5851.9 5850.5 6084.0 6106.4 6168.8 6168.9 5873.9 5876.0 5891.6 5898.6 5903.8 5064.3 5229.3 5231.2 5257.7 5283.8 6307.2 6319.4 6324.3 6335.8 6337.2 6104.6 6109.7 6110.9 6116.7 6118.0 6121.9 6281.9 6315.5 6352.7 6365.5 5998.8 6029.6 6043.0 6045.4 6062.2 6137.4 6139.3 6143.1 6147.7 6152.2 5657.4 5935.6 6021.2 6023.9 6027.5 5886.1 5922.1 5927.6 5953.3 5958.1 5681.3 5821.5 5859.1 5865.7 5882.9 5943.3 6001.7 6005.8 6006.2 6009.0 5874.4 5885.8 5890.0 5899.9 5912.7 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | [#1] ext.html Cycles:180 Average:52173.91 Median:39634.90 stddev:96963.60 (244.6%) stddev-sans-first:97158.46 03:48:15 INFO - PROCESS | 25892 | Values: 658.0 670.4 681.7 694.7 779.6 39306.8 40204.2 40224.2 40371.6 40399.8 43448.3 44054.3 44379.0 44527.8 44566.3 8806.6 8990.6 8991.8 9036.7 9041.1 8890.2 8916.7 8935.6 8940.9 8974.8 8957.0 8997.9 9077.5 9078.9 9080.1 8928.3 9004.6 9019.1 9040.1 9045.6 8839.2 8897.2 8946.6 8951.5 8977.5 33724.3 39963.0 40467.6 40946.6 41110.6 3373.5 3751.3 3760.8 3887.8 3901.3 28145.0 29462.9 29793.4 31772.8 32606.5 4405.9 4415.2 4461.4 4514.8 4589.4 248190.0 248913.0 249988.0 250464.0 252261.0 36307.3 38205.2 38473.8 38487.4 38528.8 38165.4 38215.0 38225.0 38245.2 38246.6 13381.3 13798.4 13814.9 13882.7 13896.3 11416.6 11479.9 11544.4 11545.0 11578.0 9412.7 9476.7 9521.2 9527.4 9582.7 3558.6 3610.5 3615.4 3675.6 3679.4 1024.7 1121.5 1193.4 1199.5 1211.9 33232.8 33503.0 33792.5 33820.7 33875.0 1149.1 1191.2 1230.0 1241.9 1248.4 15881.7 16087.4 16220.1 16304.4 16626.3 321498.0 324707.0 327982.0 329023.0 487445.0 57423.1 58603.7 58608.7 58624.4 58703.4 1490.4 1514.8 1536.7 1539.1 1546.6 33675.0 33741.7 34230.8 34475.3 34592.8 55572.4 56722.0 56738.4 56925.7 57057.0 449553.0 455239.0 458694.0 459077.0 459801.0 31569.5 32286.7 32296.0 32296.5 32385.8 52355.7 53403.2 53671.5 54032.8 54191.7 43370.8 43916.3 44778.3 44828.3 45642.6 44038.3 44181.0 44676.3 45492.1 46149.3 44141.3 44307.1 44508.8 45160.0 45750.3 37902.0 38001.2 38301.4 38948.2 39006.0 29972.4 30069.5 30243.7 30265.5 30366.4 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | [#2] jquery.html Cycles:180 Average:28608.00 Median:11580.71 stddev:80233.85 (692.8%) stddev-sans-first:80431.02 03:48:15 INFO - PROCESS | 25892 | Values: 427.0 438.9 444.1 447.1 457.0 18455.8 19021.2 19119.9 20980.2 21032.8 16923.7 18409.8 19207.5 19261.0 19517.3 5307.5 5426.2 5437.5 5452.8 5456.1 5396.4 5455.5 5457.4 5520.5 5525.4 5614.1 5696.7 5717.8 5720.3 5731.2 5526.8 6447.6 6551.8 6567.1 6575.2 5681.6 5689.3 5882.4 5910.3 5922.2 14187.6 14271.2 14323.3 14443.4 18591.5 2364.8 2483.0 2525.3 2582.9 2846.9 10388.8 10543.6 10628.6 10781.0 13031.9 2010.5 2095.6 2128.6 2167.0 2212.1 59990.7 69655.7 71092.6 72882.0 79100.6 10885.9 11259.5 11391.7 11700.5 11714.3 16379.8 16580.9 16593.6 16597.2 16661.0 8007.6 8031.7 8080.8 8083.0 8145.6 7509.8 7567.3 7652.4 7699.4 7772.1 4855.2 4996.0 5005.9 5020.2 5054.3 1998.7 2020.2 2024.2 2061.7 2089.9 1012.5 1094.4 1100.2 1178.5 1192.5 17022.2 19217.9 19402.5 19534.0 19657.9 1037.3 1039.4 1040.4 1058.2 1062.2 10508.7 10811.5 10830.9 10879.9 10935.7 475503.0 480231.0 487522.0 495442.0 497770.0 87234.6 95097.5 96116.5 96231.5 96256.5 1062.3 1091.8 1104.3 1109.6 1109.9 16900.6 17067.3 17080.7 17199.1 17489.0 39808.2 39878.4 40248.6 41422.0 41985.2 54975.2 55938.7 58375.4 58802.1 58851.4 9019.1 9053.4 9083.8 9281.2 9334.3 13310.5 13614.9 13672.0 13778.0 13791.1 12130.0 12144.3 12193.3 12242.5 12462.0 11756.5 11835.0 11845.0 12149.2 12161.9 9605.4 12414.6 12535.9 12582.8 12644.4 9220.4 9228.5 9303.8 9359.3 9376.1 12062.6 12199.9 12268.9 12327.1 12348.1 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | [#3] mootools.html Cycles:180 Average:5765.12 Median:4776.98 stddev:3193.01 (66.8%) stddev-sans-first:3186.44 03:48:15 INFO - PROCESS | 25892 | Values: 1575.2 1611.4 1827.8 1887.2 1920.8 7666.8 8058.4 8323.5 8591.9 8617.9 8151.0 8250.5 8273.5 8312.3 8336.2 2413.6 2456.4 2463.5 2466.8 2471.1 2353.5 2411.8 2429.3 2430.2 2435.3 2378.3 2396.8 2398.9 2419.0 2420.9 2349.5 2350.7 2367.6 2368.4 2393.2 2316.7 2325.6 2388.1 2398.3 2425.3 8489.4 8605.5 8621.4 8625.5 8631.6 5152.6 5259.2 5330.4 5337.7 5343.0 3323.2 3330.6 3405.9 3425.5 3450.7 1172.7 1185.8 1197.0 1249.7 1267.8 11889.5 12094.9 12097.5 12129.0 12161.0 4745.9 4824.2 4834.1 4837.6 4893.7 10278.3 10345.3 10346.8 10361.7 10392.5 5303.3 5346.8 5358.3 5392.9 5421.4 4220.6 4808.0 4880.1 4957.4 4965.7 3965.4 4110.1 4151.3 4218.0 4220.5 1280.6 1327.1 1330.9 1342.9 1348.0 1016.0 1019.7 1022.8 1048.2 1056.6 6012.4 6019.1 6059.7 6126.3 6158.6 457.4 457.7 464.7 468.0 469.9 4188.3 4242.7 4280.0 4306.6 4361.2 10289.7 10563.6 10685.3 10811.7 10862.7 10498.5 10558.5 10573.7 10600.2 10648.9 8154.3 8161.0 8258.6 8376.5 8379.6 5864.8 5874.4 5934.3 5984.1 6234.3 9462.2 9842.9 9959.5 10012.9 10134.7 9710.5 9844.4 9893.0 10012.4 10060.6 7012.4 7459.7 7716.0 7844.4 7970.6 8177.5 8219.2 8256.2 8285.5 8289.0 7386.8 7545.1 7610.3 7626.1 7928.1 7538.0 7717.4 7760.7 7850.0 7851.7 7060.9 7197.9 7205.5 7214.4 7224.5 5156.7 5163.1 5275.0 5275.7 5328.8 5167.3 5202.3 5207.9 5208.6 5284.5 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | [#4] prototype.html Cycles:180 Average:5142.53 Median:5806.30 stddev:1539.56 (26.5%) stddev-sans-first:1501.05 03:48:15 INFO - PROCESS | 25892 | Values: 337.5 344.5 349.5 353.8 358.4 5659.4 5733.3 5826.6 5882.1 5890.4 5695.3 5710.4 5717.7 5722.3 5762.9 4295.5 4491.9 4515.0 4524.1 4536.0 4437.6 4437.8 4445.6 4450.8 4455.7 4386.3 4389.4 4403.8 4419.7 4423.8 4390.3 4406.4 4420.3 4422.8 4451.1 3670.6 3852.7 3856.7 3862.0 3879.3 5494.3 5525.6 5526.8 5547.0 5567.0 5039.3 5067.3 5083.6 5093.6 5113.4 5706.0 6023.4 6056.5 6072.7 6082.4 4261.3 4275.6 4280.7 4284.8 4290.0 5644.0 6213.4 6293.3 6296.5 6306.9 4325.5 4334.6 4345.9 4349.3 4365.0 4405.9 4407.6 4411.8 4415.4 4418.4 4914.9 5044.8 5050.9 5084.6 5087.8 5991.2 5998.6 6040.6 6045.3 6047.0 1545.6 1549.0 1550.9 1554.8 1557.3 1036.9 1057.1 1063.3 1069.3 1076.9 6205.3 6251.2 6278.0 6286.8 6297.9 6612.9 6650.7 6691.7 6704.4 6708.8 5607.2 5985.5 6006.2 6016.4 6023.3 3607.9 3613.4 3615.7 3629.8 3633.8 6271.8 6566.8 6579.7 6587.4 6935.4 6391.1 6392.9 6430.0 6434.6 6456.6 6336.7 6556.2 6570.9 6588.8 6610.1 6294.1 6346.6 6372.4 6376.5 6398.4 6124.3 6225.7 6227.3 6295.3 6295.3 6499.8 6539.1 6552.9 6556.9 6564.9 4366.4 4435.7 4447.4 4455.4 4457.2 6114.3 6308.5 6345.5 6348.6 6350.7 6040.5 6128.6 6132.0 6146.8 6154.3 5890.9 6081.3 6118.6 6122.6 6126.0 5984.4 6005.2 6008.9 6012.0 6028.5 6153.0 6168.8 6181.3 6204.8 6205.3 5786.0 5972.6 6014.8 6026.3 6065.8 03:48:15 INFO - PROCESS | 25892 | 03:48:15 INFO - PROCESS | 25892 | [#5] yui.html Cycles:180 Average:16176.09 Median:4174.56 stddev:18936.99 (453.6%) stddev-sans-first:18955.11 03:48:15 INFO - PROCESS | 25892 | Values: 844.1 851.5 861.0 871.0 913.9 13520.7 14383.3 14447.9 14450.3 14471.1 14171.1 14174.1 14187.3 14192.2 14218.0 722.4 887.3 888.5 920.6 921.2 902.3 903.8 906.1 909.1 910.9 945.8 949.5 953.6 957.0 961.9 939.2 943.8 944.6 944.7 949.2 700.7 702.1 703.1 703.7 707.5 13617.8 13857.3 13871.4 13921.7 13954.4 15018.6 15104.8 15268.4 15372.5 15560.5 12450.4 12450.8 12566.2 12569.9 12854.7 4107.8 4154.6 4155.9 4193.3 4195.9 55961.0 57336.7 57482.4 57691.4 57900.4 11826.3 11951.9 12126.3 12176.7 12312.6 19639.9 20200.3 20209.9 20252.3 20273.3 8991.5 9040.0 9202.1 9212.9 9233.1 5096.4 5127.6 5184.2 5226.8 5319.3 3640.3 3701.1 3701.9 3703.1 3722.3 664.3 678.4 695.9 698.1 715.6 755.4 792.9 793.6 807.2 825.3 10266.8 10281.0 10635.6 10640.3 10686.8 684.6 794.4 806.4 826.9 845.7 4643.7 4655.7 4710.4 4733.2 4795.7 68581.3 70379.6 70574.3 71832.3 71860.6 59065.7 60973.4 61195.0 62728.0 63423.7 51796.5 55476.7 56394.7 56911.4 57194.1 9867.2 9957.2 10382.4 10404.5 10459.8 36127.8 36880.6 36998.0 37509.8 38082.0 46489.3 51100.0 52062.7 52347.2 52427.5 13157.9 13299.8 13321.8 13495.9 13780.2 13920.3 14421.9 14535.6 14669.4 14738.0 14047.9 14380.2 14435.3 14618.6 14620.6 12875.5 13050.2 13152.5 13232.3 14252.9 13375.3 13429.3 13461.1 13536.9 13656.3 10875.5 10929.8 10973.9 11131.2 11142.4 11501.3 11732.8 11887.2 11940.1 12072.7 03:48:15 INFO - PROCESS | 25892 | -------- Summary: end -------- 03:48:15 INFO - PROCESS | 25892 | 03:48:16 INFO - TEST-INFO | 25892: exit 0 03:48:16 INFO - TEST-OK | dromaeo_css | took 1109275ms 03:48:16 INFO - TEST-START | kraken 03:48:16 INFO - operating with platform_type : linux_ 03:48:16 INFO - Initialising browser for kraken test... 03:48:16 INFO - TEST-INFO | started process 26134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE2oJL7/profile http://localhost:47090/getInfo.html) 03:48:20 INFO - PROCESS | 26134 | 03:48:20 INFO - PROCESS | 26134 | (process:26211): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:48:20 INFO - PROCESS | 26134 | __metrics Screen width/height:1600/1200 03:48:20 INFO - PROCESS | 26134 | colorDepth:24 03:48:20 INFO - PROCESS | 26134 | Browser inner width/height: 1024/697 03:48:20 INFO - PROCESS | 26134 | __metrics 03:48:21 ERROR - PROCESS | 26134 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:48:22 INFO - TEST-INFO | 26134: exit 0 03:48:22 INFO - Browser initialized. 03:48:22 INFO - Running cycle 1/1 for kraken test... 03:48:22 INFO - TEST-INFO | started process 26262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE2oJL7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:24 INFO - PROCESS | 26262 | 03:48:24 INFO - PROCESS | 26262 | (process:26331): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:48:34 INFO - PROCESS | 26262 | RSS: Main: 152723456 03:48:34 INFO - PROCESS | 26262 | 03:48:36 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:37 INFO - PROCESS | 26262 | RSS: Main: 156987392 03:48:37 INFO - PROCESS | 26262 | 03:48:40 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-dft) 03:48:40 INFO - PROCESS | 26262 | RSS: Main: 157261824 03:48:40 INFO - PROCESS | 26262 | 03:48:43 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-fft) 03:48:44 INFO - PROCESS | 26262 | RSS: Main: 157597696 03:48:44 INFO - PROCESS | 26262 | 03:48:46 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47090/tests/kraken/driver.html?testName=audio-oscillator) 03:48:46 INFO - PROCESS | 26262 | RSS: Main: 158089216 03:48:46 INFO - PROCESS | 26262 | 03:48:49 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:49 INFO - PROCESS | 26262 | RSS: Main: 157573120 03:48:49 INFO - PROCESS | 26262 | 03:48:52 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47090/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:53 INFO - PROCESS | 26262 | RSS: Main: 157757440 03:48:53 INFO - PROCESS | 26262 | 03:48:56 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47090/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:57 INFO - PROCESS | 26262 | RSS: Main: 158060544 03:48:57 INFO - PROCESS | 26262 | 03:49:00 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47090/tests/kraken/driver.html?testName=json-parse-financial) 03:49:00 INFO - PROCESS | 26262 | RSS: Main: 158019584 03:49:00 INFO - PROCESS | 26262 | 03:49:02 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:03 INFO - PROCESS | 26262 | RSS: Main: 157761536 03:49:03 INFO - PROCESS | 26262 | 03:49:04 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:05 INFO - PROCESS | 26262 | RSS: Main: 158568448 03:49:05 INFO - PROCESS | 26262 | 03:49:07 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:08 INFO - PROCESS | 26262 | RSS: Main: 158195712 03:49:08 INFO - PROCESS | 26262 | 03:49:10 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:11 INFO - PROCESS | 26262 | RSS: Main: 158433280 03:49:11 INFO - PROCESS | 26262 | 03:49:13 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:14 INFO - PROCESS | 26262 | RSS: Main: 159186944 03:49:14 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | Cycle 1(1): loaded http://localhost:47090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47090/tests/kraken/driver.html?testName=ai-astar) 03:49:16 INFO - PROCESS | 26262 | RSS: Main: 160043008 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | __start_tp_report 03:49:16 INFO - PROCESS | 26262 | _x_x_mozilla_page_load 03:49:16 INFO - PROCESS | 26262 | _x_x_mozilla_page_load_details 03:49:16 INFO - PROCESS | 26262 | |i|pagename|runs| 03:49:16 INFO - PROCESS | 26262 | |0;ai-astar;111;104;109;109;111;120;110;113;110;109 03:49:16 INFO - PROCESS | 26262 | |1;audio-beat-detection;157;127;156;175;129;160;158;133;181;134 03:49:16 INFO - PROCESS | 26262 | |2;audio-dft;165;161;163;162;164;161;162;163;164;165 03:49:16 INFO - PROCESS | 26262 | |3;audio-fft;76;76;76;173;75;77;75;80;169;76 03:49:16 INFO - PROCESS | 26262 | |4;audio-oscillator;92;92;150;93;91;93;145;92;92;148 03:49:16 INFO - PROCESS | 26262 | |5;imaging-gaussian-blur;117;118;117;119;117;117;118;117;117;118 03:49:16 INFO - PROCESS | 26262 | |6;imaging-darkroom;149;147;146;147;146;156;150;149;146;147 03:49:16 INFO - PROCESS | 26262 | |7;imaging-desaturate;95;95;96;95;94;95;95;94;96;95 03:49:16 INFO - PROCESS | 26262 | |8;json-parse-financial;58;61;57;57;58;61;56;74;56;61 03:49:16 INFO - PROCESS | 26262 | |9;json-stringify-tinderbox;57;56;58;57;57;58;57;56;56;57 03:49:16 INFO - PROCESS | 26262 | |10;stanford-crypto-aes;73;73;74;71;74;82;74;75;73;82 03:49:16 INFO - PROCESS | 26262 | |11;stanford-crypto-ccm;117;123;126;118;120;120;116;122;153;126 03:49:16 INFO - PROCESS | 26262 | |12;stanford-crypto-pbkdf2;160;159;168;157;160;158;157;159;160;156 03:49:16 INFO - PROCESS | 26262 | |13;stanford-crypto-sha256-iterative;69;68;68;69;68;67;74;66;66;75 03:49:16 INFO - PROCESS | 26262 | __end_tp_report 03:49:16 INFO - PROCESS | 26262 | __start_cc_report 03:49:16 INFO - PROCESS | 26262 | _x_x_mozilla_cycle_collect,837 03:49:16 INFO - PROCESS | 26262 | __end_cc_report 03:49:16 INFO - PROCESS | 26262 | __startTimestamp1462099756431__endTimestamp 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | ------- Summary: start ------- 03:49:16 INFO - PROCESS | 26262 | Number of tests: 14 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#0] ai-astar Cycles:10 Average:110.60 Median:110.50 stddev:4.03 (3.6%) stddev-sans-first:4.28 03:49:16 INFO - PROCESS | 26262 | Values: 111.0 104.0 109.0 109.0 111.0 120.0 110.0 113.0 110.0 109.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:157.50 stddev:19.26 (12.2%) stddev-sans-first:20.31 03:49:16 INFO - PROCESS | 26262 | Values: 157.0 127.0 156.0 175.0 129.0 160.0 158.0 133.0 181.0 134.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.49 (0.9%) stddev-sans-first:1.39 03:49:16 INFO - PROCESS | 26262 | Values: 165.0 161.0 163.0 162.0 164.0 161.0 162.0 163.0 164.0 165.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:39.93 (52.5%) stddev-sans-first:41.74 03:49:16 INFO - PROCESS | 26262 | Values: 76.0 76.0 76.0 173.0 75.0 77.0 75.0 80.0 169.0 76.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:26.85 (29.2%) stddev-sans-first:27.78 03:49:16 INFO - PROCESS | 26262 | Values: 92.0 92.0 150.0 93.0 91.0 93.0 145.0 92.0 92.0 148.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 03:49:16 INFO - PROCESS | 26262 | Values: 117.0 118.0 117.0 119.0 117.0 117.0 118.0 117.0 117.0 118.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:3.06 (2.1%) stddev-sans-first:3.23 03:49:16 INFO - PROCESS | 26262 | Values: 149.0 147.0 146.0 147.0 146.0 156.0 150.0 149.0 146.0 147.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:49:16 INFO - PROCESS | 26262 | Values: 95.0 95.0 96.0 95.0 94.0 95.0 95.0 94.0 96.0 95.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.50 stddev:5.34 (9.0%) stddev-sans-first:5.62 03:49:16 INFO - PROCESS | 26262 | Values: 58.0 61.0 57.0 57.0 58.0 61.0 56.0 74.0 56.0 61.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 03:49:16 INFO - PROCESS | 26262 | Values: 57.0 56.0 58.0 57.0 57.0 58.0 57.0 56.0 56.0 57.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.00 stddev:3.78 (5.1%) stddev-sans-first:3.94 03:49:16 INFO - PROCESS | 26262 | Values: 73.0 73.0 74.0 71.0 74.0 82.0 74.0 75.0 73.0 82.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:122.50 stddev:10.72 (8.8%) stddev-sans-first:11.06 03:49:16 INFO - PROCESS | 26262 | Values: 117.0 123.0 126.0 118.0 120.0 120.0 116.0 122.0 153.0 126.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.50 stddev:3.34 (2.1%) stddev-sans-first:3.54 03:49:16 INFO - PROCESS | 26262 | Values: 160.0 159.0 168.0 157.0 160.0 158.0 157.0 159.0 160.0 156.0 03:49:16 INFO - PROCESS | 26262 | 03:49:16 INFO - PROCESS | 26262 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:3.09 (4.5%) stddev-sans-first:3.28 03:49:16 INFO - PROCESS | 26262 | Values: 69.0 68.0 68.0 69.0 68.0 67.0 74.0 66.0 66.0 75.0 03:49:16 INFO - PROCESS | 26262 | -------- Summary: end -------- 03:49:16 INFO - PROCESS | 26262 | 03:49:17 INFO - TEST-INFO | 26262: exit 0 03:49:17 INFO - TEST-OK | kraken | took 60921ms 03:49:17 INFO - SUITE-END | took 1170s 03:49:17 INFO - Completed test suite (00:19:30) 03:49:17 INFO - javascript benchmark 03:49:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.6990670839627, 3404.2340473393506, 3417.367786959412, 3444.500547420624, 3447.982845060707, 5604.327480702316, 5642.407547207546, 5651.632643878145, 5660.8301750947485, 5667.149927510865, 5588.4411558844195, 5661.5187709044785, 5662.716864156796, 5667.0932650775885, 5674.035413979623, 5127.923081153795, 5169.431362550116, 5180.222966555009, 5210.661307015051, 5217.113090774577, 5008.39899212095, 5155.7679904404395, 5306.548943339821, 5311.123664595337, 5329.173978033392, 5182.792688292464, 5233.607479439038, 5236.266922630834, 5313.707746073965, 5343.786248550054, 5230.953809238149, 5233.136532472137, 5243.292155558989, 5249.1076516991825, 5298.576113910916, 5018.598512119058, 5094.0, 5145.716985565829, 5199.974000129975, 5217.2695822584865, 5461.863453413696, 5509.311336082989, 5568.777248910079, 5600.467955544257, 5656.575756818214, 5995.550333724945, 6036.9396306036815, 6039.184710064173, 6051.062085376773, 6053.848653783647, 6096.085587161917, 6099.48154406876, 6104.481119104881, 6108.5418593605655, 6123.357047509992, 5512.862178445531, 5650.0959846424785, 5695.829125126253, 5720.113382425689, 5751.309842818847, 6174.197354343996, 6178.320384757673, 6195.659238741822, 6206.751729930752, 6215.595986260969, 5856.267966504187, 5871.4128587141795, 5939.554533410012, 5942.821715348547, 5944.940550594525, 6015.909761353583, 6074.908876366858, 6081.756729730761, 6086.482648974798, 6110.266767987781, 5997.910031349533, 6105.572609917263, 6126.601770884968, 6143.078538219303, 6144.5084393248435, 5778.739956701958, 6072.271327440735, 6112.327643959161, 6125.448709616156, 6131.601445906002, 4545.977270113694, 4558.9772051139535, 4592.67851250416, 4614.884627884329, 4617.607503362185, 4104.0, 4113.354184437549, 4120.793960301973, 4128.504579450425, 4142.150859073882, 5663.065594176915, 5763.452472015152, 5834.737436815353, 5848.590598658053, 5851.912221316684, 5850.47345738877, 6084.026555751058, 6106.389361063858, 6168.784092556739, 6168.8766224675255, 5873.941260587425, 5876.030454974967, 5891.617044892068, 5898.616589921728, 5903.793367232126, 5064.316317297192, 5229.320188375486, 5231.163013917755, 5257.737113144328, 5283.762230699628, 6307.180066591405, 6319.399657032574, 6324.3043265240785, 6335.809925702236, 6337.239531256187, 6104.603200791934, 6109.69451527413, 6110.938890611037, 6116.694165291628, 6118.0, 6121.87979361315, 6281.937180628318, 6315.463185629273, 6352.745890164341, 6365.4589359903075, 5998.760049598141, 6029.638221706711, 6043.0, 6045.365236650088, 6062.211912451353, 6137.3862613738265, 6139.29398119222, 6143.139960405636, 6147.692615369303, 6152.169457123231, 5657.405972373006, 5935.614185077956, 6021.2473440819895, 6023.909641355471, 6027.457528822427, 5886.146508756292, 5922.1412895130825, 5927.585069045125, 5953.255843019622, 5958.106284057426, 5681.261436013292, 5821.505172060253, 5859.062549991981, 5865.706714664165, 5882.882342353215, 5943.316518600243, 6001.699915004145, 6005.849853753691, 6006.159137720635, 6009.0, 5874.353821079763, 5885.764569417347, 5889.970550147222, 5899.852503687443, 5912.733926973383], "value": 5613.270584787851, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.9934200657995, 670.3999920071536, 681.7409384433915, 694.6735034533767, 779.6179871862789, 39306.803465982666, 40204.19591608166, 40224.19551608966, 40371.59628403715, 40399.79800100999, 43448.348274775904, 44054.33918491225, 44379.0, 44527.77736111315, 44566.331505027454, 8806.603702833372, 8990.59542320594, 8991.775205619879, 9036.68371606994, 9041.141091596288, 8890.199882010618, 8916.73249802507, 8935.55322233889, 8940.910590894073, 8974.820503589925, 8957.0, 8997.910020899806, 9077.45535267886, 9078.909210907905, 9080.137386948229, 8928.285737141046, 9004.59479323432, 9019.098090190993, 9040.050794666531, 9045.592948317342, 8839.24866386358, 8897.199252067345, 8946.597403116875, 8951.462912225223, 8977.461352318816, 33724.325513489835, 39963.001849907385, 40467.59532404668, 40946.590534094576, 41110.58889411127, 3373.4939759036097, 3751.268502641986, 3760.755550889211, 3887.8250478728523, 3901.2782635212293, 28145.0, 29462.944509719342, 29793.404131917458, 31772.841135794173, 32606.510902336486, 4405.933910991338, 4415.241792976437, 4461.397711308964, 4514.841980530666, 4589.426321709786, 248190.0, 248913.0, 249988.0, 250464.0, 252261.0, 36307.27385452329, 38205.23589528194, 38473.807630961666, 38487.422688659695, 38528.80735596304, 38165.42751858725, 38215.0, 38225.0, 38245.23509529849, 38246.617533824305, 13381.264030478222, 13798.448062077605, 13814.861851381558, 13882.722345553033, 13896.305184740722, 11416.600418985296, 11479.885201147881, 11544.365059921785, 11545.0, 11578.015868651259, 9412.67055653049, 9476.668316608886, 9521.190698790542, 9527.38072025316, 9582.66460673887, 3558.5907620623443, 3610.548681414823, 3615.385384484644, 3675.5956844747056, 3679.448082787603, 1024.71820249432, 1121.52895783771, 1193.4271549656214, 1199.4782269712703, 1211.8850657395217, 33232.83383583115, 33503.0, 33792.49311260333, 33820.735479892115, 33874.96750194996, 1149.1151813103863, 1191.237607930925, 1230.0, 1241.8633950265464, 1248.375812093953, 15881.682366352608, 16087.356505739639, 16220.107894065939, 16304.429344972868, 16626.25181866819, 321498.0, 324707.0, 327982.0, 329023.0, 487445.0, 57423.13865292024, 58603.70698146482, 58608.70695646494, 58624.4137558619, 58703.41296586979, 1490.4410845932775, 1514.8485151484983, 1536.6926614677109, 1539.1150088698819, 1546.5824227458522, 33675.0, 33741.66258337483, 34230.82884585561, 34475.31049378948, 34592.82703586466, 55572.44427555673, 56722.0, 56738.446769896276, 56925.71537142288, 57057.0, 449553.0, 455239.0, 458694.0, 459077.0, 459801.0, 31569.526457102704, 32286.677133228368, 32296.0, 32296.515552267203, 32385.838070809496, 52355.73822130865, 53403.19895201653, 53671.46328536665, 54032.820880940126, 54191.72904135454, 43370.78314608407, 43916.341254880565, 44778.3283250745, 44828.32757508575, 45642.63072107842, 44038.339424909296, 44181.0, 44676.32985505155, 45492.09015819599, 46149.30776038295, 44141.33787993247, 44307.11385772331, 44508.77745611381, 45160.0, 45750.313745294516, 37902.0, 38001.23997519979, 38301.42547861728, 38948.221035578565, 39006.0, 29972.400551989274, 30069.54895676523, 30243.69756302409, 30265.546016810207, 30366.392672146874], "value": 19003.440654528247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.95183324937284, 438.93415987601867, 444.12285735672043, 447.1214064363525, 457.04705688639206, 18455.815441845578, 19021.239150434, 19119.904400477997, 20980.16079356824, 21032.789672103274, 16923.730720196003, 18409.81590184098, 19207.519812004706, 19261.036948152607, 19517.316893908715, 5307.469253074681, 5426.21319908613, 5437.483439073281, 5452.83641490754, 5456.0997435423105, 5396.352437707461, 5455.481729235736, 5457.399686034553, 5520.530754885839, 5525.419830917756, 5614.073677843151, 5696.743646535895, 5717.828465146053, 5720.3135623725, 5731.226284451608, 5526.806561770339, 6447.645379504125, 6551.836204094888, 6567.113439685653, 6575.210974683021, 5681.57388195887, 5689.317281926195, 5882.3529411764675, 5910.290765108171, 5922.170896074553, 14187.574372768833, 14271.215083170422, 14323.283835808168, 14443.350049247809, 18591.53521161968, 2364.775346342095, 2483.0, 2525.255049760325, 2582.9095981640553, 2846.9145925622265, 10388.84416733742, 10543.630972915988, 10628.627998020032, 10781.02970732638, 13031.934840325832, 2010.517475805796, 2095.5704080663427, 2128.638131517646, 2167.0, 2212.0930418528487, 59990.70004649992, 69655.65172174107, 71092.6445367775, 72882.0, 79100.60449697773, 10885.945570272099, 11259.493322800494, 11391.65825025234, 11700.473478693479, 11714.297142171326, 16379.836201638069, 16580.917095414687, 16593.585160371087, 16597.17014149312, 16661.0, 8007.559584222924, 8031.718889838828, 8080.757577272691, 8082.959585202154, 8145.592720364077, 7509.774706758806, 7567.281108294703, 7652.426068044919, 7699.422543309274, 7772.106207786177, 4855.223164293767, 4995.950040499549, 5005.89988200234, 5020.221865610836, 5054.342935418372, 1998.7101870228735, 2020.2121172742643, 2024.210557882427, 2061.6598261287018, 2089.9268525601833, 1012.5139932832282, 1094.370736826328, 1100.2353364411656, 1178.452019810792, 1192.4991503568522, 17022.233999470052, 19217.903910480636, 19402.514937126685, 19534.0, 19657.901710491642, 1037.2531777120462, 1039.3815679670583, 1040.3705758016442, 1058.1799105692996, 1062.198040479433, 10508.737281568023, 10811.513481893333, 10830.945845270724, 10879.945600272107, 10935.726606834893, 475503.0, 480231.0, 487522.0, 495442.0, 497770.0, 87234.56382718046, 95097.524512377, 96116.51941740386, 96231.51884240675, 96256.51871740737, 1062.2564205056337, 1091.8034753744403, 1104.3263609198382, 1109.5672687651822, 1109.9056580190613, 16900.57748556296, 17067.317307308065, 17080.65838683244, 17199.05405202726, 17489.0, 39808.2038359237, 39878.40182397325, 40248.597514025656, 41422.0, 41985.160296793285, 54975.17537237025, 55938.72030639821, 58375.416245837, 58802.11796823137, 58851.4114858863, 9019.143181397756, 9053.366264361432, 9083.818323633623, 9281.164695177466, 9334.25325973907, 13310.46758129664, 13614.863851361755, 13672.0, 13778.0, 13791.10357826738, 12130.0, 12144.271343719405, 12193.268403895794, 12242.510299588273, 12462.0, 11756.529738810352, 11835.0, 11845.0, 12149.210301330739, 12161.939190303992, 9605.423674579548, 12414.565490207799, 12535.93732031334, 12582.844205518342, 12644.431000605178, 9220.400673956172, 9228.538573071453, 9303.834749358502, 9359.251259899327, 9376.062393760842, 12062.577809776616, 12199.939000304941, 12268.87731122713, 12327.137100403244, 12348.135630506138], "value": 9360.79526413015, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.1572908493958, 1611.4359974009099, 1827.8172182781716, 1887.1979408751276, 1920.8463322934158, 7666.846663066735, 8058.355331573474, 8323.54220517872, 8591.91408085919, 8617.91382086179, 8150.959245203766, 8250.504969701822, 8273.503589784617, 8312.293455056328, 8336.16638336166, 2413.60175571031, 2456.4227406559444, 2463.458039231375, 2466.839655422401, 2471.147454128332, 2353.5163070046833, 2411.807055435561, 2429.2712186344024, 2430.173740928084, 2435.2937648082125, 2378.262738551046, 2396.760323967598, 2398.868062256584, 2419.032387045187, 2420.8547487150827, 2349.5418393413293, 2350.717913850332, 2367.5738367094004, 2368.4434157972864, 2393.1623931623967, 2316.698829152216, 2325.5930212212966, 2388.1283331584023, 2398.2805158452393, 2425.320910145162, 8489.405741598091, 8605.526696031715, 8621.396502244845, 8625.482471051757, 8631.611577479029, 5152.562032227265, 5259.184826351921, 5330.360356757175, 5337.70642614656, 5343.0, 3323.1858194742445, 3330.58367704037, 3405.9489107663403, 3425.486177073434, 3450.6721861423125, 1172.6775136837352, 1185.8458400407978, 1196.9880301196963, 1249.6938250128685, 1267.790814515613, 11889.464974076187, 12094.939525302318, 12097.516099356015, 12129.0, 12161.0, 4745.920009477972, 4824.179889418807, 4834.105690447279, 4837.588804951619, 4893.706377617284, 10278.280520363653, 10345.327553708985, 10346.793064138676, 10361.74095647615, 10392.532336044746, 5303.337082864642, 5346.812861549827, 5358.27663265462, 5392.892142157135, 5421.403645598981, 4220.620144186976, 4808.0383923215495, 4880.072786170616, 4957.355543779286, 4965.702057876467, 3965.385365268388, 4110.116324990141, 4151.294279972412, 4217.97891010543, 4220.451341325608, 1280.5966120671958, 1327.0644195841908, 1330.9068365214341, 1342.9059965802496, 1348.0, 1015.9898401016043, 1019.7144799456164, 1022.8005538919988, 1048.16670746755, 1056.630179437191, 6012.368701286302, 6019.127226552126, 6059.666718330446, 6126.264848218242, 6158.568900177034, 457.3551292677309, 457.71164166574846, 464.7165229210179, 468.0054883372833, 469.896622742996, 4188.308929026676, 4242.745435273893, 4279.957200428018, 4306.633936115465, 4361.236783562864, 10289.742756431, 10563.577456901792, 10685.305455145392, 10811.675649730521, 10862.72843178911, 10498.527566259536, 10558.472076396149, 10573.682789516326, 10600.204984626183, 10648.893511064945, 8154.347652187811, 8160.959195203986, 8258.628361723737, 8376.455530390505, 8379.62291696875, 5864.794732184353, 5874.441928016831, 5934.258217722785, 5984.1323008164445, 6234.2830574482705, 9462.243020558477, 9842.901570984484, 9959.502024898871, 10012.949935250277, 10134.746631334276, 9710.465924373944, 9844.409335439897, 9892.950535247277, 10012.449315287438, 10060.647877324258, 7012.4390048796995, 7459.664315105942, 7715.961420193088, 7844.372450203856, 7970.561619111005, 8177.4684645497855, 8219.219174178443, 8256.215659512336, 8285.461445006296, 8288.958555207426, 7386.778396648109, 7545.098978288704, 7610.315071643578, 7626.084869815658, 7928.127905930459, 7538.0, 7717.421193410404, 7760.650770715444, 7849.960750196213, 7851.685932562634, 7060.929390706027, 7197.8920316196345, 7205.495615306878, 7214.386777124003, 7224.458165637703, 5156.716380598953, 5163.122269214167, 5274.973625132004, 5275.683458992473, 5328.813491527778, 5167.250748641351, 5202.297689811827, 5207.92188117171, 5208.557272631869, 5284.497972692588], "value": 4604.107120693491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.5426297367068, 344.5159550831082, 349.46706272933756, 353.7519066333451, 358.3531725235948, 5659.4340565943385, 5733.340665823426, 5826.621269617477, 5882.088276317167, 5890.350701803502, 5695.288088988877, 5710.371859095496, 5717.714114294279, 5722.313322401307, 5762.9135562966585, 4295.463067116611, 4491.865244042684, 4515.0, 4524.11779702958, 4535.954640453603, 4437.5562443755525, 4437.800298986554, 4445.622122119624, 4450.799714012877, 4455.665825063117, 4386.254336762758, 4389.3759309055695, 4403.801828917691, 4419.712718673292, 4423.778811059434, 4390.319500477431, 4406.427164468614, 4420.276092323997, 4422.756748378838, 4451.1097780443715, 3670.5595328560476, 3852.672522835562, 3856.691464682847, 3861.9613803861885, 3879.2931110311656, 5494.2582751328455, 5525.563353528071, 5526.751296191681, 5547.0, 5567.0, 5039.344885164942, 5067.265246539231, 5083.567896728782, 5093.617978651579, 5113.440400677791, 5706.0, 6023.397660233942, 6056.454919057306, 6072.666003369813, 6082.361352058058, 4261.275583150872, 4275.605660829945, 4280.72175308604, 4284.828606855722, 4289.957100428987, 5644.0, 6213.4407903289375, 6293.2762732285455, 6296.527760417987, 6306.936930630681, 4325.502567204811, 4334.634590104107, 4345.891352716208, 4349.282368409177, 4364.978175109104, 4405.942573782269, 4407.647388208936, 4411.779411029435, 4415.448068991376, 4418.403515525427, 4914.92627610579, 5044.823431179964, 5050.898982020339, 5084.618653600995, 5087.796488140507, 5991.172692328882, 5998.550108741862, 6040.64744067047, 6045.304789949124, 6046.969765151146, 1545.6290490282252, 1548.9922550387175, 1550.937962481488, 1554.7901033360579, 1557.2914323982561, 1036.9066783989476, 1057.1014637558014, 1063.3301020357126, 1069.2996087562658, 1076.9084627806567, 6205.348438413902, 6251.218597675291, 6277.96861015692, 6286.811395658137, 6297.905531417033, 6612.86774264512, 6650.667466626649, 6691.698873550702, 6704.396604305636, 6708.83227919306, 5607.214989901417, 5985.521158307325, 6006.249218847644, 6016.398360163948, 6023.307319658208, 3607.9098022549647, 3613.403788374941, 3615.7468977171347, 3629.8185090745355, 3633.7819730816236, 6271.811845644638, 6566.770163044271, 6579.671016449159, 6587.442780898357, 6935.375816176467, 6391.073294372383, 6392.936070639327, 6429.967850160813, 6434.581752186093, 6456.644884531302, 6336.714847831859, 6556.18047744032, 6570.934290657128, 6588.8023359299295, 6610.140681711443, 6294.073255936012, 6346.587471814318, 6372.394622510854, 6376.458001069961, 6398.400399900025, 6124.295705993868, 6225.657588832658, 6227.314995350417, 6295.276043255084, 6295.307516173126, 6499.837504062436, 6539.11721917535, 6552.901706474502, 6556.868862622816, 6564.901526477011, 4366.388705581285, 4435.693439411423, 4447.399601053946, 4455.376247325312, 4457.219986502284, 6114.266288045463, 6308.463780578702, 6345.46063584582, 6348.587341822767, 6350.650714210763, 6040.516758659209, 6128.63228206309, 6131.96934015327, 6146.754129834935, 6154.323024467394, 5890.882182356415, 6081.300650425081, 6118.60229085108, 6122.632642041492, 6126.039667306419, 5984.431479009487, 6005.249343832021, 6008.939910600838, 6012.0, 6028.457438830526, 6152.969235153795, 6168.814935551941, 6181.258249010148, 6204.81385558434, 6205.348438414082, 5785.971070144791, 5972.611780234271, 6014.759409623566, 6026.306974697965, 6065.8180254592435], "value": 4650.91808802795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.0588743550938, 851.4720873058704, 861.0356400831071, 871.0288028847837, 913.8759326028983, 13520.661983450407, 14383.2808359582, 14447.855521444782, 14450.349734261958, 14471.131732096082, 14171.149731016147, 14174.149551026945, 14187.290635468236, 14192.219427931486, 14218.0, 722.3607107709662, 887.3344991256557, 888.5290795878178, 920.6041402197053, 921.1801496667971, 902.2646543067411, 903.8373092843285, 906.0576999920075, 909.1272378516599, 910.8588168833842, 945.7966537194502, 949.4588084791671, 953.5708930981051, 957.042957042957, 961.8557216417523, 939.1829108675428, 943.8253923024193, 944.5796620503878, 944.7354740672623, 949.1742184299669, 700.6881937537797, 702.0627462337785, 703.1210986267166, 703.6552089476171, 707.508281744188, 13617.795733064011, 13857.307134643228, 13871.4451421943, 13921.651958701012, 13954.441822327095, 15018.624534386729, 15104.848951510454, 15268.389264429521, 15372.538823835303, 15560.533184004498, 12450.377481125908, 12450.75098498025, 12566.246025238515, 12569.937150314281, 12854.67863303425, 4107.794610269504, 4154.563770804052, 4155.854545090907, 4193.266178418795, 4195.853145139906, 55961.0, 57336.71331643315, 57482.425175748125, 57691.42308576903, 57900.420995790344, 11826.290422574673, 11951.88048119525, 12126.27242365461, 12176.695582610506, 12312.569060083033, 19639.901800490905, 20200.29298974529, 20209.898950505154, 20252.29116980928, 20273.29043483471, 8991.460512369278, 9039.954800225956, 9202.079792020744, 9212.861807072899, 9233.122853328923, 5096.362954630671, 5127.6410651254055, 5184.222366644958, 5226.843194704165, 5319.28189694394, 3640.2537479816574, 3701.148735790783, 3701.851925922933, 3703.148275896559, 3722.3113723961155, 664.2825748191941, 678.4267294136447, 695.8886578147574, 698.0785363320368, 715.5670819154336, 755.4324776089636, 792.9048514178336, 793.5754371411267, 807.1565214351017, 825.2943733108226, 10266.794664106676, 10281.0, 10635.574577016832, 10640.308379955279, 10686.839697404544, 684.5960883079007, 794.364508393283, 806.435495153395, 826.9379796515165, 845.7166849105496, 4643.651726120487, 4655.650826188049, 4710.364100846342, 4733.242681171065, 4795.688280261772, 68581.3141868585, 70379.64810175916, 70574.2942570578, 71832.28167718361, 71860.64069679618, 59065.70467147637, 60973.39026609766, 61195.0, 62728.0, 63423.68288158529, 51796.482035179164, 55476.72261638666, 56394.7180264096, 56911.43088569144, 57194.14208786871, 9867.16129129032, 9957.153641940517, 10382.42896640692, 10404.47977601132, 10459.790804184026, 36127.81936090303, 36880.63119368772, 36998.0, 37509.81245093757, 38082.0, 46489.302660460795, 51100.0, 52062.73968630133, 52347.21479177892, 52427.47572524226, 13157.868421316047, 13299.80050299227, 13321.800172997606, 13495.865041349462, 13780.242086685328, 13920.303984800517, 14421.92789036048, 14535.636609084857, 14669.413223471369, 14738.0, 14047.859521404655, 14380.209088500233, 14435.278236088363, 14618.561443156723, 14620.634484137981, 12875.549355772877, 13050.15174013686, 13152.473901044234, 13232.272225027331, 14252.928735356258, 13375.331233438095, 13429.287476102143, 13461.05043166744, 13536.932315338361, 13656.317184140555, 10875.456227188768, 10929.781404372026, 10973.945130274298, 11131.165162612675, 11142.442877855912, 11501.309921404743, 11732.824007639721, 11887.16789824704, 11940.10449216295, 12072.698182545155], "value": 7352.65987856366, "unit": "score"}], "name": "dromaeo_css", "value": 7346.627839381257, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 109.0, 109.0, 111.0, 120.0, 110.0, 113.0, 110.0, 109.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 156.0, 175.0, 129.0, 160.0, 158.0, 133.0, 181.0, 134.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 163.0, 162.0, 164.0, 161.0, 162.0, 163.0, 164.0, 165.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 173.0, 75.0, 77.0, 75.0, 80.0, 169.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 93.0, 91.0, 93.0, 145.0, 92.0, 92.0, 148.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 146.0, 147.0, 146.0, 156.0, 150.0, 149.0, 146.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 57.0, 57.0, 58.0, 61.0, 56.0, 74.0, 56.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 57.0, 57.0, 58.0, 57.0, 56.0, 56.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 71.0, 74.0, 82.0, 74.0, 75.0, 73.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 123.0, 126.0, 118.0, 120.0, 120.0, 116.0, 122.0, 153.0, 126.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 168.0, 157.0, 160.0, 158.0, 157.0, 159.0, 160.0, 156.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 68.0, 67.0, 74.0, 66.0, 66.0, 75.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1533.9, "alertThreshold": 2.0}]} 03:49:17 INFO - Return code: 0 03:49:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:49:17 ERROR - # TBPL SUCCESS # 03:49:17 INFO - Running post-action listener: _resource_record_post_action 03:49:17 INFO - Running post-run listener: _resource_record_post_run 03:49:18 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 498733056; Read time: 0; Write time: 482244 03:49:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248963072; Read time: 0; Write time: 315272 03:49:18 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249769984; Read time: 0; Write time: 166972 03:49:18 INFO - Running post-run listener: _upload_blobber_files 03:49:18 INFO - Blob upload gear active. 03:49:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:18 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 03:49:18 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'] 03:49:18 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 03:49:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:20 INFO - (blobuploader) - INFO - Done attempting. 03:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:21 INFO - (blobuploader) - INFO - Done attempting. 03:49:21 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:21 INFO - Return code: 0 03:49:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4f1bbb0b2eb1d233cd7ab9591bffcea48bbf6ea46ffbed48d173f6cbbfd6795016a3eab76ed0e121cd5fb08a9f6351461c3459442c473c19b548e31dc26af71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee3b8158740019111782a2512444728cea2f0f8fb93807cf20de11d59e20ea482ccdedc2fcd194a7f45f69963cdaab55713832113930ba5ae5707a4cf8595ac0"} 03:49:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:21 INFO - Contents: 03:49:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4f1bbb0b2eb1d233cd7ab9591bffcea48bbf6ea46ffbed48d173f6cbbfd6795016a3eab76ed0e121cd5fb08a9f6351461c3459442c473c19b548e31dc26af71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee3b8158740019111782a2512444728cea2f0f8fb93807cf20de11d59e20ea482ccdedc2fcd194a7f45f69963cdaab55713832113930ba5ae5707a4cf8595ac0"} 03:49:21 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:21 INFO - Copying logs to upload dir... 03:49:21 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.134685 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-01 03:49:19.114142) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 03:49:19.121420) ========= 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=cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290 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/d4f1bbb0b2eb1d233cd7ab9591bffcea48bbf6ea46ffbed48d173f6cbbfd6795016a3eab76ed0e121cd5fb08a9f6351461c3459442c473c19b548e31dc26af71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee3b8158740019111782a2512444728cea2f0f8fb93807cf20de11d59e20ea482ccdedc2fcd194a7f45f69963cdaab55713832113930ba5ae5707a4cf8595ac0"} build_url:https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011128 build_url: 'https://queue.taskcluster.net/v1/task/Z5Jy9MdZSayhmKYWK8Gg-w/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/d4f1bbb0b2eb1d233cd7ab9591bffcea48bbf6ea46ffbed48d173f6cbbfd6795016a3eab76ed0e121cd5fb08a9f6351461c3459442c473c19b548e31dc26af71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee3b8158740019111782a2512444728cea2f0f8fb93807cf20de11d59e20ea482ccdedc2fcd194a7f45f69963cdaab55713832113930ba5ae5707a4cf8595ac0"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 03:49:19.187900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:49:19.188290) ========= 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=cbe409c6de289db6ac707de3000001d4-1462092963.123140-755345290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 03:49:19.214543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 03:49:19.214864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 03:49:19.215170) ========= ========= Total master_lag: 0.22 =========