builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1464279210.15 results: success (0) buildid: 20160526064139 builduid: 1235cebdd67347c5b9996d150f3dbc64 revision: 5564b762402e5c577f720c88244baeb641738b39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.152504) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.153089) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.153399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.169172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.169628) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 09:13:30-- 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% 86.6M=0s 2016-05-26 09:13:30 (86.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069860 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.253143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.253470) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020170 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:30.303057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 09:13:30.303420) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5564b762402e5c577f720c88244baeb641738b39 --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-beta --rev 5564b762402e5c577f720c88244baeb641738b39 --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=20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 09:13:30,396 truncating revision to first 12 chars 2016-05-26 09:13:30,396 Setting DEBUG logging. 2016-05-26 09:13:30,396 attempt 1/10 2016-05-26 09:13:30,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5564b762402e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 09:13:31,786 unpacking tar archive at: mozilla-beta-5564b762402e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.780987 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 09:13:32.100267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:32.100889) ========= script_repo_revision: 5564b762402e5c577f720c88244baeb641738b39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:32.101492) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:32.101945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 09:13:32.113381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-26 09:13:32.113981) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:13:32 INFO - MultiFileLogger online at 20160526 09:13:32 in /builds/slave/test 09:13:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:13:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:13:32 INFO - {'append_to_log': False, 09:13:32 INFO - 'base_work_dir': '/builds/slave/test', 09:13:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:13:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:13:32 INFO - 'branch': 'Mozilla-Beta', 09:13:32 INFO - 'buildbot_json_path': 'buildprops.json', 09:13:32 INFO - 'config_files': ('talos/linux_config.py',), 09:13:32 INFO - 'default_actions': ('clobber', 09:13:32 INFO - 'read-buildbot-config', 09:13:32 INFO - 'download-and-extract', 09:13:32 INFO - 'populate-webroot', 09:13:32 INFO - 'create-virtualenv', 09:13:32 INFO - 'install', 09:13:32 INFO - 'run-tests'), 09:13:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:13:32 INFO - 'download_minidump_stackwalk': True, 09:13:32 INFO - 'download_symbols': 'ondemand', 09:13:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:13:32 INFO - 'tooltool.py': '/tools/tooltool.py', 09:13:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:13:32 INFO - '/tools/misc-python/virtualenv.py')}, 09:13:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:13:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:13:32 INFO - 'installer_path': 'installer.exe', 09:13:32 INFO - 'log_level': 'info', 09:13:32 INFO - 'log_name': 'talos', 09:13:32 INFO - 'log_to_console': True, 09:13:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:13:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:13:32 INFO - 'opt_config_files': (), 09:13:32 INFO - 'pip_index': False, 09:13:32 INFO - 'sps_profile': False, 09:13:32 INFO - 'sps_profile_interval': 0, 09:13:32 INFO - 'suite': 'dromaeojs', 09:13:32 INFO - 'system_bits': '32', 09:13:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:13:32 INFO - 'title': 'talos-linux64-ix-015', 09:13:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:13:32 INFO - 'use_talos_json': True, 09:13:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:13:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:13:32 INFO - 'work_dir': 'build'} 09:13:32 INFO - ##### 09:13:32 INFO - ##### Running clobber step. 09:13:32 INFO - ##### 09:13:32 INFO - Running pre-action listener: _resource_record_pre_action 09:13:32 INFO - Running main action method: clobber 09:13:32 INFO - rmtree: /builds/slave/test/build 09:13:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:13:32 INFO - Running post-action listener: _resource_record_post_action 09:13:32 INFO - ##### 09:13:32 INFO - ##### Running read-buildbot-config step. 09:13:32 INFO - ##### 09:13:32 INFO - Running pre-action listener: _resource_record_pre_action 09:13:32 INFO - Running main action method: read_buildbot_config 09:13:32 INFO - Using buildbot properties: 09:13:32 INFO - { 09:13:32 INFO - "project": "", 09:13:32 INFO - "product": "firefox", 09:13:32 INFO - "script_repo_revision": "production", 09:13:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:13:32 INFO - "repository": "", 09:13:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:13:32 INFO - "buildid": "20160526064139", 09:13:32 INFO - "pgo_build": "True", 09:13:32 INFO - "basedir": "/builds/slave/test", 09:13:32 INFO - "buildnumber": 252, 09:13:32 INFO - "slavename": "talos-linux64-ix-015", 09:13:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:13:32 INFO - "platform": "ubuntu64_hw", 09:13:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:13:32 INFO - "branch": "mozilla-beta", 09:13:32 INFO - "repo_path": "releases/mozilla-beta", 09:13:32 INFO - "revision": "5564b762402e5c577f720c88244baeb641738b39", 09:13:32 INFO - "stage_platform": "linux64-pgo", 09:13:32 INFO - "builduid": "1235cebdd67347c5b9996d150f3dbc64", 09:13:32 INFO - "slavebuilddir": "test" 09:13:32 INFO - } 09:13:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 09:13:32 INFO - Running post-action listener: _resource_record_post_action 09:13:32 INFO - ##### 09:13:32 INFO - ##### Running download-and-extract step. 09:13:32 INFO - ##### 09:13:32 INFO - Running pre-action listener: _resource_record_pre_action 09:13:32 INFO - Running main action method: download_and_extract 09:13:32 INFO - mkdir: /builds/slave/test/build/tests 09:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:32 INFO - https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:13:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:13:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:13:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:13:33 INFO - Downloaded 1412 bytes. 09:13:33 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 09:13:33 INFO - Using the following test package requirements: 09:13:33 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:13:33 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:13:33 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 09:13:33 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'jsshell-linux-x86_64.zip'], 09:13:33 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:13:33 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:13:33 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 09:13:33 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 09:13:33 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:13:33 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 09:13:33 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 09:13:33 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:13:33 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:33 INFO - https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:13:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:13:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:13:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:13:35 INFO - Downloaded 23434130 bytes. 09:13:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:13:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:13:36 INFO - Return code: 0 09:13:36 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:36 INFO - https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 09:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:13:40 INFO - Downloaded 23434130 bytes. 09:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:13:41 INFO - Return code: 0 09:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:41 INFO - https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 09:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:13:43 INFO - Downloaded 10845194 bytes. 09:13:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:13:43 INFO - Return code: 0 09:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:43 INFO - https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:13:44 INFO - Downloaded 53855370 bytes. 09:13:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:13:44 INFO - mkdir: /builds/slave/test/properties 09:13:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:13:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:13:44 INFO - Contents: 09:13:44 INFO - build_url:https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 09:13:45 INFO - Running post-action listener: _resource_record_post_action 09:13:45 INFO - Running post-action listener: set_extra_try_arguments 09:13:45 INFO - ##### 09:13:45 INFO - ##### Running populate-webroot step. 09:13:45 INFO - ##### 09:13:45 INFO - Running pre-action listener: _resource_record_pre_action 09:13:45 INFO - Running main action method: populate_webroot 09:13:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:13:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:13:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:13:45 INFO - '--tppagecycles', 09:13:45 INFO - '7'], 09:13:45 INFO - 'tests': ['tsvgm']}}, 09:13:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:13:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:13:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:13:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:13:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'tests': ['damp', 'tps']}, 09:13:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['damp', 'tps']}, 09:13:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:13:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:13:45 INFO - 'other': {'tests': ['a11yr', 09:13:45 INFO - 'ts_paint', 09:13:45 INFO - 'tpaint', 09:13:45 INFO - 'sessionrestore', 09:13:45 INFO - 'sessionrestore_no_auto_restore', 09:13:45 INFO - 'tabpaint']}, 09:13:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['a11yr', 09:13:45 INFO - 'ts_paint', 09:13:45 INFO - 'tpaint', 09:13:45 INFO - 'sessionrestore', 09:13:45 INFO - 'sessionrestore_no_auto_restore', 09:13:45 INFO - 'tabpaint']}, 09:13:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['a11yr', 09:13:45 INFO - 'ts_paint', 09:13:45 INFO - 'tpaint', 09:13:45 INFO - 'sessionrestore', 09:13:45 INFO - 'sessionrestore_no_auto_restore', 09:13:45 INFO - 'tabpaint']}, 09:13:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['a11yr', 09:13:45 INFO - 'ts_paint', 09:13:45 INFO - 'tpaint', 09:13:45 INFO - 'sessionrestore', 09:13:45 INFO - 'sessionrestore_no_auto_restore', 09:13:45 INFO - 'tabpaint']}, 09:13:45 INFO - 'other_l64': {'tests': ['a11yr', 09:13:45 INFO - 'ts_paint', 09:13:45 INFO - 'tpaint', 09:13:45 INFO - 'sessionrestore', 09:13:45 INFO - 'sessionrestore_no_auto_restore', 09:13:45 INFO - 'tabpaint']}, 09:13:45 INFO - 'other_nol64': {'tests': ['a11yr', 09:13:45 INFO - 'ts_paint', 09:13:45 INFO - 'tpaint', 09:13:45 INFO - 'sessionrestore', 09:13:45 INFO - 'sessionrestore_no_auto_restore', 09:13:45 INFO - 'tabpaint']}, 09:13:45 INFO - 'svgr': {'tests': ['tsvgx', 09:13:45 INFO - 'tsvgr_opacity', 09:13:45 INFO - 'tart', 09:13:45 INFO - 'tscrollx', 09:13:45 INFO - 'cart']}, 09:13:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['tsvgx', 09:13:45 INFO - 'tsvgr_opacity', 09:13:45 INFO - 'tart', 09:13:45 INFO - 'tscrollx', 09:13:45 INFO - 'cart']}, 09:13:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'tests': ['tp5o']}, 09:13:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'talos_options': ['--e10s'], 09:13:45 INFO - 'tests': ['tp5o']}, 09:13:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'talos_options': ['--xperf_path', 09:13:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:45 INFO - 'tests': ['tp5n']}, 09:13:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:45 INFO - 'talos_options': ['--e10s', 09:13:45 INFO - '--xperf_path', 09:13:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:45 INFO - 'tests': ['tp5n']}}, 09:13:45 INFO - 'talos.zip': {'path': '', 09:13:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:13:45 INFO - Running post-action listener: _resource_record_post_action 09:13:45 INFO - ##### 09:13:45 INFO - ##### Running create-virtualenv step. 09:13:45 INFO - ##### 09:13:45 INFO - Running pre-action listener: _resource_record_pre_action 09:13:45 INFO - Running main action method: create_virtualenv 09:13:45 INFO - Creating virtualenv /builds/slave/test/build/venv 09:13:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:13:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:13:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:13:45 INFO - Using real prefix '/usr' 09:13:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:13:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:48 INFO - Installing pip.................done. 09:13:48 INFO - Return code: 0 09:13:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:48 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:13:48 INFO - Using env: {'DISPLAY': ':0', 09:13:48 INFO - 'HOME': '/home/cltbld', 09:13:48 INFO - 'LANG': 'en_US.UTF-8', 09:13:48 INFO - 'LANGUAGE': 'en_US:en', 09:13:48 INFO - 'LOGNAME': 'cltbld', 09:13:48 INFO - 'MAIL': '/var/mail/cltbld', 09:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:48 INFO - 'MOZ_NO_REMOTE': '1', 09:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:48 INFO - 'NO_EM_RESTART': '1', 09:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:48 INFO - 'PWD': '/builds/slave/test', 09:13:48 INFO - 'SHELL': '/bin/bash', 09:13:48 INFO - 'SHLVL': '1', 09:13:48 INFO - 'TERM': 'linux', 09:13:48 INFO - 'TMOUT': '86400', 09:13:48 INFO - 'USER': 'cltbld', 09:13:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:48 INFO - '_': '/tools/buildbot/bin/python'} 09:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:13:48 INFO - Cleaning up... 09:13:48 INFO - Return code: 0 09:13:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:48 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:13:48 INFO - Using env: {'DISPLAY': ':0', 09:13:48 INFO - 'HOME': '/home/cltbld', 09:13:48 INFO - 'LANG': 'en_US.UTF-8', 09:13:48 INFO - 'LANGUAGE': 'en_US:en', 09:13:48 INFO - 'LOGNAME': 'cltbld', 09:13:48 INFO - 'MAIL': '/var/mail/cltbld', 09:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:48 INFO - 'MOZ_NO_REMOTE': '1', 09:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:48 INFO - 'NO_EM_RESTART': '1', 09:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:48 INFO - 'PWD': '/builds/slave/test', 09:13:48 INFO - 'SHELL': '/bin/bash', 09:13:48 INFO - 'SHLVL': '1', 09:13:48 INFO - 'TERM': 'linux', 09:13:48 INFO - 'TMOUT': '86400', 09:13:48 INFO - 'USER': 'cltbld', 09:13:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:48 INFO - '_': '/tools/buildbot/bin/python'} 09:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:48 INFO - Downloading/unpacking psutil>=0.7.1 09:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:50 INFO - Installing collected packages: psutil 09:13:50 INFO - Running setup.py install for psutil 09:13:50 INFO - building 'psutil._psutil_linux' extension 09:13:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:13:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:13:50 INFO - building 'psutil._psutil_posix' extension 09:13:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:13:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:51 INFO - Successfully installed psutil 09:13:51 INFO - Cleaning up... 09:13:52 INFO - Return code: 0 09:13:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:52 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:13:52 INFO - Using env: {'DISPLAY': ':0', 09:13:52 INFO - 'HOME': '/home/cltbld', 09:13:52 INFO - 'LANG': 'en_US.UTF-8', 09:13:52 INFO - 'LANGUAGE': 'en_US:en', 09:13:52 INFO - 'LOGNAME': 'cltbld', 09:13:52 INFO - 'MAIL': '/var/mail/cltbld', 09:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:52 INFO - 'MOZ_NO_REMOTE': '1', 09:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:52 INFO - 'NO_EM_RESTART': '1', 09:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:52 INFO - 'PWD': '/builds/slave/test', 09:13:52 INFO - 'SHELL': '/bin/bash', 09:13:52 INFO - 'SHLVL': '1', 09:13:52 INFO - 'TERM': 'linux', 09:13:52 INFO - 'TMOUT': '86400', 09:13:52 INFO - 'USER': 'cltbld', 09:13:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:52 INFO - '_': '/tools/buildbot/bin/python'} 09:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:13:54 INFO - Installing collected packages: mozsystemmonitor 09:13:54 INFO - Running setup.py install for mozsystemmonitor 09:13:54 INFO - Successfully installed mozsystemmonitor 09:13:54 INFO - Cleaning up... 09:13:54 INFO - Return code: 0 09:13:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:54 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:13:54 INFO - Using env: {'DISPLAY': ':0', 09:13:54 INFO - 'HOME': '/home/cltbld', 09:13:54 INFO - 'LANG': 'en_US.UTF-8', 09:13:54 INFO - 'LANGUAGE': 'en_US:en', 09:13:54 INFO - 'LOGNAME': 'cltbld', 09:13:54 INFO - 'MAIL': '/var/mail/cltbld', 09:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:54 INFO - 'MOZ_NO_REMOTE': '1', 09:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:54 INFO - 'NO_EM_RESTART': '1', 09:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:54 INFO - 'PWD': '/builds/slave/test', 09:13:54 INFO - 'SHELL': '/bin/bash', 09:13:54 INFO - 'SHLVL': '1', 09:13:54 INFO - 'TERM': 'linux', 09:13:54 INFO - 'TMOUT': '86400', 09:13:54 INFO - 'USER': 'cltbld', 09:13:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:54 INFO - '_': '/tools/buildbot/bin/python'} 09:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:13:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:13:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:57 INFO - Downloading docopt-0.6.1.tar.gz 09:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:13:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:13:57 INFO - Running setup.py install for blobuploader 09:13:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:13:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:13:57 INFO - Running setup.py install for requests 09:13:57 INFO - Running setup.py install for docopt 09:13:57 INFO - Successfully installed blobuploader requests docopt 09:13:57 INFO - Cleaning up... 09:13:58 INFO - Return code: 0 09:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:58 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:13:58 INFO - Using env: {'DISPLAY': ':0', 09:13:58 INFO - 'HOME': '/home/cltbld', 09:13:58 INFO - 'LANG': 'en_US.UTF-8', 09:13:58 INFO - 'LANGUAGE': 'en_US:en', 09:13:58 INFO - 'LOGNAME': 'cltbld', 09:13:58 INFO - 'MAIL': '/var/mail/cltbld', 09:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:58 INFO - 'MOZ_NO_REMOTE': '1', 09:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:58 INFO - 'NO_EM_RESTART': '1', 09:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:58 INFO - 'PWD': '/builds/slave/test', 09:13:58 INFO - 'SHELL': '/bin/bash', 09:13:58 INFO - 'SHLVL': '1', 09:13:58 INFO - 'TERM': 'linux', 09:13:58 INFO - 'TMOUT': '86400', 09:13:58 INFO - 'USER': 'cltbld', 09:13:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:58 INFO - '_': '/tools/buildbot/bin/python'} 09:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:58 INFO - Running setup.py (path:/tmp/pip-CqEDhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:58 INFO - Running setup.py (path:/tmp/pip-bh2t4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:58 INFO - Running setup.py (path:/tmp/pip-dnjfFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:58 INFO - Running setup.py (path:/tmp/pip-Z5vVjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:58 INFO - Running setup.py (path:/tmp/pip-C8nq6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:58 INFO - Running setup.py (path:/tmp/pip-9GDdVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:58 INFO - Running setup.py (path:/tmp/pip-L08yPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:58 INFO - Running setup.py (path:/tmp/pip-8tkK10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:58 INFO - Running setup.py (path:/tmp/pip-u4q0dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:58 INFO - Running setup.py (path:/tmp/pip-7MN4Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:58 INFO - Running setup.py (path:/tmp/pip-HTEy36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:59 INFO - Running setup.py (path:/tmp/pip-D3F2e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:59 INFO - Running setup.py (path:/tmp/pip-zUXARc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:59 INFO - Running setup.py (path:/tmp/pip-VDbxMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:59 INFO - Running setup.py (path:/tmp/pip-jCRggK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:59 INFO - Running setup.py (path:/tmp/pip-PErsUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:59 INFO - Running setup.py (path:/tmp/pip-yxV2iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:13:59 INFO - Running setup.py install for manifestparser 09:13:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:13:59 INFO - Running setup.py install for mozcrash 09:13:59 INFO - Running setup.py install for mozdebug 09:13:59 INFO - Running setup.py install for mozdevice 09:13:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:13:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:13:59 INFO - Running setup.py install for mozfile 09:13:59 INFO - Running setup.py install for mozhttpd 09:14:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Running setup.py install for mozinfo 09:14:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Running setup.py install for mozInstall 09:14:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Running setup.py install for mozleak 09:14:00 INFO - Running setup.py install for mozlog 09:14:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Running setup.py install for moznetwork 09:14:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Running setup.py install for mozprocess 09:14:00 INFO - Running setup.py install for mozprofile 09:14:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Running setup.py install for mozrunner 09:14:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:00 INFO - Running setup.py install for mozscreenshot 09:14:01 INFO - Running setup.py install for moztest 09:14:01 INFO - Running setup.py install for mozversion 09:14:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:01 INFO - Cleaning up... 09:14:01 INFO - Return code: 0 09:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:01 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:14:01 INFO - Using env: {'DISPLAY': ':0', 09:14:01 INFO - 'HOME': '/home/cltbld', 09:14:01 INFO - 'LANG': 'en_US.UTF-8', 09:14:01 INFO - 'LANGUAGE': 'en_US:en', 09:14:01 INFO - 'LOGNAME': 'cltbld', 09:14:01 INFO - 'MAIL': '/var/mail/cltbld', 09:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:01 INFO - 'MOZ_NO_REMOTE': '1', 09:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:01 INFO - 'NO_EM_RESTART': '1', 09:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:01 INFO - 'PWD': '/builds/slave/test', 09:14:01 INFO - 'SHELL': '/bin/bash', 09:14:01 INFO - 'SHLVL': '1', 09:14:01 INFO - 'TERM': 'linux', 09:14:01 INFO - 'TMOUT': '86400', 09:14:01 INFO - 'USER': 'cltbld', 09:14:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:01 INFO - '_': '/tools/buildbot/bin/python'} 09:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:01 INFO - Running setup.py (path:/tmp/pip-wsr2z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:01 INFO - Running setup.py (path:/tmp/pip-HJub95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:01 INFO - Running setup.py (path:/tmp/pip-BzLYAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:01 INFO - Running setup.py (path:/tmp/pip-UKUHUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:01 INFO - Running setup.py (path:/tmp/pip-bCVI5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:01 INFO - Running setup.py (path:/tmp/pip-qZVD65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:01 INFO - Running setup.py (path:/tmp/pip-fsk2zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:01 INFO - Running setup.py (path:/tmp/pip-9gUhlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:02 INFO - Running setup.py (path:/tmp/pip-oHNcWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:02 INFO - Running setup.py (path:/tmp/pip-G7gP3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:02 INFO - Running setup.py (path:/tmp/pip-xvt2Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:02 INFO - Running setup.py (path:/tmp/pip-yUsn5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:02 INFO - Running setup.py (path:/tmp/pip-btO4jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:02 INFO - Running setup.py (path:/tmp/pip-tyj5lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:02 INFO - Running setup.py (path:/tmp/pip-6paLsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:02 INFO - Running setup.py (path:/tmp/pip-HNbDeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:02 INFO - Running setup.py (path:/tmp/pip-uXAewG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:04 INFO - Downloading blessings-1.6.tar.gz 09:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:04 INFO - Installing collected packages: blessings 09:14:04 INFO - Running setup.py install for blessings 09:14:04 INFO - Successfully installed blessings 09:14:04 INFO - Cleaning up... 09:14:04 INFO - Return code: 0 09:14:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:05 INFO - Reading from file tmpfile_stdout 09:14:05 INFO - Current package versions: 09:14:05 INFO - argparse == 1.2.1 09:14:05 INFO - blessings == 1.6 09:14:05 INFO - blobuploader == 1.2.4 09:14:05 INFO - docopt == 0.6.1 09:14:05 INFO - manifestparser == 1.1 09:14:05 INFO - mozInstall == 1.12 09:14:05 INFO - mozcrash == 0.17 09:14:05 INFO - mozdebug == 0.1 09:14:05 INFO - mozdevice == 0.48 09:14:05 INFO - mozfile == 1.2 09:14:05 INFO - mozhttpd == 0.7 09:14:05 INFO - mozinfo == 0.9 09:14:05 INFO - mozleak == 0.1 09:14:05 INFO - mozlog == 3.1 09:14:05 INFO - moznetwork == 0.27 09:14:05 INFO - mozprocess == 0.22 09:14:05 INFO - mozprofile == 0.28 09:14:05 INFO - mozrunner == 6.11 09:14:05 INFO - mozscreenshot == 0.1 09:14:05 INFO - mozsystemmonitor == 0.0 09:14:05 INFO - moztest == 0.7 09:14:05 INFO - mozversion == 1.4 09:14:05 INFO - psutil == 3.1.1 09:14:05 INFO - requests == 1.2.3 09:14:05 INFO - wsgiref == 0.1.2 09:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:14:05 INFO - Using env: {'DISPLAY': ':0', 09:14:05 INFO - 'HOME': '/home/cltbld', 09:14:05 INFO - 'LANG': 'en_US.UTF-8', 09:14:05 INFO - 'LANGUAGE': 'en_US:en', 09:14:05 INFO - 'LOGNAME': 'cltbld', 09:14:05 INFO - 'MAIL': '/var/mail/cltbld', 09:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:05 INFO - 'MOZ_NO_REMOTE': '1', 09:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:05 INFO - 'NO_EM_RESTART': '1', 09:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:05 INFO - 'PWD': '/builds/slave/test', 09:14:05 INFO - 'SHELL': '/bin/bash', 09:14:05 INFO - 'SHLVL': '1', 09:14:05 INFO - 'TERM': 'linux', 09:14:05 INFO - 'TMOUT': '86400', 09:14:05 INFO - 'USER': 'cltbld', 09:14:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:05 INFO - '_': '/tools/buildbot/bin/python'} 09:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:14:05 INFO - Cleaning up... 09:14:05 INFO - Return code: 0 09:14:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:05 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 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:14:05 INFO - Using env: {'DISPLAY': ':0', 09:14:05 INFO - 'HOME': '/home/cltbld', 09:14:05 INFO - 'LANG': 'en_US.UTF-8', 09:14:05 INFO - 'LANGUAGE': 'en_US:en', 09:14:05 INFO - 'LOGNAME': 'cltbld', 09:14:05 INFO - 'MAIL': '/var/mail/cltbld', 09:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:05 INFO - 'MOZ_NO_REMOTE': '1', 09:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:05 INFO - 'NO_EM_RESTART': '1', 09:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:05 INFO - 'PWD': '/builds/slave/test', 09:14:05 INFO - 'SHELL': '/bin/bash', 09:14:05 INFO - 'SHLVL': '1', 09:14:05 INFO - 'TERM': 'linux', 09:14:05 INFO - 'TMOUT': '86400', 09:14:05 INFO - 'USER': 'cltbld', 09:14:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:05 INFO - '_': '/tools/buildbot/bin/python'} 09:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:05 INFO - Downloading/unpacking jsonschema 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:08 INFO - Downloading/unpacking functools32 (from jsonschema) 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:08 INFO - warning: no files found matching '*.txt' 09:14:08 INFO - no previously-included directories found matching 'build' 09:14:08 INFO - no previously-included directories found matching 'dist' 09:14:08 INFO - no previously-included directories found matching '.git*' 09:14:08 INFO - Installing collected packages: jsonschema, functools32 09:14:08 INFO - Running setup.py install for functools32 09:14:08 INFO - warning: no files found matching '*.txt' 09:14:08 INFO - no previously-included directories found matching 'build' 09:14:08 INFO - no previously-included directories found matching 'dist' 09:14:08 INFO - no previously-included directories found matching '.git*' 09:14:08 INFO - Successfully installed jsonschema functools32 09:14:08 INFO - Cleaning up... 09:14:08 INFO - Return code: 0 09:14:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa24488ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:14:08 INFO - Using env: {'DISPLAY': ':0', 09:14:08 INFO - 'HOME': '/home/cltbld', 09:14:08 INFO - 'LANG': 'en_US.UTF-8', 09:14:08 INFO - 'LANGUAGE': 'en_US:en', 09:14:08 INFO - 'LOGNAME': 'cltbld', 09:14:08 INFO - 'MAIL': '/var/mail/cltbld', 09:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:08 INFO - 'MOZ_NO_REMOTE': '1', 09:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:08 INFO - 'NO_EM_RESTART': '1', 09:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:08 INFO - 'PWD': '/builds/slave/test', 09:14:08 INFO - 'SHELL': '/bin/bash', 09:14:08 INFO - 'SHLVL': '1', 09:14:08 INFO - 'TERM': 'linux', 09:14:08 INFO - 'TMOUT': '86400', 09:14:08 INFO - 'USER': 'cltbld', 09:14:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:08 INFO - '_': '/tools/buildbot/bin/python'} 09:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:09 INFO - Downloading/unpacking flake8 09:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:14:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:14:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:14:11 INFO - no previously-included directories found matching 'docs/_build' 09:14:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:14:11 INFO - Running setup.py install for pep8 09:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:14:11 INFO - no previously-included directories found matching 'docs/_build' 09:14:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:14:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:14:11 INFO - Cleaning up... 09:14:11 INFO - Return code: 0 09:14:11 INFO - Running post-action listener: _resource_record_post_action 09:14:11 INFO - Running post-action listener: _start_resource_monitoring 09:14:11 INFO - Starting resource monitoring. 09:14:11 INFO - ##### 09:14:11 INFO - ##### Running install step. 09:14:11 INFO - ##### 09:14:11 INFO - Running pre-action listener: _resource_record_pre_action 09:14:11 INFO - Running main action method: install 09:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:12 INFO - Reading from file tmpfile_stdout 09:14:12 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:12 INFO - Reading from file tmpfile_stdout 09:14:12 INFO - Output received: 09:14:12 INFO - Usage: mozinstall [options] installer 09:14:12 INFO - Options: 09:14:12 INFO - -h, --help show this help message and exit 09:14:12 INFO - -d DEST, --destination=DEST 09:14:12 INFO - Directory to install application into. [default: 09:14:12 INFO - "/builds/slave/test"] 09:14:12 INFO - --app=APP Application being installed. [default: firefox] 09:14:12 INFO - mkdir: /builds/slave/test/build/application 09:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:14:24 INFO - Reading from file tmpfile_stdout 09:14:24 INFO - Output received: 09:14:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:14:24 INFO - Running post-action listener: _resource_record_post_action 09:14:24 INFO - ##### 09:14:24 INFO - ##### Running run-tests step. 09:14:24 INFO - ##### 09:14:24 INFO - Running pre-action listener: _resource_record_pre_action 09:14:24 INFO - Running main action method: run_tests 09:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:24 INFO - Python 2.7.3 09:14:24 INFO - Return code: 0 09:14:24 INFO - grabbing minidump binary from tooltool 09:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:24 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 0x141d160>, '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 0x141e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:14:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:14:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:24 INFO - Return code: 0 09:14:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:14:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:14:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:14:26 INFO - Return code: 0 09:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:14:26 INFO - Using env: {'DISPLAY': ':0', 09:14:26 INFO - 'HOME': '/home/cltbld', 09:14:26 INFO - 'LANG': 'en_US.UTF-8', 09:14:26 INFO - 'LANGUAGE': 'en_US:en', 09:14:26 INFO - 'LOGNAME': 'cltbld', 09:14:26 INFO - 'MAIL': '/var/mail/cltbld', 09:14:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:26 INFO - 'MOZ_NO_REMOTE': '1', 09:14:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:26 INFO - 'NO_EM_RESTART': '1', 09:14:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:26 INFO - 'PWD': '/builds/slave/test', 09:14:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:26 INFO - 'SHELL': '/bin/bash', 09:14:26 INFO - 'SHLVL': '1', 09:14:26 INFO - 'TERM': 'linux', 09:14:26 INFO - 'TMOUT': '86400', 09:14:26 INFO - 'USER': 'cltbld', 09:14:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642', 09:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:26 INFO - '_': '/tools/buildbot/bin/python'} 09:14:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:14:26 INFO - mozversion application_buildid: 20160526064139 09:14:26 INFO - mozversion application_changeset: 5564b762402e5c577f720c88244baeb641738b39 09:14:26 INFO - mozversion application_display_name: Firefox 09:14:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:26 INFO - mozversion application_name: Firefox 09:14:26 INFO - mozversion application_remotingname: firefox 09:14:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:14:26 INFO - mozversion application_vendor: Mozilla 09:14:26 INFO - mozversion application_version: 47.0 09:14:26 INFO - mozversion platform_buildid: 20160526064139 09:14:26 INFO - mozversion platform_changeset: 5564b762402e5c577f720c88244baeb641738b39 09:14:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:14:26 INFO - mozversion platform_version: 47.0 09:14:26 INFO - using testdate: 1464279266 09:14:26 INFO - actual date: 1464279266 09:14:26 INFO - starting webserver on 'localhost:38824' 09:14:26 INFO - SUITE-START | Running 2 tests 09:14:26 INFO - TEST-START | dromaeo_css 09:14:26 INFO - operating with platform_type : linux_ 09:14:26 INFO - Initialising browser for dromaeo_css test... 09:14:26 INFO - TEST-INFO | started process 6712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpydxpdF/profile http://localhost:38824/getInfo.html) 09:14:30 INFO - PROCESS | 6712 | __metrics Screen width/height:1600/1200 09:14:30 INFO - PROCESS | 6712 | colorDepth:24 09:14:30 INFO - PROCESS | 6712 | Browser inner width/height: 1024/697 09:14:30 INFO - PROCESS | 6712 | __metrics 09:14:31 INFO - PROCESS | 6712 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:32 INFO - TEST-INFO | 6712: exit 0 09:14:32 INFO - Browser initialized. 09:14:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:32 INFO - TEST-INFO | started process 6802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpydxpdF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:43 INFO - PROCESS | 6802 | RSS: Main: 138571776 09:14:43 INFO - PROCESS | 6802 | 09:15:35 INFO - PROCESS | 6802 | 1464279335169 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:17:42 INFO - PROCESS | 6802 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38824/tests/dromaeo/cssquery-ext.html) 09:17:43 INFO - PROCESS | 6802 | RSS: Main: 214228992 09:17:43 INFO - PROCESS | 6802 | 09:20:45 INFO - PROCESS | 6802 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-ext.html (next: http://localhost:38824/tests/dromaeo/cssquery-jquery.html) 09:20:45 INFO - PROCESS | 6802 | RSS: Main: 225005568 09:20:45 INFO - PROCESS | 6802 | 09:23:47 INFO - PROCESS | 6802 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38824/tests/dromaeo/cssquery-mootools.html) 09:23:48 INFO - PROCESS | 6802 | RSS: Main: 213028864 09:23:48 INFO - PROCESS | 6802 | 09:26:49 INFO - PROCESS | 6802 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38824/tests/dromaeo/cssquery-prototype.html) 09:26:50 INFO - PROCESS | 6802 | RSS: Main: 203620352 09:26:50 INFO - PROCESS | 6802 | 09:29:52 INFO - PROCESS | 6802 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38824/tests/dromaeo/cssquery-yui.html) 09:29:53 INFO - PROCESS | 6802 | RSS: Main: 203554816 09:29:53 INFO - PROCESS | 6802 | 09:32:55 INFO - PROCESS | 6802 | Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-yui.html (next: http://localhost:38824/tests/dromaeo/cssquery-dojo.html) 09:32:56 INFO - PROCESS | 6802 | RSS: Main: 246263808 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | __start_tp_report 09:32:56 INFO - PROCESS | 6802 | _x_x_mozilla_page_load 09:32:56 INFO - PROCESS | 6802 | _x_x_mozilla_page_load_details 09:32:56 INFO - PROCESS | 6802 | |i|pagename|runs| 09:32:56 INFO - PROCESS | 6802 | |0;dojo.html;3256.6743325667435;3316.3698897209542;3323.8171900545467;3335.48300013498;3352.21223012592;5221.425643179247;5236.057509648262;5244.160934250521;5247.632665713397;5247.86880327991;5245.763940622672;5259.289995850559;5282.049231138403;5290.576753859692;5301.41684414715;4756.167670657638;4779.761011949415;4820.590249828751;4834.347363105989;4881.4630390657;4818.59041981432;4841.878953026185;4880.292357608145;4883.804647814083;4884.120858245515;4814.951850481503;4871.975640121795;4873.902521949577;4890.021995600876;4933.1120398328285;4804.159272127398;4833.202521583935;4906.092372911023;4935.284383764352;4937.728424936627;4747.454042785055;4814.590759785422;4835.081334546425;4868.805247790084;4874.683145595525;5072.213806859942;5134.948650513485;5138.820141295074;5151.072806894795;5171.7672704728375;5682.801101961453;5718.34239062509;5719.056355701305;5720.914186287209;5723.771049158028;5624.100143976985;5669.433056694339;5712.11462223356;5722.456366645162;5741.511971482429;5325.201219817059;5328.866778330534;5331.200319952039;5334.093204155303;5357.464253574651;5804.9419505805245;5805.216295800097;5806.361300256968;5807.796727114531;5831.475167234969;5499.312585926759;5527.723613819293;5578.553715702815;5590;5591.3569939456665;5693.686847223443;5696.401877802854;5696.515796157373;5697.914531282034;5721.599488035798;5654.688992105392;5656.462636049569;5661.631993920382;5661.773529058792;5662.065759149777;5565.833025009256;5648.717564121777;5654.943450565524;5729.1119876419225;5745.798897038583;4342.34864770287;4352.586504282088;4356.106998065389;4356.411884395629;4375.16871794358;3947.5657677655436;3961.3067713150085;3968.1865217630316;3986.2824691555797;3996.500437445319;5342.225377320345;5452.263944367539;5521.723913804293;5528.06022976095;5552.666839989613;5687.800926967537;5704.3154821421695;5711.857203569944;5719.3422756382715;5728.341240757366;5378.650387724785;5444.646098003617;5469.480399362054;5494.203340515683;5497.202905578749;4827.686200396963;4871.610271178297;4881.341018962395;4894.559489645949;4900.2894580286375;5979.970100149471;6038.245219347582;6039.758409663565;6044.848878778066;6046.939530604637;5626.2685850839125;5725.599208055396;5743.59794814359;5770.221020162392;5775;5898.997170480942;5900.43945825146;5905.261842269716;5909.527237820878;5914.378990205966;5555.694436805853;5558.749856256559;5564.582656300713;5575.470330318613;5586.52514536269;5610.354809196831;5676.063449530781;5682.204491371129;5736.053551164011;5797.014507533645;5610.298712660918;5636.85907852307;5638.041532939328;5638.21065050885;5646.407127251744;5596.4123767003875;5633.0987042073075;5644;5644.407337229696;5650.660960342392;5398.703071330958;5484.122540393678;5494.1758736189895;5564.304461942257;5591.524720398812;5495.230667706604;5540.584456165884;5575;5641.351244606923;5695.401982791747;5390.541803946551;5452.754626041917;5453.10023846061;5458.153986132156;5489.698066606375 09:32:56 INFO - PROCESS | 6802 | |1;ext.html;530.7372850439033;556.9387367389588;573.905305624572;596.6479776931609;600.111834484962;30139.849300753493;31001;39059.60940390595;39523;39530.80234598823;43195.78402107985;43604;43611.78194109033;43630.7818460908;43636.56363436364;8780.209781119698;8952.328575356842;8960.193582577567;8980.59587318569;8980.775480612972;8710;8861.867071993925;8862.734117976439;8868.379213455028;8870.467771933672;8870.06864279251;8953.194212520872;9110.45337279762;9111.863322050174;9174.449533028039;8985.95507022464;9060.229880460169;9060.592273347715;9060.637574497045;9065.184133427958;8944.552772361356;9077.409968352036;9080.8637870432;9081.500517471537;9084.409513381675;42703.35944960828;42914.78542607267;43045;43064.1387172258;43144.352834707504;3723.2181241939224;3826.215625796705;3840.7503512271614;3884.9028774280587;4458.0415210729525;31167.844160779277;31264.843675781703;31327.53008704871;31349.216269593213;32692.83653581717;4233.25917964355;4279.422277992493;4366.716163449366;4369.082492676542;4410.6030457259;283550;289785;289852.2029559397;290354;290567;47650.76174619105;48626.51373486291;70227.29772702309;71538.64230678813;71708.28291717016;47631;48348.27477587839;48356;48379;48402;16714.665706686043;16873.831261687472;16903.492895213163;16905.7464138038;16921.915390423215;13322;13330.533431329857;13402.329883505785;13446;13459.663508412172;16281.104539250218;16319.673606527804;16448;16454.177291135395;16512;6247.156633854372;6410.775622853178;6440.903386449207;6467.547271690936;6548.967255163694;1041.9322744021615;1116.7264020314913;1123.4719681749564;1148.8851114888444;1169.181572898974;30444.391112177633;30733.23166920845;30845.537316940263;31420.37159256802;31441.371172576877;1125.27419814221;1164.5923926625612;1172.8123500239922;1179.1510112719;1288.4395288049727;16082.597935051717;16161.191940403169;16303.918480407521;16338.591535211715;16511.587210319838;327622;329754;331088;331227;331707;58382.12426813601;58921.705391472766;58962.705186473795;59046.22861314168;59068.40931590629;1380.8895288377107;1457.2203870929002;1468.875145612635;1482.3181336585292;1505.533284681752;27915.581266280617;28259.293517662223;28283.575746364233;29105;30682.079537613015;47115.528844711116;47461.52538474571;47541.28688069751;47674.76162619165;47701;192124;204755;205045;206063;206079;30511.84744076354;35235.82382088073;35846;35853.46219806757;37127.62872371242;41314.1737165261;41788.373174403016;41997.79001104975;42002;42369.36445953252;35251.82374088216;35403.114922127155;35459;35478.29043419169;35927.28145437024;36596.81701591475;36912.261754764215;36912.630873692;37388.813055934545;37398.252034959696;37060.81469592635;37154;42103;43092.78453607712;43225.91935201645;30773.23066923345;32609.836950815094;33537;33630.831845840614;35755.28489430145;26964.73035269622;27485.31286717848;27564.724352756217;27901.162965111078;27958.72041279561 09:32:56 INFO - PROCESS | 6802 | |2;jquery.html;365.512041424698;370.64603303844825;373.676769594301;374.56737468224196;375.16712897367836;17621.383251586198;18029.368972085962;18261.908690456545;18392;18399.172037258322;16584.751228731548;17376.485522094146;17836.375726849565;17840.197191126397;17854.196561154746;5550.77796888125;5740.540756739471;5754.5108665763255;5778.884422311572;5786.392428794979;4196.055887425336;4327.913441731163;5682.687452190128;6105.419985101408;6297.622142671455;6228.781992630259;6253.343398943114;6264.123022776815;6264.812055638338;6266.905996410058;6100.664463454508;6173.969130154365;6219.5957262778;6239.87520249597;6309.968450157743;3729.776213427203;5378.327709036371;5487.286652735159;5559.277293951801;5563.443655634444;19789.604207915905;20413.69379459309;20490.487737806674;20637.587248255102;20695.89652051745;2489.352768280242;2599.9350016249555;2614.843109413441;2691.1388355726176;2818.041865765629;6390.7763228286785;7151.891456824201;12288.385580721018;13572.932135339359;13787;1894.479018269973;1909.1313452379134;1939.6896496560482;1944.0377013378327;1955.2667749593902;59606.70196649032;59784.103238451455;59818.700906495185;61085.08372374418;61914;9297.116773906468;9604.183644390165;9777.853332200022;9926.404415735078;9949.303548751517;13674.111182773087;13756.65608359799;13762.380692868845;13774.517891873737;13874.93062534681;7952.443328967032;8000.4399692021;8024.799380015546;8040.437169398203;8068.47554908929;7998.280154786097;8045.436819422584;8128.512289262545;8130.3495720342235;8135.3491720662205;5923.466887980103;6073.180120683651;6086.695665216722;6100.267967843887;6116.969415152896;1652.9752053719203;1667.7415000674914;1685.9578510537335;1724.2240991553851;1835.320931255444;634.9396807303299;1022.555188492993;1023.8361862102176;1069.7486090768664;1106.0211712634377;17257;17571.912140439217;17612.735808962876;17670.965375732252;18131.72802407965;1038.89611038897;1050.4012712753656;1054.862867827193;1083.7019819549687;1112.8553288072499;8689.652413903374;10302.381857088449;10523.736906577396;10591.258611897247;10737.892621073846;430317;431081;442988;443294;450552;65359.67320163369;67456;67482;68661.65669171722;69129.30870691329;1101.4492753623188;1127.3855748617023;1162.0703437250165;1175.312442221293;1175.5944199251244;16011.759823602422;16034.759478607597;16062.43781467643;16133.919330403272;16234.18829058566;31168.53247201339;31987.840060799546;32599.18502037468;32799.50800737943;33524;42251.3662295072;43838.34242486429;44234.3364849534;44335.334969976124;44365.33451998158;7619;7687.88468172989;7787;7869.0950540688555;7904.051513818378;7751.457397982087;11611.47748351343;11620.709482263012;12182.939085304517;12335.69160770988;9731.610735570497;9797.85303220438;10066;10104.292699510963;10224.33541819809;10305.124064454605;10461.320014199053;10692.465376730977;10816.242862999514;11080.224384293022;9644.903550964682;9869.013098690073;10338;10354.1198998083;10455.634052808115;7812.765617031499;7827;7893.447458677838;7951.920480795118;7993.6802527898235;9993.250506212209;10003.469296723935;10193.439360835226;10300.587976480856;10363 09:32:56 INFO - PROCESS | 6802 | |3;mootools.html;1546.8530489603488;1570.387548855946;1801.171461127881;1931.661959157147;1976.6738488149465;8117.350611951045;8218.712345067925;8254.669813207465;8271.090180080186;8296.834063318738;8138.91861081389;8170.346372290217;8176.550289734062;8183.386246031541;8200.466969646985;2349.2364981381033;2390.486045500217;2397.1609936522163;2407.711074671033;2416.66166736657;2412.8190385721055;2430.3924018995253;2446.6696995905504;2446.706395232575;2447.9755202448014;2037.9694304585444;2261.479859632277;2290.2556669082533;2399.8320117591775;2421.4188594737225;2269.012979353978;2282.075759317479;2295.0819672131197;2296.1619009061574;2298.1496846166856;2250.988745056264;2268.5122698619875;2271.8409711320214;2276.8747718875456;2300.2754132448395;7040.683169257396;7183.604901730403;7845.607719613997;8018.238267364591;8064.596770161468;4849.806007759686;4962.62780291476;4969;4969.503049695038;4972.825951091694;3141.1204862638497;3155.2742869140225;3174.365126974614;3192.5690031845634;3212.1648371423366;1073.9194560408;1075.7256899490658;1079.282277285604;1120.2774210634095;1130.3782919394382;11440.713982150513;11531.423428828524;11539.769204615945;11542.480588373543;11555.94222028893;4330.761808100522;4469.726128053489;4470.307102399133;4488.9102217956115;4496.213162696515;10008.599656013677;10012.24908131893;10019.749506262402;10029.04724051214;10086.697399078039;5086.3133476980875;5093.949060509348;5097.490250974947;5098.1842905135;5098.974505127525;4553.658475614342;4581.175388430114;4650.720956742606;4658.813647454064;4659.720416775004;3627.691646210049;3628.4920111184456;3636.7272454566014;3657.9817100914324;3673.8897833064516;1178.6935396796723;1198.898093662031;1214.4110106598293;1217.056780994736;1223.1988047828509;1059.3273271472517;1142.765733024728;1212.4240985531978;1249.881261280177;1413.3498590648417;7706.7687969361;7768;7809.219078092259;7810.1799311072655;7811.140774514799;1086.2342048855537;1168.526746667601;1187.2460987273143;1217.713837248246;1233.2415564427993;6203.286622038523;6229.065640154013;6231.40801623845;6284.402981716729;6292.937070629327;9747.951260243795;10155.441450720282;10282.434466104287;10294.485275736333;10439.321444106108;10095.697129086138;10105.090541851268;10217.591296348062;10260.743481413025;10362.067413932631;7963.721269755647;7973.720919767897;7986.321162701235;7997.160298168725;8078.7172448965175;7656.349210317186;7723.613819309125;7744.631085477835;7761.146273909752;7786.338161256356;9043.773905652411;9085.909140908507;9188.494632794993;9194.356395052282;9195.724128276162;9291.62833486653;9310.394824336396;9419.105185007413;9517.666881659108;9517.952410238182;6986.650667466504;7071.540349877241;7075.363217310467;7076.115485564304;7081.964590177016;7916.802079948047;8082.7171049013;8136.430449868689;8138.83722325562;8142.18578142181;7418.36943859778;7475.514091584029;7485.401167906663;7532.661030253542;7574.583397913168;7245.094363204599;7319.377852882564;7333.523320984119;7396.96301518489;7497.175310715707;7048.612326322102;7178.28217178278;7215.927840721525;7216.386607138242;7730;6701.396874281338;6717.093192419156;6723.193216814014;6729.192496900403;6763.086983257197;6657.4674026078765;6789.72841086351;6811.489138314547;6939.30606939302;6988.510804243858 09:32:56 INFO - PROCESS | 6802 | |4;prototype.html;316.4272666473683;321.17778487073093;322.64831333846104;323.1033880980278;327.52181814550755;5816.243888294526;5840.620359676624;5852.707364631768;5854.912176317359;5873.735681894314;5740.971295143529;5756.625819321741;5844.503217226541;5851.76592936282;5868.207791948085;4291.163223171483;4390.780460976955;4485.7757112144345;4502.617277531397;4547;4511.097780443908;4520.321951707254;4523.8642840714665;4533.9319910201375;4538.773061346936;4472.262076757331;4475.709078909877;4477.037436951055;4487.416635837353;4488.910221795562;4197.769122698251;4327.653787696977;4415.072834704716;4445;4461.527695860358;3913.25648126855;3923.8234279457206;3927.19492504036;3930.803459827026;3937.1535119949062;5494.038543254915;5497.285352904097;5507.0637991541535;5518.2826232589905;5520.254765606632;5200.97399513;5211.270422140903;5219.295395121648;5222.4255331913455;5223.529882310572;6178.104174894615;6191.288001879751;6206.286277078104;6206.596571222901;6206.782762603287;4076.7961601919787;4198.391233271189;4209.452771139732;4349.934750978738;4355.194289056535;6407.583507072072;6452.161219041494;6459.09572659828;6473.708683109225;6488.643124628144;4339.34909763538;4343.587359200871;4343.717658352197;4344.739315641072;4353.455818022747;4349.064951035542;4361.760103194291;4366.279563871925;4371.103923695635;4403.427554417969;5118.411382690963;5129.794808207705;5130.538251557377;5131.358580177478;5132;5981.6710080945095;6246.562740608114;6249.156363890907;6253.1245625612455;6257.217847769029;1511.7959075524884;1530.6096945278882;1537.2237020304674;1539.3226980128707;1539.7844301797757;933.803901180746;969.6715499765367;997.9322125325832;1010.9443980580992;1020.5611587017505;5905.202797622352;5905.911411328833;5969.2240008799445;5970.104484327298;6021.066734656135;6251.718672659741;6266;6281.434670879643;6287.748490060438;6289.24529056507;5865.266841644794;5932.139839723216;5952.226210592682;5980.491658209014;5995;3403.829808509565;3440.535527703778;3450.6721861423125;3452.205992621711;3452.5511683480986;6547.803565893031;6586.604803711793;6598.7030583623855;6803.217629972616;6844.8973265401055;6628.767993120217;6664.83337916556;6665.533412661067;6668.933310666928;6683.699233534503;6796.082528858541;6800.8299792504595;6805.6597170141295;6815.556988795812;6829.69266383004;6482.740690372332;6484.643344616092;6486.5783724059675;6491.772787952399;6494.935050649433;6157.261128664589;6363.077353783768;6379.776707815204;6385.169927909342;6394.200724909387;6765.357291057342;6768.390844823989;6775.559588626724;6806.42145417645;6818.8636227276165;4319.956800432081;4342.240107981153;4353.238183317843;4358.455193100863;4372.562743725602;6424.357564243725;6477.967610161919;6484.902726459201;6490.902636460552;6493.967530162319;6272.153259310117;6279.96860015697;6300.905486417799;6301.275353334242;6306.400891915261;6091.451769340781;6300.369963003663;6319.842003949938;6320.083587879823;6322.399372059647;6109.358517355791;6148.292946311052;6179.81460556184;6186.226721659793;6196.690165491617;6285.74857005733;6339.651319177489;6339.778107766206;6342.365763423621;6352.841178970378;5904.439078287556;5973.880522389615;6180.567360284737;6183.165272688129;6184.257889053162 09:32:56 INFO - PROCESS | 6802 | |5;yui.html;809.6397103289039;851.3955091884761;865.0484467086206;877.8683197520368;888.7022847346138;14402;14564.781528277057;14612.561623151323;14648.926755366221;14715.043522171065;13639.454421823115;14326.785098223509;14348.282585870717;14370.928145359285;14372.49696260631;761.7676608634364;775.3022279948035;775.5269285735696;914.862770584411;931.776373670321;918.5177781664613;939.9577019034126;940.7742141885966;941.4633658814479;941.5480569326727;1007.9193664506822;1011.0597144655468;1013.8986101389876;1014.4775440648073;1014.9340292880939;623.6414061914372;631.4033238589535;1008.9293749437543;1009.5457044330044;1011.9392836429801;718.1956209045902;727.4471401734667;729.0704351951251;732.8900664900254;734.0933946575974;14511.1293322401;14571.489997850025;14615.488457903923;14642.341094650767;14645.780313295309;14089.929550352183;14483.42066317346;14653.340599672934;14662.706745865024;14817.70364592702;11571.884281157165;11704.70738231551;11875;12098.516059357615;12115.212511186834;3802.258559580883;3817.9045523861846;3844.5386553613744;3912.374020156761;3919.686425086015;49006;49261;49320.75339623279;49664.75167624139;49677.751611241714;9864.506774661239;10165.847512287322;10243.334183278212;10331.896681033244;10367.170626349875;17633.382831600833;17698.380556680455;17699.38052168168;17745.290188392577;17777.377791777486;8142.715004974916;8146.674133034612;8455.577221138918;8559.828803423896;8583;4713.2458806590785;4773.212419950669;4874.926876096862;4929.926051109236;4995.075910956485;3187.2509960159346;3230.596175478065;3230.8707651693667;3238.6923242291946;3241.173500757292;575.1746244139673;579.8086631411624;580.5210701171551;593.1162567774072;594.230471539349;547.4416095582484;598.9907006693735;612.6385432594791;675.3347952267013;705.2489099109432;8469.491830490191;8493.617787199591;8494.06565277819;8511.872321915176;8933.419327743675;683.7914436096938;689.7689274093135;691.9723211071602;713.9500234983501;716.3982254905904;4049.797510124482;4059.878203653895;4071.531773845986;4103.876883693494;4121.052158003676;62244.37755622476;62786;63674.68162659157;63897;64132.67933660302;54076;55080.724596377564;55372;55528;55688.443115569135;48465.515344846805;48540.51459485431;50288.49711502838;50334.24498632523;50935.745321273156;8014.879776803469;8050.919490805017;8095;8164.469309494863;8229.218224268685;38079.23841523099;38585.614143858205;39223.2155356897;39433.40849887311;39440.40839387354;45526.54473455223;46108.30837537507;48983.26525102055;50301.24548131854;50750.23874641957;10130.949345253226;10195.694129176136;10398.792024159626;10484.737881552717;10553.472326383804;11096.167787415814;11096.5561377544;11356.148288878201;11364.318140911571;11589.24669896454;9977.151942085004;10119.949400252952;10317.690469285933;10415.583376664848;10467.319624224401;9740;9936.354136981363;9988.200943924323;10094.19246460296;10405.84391234117;10405;10523.210759192938;10525.36847789135;10661.25371224038;10813.459327033774;8649.91350086491;8769.123087691434;8790.340724445565;8809.51547664859;8901.51041692713;8458.450200736932;9741.269404794528;9771.755706107404;10130.797384052425;10195.745106372104 09:32:56 INFO - PROCESS | 6802 | __end_tp_report 09:32:56 INFO - PROCESS | 6802 | __start_cc_report 09:32:56 INFO - PROCESS | 6802 | _x_x_mozilla_cycle_collect,664 09:32:56 INFO - PROCESS | 6802 | __end_cc_report 09:32:56 INFO - PROCESS | 6802 | __startTimestamp1464280376018__endTimestamp 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | ------- Summary: start ------- 09:32:56 INFO - PROCESS | 6802 | Number of tests: 6 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | [#0] dojo.html Cycles:165 Average:5301.99 Median:5521.72 stddev:574.94 (10.4%) stddev-sans-first:553.86 09:32:56 INFO - PROCESS | 6802 | Values: 3256.7 3316.4 3323.8 3335.5 3352.2 5221.4 5236.1 5244.2 5247.6 5247.9 5245.8 5259.3 5282.0 5290.6 5301.4 4756.2 4779.8 4820.6 4834.3 4881.5 4818.6 4841.9 4880.3 4883.8 4884.1 4815.0 4872.0 4873.9 4890.0 4933.1 4804.2 4833.2 4906.1 4935.3 4937.7 4747.5 4814.6 4835.1 4868.8 4874.7 5072.2 5134.9 5138.8 5151.1 5171.8 5682.8 5718.3 5719.1 5720.9 5723.8 5624.1 5669.4 5712.1 5722.5 5741.5 5325.2 5328.9 5331.2 5334.1 5357.5 5804.9 5805.2 5806.4 5807.8 5831.5 5499.3 5527.7 5578.6 5590.0 5591.4 5693.7 5696.4 5696.5 5697.9 5721.6 5654.7 5656.5 5661.6 5661.8 5662.1 5565.8 5648.7 5654.9 5729.1 5745.8 4342.3 4352.6 4356.1 4356.4 4375.2 3947.6 3961.3 3968.2 3986.3 3996.5 5342.2 5452.3 5521.7 5528.1 5552.7 5687.8 5704.3 5711.9 5719.3 5728.3 5378.7 5444.6 5469.5 5494.2 5497.2 4827.7 4871.6 4881.3 4894.6 4900.3 5980.0 6038.2 6039.8 6044.8 6046.9 5626.3 5725.6 5743.6 5770.2 5775.0 5899.0 5900.4 5905.3 5909.5 5914.4 5555.7 5558.7 5564.6 5575.5 5586.5 5610.4 5676.1 5682.2 5736.1 5797.0 5610.3 5636.9 5638.0 5638.2 5646.4 5596.4 5633.1 5644.0 5644.4 5650.7 5398.7 5484.1 5494.2 5564.3 5591.5 5495.2 5540.6 5575.0 5641.4 5695.4 5390.5 5452.8 5453.1 5458.2 5489.7 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | [#1] ext.html Cycles:180 Average:45272.66 Median:37140.81 stddev:72918.25 (196.3%) stddev-sans-first:73045.42 09:32:56 INFO - PROCESS | 6802 | Values: 530.7 556.9 573.9 596.6 600.1 30139.8 31001.0 39059.6 39523.0 39530.8 43195.8 43604.0 43611.8 43630.8 43636.6 8780.2 8952.3 8960.2 8980.6 8980.8 8710.0 8861.9 8862.7 8868.4 8870.5 8870.1 8953.2 9110.5 9111.9 9174.4 8986.0 9060.2 9060.6 9060.6 9065.2 8944.6 9077.4 9080.9 9081.5 9084.4 42703.4 42914.8 43045.0 43064.1 43144.4 3723.2 3826.2 3840.8 3884.9 4458.0 31167.8 31264.8 31327.5 31349.2 32692.8 4233.3 4279.4 4366.7 4369.1 4410.6 283550.0 289785.0 289852.2 290354.0 290567.0 47650.8 48626.5 70227.3 71538.6 71708.3 47631.0 48348.3 48356.0 48379.0 48402.0 16714.7 16873.8 16903.5 16905.7 16921.9 13322.0 13330.5 13402.3 13446.0 13459.7 16281.1 16319.7 16448.0 16454.2 16512.0 6247.2 6410.8 6440.9 6467.5 6549.0 1041.9 1116.7 1123.5 1148.9 1169.2 30444.4 30733.2 30845.5 31420.4 31441.4 1125.3 1164.6 1172.8 1179.2 1288.4 16082.6 16161.2 16303.9 16338.6 16511.6 327622.0 329754.0 331088.0 331227.0 331707.0 58382.1 58921.7 58962.7 59046.2 59068.4 1380.9 1457.2 1468.9 1482.3 1505.5 27915.6 28259.3 28283.6 29105.0 30682.1 47115.5 47461.5 47541.3 47674.8 47701.0 192124.0 204755.0 205045.0 206063.0 206079.0 30511.8 35235.8 35846.0 35853.5 37127.6 41314.2 41788.4 41997.8 42002.0 42369.4 35251.8 35403.1 35459.0 35478.3 35927.3 36596.8 36912.3 36912.6 37388.8 37398.3 37060.8 37154.0 42103.0 43092.8 43225.9 30773.2 32609.8 33537.0 33630.8 35755.3 26964.7 27485.3 27564.7 27901.2 27958.7 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | [#2] jquery.html Cycles:180 Average:25177.56 Median:368.08 stddev:71862.85 (19523.8%) stddev-sans-first:72040.30 09:32:56 INFO - PROCESS | 6802 | Values: 365.5 370.6 373.7 374.6 375.2 17621.4 18029.4 18261.9 18392.0 18399.2 16584.8 17376.5 17836.4 17840.2 17854.2 5550.8 5740.5 5754.5 5778.9 5786.4 4196.1 4327.9 5682.7 6105.4 6297.6 6228.8 6253.3 6264.1 6264.8 6266.9 6100.7 6174.0 6219.6 6239.9 6310.0 3729.8 5378.3 5487.3 5559.3 5563.4 19789.6 20413.7 20490.5 20637.6 20695.9 2489.4 2599.9 2614.8 2691.1 2818.0 6390.8 7151.9 12288.4 13572.9 13787.0 1894.5 1909.1 1939.7 1944.0 1955.3 59606.7 59784.1 59818.7 61085.1 61914.0 9297.1 9604.2 9777.9 9926.4 9949.3 13674.1 13756.7 13762.4 13774.5 13874.9 7952.4 8000.4 8024.8 8040.4 8068.5 7998.3 8045.4 8128.5 8130.3 8135.3 5923.5 6073.2 6086.7 6100.3 6117.0 1653.0 1667.7 1686.0 1724.2 1835.3 634.9 1022.6 1023.8 1069.7 1106.0 17257.0 17571.9 17612.7 17671.0 18131.7 1038.9 1050.4 1054.9 1083.7 1112.9 8689.7 10302.4 10523.7 10591.3 10737.9 430317.0 431081.0 442988.0 443294.0 450552.0 65359.7 67456.0 67482.0 68661.7 69129.3 1101.4 1127.4 1162.1 1175.3 1175.6 16011.8 16034.8 16062.4 16133.9 16234.2 31168.5 31987.8 32599.2 32799.5 33524.0 42251.4 43838.3 44234.3 44335.3 44365.3 7619.0 7687.9 7787.0 7869.1 7904.1 7751.5 11611.5 11620.7 12182.9 12335.7 9731.6 9797.9 10066.0 10104.3 10224.3 10305.1 10461.3 10692.5 10816.2 11080.2 9644.9 9869.0 10338.0 10354.1 10455.6 7812.8 7827.0 7893.4 7951.9 7993.7 9993.3 10003.5 10193.4 10300.6 10363.0 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | [#3] mootools.html Cycles:180 Average:5811.24 Median:4965.81 stddev:3062.20 (61.7%) stddev-sans-first:3054.02 09:32:56 INFO - PROCESS | 6802 | Values: 1546.9 1570.4 1801.2 1931.7 1976.7 8117.4 8218.7 8254.7 8271.1 8296.8 8138.9 8170.3 8176.6 8183.4 8200.5 2349.2 2390.5 2397.2 2407.7 2416.7 2412.8 2430.4 2446.7 2446.7 2448.0 2038.0 2261.5 2290.3 2399.8 2421.4 2269.0 2282.1 2295.1 2296.2 2298.1 2251.0 2268.5 2271.8 2276.9 2300.3 7040.7 7183.6 7845.6 8018.2 8064.6 4849.8 4962.6 4969.0 4969.5 4972.8 3141.1 3155.3 3174.4 3192.6 3212.2 1073.9 1075.7 1079.3 1120.3 1130.4 11440.7 11531.4 11539.8 11542.5 11555.9 4330.8 4469.7 4470.3 4488.9 4496.2 10008.6 10012.2 10019.7 10029.0 10086.7 5086.3 5093.9 5097.5 5098.2 5099.0 4553.7 4581.2 4650.7 4658.8 4659.7 3627.7 3628.5 3636.7 3658.0 3673.9 1178.7 1198.9 1214.4 1217.1 1223.2 1059.3 1142.8 1212.4 1249.9 1413.3 7706.8 7768.0 7809.2 7810.2 7811.1 1086.2 1168.5 1187.2 1217.7 1233.2 6203.3 6229.1 6231.4 6284.4 6292.9 9748.0 10155.4 10282.4 10294.5 10439.3 10095.7 10105.1 10217.6 10260.7 10362.1 7963.7 7973.7 7986.3 7997.2 8078.7 7656.3 7723.6 7744.6 7761.1 7786.3 9043.8 9085.9 9188.5 9194.4 9195.7 9291.6 9310.4 9419.1 9517.7 9518.0 6986.7 7071.5 7075.4 7076.1 7082.0 7916.8 8082.7 8136.4 8138.8 8142.2 7418.4 7475.5 7485.4 7532.7 7574.6 7245.1 7319.4 7333.5 7397.0 7497.2 7048.6 7178.3 7215.9 7216.4 7730.0 6701.4 6717.1 6723.2 6729.2 6763.1 6657.5 6789.7 6811.5 6939.3 6988.5 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | [#4] prototype.html Cycles:180 Average:5201.21 Median:5919.03 stddev:1596.12 (27.0%) stddev-sans-first:1557.92 09:32:56 INFO - PROCESS | 6802 | Values: 316.4 321.2 322.6 323.1 327.5 5816.2 5840.6 5852.7 5854.9 5873.7 5741.0 5756.6 5844.5 5851.8 5868.2 4291.2 4390.8 4485.8 4502.6 4547.0 4511.1 4520.3 4523.9 4533.9 4538.8 4472.3 4475.7 4477.0 4487.4 4488.9 4197.8 4327.7 4415.1 4445.0 4461.5 3913.3 3923.8 3927.2 3930.8 3937.2 5494.0 5497.3 5507.1 5518.3 5520.3 5201.0 5211.3 5219.3 5222.4 5223.5 6178.1 6191.3 6206.3 6206.6 6206.8 4076.8 4198.4 4209.5 4349.9 4355.2 6407.6 6452.2 6459.1 6473.7 6488.6 4339.3 4343.6 4343.7 4344.7 4353.5 4349.1 4361.8 4366.3 4371.1 4403.4 5118.4 5129.8 5130.5 5131.4 5132.0 5981.7 6246.6 6249.2 6253.1 6257.2 1511.8 1530.6 1537.2 1539.3 1539.8 933.8 969.7 997.9 1010.9 1020.6 5905.2 5905.9 5969.2 5970.1 6021.1 6251.7 6266.0 6281.4 6287.7 6289.2 5865.3 5932.1 5952.2 5980.5 5995.0 3403.8 3440.5 3450.7 3452.2 3452.6 6547.8 6586.6 6598.7 6803.2 6844.9 6628.8 6664.8 6665.5 6668.9 6683.7 6796.1 6800.8 6805.7 6815.6 6829.7 6482.7 6484.6 6486.6 6491.8 6494.9 6157.3 6363.1 6379.8 6385.2 6394.2 6765.4 6768.4 6775.6 6806.4 6818.9 4320.0 4342.2 4353.2 4358.5 4372.6 6424.4 6478.0 6484.9 6490.9 6494.0 6272.2 6280.0 6300.9 6301.3 6306.4 6091.5 6300.4 6319.8 6320.1 6322.4 6109.4 6148.3 6179.8 6186.2 6196.7 6285.7 6339.7 6339.8 6342.4 6352.8 5904.4 5973.9 6180.6 6183.2 6184.3 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - PROCESS | 6802 | [#5] yui.html Cycles:180 Average:14494.51 Median:26707.72 stddev:17259.71 (64.6%) stddev-sans-first:17277.53 09:32:56 INFO - PROCESS | 6802 | Values: 809.6 851.4 865.0 877.9 888.7 14402.0 14564.8 14612.6 14648.9 14715.0 13639.5 14326.8 14348.3 14370.9 14372.5 761.8 775.3 775.5 914.9 931.8 918.5 940.0 940.8 941.5 941.5 1007.9 1011.1 1013.9 1014.5 1014.9 623.6 631.4 1008.9 1009.5 1011.9 718.2 727.4 729.1 732.9 734.1 14511.1 14571.5 14615.5 14642.3 14645.8 14089.9 14483.4 14653.3 14662.7 14817.7 11571.9 11704.7 11875.0 12098.5 12115.2 3802.3 3817.9 3844.5 3912.4 3919.7 49006.0 49261.0 49320.8 49664.8 49677.8 9864.5 10165.8 10243.3 10331.9 10367.2 17633.4 17698.4 17699.4 17745.3 17777.4 8142.7 8146.7 8455.6 8559.8 8583.0 4713.2 4773.2 4874.9 4929.9 4995.1 3187.3 3230.6 3230.9 3238.7 3241.2 575.2 579.8 580.5 593.1 594.2 547.4 599.0 612.6 675.3 705.2 8469.5 8493.6 8494.1 8511.9 8933.4 683.8 689.8 692.0 714.0 716.4 4049.8 4059.9 4071.5 4103.9 4121.1 62244.4 62786.0 63674.7 63897.0 64132.7 54076.0 55080.7 55372.0 55528.0 55688.4 48465.5 48540.5 50288.5 50334.2 50935.7 8014.9 8050.9 8095.0 8164.5 8229.2 38079.2 38585.6 39223.2 39433.4 39440.4 45526.5 46108.3 48983.3 50301.2 50750.2 10130.9 10195.7 10398.8 10484.7 10553.5 11096.2 11096.6 11356.1 11364.3 11589.2 9977.2 10119.9 10317.7 10415.6 10467.3 9740.0 9936.4 9988.2 10094.2 10405.8 10405.0 10523.2 10525.4 10661.3 10813.5 8649.9 8769.1 8790.3 8809.5 8901.5 8458.5 9741.3 9771.8 10130.8 10195.7 09:32:56 INFO - PROCESS | 6802 | -------- Summary: end -------- 09:32:56 INFO - PROCESS | 6802 | 09:32:56 INFO - TEST-INFO | 6802: exit 0 09:32:56 INFO - TEST-OK | dromaeo_css | took 1110463ms 09:32:56 INFO - TEST-START | kraken 09:32:56 INFO - operating with platform_type : linux_ 09:32:56 INFO - Initialising browser for kraken test... 09:32:56 INFO - TEST-INFO | started process 7003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2u0bcE/profile http://localhost:38824/getInfo.html) 09:33:00 INFO - PROCESS | 7003 | __metrics Screen width/height:1600/1200 09:33:00 INFO - PROCESS | 7003 | colorDepth:24 09:33:00 INFO - PROCESS | 7003 | Browser inner width/height: 1024/697 09:33:00 INFO - PROCESS | 7003 | __metrics 09:33:01 INFO - PROCESS | 7003 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:02 INFO - TEST-INFO | 7003: exit 0 09:33:02 INFO - Browser initialized. 09:33:02 INFO - Running cycle 1/1 for kraken test... 09:33:02 INFO - TEST-INFO | started process 7095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2u0bcE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:13 INFO - PROCESS | 7095 | RSS: Main: 139304960 09:33:13 INFO - PROCESS | 7095 | 09:33:16 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:17 INFO - PROCESS | 7095 | RSS: Main: 183046144 09:33:17 INFO - PROCESS | 7095 | 09:33:19 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-dft) 09:33:20 INFO - PROCESS | 7095 | RSS: Main: 175316992 09:33:20 INFO - PROCESS | 7095 | 09:33:23 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-fft) 09:33:23 INFO - PROCESS | 7095 | RSS: Main: 174866432 09:33:23 INFO - PROCESS | 7095 | 09:33:25 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-oscillator) 09:33:26 INFO - PROCESS | 7095 | RSS: Main: 175349760 09:33:26 INFO - PROCESS | 7095 | 09:33:28 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:29 INFO - PROCESS | 7095 | RSS: Main: 174419968 09:33:29 INFO - PROCESS | 7095 | 09:33:31 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:32 INFO - PROCESS | 7095 | RSS: Main: 174321664 09:33:32 INFO - PROCESS | 7095 | 09:33:35 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:36 INFO - PROCESS | 7095 | RSS: Main: 174931968 09:33:36 INFO - PROCESS | 7095 | 09:33:39 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38824/tests/kraken/driver.html?testName=json-parse-financial) 09:33:39 INFO - PROCESS | 7095 | RSS: Main: 174288896 09:33:39 INFO - PROCESS | 7095 | 09:33:41 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38824/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:33:41 INFO - PROCESS | 7095 | RSS: Main: 185028608 09:33:41 INFO - PROCESS | 7095 | 09:33:43 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:33:44 INFO - PROCESS | 7095 | RSS: Main: 184250368 09:33:44 INFO - PROCESS | 7095 | 09:33:46 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:33:46 INFO - PROCESS | 7095 | RSS: Main: 187428864 09:33:46 INFO - PROCESS | 7095 | 09:33:49 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:33:49 INFO - PROCESS | 7095 | RSS: Main: 189886464 09:33:49 INFO - PROCESS | 7095 | 09:33:52 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:33:53 INFO - PROCESS | 7095 | RSS: Main: 186695680 09:33:53 INFO - PROCESS | 7095 | 09:33:54 INFO - PROCESS | 7095 | Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38824/tests/kraken/driver.html?testName=ai-astar) 09:33:55 INFO - PROCESS | 7095 | RSS: Main: 249044992 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | __start_tp_report 09:33:55 INFO - PROCESS | 7095 | _x_x_mozilla_page_load 09:33:55 INFO - PROCESS | 7095 | _x_x_mozilla_page_load_details 09:33:55 INFO - PROCESS | 7095 | |i|pagename|runs| 09:33:55 INFO - PROCESS | 7095 | |0;ai-astar;111;110;112;111;111;111;112;112;111;124 09:33:55 INFO - PROCESS | 7095 | |1;audio-beat-detection;159;130;151;168;126;166;151;127;170;129 09:33:55 INFO - PROCESS | 7095 | |2;audio-dft;161;162;160;161;162;159;162;159;159;162 09:33:55 INFO - PROCESS | 7095 | |3;audio-fft;76;77;76;164;77;76;76;76;169;74 09:33:55 INFO - PROCESS | 7095 | |4;audio-oscillator;93;92;137;93;93;93;143;93;92;139 09:33:55 INFO - PROCESS | 7095 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 09:33:55 INFO - PROCESS | 7095 | |6;imaging-darkroom;146;145;145;145;145;144;145;145;145;146 09:33:55 INFO - PROCESS | 7095 | |7;imaging-desaturate;96;96;96;96;96;96;95;95;96;96 09:33:55 INFO - PROCESS | 7095 | |8;json-parse-financial;54;57;55;55;55;54;54;55;81;52 09:33:55 INFO - PROCESS | 7095 | |9;json-stringify-tinderbox;64;64;63;64;65;64;65;64;64;65 09:33:55 INFO - PROCESS | 7095 | |10;stanford-crypto-aes;80;78;78;81;80;80;80;88;86;79 09:33:55 INFO - PROCESS | 7095 | |11;stanford-crypto-ccm;115;120;114;117;111;116;113;118;118;115 09:33:55 INFO - PROCESS | 7095 | |12;stanford-crypto-pbkdf2;159;140;150;149;150;142;140;148;151;149 09:33:55 INFO - PROCESS | 7095 | |13;stanford-crypto-sha256-iterative;69;69;68;69;67;68;67;69;68;68 09:33:55 INFO - PROCESS | 7095 | __end_tp_report 09:33:55 INFO - PROCESS | 7095 | __start_cc_report 09:33:55 INFO - PROCESS | 7095 | _x_x_mozilla_cycle_collect,1056 09:33:55 INFO - PROCESS | 7095 | __end_cc_report 09:33:55 INFO - PROCESS | 7095 | __startTimestamp1464280435022__endTimestamp 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | ------- Summary: start ------- 09:33:55 INFO - PROCESS | 7095 | Number of tests: 14 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#0] ai-astar Cycles:10 Average:112.50 Median:111.50 stddev:4.09 (3.7%) stddev-sans-first:4.30 09:33:55 INFO - PROCESS | 7095 | Values: 111.0 110.0 112.0 111.0 111.0 111.0 112.0 112.0 111.0 124.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:155.00 stddev:18.12 (11.7%) stddev-sans-first:18.76 09:33:55 INFO - PROCESS | 7095 | Values: 159.0 130.0 151.0 168.0 126.0 166.0 151.0 127.0 170.0 129.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.50 stddev:1.34 (0.8%) stddev-sans-first:1.41 09:33:55 INFO - PROCESS | 7095 | Values: 161.0 162.0 160.0 161.0 162.0 159.0 162.0 159.0 159.0 162.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.19 (50.2%) stddev-sans-first:39.94 09:33:55 INFO - PROCESS | 7095 | Values: 76.0 77.0 76.0 164.0 77.0 76.0 76.0 76.0 169.0 74.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.73 (24.4%) stddev-sans-first:23.55 09:33:55 INFO - PROCESS | 7095 | Values: 93.0 92.0 137.0 93.0 93.0 93.0 143.0 93.0 92.0 139.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:33:55 INFO - PROCESS | 7095 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 09:33:55 INFO - PROCESS | 7095 | Values: 146.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 145.0 146.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:33:55 INFO - PROCESS | 7095 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.00 stddev:8.46 (15.4%) stddev-sans-first:8.89 09:33:55 INFO - PROCESS | 7095 | Values: 54.0 57.0 55.0 55.0 55.0 54.0 54.0 55.0 81.0 52.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:33:55 INFO - PROCESS | 7095 | Values: 64.0 64.0 63.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:3.33 (4.2%) stddev-sans-first:3.52 09:33:55 INFO - PROCESS | 7095 | Values: 80.0 78.0 78.0 81.0 80.0 80.0 80.0 88.0 86.0 79.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:116.50 stddev:2.67 (2.3%) stddev-sans-first:2.82 09:33:55 INFO - PROCESS | 7095 | Values: 115.0 120.0 114.0 117.0 111.0 116.0 113.0 118.0 118.0 115.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.50 stddev:5.81 (3.9%) stddev-sans-first:4.53 09:33:55 INFO - PROCESS | 7095 | Values: 159.0 140.0 150.0 149.0 150.0 142.0 140.0 148.0 151.0 149.0 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - PROCESS | 7095 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 09:33:55 INFO - PROCESS | 7095 | Values: 69.0 69.0 68.0 69.0 67.0 68.0 67.0 69.0 68.0 68.0 09:33:55 INFO - PROCESS | 7095 | -------- Summary: end -------- 09:33:55 INFO - PROCESS | 7095 | 09:33:55 INFO - TEST-INFO | 7095: exit 0 09:33:55 INFO - TEST-OK | kraken | took 59313ms 09:33:55 INFO - SUITE-END | took 1169s 09:33:56 INFO - Completed test suite (00:19:29) 09:33:56 INFO - javascript benchmark 09:33:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3256.6743325667435, 3316.3698897209542, 3323.8171900545467, 3335.48300013498, 3352.21223012592, 5221.425643179247, 5236.057509648262, 5244.160934250521, 5247.632665713397, 5247.86880327991, 5245.763940622672, 5259.289995850559, 5282.049231138403, 5290.576753859692, 5301.41684414715, 4756.167670657638, 4779.761011949415, 4820.590249828751, 4834.347363105989, 4881.4630390657, 4818.59041981432, 4841.878953026185, 4880.292357608145, 4883.804647814083, 4884.120858245515, 4814.951850481503, 4871.975640121795, 4873.902521949577, 4890.021995600876, 4933.1120398328285, 4804.159272127398, 4833.202521583935, 4906.092372911023, 4935.284383764352, 4937.728424936627, 4747.454042785055, 4814.590759785422, 4835.081334546425, 4868.805247790084, 4874.683145595525, 5072.213806859942, 5134.948650513485, 5138.820141295074, 5151.072806894795, 5171.7672704728375, 5682.801101961453, 5718.34239062509, 5719.056355701305, 5720.914186287209, 5723.771049158028, 5624.100143976985, 5669.433056694339, 5712.11462223356, 5722.456366645162, 5741.511971482429, 5325.201219817059, 5328.866778330534, 5331.200319952039, 5334.093204155303, 5357.464253574651, 5804.9419505805245, 5805.216295800097, 5806.361300256968, 5807.796727114531, 5831.475167234969, 5499.312585926759, 5527.723613819293, 5578.553715702815, 5590.0, 5591.3569939456665, 5693.686847223443, 5696.401877802854, 5696.515796157373, 5697.914531282034, 5721.599488035798, 5654.688992105392, 5656.462636049569, 5661.631993920382, 5661.773529058792, 5662.065759149777, 5565.833025009256, 5648.717564121777, 5654.943450565524, 5729.1119876419225, 5745.798897038583, 4342.34864770287, 4352.586504282088, 4356.106998065389, 4356.411884395629, 4375.16871794358, 3947.5657677655436, 3961.3067713150085, 3968.1865217630316, 3986.2824691555797, 3996.500437445319, 5342.225377320345, 5452.263944367539, 5521.723913804293, 5528.06022976095, 5552.666839989613, 5687.800926967537, 5704.3154821421695, 5711.857203569944, 5719.3422756382715, 5728.341240757366, 5378.650387724785, 5444.646098003617, 5469.480399362054, 5494.203340515683, 5497.202905578749, 4827.686200396963, 4871.610271178297, 4881.341018962395, 4894.559489645949, 4900.2894580286375, 5979.970100149471, 6038.245219347582, 6039.758409663565, 6044.848878778066, 6046.939530604637, 5626.2685850839125, 5725.599208055396, 5743.59794814359, 5770.221020162392, 5775.0, 5898.997170480942, 5900.43945825146, 5905.261842269716, 5909.527237820878, 5914.378990205966, 5555.694436805853, 5558.749856256559, 5564.582656300713, 5575.470330318613, 5586.52514536269, 5610.354809196831, 5676.063449530781, 5682.204491371129, 5736.053551164011, 5797.014507533645, 5610.298712660918, 5636.85907852307, 5638.041532939328, 5638.21065050885, 5646.407127251744, 5596.4123767003875, 5633.0987042073075, 5644.0, 5644.407337229696, 5650.660960342392, 5398.703071330958, 5484.122540393678, 5494.1758736189895, 5564.304461942257, 5591.524720398812, 5495.230667706604, 5540.584456165884, 5575.0, 5641.351244606923, 5695.401982791747, 5390.541803946551, 5452.754626041917, 5453.10023846061, 5458.153986132156, 5489.698066606375], "unit": "score", "name": "dojo.html", "value": 5266.1882982183}, {"lowerIsBetter": false, "replicates": [530.7372850439033, 556.9387367389588, 573.905305624572, 596.6479776931609, 600.111834484962, 30139.849300753493, 31001.0, 39059.60940390595, 39523.0, 39530.80234598823, 43195.78402107985, 43604.0, 43611.78194109033, 43630.7818460908, 43636.56363436364, 8780.209781119698, 8952.328575356842, 8960.193582577567, 8980.59587318569, 8980.775480612972, 8710.0, 8861.867071993925, 8862.734117976439, 8868.379213455028, 8870.467771933672, 8870.06864279251, 8953.194212520872, 9110.45337279762, 9111.863322050174, 9174.449533028039, 8985.95507022464, 9060.229880460169, 9060.592273347715, 9060.637574497045, 9065.184133427958, 8944.552772361356, 9077.409968352036, 9080.8637870432, 9081.500517471537, 9084.409513381675, 42703.35944960828, 42914.78542607267, 43045.0, 43064.1387172258, 43144.352834707504, 3723.2181241939224, 3826.215625796705, 3840.7503512271614, 3884.9028774280587, 4458.0415210729525, 31167.844160779277, 31264.843675781703, 31327.53008704871, 31349.216269593213, 32692.83653581717, 4233.25917964355, 4279.422277992493, 4366.716163449366, 4369.082492676542, 4410.6030457259, 283550.0, 289785.0, 289852.2029559397, 290354.0, 290567.0, 47650.76174619105, 48626.51373486291, 70227.29772702309, 71538.64230678813, 71708.28291717016, 47631.0, 48348.27477587839, 48356.0, 48379.0, 48402.0, 16714.665706686043, 16873.831261687472, 16903.492895213163, 16905.7464138038, 16921.915390423215, 13322.0, 13330.533431329857, 13402.329883505785, 13446.0, 13459.663508412172, 16281.104539250218, 16319.673606527804, 16448.0, 16454.177291135395, 16512.0, 6247.156633854372, 6410.775622853178, 6440.903386449207, 6467.547271690936, 6548.967255163694, 1041.9322744021615, 1116.7264020314913, 1123.4719681749564, 1148.8851114888444, 1169.181572898974, 30444.391112177633, 30733.23166920845, 30845.537316940263, 31420.37159256802, 31441.371172576877, 1125.27419814221, 1164.5923926625612, 1172.8123500239922, 1179.1510112719, 1288.4395288049727, 16082.597935051717, 16161.191940403169, 16303.918480407521, 16338.591535211715, 16511.587210319838, 327622.0, 329754.0, 331088.0, 331227.0, 331707.0, 58382.12426813601, 58921.705391472766, 58962.705186473795, 59046.22861314168, 59068.40931590629, 1380.8895288377107, 1457.2203870929002, 1468.875145612635, 1482.3181336585292, 1505.533284681752, 27915.581266280617, 28259.293517662223, 28283.575746364233, 29105.0, 30682.079537613015, 47115.528844711116, 47461.52538474571, 47541.28688069751, 47674.76162619165, 47701.0, 192124.0, 204755.0, 205045.0, 206063.0, 206079.0, 30511.84744076354, 35235.82382088073, 35846.0, 35853.46219806757, 37127.62872371242, 41314.1737165261, 41788.373174403016, 41997.79001104975, 42002.0, 42369.36445953252, 35251.82374088216, 35403.114922127155, 35459.0, 35478.29043419169, 35927.28145437024, 36596.81701591475, 36912.261754764215, 36912.630873692, 37388.813055934545, 37398.252034959696, 37060.81469592635, 37154.0, 42103.0, 43092.78453607712, 43225.91935201645, 30773.23066923345, 32609.836950815094, 33537.0, 33630.831845840614, 35755.28489430145, 26964.73035269622, 27485.31286717848, 27564.724352756217, 27901.162965111078, 27958.72041279561], "unit": "score", "name": "ext.html", "value": 18925.66608093312}, {"lowerIsBetter": false, "replicates": [365.512041424698, 370.64603303844825, 373.676769594301, 374.56737468224196, 375.16712897367836, 17621.383251586198, 18029.368972085962, 18261.908690456545, 18392.0, 18399.172037258322, 16584.751228731548, 17376.485522094146, 17836.375726849565, 17840.197191126397, 17854.196561154746, 5550.77796888125, 5740.540756739471, 5754.5108665763255, 5778.884422311572, 5786.392428794979, 4196.055887425336, 4327.913441731163, 5682.687452190128, 6105.419985101408, 6297.622142671455, 6228.781992630259, 6253.343398943114, 6264.123022776815, 6264.812055638338, 6266.905996410058, 6100.664463454508, 6173.969130154365, 6219.5957262778, 6239.87520249597, 6309.968450157743, 3729.776213427203, 5378.327709036371, 5487.286652735159, 5559.277293951801, 5563.443655634444, 19789.604207915905, 20413.69379459309, 20490.487737806674, 20637.587248255102, 20695.89652051745, 2489.352768280242, 2599.9350016249555, 2614.843109413441, 2691.1388355726176, 2818.041865765629, 6390.7763228286785, 7151.891456824201, 12288.385580721018, 13572.932135339359, 13787.0, 1894.479018269973, 1909.1313452379134, 1939.6896496560482, 1944.0377013378327, 1955.2667749593902, 59606.70196649032, 59784.103238451455, 59818.700906495185, 61085.08372374418, 61914.0, 9297.116773906468, 9604.183644390165, 9777.853332200022, 9926.404415735078, 9949.303548751517, 13674.111182773087, 13756.65608359799, 13762.380692868845, 13774.517891873737, 13874.93062534681, 7952.443328967032, 8000.4399692021, 8024.799380015546, 8040.437169398203, 8068.47554908929, 7998.280154786097, 8045.436819422584, 8128.512289262545, 8130.3495720342235, 8135.3491720662205, 5923.466887980103, 6073.180120683651, 6086.695665216722, 6100.267967843887, 6116.969415152896, 1652.9752053719203, 1667.7415000674914, 1685.9578510537335, 1724.2240991553851, 1835.320931255444, 634.9396807303299, 1022.555188492993, 1023.8361862102176, 1069.7486090768664, 1106.0211712634377, 17257.0, 17571.912140439217, 17612.735808962876, 17670.965375732252, 18131.72802407965, 1038.89611038897, 1050.4012712753656, 1054.862867827193, 1083.7019819549687, 1112.8553288072499, 8689.652413903374, 10302.381857088449, 10523.736906577396, 10591.258611897247, 10737.892621073846, 430317.0, 431081.0, 442988.0, 443294.0, 450552.0, 65359.67320163369, 67456.0, 67482.0, 68661.65669171722, 69129.30870691329, 1101.4492753623188, 1127.3855748617023, 1162.0703437250165, 1175.312442221293, 1175.5944199251244, 16011.759823602422, 16034.759478607597, 16062.43781467643, 16133.919330403272, 16234.18829058566, 31168.53247201339, 31987.840060799546, 32599.18502037468, 32799.50800737943, 33524.0, 42251.3662295072, 43838.34242486429, 44234.3364849534, 44335.334969976124, 44365.33451998158, 7619.0, 7687.88468172989, 7787.0, 7869.0950540688555, 7904.051513818378, 7751.457397982087, 11611.47748351343, 11620.709482263012, 12182.939085304517, 12335.69160770988, 9731.610735570497, 9797.85303220438, 10066.0, 10104.292699510963, 10224.33541819809, 10305.124064454605, 10461.320014199053, 10692.465376730977, 10816.242862999514, 11080.224384293022, 9644.903550964682, 9869.013098690073, 10338.0, 10354.1198998083, 10455.634052808115, 7812.765617031499, 7827.0, 7893.447458677838, 7951.920480795118, 7993.6802527898235, 9993.250506212209, 10003.469296723935, 10193.439360835226, 10300.587976480856, 10363.0], "unit": "score", "name": "jquery.html", "value": 8617.888861472127}, {"lowerIsBetter": false, "replicates": [1546.8530489603488, 1570.387548855946, 1801.171461127881, 1931.661959157147, 1976.6738488149465, 8117.350611951045, 8218.712345067925, 8254.669813207465, 8271.090180080186, 8296.834063318738, 8138.91861081389, 8170.346372290217, 8176.550289734062, 8183.386246031541, 8200.466969646985, 2349.2364981381033, 2390.486045500217, 2397.1609936522163, 2407.711074671033, 2416.66166736657, 2412.8190385721055, 2430.3924018995253, 2446.6696995905504, 2446.706395232575, 2447.9755202448014, 2037.9694304585444, 2261.479859632277, 2290.2556669082533, 2399.8320117591775, 2421.4188594737225, 2269.012979353978, 2282.075759317479, 2295.0819672131197, 2296.1619009061574, 2298.1496846166856, 2250.988745056264, 2268.5122698619875, 2271.8409711320214, 2276.8747718875456, 2300.2754132448395, 7040.683169257396, 7183.604901730403, 7845.607719613997, 8018.238267364591, 8064.596770161468, 4849.806007759686, 4962.62780291476, 4969.0, 4969.503049695038, 4972.825951091694, 3141.1204862638497, 3155.2742869140225, 3174.365126974614, 3192.5690031845634, 3212.1648371423366, 1073.9194560408, 1075.7256899490658, 1079.282277285604, 1120.2774210634095, 1130.3782919394382, 11440.713982150513, 11531.423428828524, 11539.769204615945, 11542.480588373543, 11555.94222028893, 4330.761808100522, 4469.726128053489, 4470.307102399133, 4488.9102217956115, 4496.213162696515, 10008.599656013677, 10012.24908131893, 10019.749506262402, 10029.04724051214, 10086.697399078039, 5086.3133476980875, 5093.949060509348, 5097.490250974947, 5098.1842905135, 5098.974505127525, 4553.658475614342, 4581.175388430114, 4650.720956742606, 4658.813647454064, 4659.720416775004, 3627.691646210049, 3628.4920111184456, 3636.7272454566014, 3657.9817100914324, 3673.8897833064516, 1178.6935396796723, 1198.898093662031, 1214.4110106598293, 1217.056780994736, 1223.1988047828509, 1059.3273271472517, 1142.765733024728, 1212.4240985531978, 1249.881261280177, 1413.3498590648417, 7706.7687969361, 7768.0, 7809.219078092259, 7810.1799311072655, 7811.140774514799, 1086.2342048855537, 1168.526746667601, 1187.2460987273143, 1217.713837248246, 1233.2415564427993, 6203.286622038523, 6229.065640154013, 6231.40801623845, 6284.402981716729, 6292.937070629327, 9747.951260243795, 10155.441450720282, 10282.434466104287, 10294.485275736333, 10439.321444106108, 10095.697129086138, 10105.090541851268, 10217.591296348062, 10260.743481413025, 10362.067413932631, 7963.721269755647, 7973.720919767897, 7986.321162701235, 7997.160298168725, 8078.7172448965175, 7656.349210317186, 7723.613819309125, 7744.631085477835, 7761.146273909752, 7786.338161256356, 9043.773905652411, 9085.909140908507, 9188.494632794993, 9194.356395052282, 9195.724128276162, 9291.62833486653, 9310.394824336396, 9419.105185007413, 9517.666881659108, 9517.952410238182, 6986.650667466504, 7071.540349877241, 7075.363217310467, 7076.115485564304, 7081.964590177016, 7916.802079948047, 8082.7171049013, 8136.430449868689, 8138.83722325562, 8142.18578142181, 7418.36943859778, 7475.514091584029, 7485.401167906663, 7532.661030253542, 7574.583397913168, 7245.094363204599, 7319.377852882564, 7333.523320984119, 7396.96301518489, 7497.175310715707, 7048.612326322102, 7178.28217178278, 7215.927840721525, 7216.386607138242, 7730.0, 6701.396874281338, 6717.093192419156, 6723.193216814014, 6729.192496900403, 6763.086983257197, 6657.4674026078765, 6789.72841086351, 6811.489138314547, 6939.30606939302, 6988.510804243858], "unit": "score", "name": "mootools.html", "value": 4752.54836766585}, {"lowerIsBetter": false, "replicates": [316.4272666473683, 321.17778487073093, 322.64831333846104, 323.1033880980278, 327.52181814550755, 5816.243888294526, 5840.620359676624, 5852.707364631768, 5854.912176317359, 5873.735681894314, 5740.971295143529, 5756.625819321741, 5844.503217226541, 5851.76592936282, 5868.207791948085, 4291.163223171483, 4390.780460976955, 4485.7757112144345, 4502.617277531397, 4547.0, 4511.097780443908, 4520.321951707254, 4523.8642840714665, 4533.9319910201375, 4538.773061346936, 4472.262076757331, 4475.709078909877, 4477.037436951055, 4487.416635837353, 4488.910221795562, 4197.769122698251, 4327.653787696977, 4415.072834704716, 4445.0, 4461.527695860358, 3913.25648126855, 3923.8234279457206, 3927.19492504036, 3930.803459827026, 3937.1535119949062, 5494.038543254915, 5497.285352904097, 5507.0637991541535, 5518.2826232589905, 5520.254765606632, 5200.97399513, 5211.270422140903, 5219.295395121648, 5222.4255331913455, 5223.529882310572, 6178.104174894615, 6191.288001879751, 6206.286277078104, 6206.596571222901, 6206.782762603287, 4076.7961601919787, 4198.391233271189, 4209.452771139732, 4349.934750978738, 4355.194289056535, 6407.583507072072, 6452.161219041494, 6459.09572659828, 6473.708683109225, 6488.643124628144, 4339.34909763538, 4343.587359200871, 4343.717658352197, 4344.739315641072, 4353.455818022747, 4349.064951035542, 4361.760103194291, 4366.279563871925, 4371.103923695635, 4403.427554417969, 5118.411382690963, 5129.794808207705, 5130.538251557377, 5131.358580177478, 5132.0, 5981.6710080945095, 6246.562740608114, 6249.156363890907, 6253.1245625612455, 6257.217847769029, 1511.7959075524884, 1530.6096945278882, 1537.2237020304674, 1539.3226980128707, 1539.7844301797757, 933.803901180746, 969.6715499765367, 997.9322125325832, 1010.9443980580992, 1020.5611587017505, 5905.202797622352, 5905.911411328833, 5969.2240008799445, 5970.104484327298, 6021.066734656135, 6251.718672659741, 6266.0, 6281.434670879643, 6287.748490060438, 6289.24529056507, 5865.266841644794, 5932.139839723216, 5952.226210592682, 5980.491658209014, 5995.0, 3403.829808509565, 3440.535527703778, 3450.6721861423125, 3452.205992621711, 3452.5511683480986, 6547.803565893031, 6586.604803711793, 6598.7030583623855, 6803.217629972616, 6844.8973265401055, 6628.767993120217, 6664.83337916556, 6665.533412661067, 6668.933310666928, 6683.699233534503, 6796.082528858541, 6800.8299792504595, 6805.6597170141295, 6815.556988795812, 6829.69266383004, 6482.740690372332, 6484.643344616092, 6486.5783724059675, 6491.772787952399, 6494.935050649433, 6157.261128664589, 6363.077353783768, 6379.776707815204, 6385.169927909342, 6394.200724909387, 6765.357291057342, 6768.390844823989, 6775.559588626724, 6806.42145417645, 6818.8636227276165, 4319.956800432081, 4342.240107981153, 4353.238183317843, 4358.455193100863, 4372.562743725602, 6424.357564243725, 6477.967610161919, 6484.902726459201, 6490.902636460552, 6493.967530162319, 6272.153259310117, 6279.96860015697, 6300.905486417799, 6301.275353334242, 6306.400891915261, 6091.451769340781, 6300.369963003663, 6319.842003949938, 6320.083587879823, 6322.399372059647, 6109.358517355791, 6148.292946311052, 6179.81460556184, 6186.226721659793, 6196.690165491617, 6285.74857005733, 6339.651319177489, 6339.778107766206, 6342.365763423621, 6352.841178970378, 5904.439078287556, 5973.880522389615, 6180.567360284737, 6183.165272688129, 6184.257889053162], "unit": "score", "name": "prototype.html", "value": 4674.079203299406}, {"lowerIsBetter": false, "replicates": [809.6397103289039, 851.3955091884761, 865.0484467086206, 877.8683197520368, 888.7022847346138, 14402.0, 14564.781528277057, 14612.561623151323, 14648.926755366221, 14715.043522171065, 13639.454421823115, 14326.785098223509, 14348.282585870717, 14370.928145359285, 14372.49696260631, 761.7676608634364, 775.3022279948035, 775.5269285735696, 914.862770584411, 931.776373670321, 918.5177781664613, 939.9577019034126, 940.7742141885966, 941.4633658814479, 941.5480569326727, 1007.9193664506822, 1011.0597144655468, 1013.8986101389876, 1014.4775440648073, 1014.9340292880939, 623.6414061914372, 631.4033238589535, 1008.9293749437543, 1009.5457044330044, 1011.9392836429801, 718.1956209045902, 727.4471401734667, 729.0704351951251, 732.8900664900254, 734.0933946575974, 14511.1293322401, 14571.489997850025, 14615.488457903923, 14642.341094650767, 14645.780313295309, 14089.929550352183, 14483.42066317346, 14653.340599672934, 14662.706745865024, 14817.70364592702, 11571.884281157165, 11704.70738231551, 11875.0, 12098.516059357615, 12115.212511186834, 3802.258559580883, 3817.9045523861846, 3844.5386553613744, 3912.374020156761, 3919.686425086015, 49006.0, 49261.0, 49320.75339623279, 49664.75167624139, 49677.751611241714, 9864.506774661239, 10165.847512287322, 10243.334183278212, 10331.896681033244, 10367.170626349875, 17633.382831600833, 17698.380556680455, 17699.38052168168, 17745.290188392577, 17777.377791777486, 8142.715004974916, 8146.674133034612, 8455.577221138918, 8559.828803423896, 8583.0, 4713.2458806590785, 4773.212419950669, 4874.926876096862, 4929.926051109236, 4995.075910956485, 3187.2509960159346, 3230.596175478065, 3230.8707651693667, 3238.6923242291946, 3241.173500757292, 575.1746244139673, 579.8086631411624, 580.5210701171551, 593.1162567774072, 594.230471539349, 547.4416095582484, 598.9907006693735, 612.6385432594791, 675.3347952267013, 705.2489099109432, 8469.491830490191, 8493.617787199591, 8494.06565277819, 8511.872321915176, 8933.419327743675, 683.7914436096938, 689.7689274093135, 691.9723211071602, 713.9500234983501, 716.3982254905904, 4049.797510124482, 4059.878203653895, 4071.531773845986, 4103.876883693494, 4121.052158003676, 62244.37755622476, 62786.0, 63674.68162659157, 63897.0, 64132.67933660302, 54076.0, 55080.724596377564, 55372.0, 55528.0, 55688.443115569135, 48465.515344846805, 48540.51459485431, 50288.49711502838, 50334.24498632523, 50935.745321273156, 8014.879776803469, 8050.919490805017, 8095.0, 8164.469309494863, 8229.218224268685, 38079.23841523099, 38585.614143858205, 39223.2155356897, 39433.40849887311, 39440.40839387354, 45526.54473455223, 46108.30837537507, 48983.26525102055, 50301.24548131854, 50750.23874641957, 10130.949345253226, 10195.694129176136, 10398.792024159626, 10484.737881552717, 10553.472326383804, 11096.167787415814, 11096.5561377544, 11356.148288878201, 11364.318140911571, 11589.24669896454, 9977.151942085004, 10119.949400252952, 10317.690469285933, 10415.583376664848, 10467.319624224401, 9740.0, 9936.354136981363, 9988.200943924323, 10094.19246460296, 10405.84391234117, 10405.0, 10523.210759192938, 10525.36847789135, 10661.25371224038, 10813.459327033774, 8649.91350086491, 8769.123087691434, 8790.340724445565, 8809.51547664859, 8901.51041692713, 8458.450200736932, 9741.269404794528, 9771.755706107404, 10130.797384052425, 10195.745106372104], "unit": "score", "name": "yui.html", "value": 6562.358852746973}], "name": "dromaeo_css", "value": 7073.127464852702}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 112.0, 111.0, 111.0, 111.0, 112.0, 112.0, 111.0, 124.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [159.0, 130.0, 151.0, 168.0, 126.0, 166.0, 151.0, 127.0, 170.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 162.0, 159.0, 162.0, 159.0, 159.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 76.0, 164.0, 77.0, 76.0, 76.0, 76.0, 169.0, 74.0], "unit": "score", "name": "audio-fft", "value": 94.1}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 137.0, 93.0, 93.0, 93.0, 143.0, 93.0, 92.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 81.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [80.0, 78.0, 78.0, 81.0, 80.0, 80.0, 80.0, 88.0, 86.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.0}, {"lowerIsBetter": true, "replicates": [115.0, 120.0, 114.0, 117.0, 111.0, 116.0, 113.0, 118.0, 118.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [159.0, 140.0, 150.0, 149.0, 150.0, 142.0, 140.0, 148.0, 151.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 67.0, 68.0, 67.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1513.8}]} 09:33:56 INFO - Return code: 0 09:33:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:33:56 INFO - # TBPL SUCCESS # 09:33:56 INFO - Running post-action listener: _resource_record_post_action 09:33:56 INFO - Running post-run listener: _resource_record_post_run 09:33:57 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 253952; Write bytes: 235900928; Read time: 336; Write time: 122852 09:33:57 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 13930496; Read time: 0; Write time: 2004 09:33:57 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 253952; Write bytes: 221970432; Read time: 336; Write time: 120848 09:33:57 INFO - Running post-run listener: _upload_blobber_files 09:33:57 INFO - Blob upload gear active. 09:33:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:33:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:33:57 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:33:57 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:33:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:33:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:58 INFO - (blobuploader) - INFO - Done attempting. 09:33:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:33:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:59 INFO - (blobuploader) - INFO - Done attempting. 09:33:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:59 INFO - Return code: 0 09:33:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a177f0734c944654c4a21187f21f948c3d79956673227f8c30d0038f40cee842a79399a907b54153d4e7a47f97c0532b323191ab1ad9225b0abdd997bed307f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6d61d3bfa5acc248b56cc672eaba60a03c7ed2e961aa23881448c20675bc0559fb7a0fde093038a32f545a75526e47cddc164bce2de059aac06a9f1d0a00bb1"} 09:33:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:59 INFO - Contents: 09:33:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a177f0734c944654c4a21187f21f948c3d79956673227f8c30d0038f40cee842a79399a907b54153d4e7a47f97c0532b323191ab1ad9225b0abdd997bed307f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6d61d3bfa5acc248b56cc672eaba60a03c7ed2e961aa23881448c20675bc0559fb7a0fde093038a32f545a75526e47cddc164bce2de059aac06a9f1d0a00bb1"} 09:33:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:59 INFO - Copying logs to upload dir... 09:33:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.353707 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-26 09:33:59.495794) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 09:33:59.499275) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a177f0734c944654c4a21187f21f948c3d79956673227f8c30d0038f40cee842a79399a907b54153d4e7a47f97c0532b323191ab1ad9225b0abdd997bed307f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6d61d3bfa5acc248b56cc672eaba60a03c7ed2e961aa23881448c20675bc0559fb7a0fde093038a32f545a75526e47cddc164bce2de059aac06a9f1d0a00bb1"} build_url:https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/bL8wRxknQSaBWTuhAwaUig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a177f0734c944654c4a21187f21f948c3d79956673227f8c30d0038f40cee842a79399a907b54153d4e7a47f97c0532b323191ab1ad9225b0abdd997bed307f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6d61d3bfa5acc248b56cc672eaba60a03c7ed2e961aa23881448c20675bc0559fb7a0fde093038a32f545a75526e47cddc164bce2de059aac06a9f1d0a00bb1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 09:33:59.530339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:33:59.530691) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464278400.553189-76642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:33:59.614185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 09:33:59.614520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 09:33:59.615200) ========= ========= Total master_lag: 0.19 =========