builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1461713012.88 results: success (0) buildid: 20160426134004 builduid: 69a9a98b06a7410caef8484159ba4e0f revision: 88c0b444691016e0fd49c901a8e54f82d4c6a665 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:32.882686) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:32.883268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:32.883566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:32.915333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:32.915644) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 16:23:32-- 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% 89.5M=0s 2016-04-26 16:23:33 (89.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:33.069757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:33.070114) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:33.126248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 16:23:33.126559) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 88c0b444691016e0fd49c901a8e54f82d4c6a665 --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 88c0b444691016e0fd49c901a8e54f82d4c6a665 --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=5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 16:23:33,235 truncating revision to first 12 chars 2016-04-26 16:23:33,236 Setting DEBUG logging. 2016-04-26 16:23:33,236 attempt 1/10 2016-04-26 16:23:33,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/88c0b4446910?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 16:23:34,562 unpacking tar archive at: mozilla-aurora-88c0b4446910/testing/mozharness/ program finished with exit code 0 elapsedTime=1.631614 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 16:23:34.774438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:34.774998) ========= script_repo_revision: 88c0b444691016e0fd49c901a8e54f82d4c6a665 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:34.775651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:34.776138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 16:23:34.919226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-26 16:23:34.919693) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:23:35 INFO - MultiFileLogger online at 20160426 16:23:35 in /builds/slave/test 16:23:35 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 16:23:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:35 INFO - {'append_to_log': False, 16:23:35 INFO - 'base_work_dir': '/builds/slave/test', 16:23:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:23:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:35 INFO - 'branch': 'Mozilla-Aurora', 16:23:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:35 INFO - 'config_files': ('talos/linux_config.py',), 16:23:35 INFO - 'default_actions': ('clobber', 16:23:35 INFO - 'read-buildbot-config', 16:23:35 INFO - 'download-and-extract', 16:23:35 INFO - 'populate-webroot', 16:23:35 INFO - 'create-virtualenv', 16:23:35 INFO - 'install', 16:23:35 INFO - 'run-tests'), 16:23:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:35 INFO - 'download_minidump_stackwalk': True, 16:23:35 INFO - 'download_symbols': 'ondemand', 16:23:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:35 INFO - 'installer_path': 'installer.exe', 16:23:35 INFO - 'log_level': 'info', 16:23:35 INFO - 'log_name': 'talos', 16:23:35 INFO - 'log_to_console': True, 16:23:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:23:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:23:35 INFO - 'opt_config_files': (), 16:23:35 INFO - 'pip_index': False, 16:23:35 INFO - 'sps_profile': False, 16:23:35 INFO - 'sps_profile_interval': 0, 16:23:35 INFO - 'suite': 'dromaeojs-e10s', 16:23:35 INFO - 'system_bits': '32', 16:23:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:35 INFO - 'title': 'talos-linux64-ix-051', 16:23:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:35 INFO - 'use_talos_json': True, 16:23:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:35 INFO - 'work_dir': 'build'} 16:23:35 INFO - ##### 16:23:35 INFO - ##### Running clobber step. 16:23:35 INFO - ##### 16:23:35 INFO - Running pre-action listener: _resource_record_pre_action 16:23:35 INFO - Running main action method: clobber 16:23:35 INFO - rmtree: /builds/slave/test/build 16:23:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:35 INFO - Running post-action listener: _resource_record_post_action 16:23:35 INFO - ##### 16:23:35 INFO - ##### Running read-buildbot-config step. 16:23:35 INFO - ##### 16:23:35 INFO - Running pre-action listener: _resource_record_pre_action 16:23:35 INFO - Running main action method: read_buildbot_config 16:23:35 INFO - Using buildbot properties: 16:23:35 INFO - { 16:23:35 INFO - "project": "", 16:23:35 INFO - "product": "firefox", 16:23:35 INFO - "script_repo_revision": "production", 16:23:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:23:35 INFO - "repository": "", 16:23:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:23:35 INFO - "buildid": "20160426134004", 16:23:35 INFO - "pgo_build": "True", 16:23:35 INFO - "basedir": "/builds/slave/test", 16:23:35 INFO - "buildnumber": 261, 16:23:35 INFO - "slavename": "talos-linux64-ix-051", 16:23:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:23:35 INFO - "platform": "ubuntu64_hw", 16:23:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:23:35 INFO - "branch": "mozilla-aurora", 16:23:35 INFO - "repo_path": "releases/mozilla-aurora", 16:23:35 INFO - "revision": "88c0b444691016e0fd49c901a8e54f82d4c6a665", 16:23:35 INFO - "stage_platform": "linux64-pgo", 16:23:35 INFO - "builduid": "69a9a98b06a7410caef8484159ba4e0f", 16:23:35 INFO - "slavebuilddir": "test" 16:23:35 INFO - } 16:23:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 16:23:35 INFO - Running post-action listener: _resource_record_post_action 16:23:35 INFO - ##### 16:23:35 INFO - ##### Running download-and-extract step. 16:23:35 INFO - ##### 16:23:35 INFO - Running pre-action listener: _resource_record_pre_action 16:23:35 INFO - Running main action method: download_and_extract 16:23:35 INFO - mkdir: /builds/slave/test/build/tests 16:23:35 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')]} 16:23:35 INFO - https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:23:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:23:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:23:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:40 INFO - Downloaded 1361 bytes. 16:23:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:23:40 INFO - Using the following test package requirements: 16:23:40 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:23:40 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:23:40 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:23:40 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'jsshell-linux-x86_64.zip'], 16:23:40 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:23:40 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:23:40 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:23:40 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:23:40 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:23:40 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:23:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:23:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:40 INFO - https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:45 INFO - Downloaded 23821217 bytes. 16:23:45 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'] 16:23:45 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 16:23:46 INFO - Return code: 0 16:23:46 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 16:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:23:46 INFO - https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:52 INFO - Downloaded 23821217 bytes. 16:23:52 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'] 16:23:52 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 16:23:53 INFO - Return code: 0 16:23:53 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')]} 16:23:53 INFO - https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:23:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:23:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:23:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:55 INFO - Downloaded 10840145 bytes. 16:23:55 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'] 16:23:55 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 16:23:55 INFO - Return code: 0 16:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:55 INFO - https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:23:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:23:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:23:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JFpIVXz-S_ykzGiefcPfwg/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 16:23:57 INFO - Downloaded 62664201 bytes. 16:23:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:23:57 INFO - mkdir: /builds/slave/test/properties 16:23:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:57 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:57 INFO - Contents: 16:23:57 INFO - build_url:https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:23:58 INFO - Running post-action listener: _resource_record_post_action 16:23:58 INFO - Running post-action listener: set_extra_try_arguments 16:23:58 INFO - ##### 16:23:58 INFO - ##### Running populate-webroot step. 16:23:58 INFO - ##### 16:23:58 INFO - Running pre-action listener: _resource_record_pre_action 16:23:58 INFO - Running main action method: populate_webroot 16:23:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:23:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:23:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:23:58 INFO - '--tppagecycles', 16:23:58 INFO - '7'], 16:23:58 INFO - 'tests': ['tsvgm']}}, 16:23:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['damp', 'tps']}, 16:23:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'tests': ['damp', 'tps']}, 16:23:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['dromaeo_dom']}, 16:23:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['a11yr', 16:23:58 INFO - 'ts_paint', 16:23:58 INFO - 'tpaint', 16:23:58 INFO - 'sessionrestore', 16:23:58 INFO - 'sessionrestore_no_auto_restore', 16:23:58 INFO - 'tabpaint']}, 16:23:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:58 INFO - 'ts_paint', 16:23:58 INFO - 'tpaint', 16:23:58 INFO - 'sessionrestore', 16:23:58 INFO - 'sessionrestore_no_auto_restore', 16:23:58 INFO - 'tabpaint']}, 16:23:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:23:58 INFO - 'ts_paint', 16:23:58 INFO - 'tpaint', 16:23:58 INFO - 'sessionrestore', 16:23:58 INFO - 'sessionrestore_no_auto_restore', 16:23:58 INFO - 'tabpaint']}, 16:23:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:23:58 INFO - 'ts_paint', 16:23:58 INFO - 'tpaint', 16:23:58 INFO - 'sessionrestore', 16:23:58 INFO - 'sessionrestore_no_auto_restore', 16:23:58 INFO - 'tabpaint']}, 16:23:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['a11yr', 16:23:58 INFO - 'ts_paint', 16:23:58 INFO - 'tpaint', 16:23:58 INFO - 'sessionrestore', 16:23:58 INFO - 'sessionrestore_no_auto_restore', 16:23:58 INFO - 'tabpaint']}, 16:23:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['a11yr', 16:23:58 INFO - 'ts_paint', 16:23:58 INFO - 'tpaint', 16:23:58 INFO - 'sessionrestore', 16:23:58 INFO - 'sessionrestore_no_auto_restore', 16:23:58 INFO - 'tabpaint']}, 16:23:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['tsvgx', 16:23:58 INFO - 'tsvgr_opacity', 16:23:58 INFO - 'tart', 16:23:58 INFO - 'tscrollx', 16:23:58 INFO - 'cart']}, 16:23:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:58 INFO - 'tsvgr_opacity', 16:23:58 INFO - 'tart', 16:23:58 INFO - 'tscrollx', 16:23:58 INFO - 'cart']}, 16:23:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'talos_options': ['--disable-e10s'], 16:23:58 INFO - 'tests': ['tp5o']}, 16:23:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'tests': ['tp5o']}, 16:23:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'talos_options': ['--disable-e10s', 16:23:58 INFO - '--xperf_path', 16:23:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:58 INFO - 'tests': ['tp5n']}, 16:23:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:58 INFO - 'talos_options': ['--xperf_path', 16:23:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:58 INFO - 'tests': ['tp5n']}}, 16:23:58 INFO - 'talos.zip': {'path': '', 16:23:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:23:58 INFO - Running post-action listener: _resource_record_post_action 16:23:58 INFO - ##### 16:23:58 INFO - ##### Running create-virtualenv step. 16:23:58 INFO - ##### 16:23:58 INFO - Running pre-action listener: _resource_record_pre_action 16:23:58 INFO - Running main action method: create_virtualenv 16:23:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:58 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 16:23:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:58 INFO - Using real prefix '/usr' 16:23:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:24:00 INFO - Installing pip.................done. 16:24:00 INFO - Return code: 0 16:24:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:24:00 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')]} 16:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:00 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')]} 16:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:00 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:00 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 16:24:00 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 16:24:00 INFO - Using env: {'DISPLAY': ':0', 16:24:00 INFO - 'HOME': '/home/cltbld', 16:24:00 INFO - 'LANG': 'en_US.UTF-8', 16:24:00 INFO - 'LANGUAGE': 'en_US:en', 16:24:00 INFO - 'LOGNAME': 'cltbld', 16:24:00 INFO - 'MAIL': '/var/mail/cltbld', 16:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:00 INFO - 'MOZ_NO_REMOTE': '1', 16:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:00 INFO - 'NO_EM_RESTART': '1', 16:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:00 INFO - 'PWD': '/builds/slave/test', 16:24:00 INFO - 'SHELL': '/bin/bash', 16:24:00 INFO - 'SHLVL': '1', 16:24:00 INFO - 'TERM': 'linux', 16:24:00 INFO - 'TMOUT': '86400', 16:24:00 INFO - 'USER': 'cltbld', 16:24:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:00 INFO - '_': '/tools/buildbot/bin/python'} 16:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:01 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 16:24:01 INFO - Cleaning up... 16:24:01 INFO - Return code: 0 16:24:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:24:01 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')]} 16:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:01 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')]} 16:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:01 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:01 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 16:24:01 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 16:24:01 INFO - Using env: {'DISPLAY': ':0', 16:24:01 INFO - 'HOME': '/home/cltbld', 16:24:01 INFO - 'LANG': 'en_US.UTF-8', 16:24:01 INFO - 'LANGUAGE': 'en_US:en', 16:24:01 INFO - 'LOGNAME': 'cltbld', 16:24:01 INFO - 'MAIL': '/var/mail/cltbld', 16:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:01 INFO - 'MOZ_NO_REMOTE': '1', 16:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:01 INFO - 'NO_EM_RESTART': '1', 16:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:01 INFO - 'PWD': '/builds/slave/test', 16:24:01 INFO - 'SHELL': '/bin/bash', 16:24:01 INFO - 'SHLVL': '1', 16:24:01 INFO - 'TERM': 'linux', 16:24:01 INFO - 'TMOUT': '86400', 16:24:01 INFO - 'USER': 'cltbld', 16:24:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:01 INFO - '_': '/tools/buildbot/bin/python'} 16:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:01 INFO - Downloading/unpacking psutil>=0.7.1 16:24:01 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 16:24:01 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 16:24:01 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 16:24:01 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 16:24:01 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 16:24:01 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 16:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:24:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:03 INFO - Installing collected packages: psutil 16:24:03 INFO - Running setup.py install for psutil 16:24:03 INFO - building 'psutil._psutil_linux' extension 16:24:03 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 16:24:03 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 16:24:03 INFO - building 'psutil._psutil_posix' extension 16:24:03 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 16:24:03 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 16:24:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:03 INFO - Successfully installed psutil 16:24:03 INFO - Cleaning up... 16:24:04 INFO - Return code: 0 16:24:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:24:04 INFO - Using env: {'DISPLAY': ':0', 16:24:04 INFO - 'HOME': '/home/cltbld', 16:24:04 INFO - 'LANG': 'en_US.UTF-8', 16:24:04 INFO - 'LANGUAGE': 'en_US:en', 16:24:04 INFO - 'LOGNAME': 'cltbld', 16:24:04 INFO - 'MAIL': '/var/mail/cltbld', 16:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:04 INFO - 'MOZ_NO_REMOTE': '1', 16:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:04 INFO - 'NO_EM_RESTART': '1', 16:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:04 INFO - 'PWD': '/builds/slave/test', 16:24:04 INFO - 'SHELL': '/bin/bash', 16:24:04 INFO - 'SHLVL': '1', 16:24:04 INFO - 'TERM': 'linux', 16:24:04 INFO - 'TMOUT': '86400', 16:24:04 INFO - 'USER': 'cltbld', 16:24:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:04 INFO - '_': '/tools/buildbot/bin/python'} 16:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:24:06 INFO - Installing collected packages: mozsystemmonitor 16:24:06 INFO - Running setup.py install for mozsystemmonitor 16:24:06 INFO - Successfully installed mozsystemmonitor 16:24:06 INFO - Cleaning up... 16:24:06 INFO - Return code: 0 16:24:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:06 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:06 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 16:24:06 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 16:24:06 INFO - Using env: {'DISPLAY': ':0', 16:24:06 INFO - 'HOME': '/home/cltbld', 16:24:06 INFO - 'LANG': 'en_US.UTF-8', 16:24:06 INFO - 'LANGUAGE': 'en_US:en', 16:24:06 INFO - 'LOGNAME': 'cltbld', 16:24:06 INFO - 'MAIL': '/var/mail/cltbld', 16:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:06 INFO - 'MOZ_NO_REMOTE': '1', 16:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:06 INFO - 'NO_EM_RESTART': '1', 16:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:06 INFO - 'PWD': '/builds/slave/test', 16:24:06 INFO - 'SHELL': '/bin/bash', 16:24:06 INFO - 'SHLVL': '1', 16:24:06 INFO - 'TERM': 'linux', 16:24:06 INFO - 'TMOUT': '86400', 16:24:06 INFO - 'USER': 'cltbld', 16:24:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:06 INFO - '_': '/tools/buildbot/bin/python'} 16:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:24:06 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 16:24:06 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 16:24:06 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 16:24:06 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 16:24:06 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 16:24:06 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 16:24:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:24:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:24:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24:09 INFO - Downloading docopt-0.6.1.tar.gz 16:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:24:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:24:09 INFO - Running setup.py install for blobuploader 16:24:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:24:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:24:09 INFO - Running setup.py install for requests 16:24:09 INFO - Running setup.py install for docopt 16:24:09 INFO - Successfully installed blobuploader requests docopt 16:24:09 INFO - Cleaning up... 16:24:09 INFO - Return code: 0 16:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:09 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:09 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 16:24:09 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 16:24:09 INFO - Using env: {'DISPLAY': ':0', 16:24:09 INFO - 'HOME': '/home/cltbld', 16:24:09 INFO - 'LANG': 'en_US.UTF-8', 16:24:09 INFO - 'LANGUAGE': 'en_US:en', 16:24:09 INFO - 'LOGNAME': 'cltbld', 16:24:09 INFO - 'MAIL': '/var/mail/cltbld', 16:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:09 INFO - 'MOZ_NO_REMOTE': '1', 16:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:09 INFO - 'NO_EM_RESTART': '1', 16:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:09 INFO - 'PWD': '/builds/slave/test', 16:24:09 INFO - 'SHELL': '/bin/bash', 16:24:09 INFO - 'SHLVL': '1', 16:24:09 INFO - 'TERM': 'linux', 16:24:09 INFO - 'TMOUT': '86400', 16:24:09 INFO - 'USER': 'cltbld', 16:24:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:09 INFO - '_': '/tools/buildbot/bin/python'} 16:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:09 INFO - Running setup.py (path:/tmp/pip-JYnOZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:10 INFO - Running setup.py (path:/tmp/pip-U2Pz5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:10 INFO - Running setup.py (path:/tmp/pip-lUPizb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:10 INFO - Running setup.py (path:/tmp/pip-cccpqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:10 INFO - Running setup.py (path:/tmp/pip-3asZrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:10 INFO - Running setup.py (path:/tmp/pip-nLj7OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:10 INFO - Running setup.py (path:/tmp/pip-thmJK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:10 INFO - Running setup.py (path:/tmp/pip-rYJGsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:10 INFO - Running setup.py (path:/tmp/pip-D091eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:10 INFO - Running setup.py (path:/tmp/pip-LfJxGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:10 INFO - Running setup.py (path:/tmp/pip-FNmHnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:10 INFO - Running setup.py (path:/tmp/pip-wb5Cc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:10 INFO - Running setup.py (path:/tmp/pip-5dgJSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:10 INFO - Running setup.py (path:/tmp/pip-5zsa3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:10 INFO - Running setup.py (path:/tmp/pip-dI1gA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:11 INFO - Running setup.py (path:/tmp/pip-L7HiIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:11 INFO - Running setup.py (path:/tmp/pip-ESPeji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:24:11 INFO - Running setup.py install for manifestparser 16:24:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Running setup.py install for mozcrash 16:24:11 INFO - Running setup.py install for mozdebug 16:24:11 INFO - Running setup.py install for mozdevice 16:24:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Running setup.py install for mozfile 16:24:11 INFO - Running setup.py install for mozhttpd 16:24:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Running setup.py install for mozinfo 16:24:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Running setup.py install for mozInstall 16:24:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:24:11 INFO - Running setup.py install for mozleak 16:24:12 INFO - Running setup.py install for mozlog 16:24:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:24:12 INFO - Running setup.py install for moznetwork 16:24:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:24:12 INFO - Running setup.py install for mozprocess 16:24:12 INFO - Running setup.py install for mozprofile 16:24:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:24:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:24:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:24:12 INFO - Running setup.py install for mozrunner 16:24:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:24:12 INFO - Running setup.py install for mozscreenshot 16:24:12 INFO - Running setup.py install for moztest 16:24:12 INFO - Running setup.py install for mozversion 16:24:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:24:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:24:13 INFO - Cleaning up... 16:24:13 INFO - Return code: 0 16:24:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:13 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:13 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 16:24:13 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 16:24:13 INFO - Using env: {'DISPLAY': ':0', 16:24:13 INFO - 'HOME': '/home/cltbld', 16:24:13 INFO - 'LANG': 'en_US.UTF-8', 16:24:13 INFO - 'LANGUAGE': 'en_US:en', 16:24:13 INFO - 'LOGNAME': 'cltbld', 16:24:13 INFO - 'MAIL': '/var/mail/cltbld', 16:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:13 INFO - 'MOZ_NO_REMOTE': '1', 16:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:13 INFO - 'NO_EM_RESTART': '1', 16:24:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:13 INFO - 'PWD': '/builds/slave/test', 16:24:13 INFO - 'SHELL': '/bin/bash', 16:24:13 INFO - 'SHLVL': '1', 16:24:13 INFO - 'TERM': 'linux', 16:24:13 INFO - 'TMOUT': '86400', 16:24:13 INFO - 'USER': 'cltbld', 16:24:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:13 INFO - '_': '/tools/buildbot/bin/python'} 16:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:13 INFO - Running setup.py (path:/tmp/pip-fb1l7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:13 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)) 16:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:13 INFO - Running setup.py (path:/tmp/pip-Fxb57a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:13 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)) 16:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:13 INFO - Running setup.py (path:/tmp/pip-2mGO4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:13 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)) 16:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:13 INFO - Running setup.py (path:/tmp/pip-lwpxgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:13 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)) 16:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:13 INFO - Running setup.py (path:/tmp/pip-IVOIG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:13 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)) 16:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:13 INFO - Running setup.py (path:/tmp/pip-v44q80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:13 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)) 16:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:13 INFO - Running setup.py (path:/tmp/pip-1gr9aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:14 INFO - Running setup.py (path:/tmp/pip-NpdgE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:14 INFO - Running setup.py (path:/tmp/pip-nfNqLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:14 INFO - Running setup.py (path:/tmp/pip-mbH3jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:14 INFO - Running setup.py (path:/tmp/pip-feUk9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:14 INFO - Running setup.py (path:/tmp/pip-gg9Je_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:14 INFO - Running setup.py (path:/tmp/pip-6KoVEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:14 INFO - Running setup.py (path:/tmp/pip-75FwS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:14 INFO - Running setup.py (path:/tmp/pip-8VTN5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:14 INFO - Running setup.py (path:/tmp/pip-JZXJxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:14 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)) 16:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:14 INFO - Running setup.py (path:/tmp/pip-8bRnMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:14 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)) 16:24:14 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)) 16:24:14 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)) 16:24:14 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)) 16:24:14 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)) 16:24:14 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)) 16:24:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:16 INFO - Downloading blessings-1.6.tar.gz 16:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:24:16 INFO - Installing collected packages: blessings 16:24:16 INFO - Running setup.py install for blessings 16:24:16 INFO - Successfully installed blessings 16:24:16 INFO - Cleaning up... 16:24:16 INFO - Return code: 0 16:24:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:17 INFO - Reading from file tmpfile_stdout 16:24:17 INFO - Current package versions: 16:24:17 INFO - argparse == 1.2.1 16:24:17 INFO - blessings == 1.6 16:24:17 INFO - blobuploader == 1.2.4 16:24:17 INFO - docopt == 0.6.1 16:24:17 INFO - manifestparser == 1.1 16:24:17 INFO - mozInstall == 1.12 16:24:17 INFO - mozcrash == 0.17 16:24:17 INFO - mozdebug == 0.1 16:24:17 INFO - mozdevice == 0.48 16:24:17 INFO - mozfile == 1.2 16:24:17 INFO - mozhttpd == 0.7 16:24:17 INFO - mozinfo == 0.9 16:24:17 INFO - mozleak == 0.1 16:24:17 INFO - mozlog == 3.1 16:24:17 INFO - moznetwork == 0.27 16:24:17 INFO - mozprocess == 0.22 16:24:17 INFO - mozprofile == 0.28 16:24:17 INFO - mozrunner == 6.11 16:24:17 INFO - mozscreenshot == 0.1 16:24:17 INFO - mozsystemmonitor == 0.0 16:24:17 INFO - moztest == 0.7 16:24:17 INFO - mozversion == 1.4 16:24:17 INFO - psutil == 3.1.1 16:24:17 INFO - requests == 1.2.3 16:24:17 INFO - wsgiref == 0.1.2 16:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:17 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:17 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 16:24:17 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 16:24:17 INFO - Using env: {'DISPLAY': ':0', 16:24:17 INFO - 'HOME': '/home/cltbld', 16:24:17 INFO - 'LANG': 'en_US.UTF-8', 16:24:17 INFO - 'LANGUAGE': 'en_US:en', 16:24:17 INFO - 'LOGNAME': 'cltbld', 16:24:17 INFO - 'MAIL': '/var/mail/cltbld', 16:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:17 INFO - 'MOZ_NO_REMOTE': '1', 16:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:17 INFO - 'NO_EM_RESTART': '1', 16:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:17 INFO - 'PWD': '/builds/slave/test', 16:24:17 INFO - 'SHELL': '/bin/bash', 16:24:17 INFO - 'SHLVL': '1', 16:24:17 INFO - 'TERM': 'linux', 16:24:17 INFO - 'TMOUT': '86400', 16:24:17 INFO - 'USER': 'cltbld', 16:24:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:17 INFO - '_': '/tools/buildbot/bin/python'} 16:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 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)) 16:24:17 INFO - Cleaning up... 16:24:17 INFO - Return code: 0 16:24:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:17 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:17 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 16:24:17 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 16:24:17 INFO - Using env: {'DISPLAY': ':0', 16:24:17 INFO - 'HOME': '/home/cltbld', 16:24:17 INFO - 'LANG': 'en_US.UTF-8', 16:24:17 INFO - 'LANGUAGE': 'en_US:en', 16:24:17 INFO - 'LOGNAME': 'cltbld', 16:24:17 INFO - 'MAIL': '/var/mail/cltbld', 16:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:17 INFO - 'MOZ_NO_REMOTE': '1', 16:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:17 INFO - 'NO_EM_RESTART': '1', 16:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:17 INFO - 'PWD': '/builds/slave/test', 16:24:17 INFO - 'SHELL': '/bin/bash', 16:24:17 INFO - 'SHLVL': '1', 16:24:17 INFO - 'TERM': 'linux', 16:24:17 INFO - 'TMOUT': '86400', 16:24:17 INFO - 'USER': 'cltbld', 16:24:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:17 INFO - '_': '/tools/buildbot/bin/python'} 16:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:17 INFO - Downloading/unpacking jsonschema 16:24:17 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 16:24:17 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 16:24:17 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 16:24:17 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 16:24:17 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 16:24:17 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 16:24:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:24:19 INFO - Downloading/unpacking functools32 (from jsonschema) 16:24:19 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 16:24:19 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 16:24:19 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 16:24:19 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 16:24:19 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 16:24:19 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 16:24:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:24:19 INFO - warning: no files found matching '*.txt' 16:24:19 INFO - no previously-included directories found matching 'build' 16:24:19 INFO - no previously-included directories found matching 'dist' 16:24:19 INFO - no previously-included directories found matching '.git*' 16:24:19 INFO - Installing collected packages: jsonschema, functools32 16:24:19 INFO - Running setup.py install for functools32 16:24:19 INFO - warning: no files found matching '*.txt' 16:24:19 INFO - no previously-included directories found matching 'build' 16:24:19 INFO - no previously-included directories found matching 'dist' 16:24:19 INFO - no previously-included directories found matching '.git*' 16:24:19 INFO - Successfully installed jsonschema functools32 16:24:19 INFO - Cleaning up... 16:24:19 INFO - Return code: 0 16:24:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:19 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 0x7fb22f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', '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 16:24:19 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 16:24:19 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 16:24:19 INFO - Using env: {'DISPLAY': ':0', 16:24:19 INFO - 'HOME': '/home/cltbld', 16:24:19 INFO - 'LANG': 'en_US.UTF-8', 16:24:19 INFO - 'LANGUAGE': 'en_US:en', 16:24:19 INFO - 'LOGNAME': 'cltbld', 16:24:19 INFO - 'MAIL': '/var/mail/cltbld', 16:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:19 INFO - 'MOZ_NO_REMOTE': '1', 16:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:19 INFO - 'NO_EM_RESTART': '1', 16:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:19 INFO - 'PWD': '/builds/slave/test', 16:24:19 INFO - 'SHELL': '/bin/bash', 16:24:19 INFO - 'SHLVL': '1', 16:24:19 INFO - 'TERM': 'linux', 16:24:19 INFO - 'TMOUT': '86400', 16:24:19 INFO - 'USER': 'cltbld', 16:24:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:19 INFO - '_': '/tools/buildbot/bin/python'} 16:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:20 INFO - Downloading/unpacking flake8 16:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:24:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24: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 16:24:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:24:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:24:22 INFO - no previously-included directories found matching 'docs/_build' 16:24:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:24:22 INFO - Running setup.py install for pep8 16:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:24:22 INFO - no previously-included directories found matching 'docs/_build' 16:24:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:24:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:24:22 INFO - Cleaning up... 16:24:22 INFO - Return code: 0 16:24:22 INFO - Running post-action listener: _resource_record_post_action 16:24:22 INFO - Running post-action listener: _start_resource_monitoring 16:24:22 INFO - Starting resource monitoring. 16:24:22 INFO - ##### 16:24:22 INFO - ##### Running install step. 16:24:22 INFO - ##### 16:24:22 INFO - Running pre-action listener: _resource_record_pre_action 16:24:22 INFO - Running main action method: install 16:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:23 INFO - Reading from file tmpfile_stdout 16:24:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:24:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:24:23 INFO - Reading from file tmpfile_stdout 16:24:23 INFO - Output received: 16:24:23 INFO - Usage: mozinstall [options] installer 16:24:23 INFO - Options: 16:24:23 INFO - -h, --help show this help message and exit 16:24:23 INFO - -d DEST, --destination=DEST 16:24:23 INFO - Directory to install application into. [default: 16:24:23 INFO - "/builds/slave/test"] 16:24:23 INFO - --app=APP Application being installed. [default: firefox] 16:24:23 INFO - mkdir: /builds/slave/test/build/application 16:24:23 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'] 16:24:23 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 16:24:38 INFO - Reading from file tmpfile_stdout 16:24:38 INFO - Output received: 16:24:38 INFO - /builds/slave/test/build/application/firefox/firefox 16:24:38 INFO - Running post-action listener: _resource_record_post_action 16:24:38 INFO - ##### 16:24:38 INFO - ##### Running run-tests step. 16:24:38 INFO - ##### 16:24:38 INFO - Running pre-action listener: _resource_record_pre_action 16:24:38 INFO - Running main action method: run_tests 16:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:24:38 INFO - Python 2.7.3 16:24:38 INFO - Return code: 0 16:24:38 INFO - grabbing minidump binary from tooltool 16:24:38 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')]} 16:24:38 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 0x2b54410>, '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 0x2b55310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b557a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:24:38 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 16:24:38 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 16:24:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:24:38 INFO - Return code: 0 16:24:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:24:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:24:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:24:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:24:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:24:39 INFO - Return code: 0 16:24:39 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/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 16:24:39 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/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 16:24:39 INFO - Using env: {'DISPLAY': ':0', 16:24:39 INFO - 'HOME': '/home/cltbld', 16:24:39 INFO - 'LANG': 'en_US.UTF-8', 16:24:39 INFO - 'LANGUAGE': 'en_US:en', 16:24:39 INFO - 'LOGNAME': 'cltbld', 16:24:39 INFO - 'MAIL': '/var/mail/cltbld', 16:24:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:24:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:39 INFO - 'MOZ_NO_REMOTE': '1', 16:24:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:39 INFO - 'NO_EM_RESTART': '1', 16:24:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:39 INFO - 'PWD': '/builds/slave/test', 16:24:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:24:39 INFO - 'SHELL': '/bin/bash', 16:24:39 INFO - 'SHLVL': '1', 16:24:39 INFO - 'TERM': 'linux', 16:24:39 INFO - 'TMOUT': '86400', 16:24:39 INFO - 'USER': 'cltbld', 16:24:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504', 16:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:39 INFO - '_': '/tools/buildbot/bin/python'} 16:24:39 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/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 16:24:40 INFO - mozversion application_buildid: 20160426134004 16:24:40 INFO - mozversion application_changeset: 88c0b444691016e0fd49c901a8e54f82d4c6a665 16:24:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:24:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:24:40 INFO - mozversion application_name: Firefox 16:24:40 INFO - mozversion application_remotingname: firefox-dev 16:24:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:24:40 INFO - mozversion application_vendor: Mozilla 16:24:40 INFO - mozversion application_version: 48.0a2 16:24:40 INFO - mozversion platform_buildid: 20160426134004 16:24:40 INFO - mozversion platform_changeset: 88c0b444691016e0fd49c901a8e54f82d4c6a665 16:24:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:24:40 INFO - mozversion platform_version: 48.0a2 16:24:40 INFO - using testdate: 1461713080 16:24:40 INFO - actual date: 1461713080 16:24:40 INFO - starting webserver on 'localhost:36654' 16:24:40 INFO - SUITE-START | Running 2 tests 16:24:40 INFO - TEST-START | dromaeo_css 16:24:40 INFO - operating with platform_type : linux_ 16:24:40 INFO - Initialising browser for dromaeo_css test... 16:24:40 INFO - TEST-INFO | started process 16505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEqC0sx/profile http://localhost:36654/getInfo.html) 16:24:43 INFO - PROCESS | 16505 | 16:24:43 INFO - PROCESS | 16505 | (process:16580): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:24:44 INFO - PROCESS | 16505 | __metrics Screen width/height:1600/1200 16:24:44 INFO - PROCESS | 16505 | colorDepth:24 16:24:44 INFO - PROCESS | 16505 | Browser inner width/height: 1024/697 16:24:44 INFO - PROCESS | 16505 | __metrics 16:24:45 ERROR - PROCESS | 16505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:24:46 INFO - TEST-INFO | 16505: exit 0 16:24:46 INFO - Browser initialized. 16:24:46 INFO - Running cycle 1/1 for dromaeo_css test... 16:24:46 INFO - TEST-INFO | started process 16631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEqC0sx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:48 INFO - PROCESS | 16631 | 16:24:48 INFO - PROCESS | 16631 | (process:16702): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:24:58 INFO - PROCESS | 16631 | RSS: Main: 152494080 16:24:58 INFO - PROCESS | 16631 | 16:25:47 INFO - PROCESS | 16631 | 1461713147618 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] 16:27:55 INFO - PROCESS | 16631 | Cycle 1(1): loaded http://localhost:36654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36654/tests/dromaeo/cssquery-ext.html) 16:27:56 INFO - PROCESS | 16631 | RSS: Main: 155705344 16:27:56 INFO - PROCESS | 16631 | 16:30:58 INFO - PROCESS | 16631 | Cycle 1(1): loaded http://localhost:36654/tests/dromaeo/cssquery-ext.html (next: http://localhost:36654/tests/dromaeo/cssquery-jquery.html) 16:30:58 INFO - PROCESS | 16631 | RSS: Main: 154472448 16:30:58 INFO - PROCESS | 16631 | 16:34:00 INFO - PROCESS | 16631 | Cycle 1(1): loaded http://localhost:36654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36654/tests/dromaeo/cssquery-mootools.html) 16:34:01 INFO - PROCESS | 16631 | RSS: Main: 153612288 16:34:01 INFO - PROCESS | 16631 | 16:37:02 INFO - PROCESS | 16631 | Cycle 1(1): loaded http://localhost:36654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36654/tests/dromaeo/cssquery-prototype.html) 16:37:03 INFO - PROCESS | 16631 | RSS: Main: 153899008 16:37:03 INFO - PROCESS | 16631 | 16:40:05 INFO - PROCESS | 16631 | Cycle 1(1): loaded http://localhost:36654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36654/tests/dromaeo/cssquery-yui.html) 16:40:06 INFO - PROCESS | 16631 | RSS: Main: 154771456 16:40:06 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | Cycle 1(1): loaded http://localhost:36654/tests/dromaeo/cssquery-yui.html (next: http://localhost:36654/tests/dromaeo/cssquery-dojo.html) 16:43:08 INFO - PROCESS | 16631 | RSS: Main: 156000256 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | __start_tp_report 16:43:08 INFO - PROCESS | 16631 | _x_x_mozilla_page_load 16:43:08 INFO - PROCESS | 16631 | _x_x_mozilla_page_load_details 16:43:08 INFO - PROCESS | 16631 | |i|pagename|runs| 16:43:08 INFO - PROCESS | 16631 | |0;dojo.html;3393.083867355814;3456.4642480415537;3468.809215493147;3485.860565577377;3530.152763336798;5634.577406694499;5669.064604340284;5709.486146246832;5730.226419433376;5737.426257374271;5660.9716951415185;5703.773688656938;5708.77164913403;5711.7715291388295;5724.742386592603;5126.179811230204;5174.896502069956;5225.242339860718;5230.320058392404;5277.551408130314;5123.898361852201;5182.689038657692;5241.8951620967555;5331.360236771593;5377.623566350357;5220.608454365919;5229.973850130763;5258.55302299305;5278.630495865291;5288.524032837044;5158.819441319573;5186.636935414523;5190.117679994391;5205.479452054802;5207.427183009866;4954.108260513106;5078.974605126988;5086.872828179288;5111.412187598399;5182.870428239286;5436.21174929637;5461.208124821918;5482.23248745176;5485.807996720096;5519.862003449905;5966;5966.642001479881;5987.520998320124;5989.8203053908455;6013.488853447462;5996.700164991777;6022.638641681469;6062.939370606326;6067.968445364255;6088.025915853442;5726.541876649858;5753.626014309057;5774.797882074149;5776.537876969833;5782.132680097977;6205.100260462208;6214.471769899519;6216.689165541705;6272.498200143978;6281.842953926097;5959.612625179349;6005.189299444606;6029.698515074228;6055.848603784941;6078.544109191828;6144.5084393248435;6157.476614487729;6159.692015399212;6176.969115154396;6182.196314479179;5921.7631294747725;6056.454919057306;6133.754649813957;6144.907826382608;6150.231221097363;5873.765049397976;5893.469587737039;5952.613080149863;5961.254843144607;5971.402859713994;4547.567981041796;4557.726536407826;4580.496145424001;4581.060882519076;4607.262837945913;4039;4085.7957102144774;4118.382242663564;4136.31750761127;4140.068484590943;5734.971325143431;5762.827115186551;5844.970775146097;5884.705764711747;5898.705064746746;6130.509559235251;6133.355997620186;6137.60105593135;6142.324344322121;6162.753489860445;5777.62445441045;5802.274715660543;5928.940710592925;5945.16767652529;5950.613210141327;4999.175136102575;5033.3205017322925;5046.21783623539;5055.620828437882;5080.288759573663;6330.335314791972;6372.84067898297;6380.106785050097;6390.233172019387;6390.968045159744;5964.612300200473;5993.640381577119;6060.454559089703;6127.356627554132;6147.139400483847;6303.810885673437;6305.842353941188;6306.211723534559;6322.620642761449;6338.112664227104;5925.733341999534;5944.762209511571;5973.133895585029;5975.133605627247;6029.879402412015;5990.161377407254;6069.666168360606;6085.604435711664;6142.109394137914;6165.260168779775;5877.471027607536;5884.911726324023;5885.735141918538;5943.227380440688;5984.790532331347;5865.178874957594;5910.083936989773;5915.556333275108;5923.555733320104;5925.288965324189;5766.279215098113;5816.651000939788;5881.705914704162;5908.231929849092;5945.10823376497;5891.587588868738;5911.763529458945;5958.702064896651;5962.821115366546;5966.343702192668;5729.828105156852;5818.069108942549;5825.242718446575;5826.76692932278;5831.533477321889 16:43:08 INFO - PROCESS | 16631 | |1;ext.html;671.3856821008777;674.0125715826314;681.3356976947474;686.7424715731602;728.7485817392998;40727.18545629089;41808.163836723244;41902;42020.36969445461;42141.57858421415;43526.56473435264;43915.34126988098;44199.77900110503;44232;44273.55726442735;8701.17338852808;8950.820983580325;8961.551922403887;8974.326925480582;8981.281497480186;8830.602622881954;8927.910720892805;8930.732078037638;9055.185033346997;9081.228095611881;9069.954650226773;9080.818383632324;9115.270778337717;9139.817203655923;9146.131117543857;9107.089291070906;9114.908850911506;9185.540722963859;9207.355485116044;9209.953950230207;8997.055309192507;9024.05247449015;9063.728088157366;9110.726678199664;9127.17855393011;44460.3330950036;44543.331850022274;44556.3316550252;44613.55386446127;45177;3798.2973149967343;4205.453291072141;4229.598188172119;4245.0236445617375;4366.061296821199;33968.32063358719;34576.65423345759;34795;35048;35933.820330898176;4239.109786944745;4348.4999225089205;4369.169857727022;4383.736975781463;4390.27560452525;321214;323242;323347;324679;324821;61405.69297153486;61670.38329616647;61779.38220617826;61780.38219617836;62085.689571551855;60809.695951520844;62412.37587624066;62490.750184996956;64064;64298.67850660717;18913.527161820788;19021.239150434103;19057.237710491427;19109.522261943286;19221.519462013563;14826.036307639968;14902.254887255594;14955.70088598222;14978.850211497964;14984.475543356148;20861.89569052145;21319.25382611601;21456.57086858254;21545.59953603011;21675.24136655241;7909.881351779728;8194.22154895284;8225.547594882339;8238.83522329562;8317.126701696356;1086.0225796782959;1125.5160281079216;1131.145984781501;1132.6035887439496;1220.8596011458797;33339.333213335594;33526.832365838505;33724;33729.32541349159;34363.14092147666;1157.8321143434155;1247.2267194339568;1294.5857325655888;1349.3320806200993;1381.240317825192;17267;17667.73498397525;17710.645787084442;17810.287588496314;17851.464456066078;320664;326860;328675;331630;479741;57989.42010579925;58594.41405585975;58760.7061964696;59181.40818591759;59296.40703592995;1508.8264849542443;1561.2349948525368;1564.9218286659861;1574.4332040465424;1592.1561572366663;32850;33062;33459.49810752792;33743.4938475928;33872.49191262182;53668.19497707616;53893.19160212522;53948;54341.45658543522;54484;452342;459034;459071;459156;459261;31261;31510.684893150774;31930.20174495656;32342.8679996199;32439.189020274684;45840.54159458363;46398.76800615976;50707.239391408424;51073;52266.21600676069;41999.370009449274;43483.56516434795;43944.34083488814;44193.55806441895;44773.32840007338;42268.36597451102;42419.363709543766;42742.14515709731;43182.784086079366;43860;43142.78428607837;43679;43901.780491098616;44052.33921491244;44588.33117503175;36137;36742.44886326761;37303.626963730014;37586.24827503489;37687.43468848024;29100.417991640472;29141.41717165687;29312.827486900285;29353.853230734563;29452.558211626416 16:43:08 INFO - PROCESS | 16631 | |2;jquery.html;426.4601357809857;432.88109173405616;437.13447374199086;437.80517669637015;450.38072650106085;20125.295614653507;20130.49673758155;20721.481962950897;20723.481912952182;21035.158593656255;18874.80942740747;19980.800191998074;20705.06827192776;20787.376378708625;20789.688154677693;5857.326407463132;5995.790147344844;6000.18997435345;6030.246219222598;6039.063945088496;5647.745851436695;5888.087346461305;5929.555283353744;5934.347221805598;5992.49063829575;5842.24050873388;5886.293644762613;5926.555508336892;5928.614640048405;6629.701663425133;6712.798616041527;6734.292899245582;6761.9323806761795;6771.5937043777285;6783.932160678404;5768.826935191951;5865.970670146622;5872.706364681749;5933.910991335133;5940.465358117747;14359.78460323096;14374.065685730498;15217.467388641344;23881.88059059711;24315;2358.8348815582917;2502.51201015802;2592.9481410371877;2682.6244325794405;2789.7070807565115;10817.405042722647;10832.620858270002;10929.945350273198;11113.888861111447;11186.608468703556;2083.9270625528034;2110.8311335093154;2163.653815389546;2172.2614311134134;2187.1798075721604;75003.24996750017;79219.60390198069;79583.20416795816;80153;81569.59215203945;11557.190996630155;11792.705182370339;11945.641630751092;12068.637940861789;12112.878871211175;15805.446809361618;15982.200889955455;15986.60033499172;16009.119498427699;16028.75956860648;8129.593520323961;8262.462939908886;8878.245349145265;8934.913603894804;8980.730578082668;9014.549272536347;9130.817383652422;9155.81688366229;9187.908120918839;9193.908060919439;5068.974655126774;5070.873228169326;5079.822206222764;5141.742912854343;5150.845474635767;1885;1885.9151338189815;1923.307609260665;2025.2202901882881;2035.8778473291354;972.1348000279756;1092.3609688332256;1130.3105105885404;1130.944135515402;1225.993870030644;19210;19511.707324390147;19619.803801962084;20162;20294.086766095563;1079.5735684404617;1084.1814430105221;1090.3893819461127;1102.404701461202;1144.856892888389;10621.415822129702;10865.619703310345;10960.671179864617;11067.944660276647;11170.944145279384;508429;521252;524277;524704;531698;99380;99800;100694.4965275169;101545;103656.48171759093;1079.4656644960637;1089.0960502782514;1128.3793913347627;1150.1488898215262;1152.383474840973;16992.3873705229;17405.216765245343;17447.47657570275;17651.646967060842;17783.644327113125;42178.789106054275;43167.35248971331;43627.56372436362;43908.78045609879;44539.10921781611;59012.40987590069;60314.39685603263;61111;61152.38847611467;61721.38278617156;8591.44155629882;8705.129487051498;9006.50464224474;9010.594523246338;9102.772430689021;13578.524751633646;13989.23059231752;14047.297635117999;14058;14349.784753228918;12050.578229761917;12262;12365.134440589072;12506.624801255977;12761.298128603015;11190.496427660937;11561.19071665009;12204.328761917825;12439.067069969607;12618.17981831178;11554.884451155716;11986.041116710816;12138.817917731065;12374.195677280948;12654.304013279358;8722.08418116114;8729.258013068706;8820.073892241222;8939.910600894167;9110.180083792491;8773.605187766438;11291.887081129084;11816.822747658964;11927.403629818647;11938.28370297785 16:43:08 INFO - PROCESS | 16631 | |3;mootools.html;1576.2118940529735;1633.2487055954261;1820.1172431370783;1900.9239630414784;1930.4401723500187;7910.881336779953;8429.367797415196;8534.786630334245;8780.28784387044;8818.823623527534;8594.914050859505;8628.266597339218;8643.617021276597;8653.048164701893;8715.477071375723;2465.8520488770687;2480.5038992201544;2480.7643273888953;2502.7121880983645;2504.111040580595;2468.568000599897;2509.6110102934076;2517.181915877338;2527.481866217421;2531.962020569693;2464.7658472445087;2492.9626055609087;2543.923682289534;2555.1695698897934;2575.85832779198;2440.73151953285;2442.658027876099;2449.6937882764655;2484.627305904111;2487.2413913756295;2399.4841109161616;2455.58255096634;2466.2847774145475;2467.7408872068354;2478.1450399612104;8797.824043519158;8821.2060914518;8914;8927.419717718327;8957.462552246821;5247.921281180786;5457.972710136424;5468.207109969032;5473.2063850741815;5485.6982865942355;3518.8240587970754;3522.4188008978745;3536.6491494607803;3672.889813305578;3683.0608194910396;1180.8701042885275;1182.875798041202;1230.3110258255406;1236.715555422258;1266.6686614204582;12393.876061239362;12399.566015189424;12427.62717118479;12432.191907525981;12453.439595218237;4869.074875773592;4895.681780684244;4971.875703107379;4988.775505102279;5014.022265658235;10581.735456613646;10582.417967011888;10624.575016999388;10629.309094908805;10670.146388288918;5456.781728730885;5531.751071201806;5581.804636837691;5582.385937546866;5604.607677462538;4498.257787465097;4836.564709176191;4845.53967373099;4957.479464656231;4972.105021096238;4199.727017743837;4224.704270701021;4264.594863487963;4299.419578356882;4312.202242585132;1389.4720006397504;1415.0660564027692;1421.5451055662295;1433.6845893903323;1447.3703938786662;915.6840889892976;919.7053351887084;929.3773171974793;951.1249650321721;974.4835237324229;5664.150377443417;5696.857578560569;5818.069108942549;5891.734871930774;5914.408559144137;456.82183948260206;460.16020762109287;468.43085650933597;478.12741746313117;499.20127795526867;4012.1975604878558;4040.6969477288735;4047.3119569673227;4050.41269015991;4114.074333275049;10465.581376744996;10523.263371563917;10945.671629851116;11042.723931901766;11086.334819910831;10697.62558310471;10908.618198363178;10977.945110274397;10987.121030317556;10992.395418252074;8247.463914845635;8295.502269863828;8300.335973122015;8463.70377036813;8515.787105322293;6095.847603809941;6169.2288463942;6210.503159747119;6270.937290627217;6294.15028971083;9811.656592019244;9818.45998470091;9982;10002.799944001225;10036.849447258151;10027.699169024942;10130.89869101329;10217.693469195936;10284;10324.638637647646;6938.895916561155;7670.923290767021;7678.424118191269;7739.071311442663;7752.844943100994;8366.958165209135;8406.495610263404;8488.023877254194;8491.57542122879;8524.957375213084;7263.673134709056;7489.063867016623;7547.773566793005;7569.280918312751;7592.088949325896;7199.496035277481;7495.325420712162;7528.736494222676;7597.088349398107;7704.30661240491;7200.063991681048;7222.494425390172;7263.382612477999;7282.271772822887;7283.380912622486;5296.285001524745;5330.813421530228;5413.593980451561;5422.566194704493;5482.040642887399;5044.394672639307;5215.29593504872;5365.114756065205;5368.033753924331;5430 16:43:08 INFO - PROCESS | 16631 | |4;prototype.html;366.72862082059265;369.75226598179216;371.2908345060934;371.34272337961806;378.70839453620704;5502.80740174093;5648.181013753004;5660.915086273709;5698.373178950317;5724.055530837412;5714.657120572769;5716.942830571693;5751.309842818857;5757.596968212227;5760.36635970044;4519.209138400775;4530.954690453086;4537.636989040885;4537.9773101134615;4558.6581006424485;4462.933056004163;4552.658550608701;4562.178807814592;4574.565416285448;4590.586847183769;4496.820127194908;4498.167838949788;4512.571305725951;4517.616002639779;4538.071319689136;4284.421603083606;4540.931886021679;4551.45382554094;4561.361409402686;4566.566176213271;3945.9802700986597;3947.6447119759073;3949.980250098731;3951.565327813938;3954.426608141803;5514.476124768141;5526.530244929186;5526.696031718254;5528.226048353234;5529.861753456155;4848.248521479177;5032.47159048302;5050.898982020339;5069.960658065088;5087.414947281073;5946.167536544887;5973.6415815050805;5976.581639285252;6019.638821670714;6032.607880487754;4276.50820155683;4325.632321252698;4327.632151267146;4359;4371.606555409997;6153.569250152491;6217.720202590895;6232;6242.219722534684;6269.7178626961895;4394.692371533962;4401.273789824643;4431.556844315543;4459.509453960061;4460.107978404332;4469.150861336336;4500.324951257272;4505.43682039745;4505.549445055468;4509.481409637933;5005.499450055038;5042.520960508746;5137.434882162959;5151.22731590257;5155.5617772489;5619.466150715675;5798.188253644493;5958.76164953397;5996.871110755619;6056.182415373956;1608.573727962091;1609.147152009437;1613.491750098715;1617.9433719819986;1624;1066.2376400873413;1083.766990097133;1087.8205096159204;1102.2614848051664;1109.1182509904645;6188.298217990089;6254.437100660963;6275.623462592168;6289.654069026156;6290.905636415458;6551.737930482823;6596.505262105361;6616.603003819786;6629.303923088103;6645.734170633217;5655.943440565624;5900.4099590041515;5928.79249226275;5940.821775346746;5942.286925568873;3567.233044895308;3574.873914716856;3592.586852511942;3595.856165753393;3604.945925811115;6146.231721034871;6431.6462594556815;6436.806895793134;6465.224173099258;7024.086868707035;6164.938350616526;6202.937970620236;6238.688065596702;6240.126382306481;6258.3428739982555;6216.191895053705;6376.553641245068;6397.488200943913;6414.743410263631;6421.51838612106;6126.540509461719;6167.907481387693;6176.6911654418;6207.193064901534;6207.255129384323;5895.852603684943;6094.421030002142;6119.4798442132915;6145.170401995673;6145.293291271561;6371.426571608577;6389.540027089511;6404.647744374104;6436.195475565554;6458.806235812933;4384.627306678968;4418.204723149735;4429.224885645063;4438.245498265238;4445.799939002817;5971.940280597139;6200.782972595937;6202.28673702512;6252.343503932022;6277.811665650038;6097.695115244309;6107.358727333743;6120.816375508742;6131.264248290234;6147.754089836357;5755.884882302246;6053.09203619443;6053.243344581927;6093.969530152321;6112.786052488142;5953.642781433128;5965.522758179422;6010.729517171825;6016.278046634432;6026.668533230714;6068.241469816273;6080.908786368296;6090.878182436415;6111.388861113853;6152.477039451696;5612.831615051555;5892;5896.614295640436;5963.165156878127;5968.4031596841705 16:43:08 INFO - PROCESS | 16631 | |5;yui.html;854.5430041778766;867.7223288547667;874.741951124418;878.3719640457076;899.8695189197563;13886.861131388683;14516.419343226285;14569.271536423163;14653.926730366347;14814.629634259136;12968.286744229064;14128.71742565148;14148.151110933351;14195.645108872284;14239.145651260906;918.3525614441819;927.689224109924;929.6142101028099;931.1293940165932;931.3620170183412;925.1765928323797;930.2046750028695;930.7254359963827;932.1098351074708;932.1098351074742;969.471637957315;970.7184916374243;971.0629242780715;972.0231167676475;973.3916302311055;958.5015791788231;961.8076384723048;968.0658164870933;971.3200759468365;973.8247115519239;705.3334598804132;712.9465290103263;714.1430283659629;714.4820005496026;717.989230161548;13373.130746501543;13521.932390337985;13551.661208469768;13583.660408489768;13588.660283492893;12650.74698506034;12748.426320815586;12812;12854.935725321408;13022.218666880017;10729.93502150975;10824.079953203987;10922.29005114665;10942.507587158518;10955.397453140075;3904.9609503905167;3909.7849618270984;3938.4879965604573;3959.6436320730986;3961.861334853295;51806.48193518054;52441.2133817993;52524;52583;54933;11190.66428007161;11594.18840681161;11799.705007374712;11867.465964031466;11949.64151075469;19684.311049113498;19768.11043503046;19936.800631993785;19961.401157965283;20075.39773806788;8818.5590720465;8837.337199710048;8904.19862212404;8952.23905967987;9060.954695226614;4924.704517728947;4997.625178111656;5007.674501157413;5084.13569693153;5109;3626.9274614507563;3655;3658.8108864619107;3667.2665466906724;3674.797886116289;681.3322943515383;689.8689249042666;693.5387967001988;700.989485157723;706.0292098364748;692.4840993459804;748.827769612992;762.3177256355641;766.1763604125476;766.1993217088157;8317.293030092509;8579.82840343202;8903.866442003375;8933.106689331014;8974.102589740975;725.3942957630333;743.7434085240583;745.4334705623766;746.5110352718978;753.4349238071446;4115.855945041909;4247.256730072225;4296.505901821268;4335.739855608674;4377.781110944504;68317.65841170763;68770;68903;69425.30574694289;72059.27940720631;60861.695691522145;62474.37525624686;62766.37233627697;63723.999999999076;63999;54764.726176368866;55435.722821386444;55745.163822542694;55805.999999999185;56041.159382609294;8322.37582181351;8521.659133634585;8619.612117454604;8678.609462574326;8874;34448;35019;35034.474482883285;35050.82474587611;36078.8196059018;43434.56565434305;49723.75138124286;50168;51039.87521497444;51789;11569.479373428385;11607.129465290305;11689.240199387013;11709.297442153498;11750.647480575597;11612.954834064974;11813.232139910879;12351.3824308786;12510.87489125097;12891.613251602466;11547.769044619228;11610.6516804496;11641;11672.76654466889;11808.763824723286;11559.36423496682;11901.226420282654;11946.926887555768;12237.26576405383;12354.382280886099;11540.884591153981;11664.183507154417;11694.415279236175;11774.175807693378;12077.75844483123;10106.343087699275;10122.544485498023;10229.130523905551;10452.32059916103;10528.36829790215;9988.850167247352;10123.138103045301;10174.86649414355;10180.898191017995;10181.34715025901 16:43:08 INFO - PROCESS | 16631 | __end_tp_report 16:43:08 INFO - PROCESS | 16631 | __start_cc_report 16:43:08 INFO - PROCESS | 16631 | _x_x_mozilla_cycle_collect,336 16:43:08 INFO - PROCESS | 16631 | __end_cc_report 16:43:08 INFO - PROCESS | 16631 | __startTimestamp1461714188882__endTimestamp 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | ------- Summary: start ------- 16:43:08 INFO - PROCESS | 16631 | Number of tests: 6 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | [#0] dojo.html Cycles:165 Average:5647.60 Median:5884.91 stddev:633.70 (10.8%) stddev-sans-first:610.47 16:43:08 INFO - PROCESS | 16631 | Values: 3393.1 3456.5 3468.8 3485.9 3530.2 5634.6 5669.1 5709.5 5730.2 5737.4 5661.0 5703.8 5708.8 5711.8 5724.7 5126.2 5174.9 5225.2 5230.3 5277.6 5123.9 5182.7 5241.9 5331.4 5377.6 5220.6 5230.0 5258.6 5278.6 5288.5 5158.8 5186.6 5190.1 5205.5 5207.4 4954.1 5079.0 5086.9 5111.4 5182.9 5436.2 5461.2 5482.2 5485.8 5519.9 5966.0 5966.6 5987.5 5989.8 6013.5 5996.7 6022.6 6062.9 6068.0 6088.0 5726.5 5753.6 5774.8 5776.5 5782.1 6205.1 6214.5 6216.7 6272.5 6281.8 5959.6 6005.2 6029.7 6055.8 6078.5 6144.5 6157.5 6159.7 6177.0 6182.2 5921.8 6056.5 6133.8 6144.9 6150.2 5873.8 5893.5 5952.6 5961.3 5971.4 4547.6 4557.7 4580.5 4581.1 4607.3 4039.0 4085.8 4118.4 4136.3 4140.1 5735.0 5762.8 5845.0 5884.7 5898.7 6130.5 6133.4 6137.6 6142.3 6162.8 5777.6 5802.3 5928.9 5945.2 5950.6 4999.2 5033.3 5046.2 5055.6 5080.3 6330.3 6372.8 6380.1 6390.2 6391.0 5964.6 5993.6 6060.5 6127.4 6147.1 6303.8 6305.8 6306.2 6322.6 6338.1 5925.7 5944.8 5973.1 5975.1 6029.9 5990.2 6069.7 6085.6 6142.1 6165.3 5877.5 5884.9 5885.7 5943.2 5984.8 5865.2 5910.1 5915.6 5923.6 5925.3 5766.3 5816.7 5881.7 5908.2 5945.1 5891.6 5911.8 5958.7 5962.8 5966.3 5729.8 5818.1 5825.2 5826.8 5831.5 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | [#1] ext.html Cycles:180 Average:56281.45 Median:23916.03 stddev:101419.31 (424.1%) stddev-sans-first:101617.88 16:43:08 INFO - PROCESS | 16631 | Values: 671.4 674.0 681.3 686.7 728.7 40727.2 41808.2 41902.0 42020.4 42141.6 43526.6 43915.3 44199.8 44232.0 44273.6 8701.2 8950.8 8961.6 8974.3 8981.3 8830.6 8927.9 8930.7 9055.2 9081.2 9070.0 9080.8 9115.3 9139.8 9146.1 9107.1 9114.9 9185.5 9207.4 9210.0 8997.1 9024.1 9063.7 9110.7 9127.2 44460.3 44543.3 44556.3 44613.6 45177.0 3798.3 4205.5 4229.6 4245.0 4366.1 33968.3 34576.7 34795.0 35048.0 35933.8 4239.1 4348.5 4369.2 4383.7 4390.3 321214.0 323242.0 323347.0 324679.0 324821.0 61405.7 61670.4 61779.4 61780.4 62085.7 60809.7 62412.4 62490.8 64064.0 64298.7 18913.5 19021.2 19057.2 19109.5 19221.5 14826.0 14902.3 14955.7 14978.9 14984.5 20861.9 21319.3 21456.6 21545.6 21675.2 7909.9 8194.2 8225.5 8238.8 8317.1 1086.0 1125.5 1131.1 1132.6 1220.9 33339.3 33526.8 33724.0 33729.3 34363.1 1157.8 1247.2 1294.6 1349.3 1381.2 17267.0 17667.7 17710.6 17810.3 17851.5 320664.0 326860.0 328675.0 331630.0 479741.0 57989.4 58594.4 58760.7 59181.4 59296.4 1508.8 1561.2 1564.9 1574.4 1592.2 32850.0 33062.0 33459.5 33743.5 33872.5 53668.2 53893.2 53948.0 54341.5 54484.0 452342.0 459034.0 459071.0 459156.0 459261.0 31261.0 31510.7 31930.2 32342.9 32439.2 45840.5 46398.8 50707.2 51073.0 52266.2 41999.4 43483.6 43944.3 44193.6 44773.3 42268.4 42419.4 42742.1 43182.8 43860.0 43142.8 43679.0 43901.8 44052.3 44588.3 36137.0 36742.4 37303.6 37586.2 37687.4 29100.4 29141.4 29312.8 29353.9 29452.6 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | [#2] jquery.html Cycles:180 Average:30439.57 Median:2137.24 stddev:86059.40 (4026.7%) stddev-sans-first:86271.32 16:43:08 INFO - PROCESS | 16631 | Values: 426.5 432.9 437.1 437.8 450.4 20125.3 20130.5 20721.5 20723.5 21035.2 18874.8 19980.8 20705.1 20787.4 20789.7 5857.3 5995.8 6000.2 6030.2 6039.1 5647.7 5888.1 5929.6 5934.3 5992.5 5842.2 5886.3 5926.6 5928.6 6629.7 6712.8 6734.3 6761.9 6771.6 6783.9 5768.8 5866.0 5872.7 5933.9 5940.5 14359.8 14374.1 15217.5 23881.9 24315.0 2358.8 2502.5 2592.9 2682.6 2789.7 10817.4 10832.6 10929.9 11113.9 11186.6 2083.9 2110.8 2163.7 2172.3 2187.2 75003.2 79219.6 79583.2 80153.0 81569.6 11557.2 11792.7 11945.6 12068.6 12112.9 15805.4 15982.2 15986.6 16009.1 16028.8 8129.6 8262.5 8878.2 8934.9 8980.7 9014.5 9130.8 9155.8 9187.9 9193.9 5069.0 5070.9 5079.8 5141.7 5150.8 1885.0 1885.9 1923.3 2025.2 2035.9 972.1 1092.4 1130.3 1130.9 1226.0 19210.0 19511.7 19619.8 20162.0 20294.1 1079.6 1084.2 1090.4 1102.4 1144.9 10621.4 10865.6 10960.7 11067.9 11170.9 508429.0 521252.0 524277.0 524704.0 531698.0 99380.0 99800.0 100694.5 101545.0 103656.5 1079.5 1089.1 1128.4 1150.1 1152.4 16992.4 17405.2 17447.5 17651.6 17783.6 42178.8 43167.4 43627.6 43908.8 44539.1 59012.4 60314.4 61111.0 61152.4 61721.4 8591.4 8705.1 9006.5 9010.6 9102.8 13578.5 13989.2 14047.3 14058.0 14349.8 12050.6 12262.0 12365.1 12506.6 12761.3 11190.5 11561.2 12204.3 12439.1 12618.2 11554.9 11986.0 12138.8 12374.2 12654.3 8722.1 8729.3 8820.1 8939.9 9110.2 8773.6 11291.9 11816.8 11927.4 11938.3 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | [#3] mootools.html Cycles:180 Average:5864.73 Median:4926.58 stddev:3260.46 (66.2%) stddev-sans-first:3253.68 16:43:08 INFO - PROCESS | 16631 | Values: 1576.2 1633.2 1820.1 1900.9 1930.4 7910.9 8429.4 8534.8 8780.3 8818.8 8594.9 8628.3 8643.6 8653.0 8715.5 2465.9 2480.5 2480.8 2502.7 2504.1 2468.6 2509.6 2517.2 2527.5 2532.0 2464.8 2493.0 2543.9 2555.2 2575.9 2440.7 2442.7 2449.7 2484.6 2487.2 2399.5 2455.6 2466.3 2467.7 2478.1 8797.8 8821.2 8914.0 8927.4 8957.5 5247.9 5458.0 5468.2 5473.2 5485.7 3518.8 3522.4 3536.6 3672.9 3683.1 1180.9 1182.9 1230.3 1236.7 1266.7 12393.9 12399.6 12427.6 12432.2 12453.4 4869.1 4895.7 4971.9 4988.8 5014.0 10581.7 10582.4 10624.6 10629.3 10670.1 5456.8 5531.8 5581.8 5582.4 5604.6 4498.3 4836.6 4845.5 4957.5 4972.1 4199.7 4224.7 4264.6 4299.4 4312.2 1389.5 1415.1 1421.5 1433.7 1447.4 915.7 919.7 929.4 951.1 974.5 5664.2 5696.9 5818.1 5891.7 5914.4 456.8 460.2 468.4 478.1 499.2 4012.2 4040.7 4047.3 4050.4 4114.1 10465.6 10523.3 10945.7 11042.7 11086.3 10697.6 10908.6 10977.9 10987.1 10992.4 8247.5 8295.5 8300.3 8463.7 8515.8 6095.8 6169.2 6210.5 6270.9 6294.2 9811.7 9818.5 9982.0 10002.8 10036.8 10027.7 10130.9 10217.7 10284.0 10324.6 6938.9 7670.9 7678.4 7739.1 7752.8 8367.0 8406.5 8488.0 8491.6 8525.0 7263.7 7489.1 7547.8 7569.3 7592.1 7199.5 7495.3 7528.7 7597.1 7704.3 7200.1 7222.5 7263.4 7282.3 7283.4 5296.3 5330.8 5413.6 5422.6 5482.0 5044.4 5215.3 5365.1 5368.0 5430.0 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | [#4] prototype.html Cycles:180 Average:5119.38 Median:5753.60 stddev:1489.98 (25.9%) stddev-sans-first:1450.83 16:43:08 INFO - PROCESS | 16631 | Values: 366.7 369.8 371.3 371.3 378.7 5502.8 5648.2 5660.9 5698.4 5724.1 5714.7 5716.9 5751.3 5757.6 5760.4 4519.2 4531.0 4537.6 4538.0 4558.7 4462.9 4552.7 4562.2 4574.6 4590.6 4496.8 4498.2 4512.6 4517.6 4538.1 4284.4 4540.9 4551.5 4561.4 4566.6 3946.0 3947.6 3950.0 3951.6 3954.4 5514.5 5526.5 5526.7 5528.2 5529.9 4848.2 5032.5 5050.9 5070.0 5087.4 5946.2 5973.6 5976.6 6019.6 6032.6 4276.5 4325.6 4327.6 4359.0 4371.6 6153.6 6217.7 6232.0 6242.2 6269.7 4394.7 4401.3 4431.6 4459.5 4460.1 4469.2 4500.3 4505.4 4505.5 4509.5 5005.5 5042.5 5137.4 5151.2 5155.6 5619.5 5798.2 5958.8 5996.9 6056.2 1608.6 1609.1 1613.5 1617.9 1624.0 1066.2 1083.8 1087.8 1102.3 1109.1 6188.3 6254.4 6275.6 6289.7 6290.9 6551.7 6596.5 6616.6 6629.3 6645.7 5655.9 5900.4 5928.8 5940.8 5942.3 3567.2 3574.9 3592.6 3595.9 3604.9 6146.2 6431.6 6436.8 6465.2 7024.1 6164.9 6202.9 6238.7 6240.1 6258.3 6216.2 6376.6 6397.5 6414.7 6421.5 6126.5 6167.9 6176.7 6207.2 6207.3 5895.9 6094.4 6119.5 6145.2 6145.3 6371.4 6389.5 6404.6 6436.2 6458.8 4384.6 4418.2 4429.2 4438.2 4445.8 5971.9 6200.8 6202.3 6252.3 6277.8 6097.7 6107.4 6120.8 6131.3 6147.8 5755.9 6053.1 6053.2 6094.0 6112.8 5953.6 5965.5 6010.7 6016.3 6026.7 6068.2 6080.9 6090.9 6111.4 6152.5 5612.8 5892.0 5896.6 5963.2 5968.4 16:43:08 INFO - PROCESS | 16631 | 16:43:08 INFO - PROCESS | 16631 | [#5] yui.html Cycles:180 Average:15352.31 Median:27324.23 stddev:18655.29 (68.3%) stddev-sans-first:18675.85 16:43:08 INFO - PROCESS | 16631 | Values: 854.5 867.7 874.7 878.4 899.9 13886.9 14516.4 14569.3 14653.9 14814.6 12968.3 14128.7 14148.2 14195.6 14239.1 918.4 927.7 929.6 931.1 931.4 925.2 930.2 930.7 932.1 932.1 969.5 970.7 971.1 972.0 973.4 958.5 961.8 968.1 971.3 973.8 705.3 712.9 714.1 714.5 718.0 13373.1 13521.9 13551.7 13583.7 13588.7 12650.7 12748.4 12812.0 12854.9 13022.2 10729.9 10824.1 10922.3 10942.5 10955.4 3905.0 3909.8 3938.5 3959.6 3961.9 51806.5 52441.2 52524.0 52583.0 54933.0 11190.7 11594.2 11799.7 11867.5 11949.6 19684.3 19768.1 19936.8 19961.4 20075.4 8818.6 8837.3 8904.2 8952.2 9061.0 4924.7 4997.6 5007.7 5084.1 5109.0 3626.9 3655.0 3658.8 3667.3 3674.8 681.3 689.9 693.5 701.0 706.0 692.5 748.8 762.3 766.2 766.2 8317.3 8579.8 8903.9 8933.1 8974.1 725.4 743.7 745.4 746.5 753.4 4115.9 4247.3 4296.5 4335.7 4377.8 68317.7 68770.0 68903.0 69425.3 72059.3 60861.7 62474.4 62766.4 63724.0 63999.0 54764.7 55435.7 55745.2 55806.0 56041.2 8322.4 8521.7 8619.6 8678.6 8874.0 34448.0 35019.0 35034.5 35050.8 36078.8 43434.6 49723.8 50168.0 51039.9 51789.0 11569.5 11607.1 11689.2 11709.3 11750.6 11613.0 11813.2 12351.4 12510.9 12891.6 11547.8 11610.7 11641.0 11672.8 11808.8 11559.4 11901.2 11946.9 12237.3 12354.4 11540.9 11664.2 11694.4 11774.2 12077.8 10106.3 10122.5 10229.1 10452.3 10528.4 9988.9 10123.1 10174.9 10180.9 10181.3 16:43:08 INFO - PROCESS | 16631 | -------- Summary: end -------- 16:43:08 INFO - PROCESS | 16631 | 16:43:09 INFO - TEST-INFO | 16631: exit 0 16:43:09 INFO - TEST-OK | dromaeo_css | took 1109516ms 16:43:09 INFO - TEST-START | kraken 16:43:09 INFO - operating with platform_type : linux_ 16:43:09 INFO - Initialising browser for kraken test... 16:43:09 INFO - TEST-INFO | started process 16871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpug5P3N/profile http://localhost:36654/getInfo.html) 16:43:12 INFO - PROCESS | 16871 | 16:43:12 INFO - PROCESS | 16871 | (process:16950): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:43:13 INFO - PROCESS | 16871 | __metrics Screen width/height:1600/1200 16:43:13 INFO - PROCESS | 16871 | colorDepth:24 16:43:13 INFO - PROCESS | 16871 | Browser inner width/height: 1024/697 16:43:13 INFO - PROCESS | 16871 | __metrics 16:43:14 ERROR - PROCESS | 16871 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:43:15 INFO - TEST-INFO | 16871: exit 0 16:43:15 INFO - Browser initialized. 16:43:15 INFO - Running cycle 1/1 for kraken test... 16:43:15 INFO - TEST-INFO | started process 17001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpug5P3N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:17 INFO - PROCESS | 17001 | 16:43:17 INFO - PROCESS | 17001 | (process:17070): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:43:27 INFO - PROCESS | 17001 | RSS: Main: 152649728 16:43:27 INFO - PROCESS | 17001 | 16:43:29 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36654/tests/kraken/driver.html?testName=audio-beat-detection) 16:43:30 INFO - PROCESS | 17001 | RSS: Main: 156721152 16:43:30 INFO - PROCESS | 17001 | 16:43:33 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36654/tests/kraken/driver.html?testName=audio-dft) 16:43:33 INFO - PROCESS | 17001 | RSS: Main: 157843456 16:43:33 INFO - PROCESS | 17001 | 16:43:36 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36654/tests/kraken/driver.html?testName=audio-fft) 16:43:37 INFO - PROCESS | 17001 | RSS: Main: 157351936 16:43:37 INFO - PROCESS | 17001 | 16:43:39 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36654/tests/kraken/driver.html?testName=audio-oscillator) 16:43:39 INFO - PROCESS | 17001 | RSS: Main: 157466624 16:43:39 INFO - PROCESS | 17001 | 16:43:42 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:42 INFO - PROCESS | 17001 | RSS: Main: 157368320 16:43:42 INFO - PROCESS | 17001 | 16:43:45 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36654/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:46 INFO - PROCESS | 17001 | RSS: Main: 157515776 16:43:46 INFO - PROCESS | 17001 | 16:43:49 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36654/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:50 INFO - PROCESS | 17001 | RSS: Main: 157413376 16:43:50 INFO - PROCESS | 17001 | 16:43:53 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36654/tests/kraken/driver.html?testName=json-parse-financial) 16:43:53 INFO - PROCESS | 17001 | RSS: Main: 157655040 16:43:53 INFO - PROCESS | 17001 | 16:43:55 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:55 INFO - PROCESS | 17001 | RSS: Main: 157659136 16:43:55 INFO - PROCESS | 17001 | 16:43:57 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:58 INFO - PROCESS | 17001 | RSS: Main: 157282304 16:43:58 INFO - PROCESS | 17001 | 16:44:00 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:01 INFO - PROCESS | 17001 | RSS: Main: 157405184 16:44:01 INFO - PROCESS | 17001 | 16:44:03 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:04 INFO - PROCESS | 17001 | RSS: Main: 159125504 16:44:04 INFO - PROCESS | 17001 | 16:44:06 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:07 INFO - PROCESS | 17001 | RSS: Main: 157929472 16:44:07 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | Cycle 1(1): loaded http://localhost:36654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36654/tests/kraken/driver.html?testName=ai-astar) 16:44:09 INFO - PROCESS | 17001 | RSS: Main: 159670272 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | __start_tp_report 16:44:09 INFO - PROCESS | 17001 | _x_x_mozilla_page_load 16:44:09 INFO - PROCESS | 17001 | _x_x_mozilla_page_load_details 16:44:09 INFO - PROCESS | 17001 | |i|pagename|runs| 16:44:09 INFO - PROCESS | 17001 | |0;ai-astar;112;107;111;112;111;123;111;112;113;111 16:44:09 INFO - PROCESS | 17001 | |1;audio-beat-detection;164;135;152;189;127;163;149;127;196;124 16:44:09 INFO - PROCESS | 17001 | |2;audio-dft;163;163;163;163;163;166;162;162;164;161 16:44:09 INFO - PROCESS | 17001 | |3;audio-fft;73;73;76;162;77;76;73;76;158;77 16:44:09 INFO - PROCESS | 17001 | |4;audio-oscillator;92;92;150;92;92;92;150;93;92;144 16:44:09 INFO - PROCESS | 17001 | |5;imaging-gaussian-blur;118;117;118;117;118;117;118;117;117;118 16:44:09 INFO - PROCESS | 17001 | |6;imaging-darkroom;147;147;148;146;147;146;146;148;148;148 16:44:09 INFO - PROCESS | 17001 | |7;imaging-desaturate;95;95;96;96;95;95;96;99;99;97 16:44:09 INFO - PROCESS | 17001 | |8;json-parse-financial;56;58;61;56;56;58;57;74;62;55 16:44:09 INFO - PROCESS | 17001 | |9;json-stringify-tinderbox;57;57;57;57;58;57;57;57;57;58 16:44:09 INFO - PROCESS | 17001 | |10;stanford-crypto-aes;74;75;76;73;82;75;76;85;77;75 16:44:09 INFO - PROCESS | 17001 | |11;stanford-crypto-ccm;130;123;122;129;121;121;129;127;153;130 16:44:09 INFO - PROCESS | 17001 | |12;stanford-crypto-pbkdf2;161;168;165;163;160;158;159;164;163;159 16:44:09 INFO - PROCESS | 17001 | |13;stanford-crypto-sha256-iterative;68;69;74;69;66;76;68;67;67;72 16:44:09 INFO - PROCESS | 17001 | __end_tp_report 16:44:09 INFO - PROCESS | 17001 | __start_cc_report 16:44:09 INFO - PROCESS | 17001 | _x_x_mozilla_cycle_collect,831 16:44:09 INFO - PROCESS | 17001 | __end_cc_report 16:44:09 INFO - PROCESS | 17001 | __startTimestamp1461714249503__endTimestamp 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | ------- Summary: start ------- 16:44:09 INFO - PROCESS | 17001 | Number of tests: 14 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.08 (3.6%) stddev-sans-first:4.33 16:44:09 INFO - PROCESS | 17001 | Values: 112.0 107.0 111.0 112.0 111.0 123.0 111.0 112.0 113.0 111.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:157.50 stddev:25.60 (16.3%) stddev-sans-first:26.82 16:44:09 INFO - PROCESS | 17001 | Values: 164.0 135.0 152.0 189.0 127.0 163.0 149.0 127.0 196.0 124.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 16:44:09 INFO - PROCESS | 17001 | Values: 163.0 163.0 163.0 163.0 163.0 166.0 162.0 162.0 164.0 161.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:35.83 (47.2%) stddev-sans-first:37.34 16:44:09 INFO - PROCESS | 17001 | Values: 73.0 73.0 76.0 162.0 77.0 76.0 73.0 76.0 158.0 77.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:27.03 (29.4%) stddev-sans-first:27.97 16:44:09 INFO - PROCESS | 17001 | Values: 92.0 92.0 150.0 92.0 92.0 92.0 150.0 93.0 92.0 144.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:44:09 INFO - PROCESS | 17001 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 16:44:09 INFO - PROCESS | 17001 | Values: 147.0 147.0 148.0 146.0 147.0 146.0 146.0 148.0 148.0 148.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.57 (1.6%) stddev-sans-first:1.59 16:44:09 INFO - PROCESS | 17001 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 99.0 99.0 97.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:58.00 stddev:5.64 (9.7%) stddev-sans-first:5.85 16:44:09 INFO - PROCESS | 17001 | Values: 56.0 58.0 61.0 56.0 56.0 58.0 57.0 74.0 62.0 55.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:44:09 INFO - PROCESS | 17001 | Values: 57.0 57.0 57.0 57.0 58.0 57.0 57.0 57.0 57.0 58.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:3.77 (5.0%) stddev-sans-first:3.86 16:44:09 INFO - PROCESS | 17001 | Values: 74.0 75.0 76.0 73.0 82.0 75.0 76.0 85.0 77.0 75.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.00 stddev:9.38 (7.3%) stddev-sans-first:9.94 16:44:09 INFO - PROCESS | 17001 | Values: 130.0 123.0 122.0 129.0 121.0 121.0 129.0 127.0 153.0 130.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:163.00 stddev:3.16 (1.9%) stddev-sans-first:3.33 16:44:09 INFO - PROCESS | 17001 | Values: 161.0 168.0 165.0 163.0 160.0 158.0 159.0 164.0 163.0 159.0 16:44:09 INFO - PROCESS | 17001 | 16:44:09 INFO - PROCESS | 17001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.00 stddev:3.31 (4.8%) stddev-sans-first:3.46 16:44:09 INFO - PROCESS | 17001 | Values: 68.0 69.0 74.0 69.0 66.0 76.0 68.0 67.0 67.0 72.0 16:44:09 INFO - PROCESS | 17001 | -------- Summary: end -------- 16:44:09 INFO - PROCESS | 17001 | 16:44:10 INFO - TEST-INFO | 17001: exit 0 16:44:10 INFO - TEST-OK | kraken | took 60872ms 16:44:10 INFO - SUITE-END | took 1170s 16:44:10 INFO - Completed test suite (00:19:30) 16:44:10 INFO - javascript benchmark 16:44:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.083867355814, 3456.4642480415537, 3468.809215493147, 3485.860565577377, 3530.152763336798, 5634.577406694499, 5669.064604340284, 5709.486146246832, 5730.226419433376, 5737.426257374271, 5660.9716951415185, 5703.773688656938, 5708.77164913403, 5711.7715291388295, 5724.742386592603, 5126.179811230204, 5174.896502069956, 5225.242339860718, 5230.320058392404, 5277.551408130314, 5123.898361852201, 5182.689038657692, 5241.8951620967555, 5331.360236771593, 5377.623566350357, 5220.608454365919, 5229.973850130763, 5258.55302299305, 5278.630495865291, 5288.524032837044, 5158.819441319573, 5186.636935414523, 5190.117679994391, 5205.479452054802, 5207.427183009866, 4954.108260513106, 5078.974605126988, 5086.872828179288, 5111.412187598399, 5182.870428239286, 5436.21174929637, 5461.208124821918, 5482.23248745176, 5485.807996720096, 5519.862003449905, 5966.0, 5966.642001479881, 5987.520998320124, 5989.8203053908455, 6013.488853447462, 5996.700164991777, 6022.638641681469, 6062.939370606326, 6067.968445364255, 6088.025915853442, 5726.541876649858, 5753.626014309057, 5774.797882074149, 5776.537876969833, 5782.132680097977, 6205.100260462208, 6214.471769899519, 6216.689165541705, 6272.498200143978, 6281.842953926097, 5959.612625179349, 6005.189299444606, 6029.698515074228, 6055.848603784941, 6078.544109191828, 6144.5084393248435, 6157.476614487729, 6159.692015399212, 6176.969115154396, 6182.196314479179, 5921.7631294747725, 6056.454919057306, 6133.754649813957, 6144.907826382608, 6150.231221097363, 5873.765049397976, 5893.469587737039, 5952.613080149863, 5961.254843144607, 5971.402859713994, 4547.567981041796, 4557.726536407826, 4580.496145424001, 4581.060882519076, 4607.262837945913, 4039.0, 4085.7957102144774, 4118.382242663564, 4136.31750761127, 4140.068484590943, 5734.971325143431, 5762.827115186551, 5844.970775146097, 5884.705764711747, 5898.705064746746, 6130.509559235251, 6133.355997620186, 6137.60105593135, 6142.324344322121, 6162.753489860445, 5777.62445441045, 5802.274715660543, 5928.940710592925, 5945.16767652529, 5950.613210141327, 4999.175136102575, 5033.3205017322925, 5046.21783623539, 5055.620828437882, 5080.288759573663, 6330.335314791972, 6372.84067898297, 6380.106785050097, 6390.233172019387, 6390.968045159744, 5964.612300200473, 5993.640381577119, 6060.454559089703, 6127.356627554132, 6147.139400483847, 6303.810885673437, 6305.842353941188, 6306.211723534559, 6322.620642761449, 6338.112664227104, 5925.733341999534, 5944.762209511571, 5973.133895585029, 5975.133605627247, 6029.879402412015, 5990.161377407254, 6069.666168360606, 6085.604435711664, 6142.109394137914, 6165.260168779775, 5877.471027607536, 5884.911726324023, 5885.735141918538, 5943.227380440688, 5984.790532331347, 5865.178874957594, 5910.083936989773, 5915.556333275108, 5923.555733320104, 5925.288965324189, 5766.279215098113, 5816.651000939788, 5881.705914704162, 5908.231929849092, 5945.10823376497, 5891.587588868738, 5911.763529458945, 5958.702064896651, 5962.821115366546, 5966.343702192668, 5729.828105156852, 5818.069108942549, 5825.242718446575, 5826.76692932278, 5831.533477321889], "value": 5606.267035915479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.3856821008777, 674.0125715826314, 681.3356976947474, 686.7424715731602, 728.7485817392998, 40727.18545629089, 41808.163836723244, 41902.0, 42020.36969445461, 42141.57858421415, 43526.56473435264, 43915.34126988098, 44199.77900110503, 44232.0, 44273.55726442735, 8701.17338852808, 8950.820983580325, 8961.551922403887, 8974.326925480582, 8981.281497480186, 8830.602622881954, 8927.910720892805, 8930.732078037638, 9055.185033346997, 9081.228095611881, 9069.954650226773, 9080.818383632324, 9115.270778337717, 9139.817203655923, 9146.131117543857, 9107.089291070906, 9114.908850911506, 9185.540722963859, 9207.355485116044, 9209.953950230207, 8997.055309192507, 9024.05247449015, 9063.728088157366, 9110.726678199664, 9127.17855393011, 44460.3330950036, 44543.331850022274, 44556.3316550252, 44613.55386446127, 45177.0, 3798.2973149967343, 4205.453291072141, 4229.598188172119, 4245.0236445617375, 4366.061296821199, 33968.32063358719, 34576.65423345759, 34795.0, 35048.0, 35933.820330898176, 4239.109786944745, 4348.4999225089205, 4369.169857727022, 4383.736975781463, 4390.27560452525, 321214.0, 323242.0, 323347.0, 324679.0, 324821.0, 61405.69297153486, 61670.38329616647, 61779.38220617826, 61780.38219617836, 62085.689571551855, 60809.695951520844, 62412.37587624066, 62490.750184996956, 64064.0, 64298.67850660717, 18913.527161820788, 19021.239150434103, 19057.237710491427, 19109.522261943286, 19221.519462013563, 14826.036307639968, 14902.254887255594, 14955.70088598222, 14978.850211497964, 14984.475543356148, 20861.89569052145, 21319.25382611601, 21456.57086858254, 21545.59953603011, 21675.24136655241, 7909.881351779728, 8194.22154895284, 8225.547594882339, 8238.83522329562, 8317.126701696356, 1086.0225796782959, 1125.5160281079216, 1131.145984781501, 1132.6035887439496, 1220.8596011458797, 33339.333213335594, 33526.832365838505, 33724.0, 33729.32541349159, 34363.14092147666, 1157.8321143434155, 1247.2267194339568, 1294.5857325655888, 1349.3320806200993, 1381.240317825192, 17267.0, 17667.73498397525, 17710.645787084442, 17810.287588496314, 17851.464456066078, 320664.0, 326860.0, 328675.0, 331630.0, 479741.0, 57989.42010579925, 58594.41405585975, 58760.7061964696, 59181.40818591759, 59296.40703592995, 1508.8264849542443, 1561.2349948525368, 1564.9218286659861, 1574.4332040465424, 1592.1561572366663, 32850.0, 33062.0, 33459.49810752792, 33743.4938475928, 33872.49191262182, 53668.19497707616, 53893.19160212522, 53948.0, 54341.45658543522, 54484.0, 452342.0, 459034.0, 459071.0, 459156.0, 459261.0, 31261.0, 31510.684893150774, 31930.20174495656, 32342.8679996199, 32439.189020274684, 45840.54159458363, 46398.76800615976, 50707.239391408424, 51073.0, 52266.21600676069, 41999.370009449274, 43483.56516434795, 43944.34083488814, 44193.55806441895, 44773.32840007338, 42268.36597451102, 42419.363709543766, 42742.14515709731, 43182.784086079366, 43860.0, 43142.78428607837, 43679.0, 43901.780491098616, 44052.33921491244, 44588.33117503175, 36137.0, 36742.44886326761, 37303.626963730014, 37586.24827503489, 37687.43468848024, 29100.417991640472, 29141.41717165687, 29312.827486900285, 29353.853230734563, 29452.558211626416], "value": 21069.687393252272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.4601357809857, 432.88109173405616, 437.13447374199086, 437.80517669637015, 450.38072650106085, 20125.295614653507, 20130.49673758155, 20721.481962950897, 20723.481912952182, 21035.158593656255, 18874.80942740747, 19980.800191998074, 20705.06827192776, 20787.376378708625, 20789.688154677693, 5857.326407463132, 5995.790147344844, 6000.18997435345, 6030.246219222598, 6039.063945088496, 5647.745851436695, 5888.087346461305, 5929.555283353744, 5934.347221805598, 5992.49063829575, 5842.24050873388, 5886.293644762613, 5926.555508336892, 5928.614640048405, 6629.701663425133, 6712.798616041527, 6734.292899245582, 6761.9323806761795, 6771.5937043777285, 6783.932160678404, 5768.826935191951, 5865.970670146622, 5872.706364681749, 5933.910991335133, 5940.465358117747, 14359.78460323096, 14374.065685730498, 15217.467388641344, 23881.88059059711, 24315.0, 2358.8348815582917, 2502.51201015802, 2592.9481410371877, 2682.6244325794405, 2789.7070807565115, 10817.405042722647, 10832.620858270002, 10929.945350273198, 11113.888861111447, 11186.608468703556, 2083.9270625528034, 2110.8311335093154, 2163.653815389546, 2172.2614311134134, 2187.1798075721604, 75003.24996750017, 79219.60390198069, 79583.20416795816, 80153.0, 81569.59215203945, 11557.190996630155, 11792.705182370339, 11945.641630751092, 12068.637940861789, 12112.878871211175, 15805.446809361618, 15982.200889955455, 15986.60033499172, 16009.119498427699, 16028.75956860648, 8129.593520323961, 8262.462939908886, 8878.245349145265, 8934.913603894804, 8980.730578082668, 9014.549272536347, 9130.817383652422, 9155.81688366229, 9187.908120918839, 9193.908060919439, 5068.974655126774, 5070.873228169326, 5079.822206222764, 5141.742912854343, 5150.845474635767, 1885.0, 1885.9151338189815, 1923.307609260665, 2025.2202901882881, 2035.8778473291354, 972.1348000279756, 1092.3609688332256, 1130.3105105885404, 1130.944135515402, 1225.993870030644, 19210.0, 19511.707324390147, 19619.803801962084, 20162.0, 20294.086766095563, 1079.5735684404617, 1084.1814430105221, 1090.3893819461127, 1102.404701461202, 1144.856892888389, 10621.415822129702, 10865.619703310345, 10960.671179864617, 11067.944660276647, 11170.944145279384, 508429.0, 521252.0, 524277.0, 524704.0, 531698.0, 99380.0, 99800.0, 100694.4965275169, 101545.0, 103656.48171759093, 1079.4656644960637, 1089.0960502782514, 1128.3793913347627, 1150.1488898215262, 1152.383474840973, 16992.3873705229, 17405.216765245343, 17447.47657570275, 17651.646967060842, 17783.644327113125, 42178.789106054275, 43167.35248971331, 43627.56372436362, 43908.78045609879, 44539.10921781611, 59012.40987590069, 60314.39685603263, 61111.0, 61152.38847611467, 61721.38278617156, 8591.44155629882, 8705.129487051498, 9006.50464224474, 9010.594523246338, 9102.772430689021, 13578.524751633646, 13989.23059231752, 14047.297635117999, 14058.0, 14349.784753228918, 12050.578229761917, 12262.0, 12365.134440589072, 12506.624801255977, 12761.298128603015, 11190.496427660937, 11561.19071665009, 12204.328761917825, 12439.067069969607, 12618.17981831178, 11554.884451155716, 11986.041116710816, 12138.817917731065, 12374.195677280948, 12654.304013279358, 8722.08418116114, 8729.258013068706, 8820.073892241222, 8939.910600894167, 9110.180083792491, 8773.605187766438, 11291.887081129084, 11816.822747658964, 11927.403629818647, 11938.28370297785], "value": 9692.366167913948, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.2118940529735, 1633.2487055954261, 1820.1172431370783, 1900.9239630414784, 1930.4401723500187, 7910.881336779953, 8429.367797415196, 8534.786630334245, 8780.28784387044, 8818.823623527534, 8594.914050859505, 8628.266597339218, 8643.617021276597, 8653.048164701893, 8715.477071375723, 2465.8520488770687, 2480.5038992201544, 2480.7643273888953, 2502.7121880983645, 2504.111040580595, 2468.568000599897, 2509.6110102934076, 2517.181915877338, 2527.481866217421, 2531.962020569693, 2464.7658472445087, 2492.9626055609087, 2543.923682289534, 2555.1695698897934, 2575.85832779198, 2440.73151953285, 2442.658027876099, 2449.6937882764655, 2484.627305904111, 2487.2413913756295, 2399.4841109161616, 2455.58255096634, 2466.2847774145475, 2467.7408872068354, 2478.1450399612104, 8797.824043519158, 8821.2060914518, 8914.0, 8927.419717718327, 8957.462552246821, 5247.921281180786, 5457.972710136424, 5468.207109969032, 5473.2063850741815, 5485.6982865942355, 3518.8240587970754, 3522.4188008978745, 3536.6491494607803, 3672.889813305578, 3683.0608194910396, 1180.8701042885275, 1182.875798041202, 1230.3110258255406, 1236.715555422258, 1266.6686614204582, 12393.876061239362, 12399.566015189424, 12427.62717118479, 12432.191907525981, 12453.439595218237, 4869.074875773592, 4895.681780684244, 4971.875703107379, 4988.775505102279, 5014.022265658235, 10581.735456613646, 10582.417967011888, 10624.575016999388, 10629.309094908805, 10670.146388288918, 5456.781728730885, 5531.751071201806, 5581.804636837691, 5582.385937546866, 5604.607677462538, 4498.257787465097, 4836.564709176191, 4845.53967373099, 4957.479464656231, 4972.105021096238, 4199.727017743837, 4224.704270701021, 4264.594863487963, 4299.419578356882, 4312.202242585132, 1389.4720006397504, 1415.0660564027692, 1421.5451055662295, 1433.6845893903323, 1447.3703938786662, 915.6840889892976, 919.7053351887084, 929.3773171974793, 951.1249650321721, 974.4835237324229, 5664.150377443417, 5696.857578560569, 5818.069108942549, 5891.734871930774, 5914.408559144137, 456.82183948260206, 460.16020762109287, 468.43085650933597, 478.12741746313117, 499.20127795526867, 4012.1975604878558, 4040.6969477288735, 4047.3119569673227, 4050.41269015991, 4114.074333275049, 10465.581376744996, 10523.263371563917, 10945.671629851116, 11042.723931901766, 11086.334819910831, 10697.62558310471, 10908.618198363178, 10977.945110274397, 10987.121030317556, 10992.395418252074, 8247.463914845635, 8295.502269863828, 8300.335973122015, 8463.70377036813, 8515.787105322293, 6095.847603809941, 6169.2288463942, 6210.503159747119, 6270.937290627217, 6294.15028971083, 9811.656592019244, 9818.45998470091, 9982.0, 10002.799944001225, 10036.849447258151, 10027.699169024942, 10130.89869101329, 10217.693469195936, 10284.0, 10324.638637647646, 6938.895916561155, 7670.923290767021, 7678.424118191269, 7739.071311442663, 7752.844943100994, 8366.958165209135, 8406.495610263404, 8488.023877254194, 8491.57542122879, 8524.957375213084, 7263.673134709056, 7489.063867016623, 7547.773566793005, 7569.280918312751, 7592.088949325896, 7199.496035277481, 7495.325420712162, 7528.736494222676, 7597.088349398107, 7704.30661240491, 7200.063991681048, 7222.494425390172, 7263.382612477999, 7282.271772822887, 7283.380912622486, 5296.285001524745, 5330.813421530228, 5413.593980451561, 5422.566194704493, 5482.040642887399, 5044.394672639307, 5215.29593504872, 5365.114756065205, 5368.033753924331, 5430.0], "value": 4678.547430460183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.72862082059265, 369.75226598179216, 371.2908345060934, 371.34272337961806, 378.70839453620704, 5502.80740174093, 5648.181013753004, 5660.915086273709, 5698.373178950317, 5724.055530837412, 5714.657120572769, 5716.942830571693, 5751.309842818857, 5757.596968212227, 5760.36635970044, 4519.209138400775, 4530.954690453086, 4537.636989040885, 4537.9773101134615, 4558.6581006424485, 4462.933056004163, 4552.658550608701, 4562.178807814592, 4574.565416285448, 4590.586847183769, 4496.820127194908, 4498.167838949788, 4512.571305725951, 4517.616002639779, 4538.071319689136, 4284.421603083606, 4540.931886021679, 4551.45382554094, 4561.361409402686, 4566.566176213271, 3945.9802700986597, 3947.6447119759073, 3949.980250098731, 3951.565327813938, 3954.426608141803, 5514.476124768141, 5526.530244929186, 5526.696031718254, 5528.226048353234, 5529.861753456155, 4848.248521479177, 5032.47159048302, 5050.898982020339, 5069.960658065088, 5087.414947281073, 5946.167536544887, 5973.6415815050805, 5976.581639285252, 6019.638821670714, 6032.607880487754, 4276.50820155683, 4325.632321252698, 4327.632151267146, 4359.0, 4371.606555409997, 6153.569250152491, 6217.720202590895, 6232.0, 6242.219722534684, 6269.7178626961895, 4394.692371533962, 4401.273789824643, 4431.556844315543, 4459.509453960061, 4460.107978404332, 4469.150861336336, 4500.324951257272, 4505.43682039745, 4505.549445055468, 4509.481409637933, 5005.499450055038, 5042.520960508746, 5137.434882162959, 5151.22731590257, 5155.5617772489, 5619.466150715675, 5798.188253644493, 5958.76164953397, 5996.871110755619, 6056.182415373956, 1608.573727962091, 1609.147152009437, 1613.491750098715, 1617.9433719819986, 1624.0, 1066.2376400873413, 1083.766990097133, 1087.8205096159204, 1102.2614848051664, 1109.1182509904645, 6188.298217990089, 6254.437100660963, 6275.623462592168, 6289.654069026156, 6290.905636415458, 6551.737930482823, 6596.505262105361, 6616.603003819786, 6629.303923088103, 6645.734170633217, 5655.943440565624, 5900.4099590041515, 5928.79249226275, 5940.821775346746, 5942.286925568873, 3567.233044895308, 3574.873914716856, 3592.586852511942, 3595.856165753393, 3604.945925811115, 6146.231721034871, 6431.6462594556815, 6436.806895793134, 6465.224173099258, 7024.086868707035, 6164.938350616526, 6202.937970620236, 6238.688065596702, 6240.126382306481, 6258.3428739982555, 6216.191895053705, 6376.553641245068, 6397.488200943913, 6414.743410263631, 6421.51838612106, 6126.540509461719, 6167.907481387693, 6176.6911654418, 6207.193064901534, 6207.255129384323, 5895.852603684943, 6094.421030002142, 6119.4798442132915, 6145.170401995673, 6145.293291271561, 6371.426571608577, 6389.540027089511, 6404.647744374104, 6436.195475565554, 6458.806235812933, 4384.627306678968, 4418.204723149735, 4429.224885645063, 4438.245498265238, 4445.799939002817, 5971.940280597139, 6200.782972595937, 6202.28673702512, 6252.343503932022, 6277.811665650038, 6097.695115244309, 6107.358727333743, 6120.816375508742, 6131.264248290234, 6147.754089836357, 5755.884882302246, 6053.09203619443, 6053.243344581927, 6093.969530152321, 6112.786052488142, 5953.642781433128, 5965.522758179422, 6010.729517171825, 6016.278046634432, 6026.668533230714, 6068.241469816273, 6080.908786368296, 6090.878182436415, 6111.388861113853, 6152.477039451696, 5612.831615051555, 5892.0, 5896.614295640436, 5963.165156878127, 5968.4031596841705], "value": 4653.722468801925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.5430041778766, 867.7223288547667, 874.741951124418, 878.3719640457076, 899.8695189197563, 13886.861131388683, 14516.419343226285, 14569.271536423163, 14653.926730366347, 14814.629634259136, 12968.286744229064, 14128.71742565148, 14148.151110933351, 14195.645108872284, 14239.145651260906, 918.3525614441819, 927.689224109924, 929.6142101028099, 931.1293940165932, 931.3620170183412, 925.1765928323797, 930.2046750028695, 930.7254359963827, 932.1098351074708, 932.1098351074742, 969.471637957315, 970.7184916374243, 971.0629242780715, 972.0231167676475, 973.3916302311055, 958.5015791788231, 961.8076384723048, 968.0658164870933, 971.3200759468365, 973.8247115519239, 705.3334598804132, 712.9465290103263, 714.1430283659629, 714.4820005496026, 717.989230161548, 13373.130746501543, 13521.932390337985, 13551.661208469768, 13583.660408489768, 13588.660283492893, 12650.74698506034, 12748.426320815586, 12812.0, 12854.935725321408, 13022.218666880017, 10729.93502150975, 10824.079953203987, 10922.29005114665, 10942.507587158518, 10955.397453140075, 3904.9609503905167, 3909.7849618270984, 3938.4879965604573, 3959.6436320730986, 3961.861334853295, 51806.48193518054, 52441.2133817993, 52524.0, 52583.0, 54933.0, 11190.66428007161, 11594.18840681161, 11799.705007374712, 11867.465964031466, 11949.64151075469, 19684.311049113498, 19768.11043503046, 19936.800631993785, 19961.401157965283, 20075.39773806788, 8818.5590720465, 8837.337199710048, 8904.19862212404, 8952.23905967987, 9060.954695226614, 4924.704517728947, 4997.625178111656, 5007.674501157413, 5084.13569693153, 5109.0, 3626.9274614507563, 3655.0, 3658.8108864619107, 3667.2665466906724, 3674.797886116289, 681.3322943515383, 689.8689249042666, 693.5387967001988, 700.989485157723, 706.0292098364748, 692.4840993459804, 748.827769612992, 762.3177256355641, 766.1763604125476, 766.1993217088157, 8317.293030092509, 8579.82840343202, 8903.866442003375, 8933.106689331014, 8974.102589740975, 725.3942957630333, 743.7434085240583, 745.4334705623766, 746.5110352718978, 753.4349238071446, 4115.855945041909, 4247.256730072225, 4296.505901821268, 4335.739855608674, 4377.781110944504, 68317.65841170763, 68770.0, 68903.0, 69425.30574694289, 72059.27940720631, 60861.695691522145, 62474.37525624686, 62766.37233627697, 63723.999999999076, 63999.0, 54764.726176368866, 55435.722821386444, 55745.163822542694, 55805.999999999185, 56041.159382609294, 8322.37582181351, 8521.659133634585, 8619.612117454604, 8678.609462574326, 8874.0, 34448.0, 35019.0, 35034.474482883285, 35050.82474587611, 36078.8196059018, 43434.56565434305, 49723.75138124286, 50168.0, 51039.87521497444, 51789.0, 11569.479373428385, 11607.129465290305, 11689.240199387013, 11709.297442153498, 11750.647480575597, 11612.954834064974, 11813.232139910879, 12351.3824308786, 12510.87489125097, 12891.613251602466, 11547.769044619228, 11610.6516804496, 11641.0, 11672.76654466889, 11808.763824723286, 11559.36423496682, 11901.226420282654, 11946.926887555768, 12237.26576405383, 12354.382280886099, 11540.884591153981, 11664.183507154417, 11694.415279236175, 11774.175807693378, 12077.75844483123, 10106.343087699275, 10122.544485498023, 10229.130523905551, 10452.32059916103, 10528.36829790215, 9988.850167247352, 10123.138103045301, 10174.86649414355, 10180.898191017995, 10181.34715025901], "value": 6940.322786653822, "unit": "score"}], "name": "dromaeo_css", "value": 7464.760858261137, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 112.0, 111.0, 123.0, 111.0, 112.0, 113.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 135.0, 152.0, 189.0, 127.0, 163.0, 149.0, 127.0, 196.0, 124.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 163.0, 166.0, 162.0, 162.0, 164.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 162.0, 77.0, 76.0, 73.0, 76.0, 158.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 92.0, 92.0, 92.0, 150.0, 93.0, 92.0, 144.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.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": [147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 148.0, 148.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 99.0, 99.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 61.0, 56.0, 56.0, 58.0, 57.0, 74.0, 62.0, 55.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 73.0, 82.0, 75.0, 76.0, 85.0, 77.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 122.0, 129.0, 121.0, 121.0, 129.0, 127.0, 153.0, 130.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 168.0, 165.0, 163.0, 160.0, 158.0, 159.0, 164.0, 163.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 74.0, 69.0, 66.0, 76.0, 68.0, 67.0, 67.0, 72.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1543.1999999999998, "alertThreshold": 2.0}]} 16:44:10 INFO - Return code: 0 16:44:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:44:10 ERROR - # TBPL SUCCESS # 16:44:10 INFO - Running post-action listener: _resource_record_post_action 16:44:10 INFO - Running post-run listener: _resource_record_post_run 16:44:11 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 262144; Write bytes: 491483136; Read time: 20; Write time: 435752 16:44:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 150978560; Read time: 0; Write time: 164400 16:44:11 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250949632; Read time: 20; Write time: 170236 16:44:11 INFO - Running post-run listener: _upload_blobber_files 16:44:11 INFO - Blob upload gear active. 16:44:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:11 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 16:44:11 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'] 16:44:11 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 16:44:12 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:44:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:44:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:13 INFO - (blobuploader) - INFO - Done attempting. 16:44:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:44:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:44:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:13 INFO - (blobuploader) - INFO - Done attempting. 16:44:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:44:13 INFO - Return code: 0 16:44:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:44:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:44:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ca83520de7312db3896c25b4bacac5dc27477c0c1767772f46b2042af7a3b351be67a2cccd731fb30f42c0259713b79d91c68db982513dab5c6b191308af570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba025a912b7b0458e7c19e90fe8c8656502414a4a1d6ee6de89fbcfe1c7deaed8d45256dd6f4da352a7ca7bc90e5b0abbc023aa47c5191d7752adda7b1fbfc49"} 16:44:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:44:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:44:13 INFO - Contents: 16:44:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ca83520de7312db3896c25b4bacac5dc27477c0c1767772f46b2042af7a3b351be67a2cccd731fb30f42c0259713b79d91c68db982513dab5c6b191308af570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba025a912b7b0458e7c19e90fe8c8656502414a4a1d6ee6de89fbcfe1c7deaed8d45256dd6f4da352a7ca7bc90e5b0abbc023aa47c5191d7752adda7b1fbfc49"} 16:44:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:44:13 INFO - Copying logs to upload dir... 16:44:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:44:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.954616 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-26 16:44:13.883664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:44:13.887488) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504 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/9ca83520de7312db3896c25b4bacac5dc27477c0c1767772f46b2042af7a3b351be67a2cccd731fb30f42c0259713b79d91c68db982513dab5c6b191308af570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba025a912b7b0458e7c19e90fe8c8656502414a4a1d6ee6de89fbcfe1c7deaed8d45256dd6f4da352a7ca7bc90e5b0abbc023aa47c5191d7752adda7b1fbfc49"} build_url:https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011072 build_url: 'https://queue.taskcluster.net/v1/task/JFpIVXz-S_ykzGiefcPfwg/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/9ca83520de7312db3896c25b4bacac5dc27477c0c1767772f46b2042af7a3b351be67a2cccd731fb30f42c0259713b79d91c68db982513dab5c6b191308af570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba025a912b7b0458e7c19e90fe8c8656502414a4a1d6ee6de89fbcfe1c7deaed8d45256dd6f4da352a7ca7bc90e5b0abbc023aa47c5191d7752adda7b1fbfc49"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:44:13.913281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:44:13.913667) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461712049.61418-1452003504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:44:13.997925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:44:13.998510) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:44:13.999075) ========= ========= Total master_lag: 0.18 =========