builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1464651392.93 results: success (0) buildid: 20160526140250 builduid: 01574422c30242cc92a6c0b32dab29da revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:32.935184) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:32.935964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:32.936243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.083015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.083359) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 16:36:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-05-30 16:36:34 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191209 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.295361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.295658) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015545 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:33.345514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:36:33.345876) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --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 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --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=3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 16:36:34,603 truncating revision to first 12 chars 2016-05-30 16:36:34,603 Setting DEBUG logging. 2016-05-30 16:36:34,603 attempt 1/10 2016-05-30 16:36:34,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2ee4473c729a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 16:36:35,274 unpacking tar archive at: mozilla-beta-2ee4473c729a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464055 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:36:34.823522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.823850) ========= script_repo_revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.824271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.824573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:36:34.832912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-30 16:36:34.833259) ========= /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=3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:36:36 INFO - MultiFileLogger online at 20160530 16:36:36 in /builds/slave/test 16:36:36 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 16:36:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:36 INFO - {'append_to_log': False, 16:36:36 INFO - 'base_work_dir': '/builds/slave/test', 16:36:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:36:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:36 INFO - 'branch': 'Mozilla-Beta', 16:36:36 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:36 INFO - 'config_files': ('talos/linux_config.py',), 16:36:36 INFO - 'default_actions': ('clobber', 16:36:36 INFO - 'read-buildbot-config', 16:36:36 INFO - 'download-and-extract', 16:36:36 INFO - 'populate-webroot', 16:36:36 INFO - 'create-virtualenv', 16:36:36 INFO - 'install', 16:36:36 INFO - 'run-tests'), 16:36:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:36 INFO - 'download_minidump_stackwalk': True, 16:36:36 INFO - 'download_symbols': 'ondemand', 16:36:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:36 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:36 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:36 INFO - 'installer_path': 'installer.exe', 16:36:36 INFO - 'log_level': 'info', 16:36:36 INFO - 'log_name': 'talos', 16:36:36 INFO - 'log_to_console': True, 16:36:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:36:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:36:36 INFO - 'opt_config_files': (), 16:36:36 INFO - 'pip_index': False, 16:36:36 INFO - 'sps_profile': False, 16:36:36 INFO - 'sps_profile_interval': 0, 16:36:36 INFO - 'suite': 'dromaeojs', 16:36:36 INFO - 'system_bits': '32', 16:36:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:36 INFO - 'title': 'talos-linux64-ix-059', 16:36:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:36 INFO - 'use_talos_json': True, 16:36:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:36 INFO - 'work_dir': 'build'} 16:36:36 INFO - ##### 16:36:36 INFO - ##### Running clobber step. 16:36:36 INFO - ##### 16:36:36 INFO - Running pre-action listener: _resource_record_pre_action 16:36:36 INFO - Running main action method: clobber 16:36:36 INFO - rmtree: /builds/slave/test/build 16:36:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:37 INFO - Running post-action listener: _resource_record_post_action 16:36:37 INFO - ##### 16:36:37 INFO - ##### Running read-buildbot-config step. 16:36:37 INFO - ##### 16:36:37 INFO - Running pre-action listener: _resource_record_pre_action 16:36:37 INFO - Running main action method: read_buildbot_config 16:36:37 INFO - Using buildbot properties: 16:36:37 INFO - { 16:36:37 INFO - "project": "", 16:36:37 INFO - "product": "firefox", 16:36:37 INFO - "script_repo_revision": "production", 16:36:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:36:37 INFO - "repository": "", 16:36:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:36:37 INFO - "buildid": "20160526140250", 16:36:37 INFO - "pgo_build": "True", 16:36:37 INFO - "basedir": "/builds/slave/test", 16:36:37 INFO - "buildnumber": 112, 16:36:37 INFO - "slavename": "talos-linux64-ix-059", 16:36:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:36:37 INFO - "platform": "ubuntu64_hw", 16:36:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:36:37 INFO - "branch": "mozilla-beta", 16:36:37 INFO - "repo_path": "releases/mozilla-beta", 16:36:37 INFO - "revision": "2ee4473c729acb2ba7dc723e7affe79ce14bff85", 16:36:37 INFO - "stage_platform": "linux64-pgo", 16:36:37 INFO - "builduid": "01574422c30242cc92a6c0b32dab29da", 16:36:37 INFO - "slavebuilddir": "test" 16:36:37 INFO - } 16:36:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:36:37 INFO - Running post-action listener: _resource_record_post_action 16:36:37 INFO - ##### 16:36:37 INFO - ##### Running download-and-extract step. 16:36:37 INFO - ##### 16:36:37 INFO - Running pre-action listener: _resource_record_pre_action 16:36:37 INFO - Running main action method: download_and_extract 16:36:37 INFO - mkdir: /builds/slave/test/build/tests 16:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:37 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:36:54 INFO - Downloaded 1412 bytes. 16:36:54 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:36:54 INFO - Using the following test package requirements: 16:36:54 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:54 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:36:54 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:36:54 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'jsshell-linux-x86_64.zip'], 16:36:54 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:36:54 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:54 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:36:54 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:36:54 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:36:54 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:36:54 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:36:54 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:36:54 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:36: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')]} 16:36:54 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:36:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:36:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:37:22 INFO - Downloaded 23434470 bytes. 16:37:22 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'] 16:37:22 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 16:37:23 INFO - Return code: 0 16:37:23 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 16:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:23 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:37:29 INFO - Downloaded 23434470 bytes. 16:37:29 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'] 16:37:29 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 16:37:30 INFO - Return code: 0 16:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:30 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:37:31 INFO - Downloaded 10845194 bytes. 16:37:31 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'] 16:37:31 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 16:37:31 INFO - Return code: 0 16:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:31 INFO - https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:37:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlZf2TaITQq31TgRtOAIMA/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 16:37:32 INFO - Downloaded 53860430 bytes. 16:37:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:32 INFO - mkdir: /builds/slave/test/properties 16:37:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:32 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:32 INFO - Contents: 16:37:32 INFO - build_url:https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:37:33 INFO - Running post-action listener: _resource_record_post_action 16:37:33 INFO - Running post-action listener: set_extra_try_arguments 16:37:33 INFO - ##### 16:37:33 INFO - ##### Running populate-webroot step. 16:37:33 INFO - ##### 16:37:33 INFO - Running pre-action listener: _resource_record_pre_action 16:37:33 INFO - Running main action method: populate_webroot 16:37:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:33 INFO - '--tppagecycles', 16:37:33 INFO - '7'], 16:37:33 INFO - 'tests': ['tsvgm']}}, 16:37:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:37:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:37:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'tests': ['damp', 'tps']}, 16:37:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['damp', 'tps']}, 16:37:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:37:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:33 INFO - 'other': {'tests': ['a11yr', 16:37:33 INFO - 'ts_paint', 16:37:33 INFO - 'tpaint', 16:37:33 INFO - 'sessionrestore', 16:37:33 INFO - 'sessionrestore_no_auto_restore', 16:37:33 INFO - 'tabpaint']}, 16:37:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['a11yr', 16:37:33 INFO - 'ts_paint', 16:37:33 INFO - 'tpaint', 16:37:33 INFO - 'sessionrestore', 16:37:33 INFO - 'sessionrestore_no_auto_restore', 16:37:33 INFO - 'tabpaint']}, 16:37:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['a11yr', 16:37:33 INFO - 'ts_paint', 16:37:33 INFO - 'tpaint', 16:37:33 INFO - 'sessionrestore', 16:37:33 INFO - 'sessionrestore_no_auto_restore', 16:37:33 INFO - 'tabpaint']}, 16:37:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['a11yr', 16:37:33 INFO - 'ts_paint', 16:37:33 INFO - 'tpaint', 16:37:33 INFO - 'sessionrestore', 16:37:33 INFO - 'sessionrestore_no_auto_restore', 16:37:33 INFO - 'tabpaint']}, 16:37:33 INFO - 'other_l64': {'tests': ['a11yr', 16:37:33 INFO - 'ts_paint', 16:37:33 INFO - 'tpaint', 16:37:33 INFO - 'sessionrestore', 16:37:33 INFO - 'sessionrestore_no_auto_restore', 16:37:33 INFO - 'tabpaint']}, 16:37:33 INFO - 'other_nol64': {'tests': ['a11yr', 16:37:33 INFO - 'ts_paint', 16:37:33 INFO - 'tpaint', 16:37:33 INFO - 'sessionrestore', 16:37:33 INFO - 'sessionrestore_no_auto_restore', 16:37:33 INFO - 'tabpaint']}, 16:37:33 INFO - 'svgr': {'tests': ['tsvgx', 16:37:33 INFO - 'tsvgr_opacity', 16:37:33 INFO - 'tart', 16:37:33 INFO - 'tscrollx', 16:37:33 INFO - 'cart']}, 16:37:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['tsvgx', 16:37:33 INFO - 'tsvgr_opacity', 16:37:33 INFO - 'tart', 16:37:33 INFO - 'tscrollx', 16:37:33 INFO - 'cart']}, 16:37:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'tests': ['tp5o']}, 16:37:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'talos_options': ['--e10s'], 16:37:33 INFO - 'tests': ['tp5o']}, 16:37:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'talos_options': ['--xperf_path', 16:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:33 INFO - 'tests': ['tp5n']}, 16:37:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:33 INFO - 'talos_options': ['--e10s', 16:37:33 INFO - '--xperf_path', 16:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:33 INFO - 'tests': ['tp5n']}}, 16:37:33 INFO - 'talos.zip': {'path': '', 16:37:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:33 INFO - Running post-action listener: _resource_record_post_action 16:37:33 INFO - ##### 16:37:33 INFO - ##### Running create-virtualenv step. 16:37:33 INFO - ##### 16:37:33 INFO - Running pre-action listener: _resource_record_pre_action 16:37:33 INFO - Running main action method: create_virtualenv 16:37:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:37:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:33 INFO - Using real prefix '/usr' 16:37:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:36 INFO - Installing pip.................done. 16:37:36 INFO - Return code: 0 16:37:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:36 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 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:37:36 INFO - Using env: {'DISPLAY': ':0', 16:37:36 INFO - 'HOME': '/home/cltbld', 16:37:36 INFO - 'LANG': 'en_US.UTF-8', 16:37:36 INFO - 'LANGUAGE': 'en_US:en', 16:37:36 INFO - 'LOGNAME': 'cltbld', 16:37:36 INFO - 'MAIL': '/var/mail/cltbld', 16:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:36 INFO - 'MOZ_NO_REMOTE': '1', 16:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:36 INFO - 'NO_EM_RESTART': '1', 16:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:36 INFO - 'PWD': '/builds/slave/test', 16:37:36 INFO - 'SHELL': '/bin/bash', 16:37:36 INFO - 'SHLVL': '1', 16:37:36 INFO - 'TERM': 'linux', 16:37:36 INFO - 'TMOUT': '86400', 16:37:36 INFO - 'USER': 'cltbld', 16:37:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:36 INFO - '_': '/tools/buildbot/bin/python'} 16:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:37:36 INFO - Cleaning up... 16:37:36 INFO - Return code: 0 16:37:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:36 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 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:37:36 INFO - Using env: {'DISPLAY': ':0', 16:37:36 INFO - 'HOME': '/home/cltbld', 16:37:36 INFO - 'LANG': 'en_US.UTF-8', 16:37:36 INFO - 'LANGUAGE': 'en_US:en', 16:37:36 INFO - 'LOGNAME': 'cltbld', 16:37:36 INFO - 'MAIL': '/var/mail/cltbld', 16:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:36 INFO - 'MOZ_NO_REMOTE': '1', 16:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:36 INFO - 'NO_EM_RESTART': '1', 16:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:36 INFO - 'PWD': '/builds/slave/test', 16:37:36 INFO - 'SHELL': '/bin/bash', 16:37:36 INFO - 'SHLVL': '1', 16:37:36 INFO - 'TERM': 'linux', 16:37:36 INFO - 'TMOUT': '86400', 16:37:36 INFO - 'USER': 'cltbld', 16:37:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:36 INFO - '_': '/tools/buildbot/bin/python'} 16:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:36 INFO - Downloading/unpacking psutil>=0.7.1 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:38 INFO - Installing collected packages: psutil 16:37:38 INFO - Running setup.py install for psutil 16:37:38 INFO - building 'psutil._psutil_linux' extension 16:37:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:37:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:37:38 INFO - building 'psutil._psutil_posix' extension 16:37:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:37:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:37:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:39 INFO - Successfully installed psutil 16:37:39 INFO - Cleaning up... 16:37:39 INFO - Return code: 0 16:37:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:37:39 INFO - Using env: {'DISPLAY': ':0', 16:37:39 INFO - 'HOME': '/home/cltbld', 16:37:39 INFO - 'LANG': 'en_US.UTF-8', 16:37:39 INFO - 'LANGUAGE': 'en_US:en', 16:37:39 INFO - 'LOGNAME': 'cltbld', 16:37:39 INFO - 'MAIL': '/var/mail/cltbld', 16:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:39 INFO - 'MOZ_NO_REMOTE': '1', 16:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:39 INFO - 'NO_EM_RESTART': '1', 16:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:39 INFO - 'PWD': '/builds/slave/test', 16:37:39 INFO - 'SHELL': '/bin/bash', 16:37:39 INFO - 'SHLVL': '1', 16:37:39 INFO - 'TERM': 'linux', 16:37:39 INFO - 'TMOUT': '86400', 16:37:39 INFO - 'USER': 'cltbld', 16:37:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:39 INFO - '_': '/tools/buildbot/bin/python'} 16:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:37:41 INFO - Installing collected packages: mozsystemmonitor 16:37:41 INFO - Running setup.py install for mozsystemmonitor 16:37:41 INFO - Successfully installed mozsystemmonitor 16:37:41 INFO - Cleaning up... 16:37:41 INFO - Return code: 0 16:37:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 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 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:37:41 INFO - Using env: {'DISPLAY': ':0', 16:37:41 INFO - 'HOME': '/home/cltbld', 16:37:41 INFO - 'LANG': 'en_US.UTF-8', 16:37:41 INFO - 'LANGUAGE': 'en_US:en', 16:37:41 INFO - 'LOGNAME': 'cltbld', 16:37:41 INFO - 'MAIL': '/var/mail/cltbld', 16:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:41 INFO - 'MOZ_NO_REMOTE': '1', 16:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:41 INFO - 'NO_EM_RESTART': '1', 16:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:41 INFO - 'PWD': '/builds/slave/test', 16:37:41 INFO - 'SHELL': '/bin/bash', 16:37:41 INFO - 'SHLVL': '1', 16:37:41 INFO - 'TERM': 'linux', 16:37:41 INFO - 'TMOUT': '86400', 16:37:41 INFO - 'USER': 'cltbld', 16:37:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:41 INFO - '_': '/tools/buildbot/bin/python'} 16:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:44 INFO - Downloading docopt-0.6.1.tar.gz 16:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:44 INFO - Running setup.py install for blobuploader 16:37:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:44 INFO - Running setup.py install for requests 16:37:44 INFO - Running setup.py install for docopt 16:37:44 INFO - Successfully installed blobuploader requests docopt 16:37:44 INFO - Cleaning up... 16:37:45 INFO - Return code: 0 16:37:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:45 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 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:45 INFO - Using env: {'DISPLAY': ':0', 16:37:45 INFO - 'HOME': '/home/cltbld', 16:37:45 INFO - 'LANG': 'en_US.UTF-8', 16:37:45 INFO - 'LANGUAGE': 'en_US:en', 16:37:45 INFO - 'LOGNAME': 'cltbld', 16:37:45 INFO - 'MAIL': '/var/mail/cltbld', 16:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:45 INFO - 'MOZ_NO_REMOTE': '1', 16:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:45 INFO - 'NO_EM_RESTART': '1', 16:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:45 INFO - 'PWD': '/builds/slave/test', 16:37:45 INFO - 'SHELL': '/bin/bash', 16:37:45 INFO - 'SHLVL': '1', 16:37:45 INFO - 'TERM': 'linux', 16:37:45 INFO - 'TMOUT': '86400', 16:37:45 INFO - 'USER': 'cltbld', 16:37:45 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:45 INFO - '_': '/tools/buildbot/bin/python'} 16:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:45 INFO - Running setup.py (path:/tmp/pip-NzSYQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:45 INFO - Running setup.py (path:/tmp/pip-vgWs6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:45 INFO - Running setup.py (path:/tmp/pip-JIES7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:45 INFO - Running setup.py (path:/tmp/pip-rr_RsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:45 INFO - Running setup.py (path:/tmp/pip-q_n7T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:45 INFO - Running setup.py (path:/tmp/pip-4mR9Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:45 INFO - Running setup.py (path:/tmp/pip-xoLZJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:45 INFO - Running setup.py (path:/tmp/pip-ts8LV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:45 INFO - Running setup.py (path:/tmp/pip-QVWrcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:45 INFO - Running setup.py (path:/tmp/pip-iyLpYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:45 INFO - Running setup.py (path:/tmp/pip-nC7dsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:46 INFO - Running setup.py (path:/tmp/pip-P5ljLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:46 INFO - Running setup.py (path:/tmp/pip-URMvPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:46 INFO - Running setup.py (path:/tmp/pip-o0Qu6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:46 INFO - Running setup.py (path:/tmp/pip-46weSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:46 INFO - Running setup.py (path:/tmp/pip-fPSFqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:46 INFO - Running setup.py (path:/tmp/pip-CELJQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:46 INFO - Running setup.py install for manifestparser 16:37:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:46 INFO - Running setup.py install for mozcrash 16:37:46 INFO - Running setup.py install for mozdebug 16:37:46 INFO - Running setup.py install for mozdevice 16:37:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:46 INFO - Running setup.py install for mozfile 16:37:46 INFO - Running setup.py install for mozhttpd 16:37:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Running setup.py install for mozinfo 16:37:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Running setup.py install for mozInstall 16:37:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Running setup.py install for mozleak 16:37:47 INFO - Running setup.py install for mozlog 16:37:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Running setup.py install for moznetwork 16:37:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Running setup.py install for mozprocess 16:37:47 INFO - Running setup.py install for mozprofile 16:37:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Running setup.py install for mozrunner 16:37:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:47 INFO - Running setup.py install for mozscreenshot 16:37:48 INFO - Running setup.py install for moztest 16:37:48 INFO - Running setup.py install for mozversion 16:37:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:48 INFO - Cleaning up... 16:37:48 INFO - Return code: 0 16:37:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:48 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 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:48 INFO - Using env: {'DISPLAY': ':0', 16:37:48 INFO - 'HOME': '/home/cltbld', 16:37:48 INFO - 'LANG': 'en_US.UTF-8', 16:37:48 INFO - 'LANGUAGE': 'en_US:en', 16:37:48 INFO - 'LOGNAME': 'cltbld', 16:37:48 INFO - 'MAIL': '/var/mail/cltbld', 16:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:48 INFO - 'MOZ_NO_REMOTE': '1', 16:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:48 INFO - 'NO_EM_RESTART': '1', 16:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:48 INFO - 'PWD': '/builds/slave/test', 16:37:48 INFO - 'SHELL': '/bin/bash', 16:37:48 INFO - 'SHLVL': '1', 16:37:48 INFO - 'TERM': 'linux', 16:37:48 INFO - 'TMOUT': '86400', 16:37:48 INFO - 'USER': 'cltbld', 16:37:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:48 INFO - '_': '/tools/buildbot/bin/python'} 16:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:48 INFO - Running setup.py (path:/tmp/pip-YSAtha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:48 INFO - Running setup.py (path:/tmp/pip-RPi5JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:48 INFO - Running setup.py (path:/tmp/pip-qmpH0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:48 INFO - Running setup.py (path:/tmp/pip-bDYrQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:48 INFO - Running setup.py (path:/tmp/pip-gYgnAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:48 INFO - Running setup.py (path:/tmp/pip-xn4hcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:48 INFO - Running setup.py (path:/tmp/pip-_ZHmZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:48 INFO - Running setup.py (path:/tmp/pip-guyWwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:49 INFO - Running setup.py (path:/tmp/pip-oRiTgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:49 INFO - Running setup.py (path:/tmp/pip-zFIVcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:49 INFO - Running setup.py (path:/tmp/pip-XfAuCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:49 INFO - Running setup.py (path:/tmp/pip-TLomDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:49 INFO - Running setup.py (path:/tmp/pip-Qc9Lny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:49 INFO - Running setup.py (path:/tmp/pip-PmsTbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:49 INFO - Running setup.py (path:/tmp/pip-BMS1Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:49 INFO - Running setup.py (path:/tmp/pip-hdNaus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:49 INFO - Running setup.py (path:/tmp/pip-2xAexE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:51 INFO - Downloading blessings-1.6.tar.gz 16:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:51 INFO - Installing collected packages: blessings 16:37:51 INFO - Running setup.py install for blessings 16:37:51 INFO - Successfully installed blessings 16:37:51 INFO - Cleaning up... 16:37:51 INFO - Return code: 0 16:37:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:52 INFO - Reading from file tmpfile_stdout 16:37:52 INFO - Current package versions: 16:37:52 INFO - argparse == 1.2.1 16:37:52 INFO - blessings == 1.6 16:37:52 INFO - blobuploader == 1.2.4 16:37:52 INFO - docopt == 0.6.1 16:37:52 INFO - manifestparser == 1.1 16:37:52 INFO - mozInstall == 1.12 16:37:52 INFO - mozcrash == 0.17 16:37:52 INFO - mozdebug == 0.1 16:37:52 INFO - mozdevice == 0.48 16:37:52 INFO - mozfile == 1.2 16:37:52 INFO - mozhttpd == 0.7 16:37:52 INFO - mozinfo == 0.9 16:37:52 INFO - mozleak == 0.1 16:37:52 INFO - mozlog == 3.1 16:37:52 INFO - moznetwork == 0.27 16:37:52 INFO - mozprocess == 0.22 16:37:52 INFO - mozprofile == 0.28 16:37:52 INFO - mozrunner == 6.11 16:37:52 INFO - mozscreenshot == 0.1 16:37:52 INFO - mozsystemmonitor == 0.0 16:37:52 INFO - moztest == 0.7 16:37:52 INFO - mozversion == 1.4 16:37:52 INFO - psutil == 3.1.1 16:37:52 INFO - requests == 1.2.3 16:37:52 INFO - wsgiref == 0.1.2 16:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:52 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 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:52 INFO - Using env: {'DISPLAY': ':0', 16:37:52 INFO - 'HOME': '/home/cltbld', 16:37:52 INFO - 'LANG': 'en_US.UTF-8', 16:37:52 INFO - 'LANGUAGE': 'en_US:en', 16:37:52 INFO - 'LOGNAME': 'cltbld', 16:37:52 INFO - 'MAIL': '/var/mail/cltbld', 16:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:52 INFO - 'MOZ_NO_REMOTE': '1', 16:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:52 INFO - 'NO_EM_RESTART': '1', 16:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:52 INFO - 'PWD': '/builds/slave/test', 16:37:52 INFO - 'SHELL': '/bin/bash', 16:37:52 INFO - 'SHLVL': '1', 16:37:52 INFO - 'TERM': 'linux', 16:37:52 INFO - 'TMOUT': '86400', 16:37:52 INFO - 'USER': 'cltbld', 16:37:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:52 INFO - '_': '/tools/buildbot/bin/python'} 16:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:37:52 INFO - Cleaning up... 16:37:52 INFO - Return code: 0 16:37:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37: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', 'jsonschema'] in /builds/slave/test/build 16:37: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 jsonschema 16:37:52 INFO - Using env: {'DISPLAY': ':0', 16:37:52 INFO - 'HOME': '/home/cltbld', 16:37:52 INFO - 'LANG': 'en_US.UTF-8', 16:37:52 INFO - 'LANGUAGE': 'en_US:en', 16:37:52 INFO - 'LOGNAME': 'cltbld', 16:37:52 INFO - 'MAIL': '/var/mail/cltbld', 16:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:52 INFO - 'MOZ_NO_REMOTE': '1', 16:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:52 INFO - 'NO_EM_RESTART': '1', 16:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:52 INFO - 'PWD': '/builds/slave/test', 16:37:52 INFO - 'SHELL': '/bin/bash', 16:37:52 INFO - 'SHLVL': '1', 16:37:52 INFO - 'TERM': 'linux', 16:37:52 INFO - 'TMOUT': '86400', 16:37:52 INFO - 'USER': 'cltbld', 16:37:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:52 INFO - '_': '/tools/buildbot/bin/python'} 16:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:52 INFO - Downloading/unpacking jsonschema 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:54 INFO - Downloading/unpacking functools32 (from jsonschema) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:54 INFO - warning: no files found matching '*.txt' 16:37:54 INFO - no previously-included directories found matching 'build' 16:37:54 INFO - no previously-included directories found matching 'dist' 16:37:54 INFO - no previously-included directories found matching '.git*' 16:37:54 INFO - Installing collected packages: jsonschema, functools32 16:37:54 INFO - Running setup.py install for functools32 16:37:54 INFO - warning: no files found matching '*.txt' 16:37:54 INFO - no previously-included directories found matching 'build' 16:37:54 INFO - no previously-included directories found matching 'dist' 16:37:54 INFO - no previously-included directories found matching '.git*' 16:37:54 INFO - Successfully installed jsonschema functools32 16:37:54 INFO - Cleaning up... 16:37:54 INFO - Return code: 0 16:37:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f312c739f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177c410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:37: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', 'flake8'] in /builds/slave/test/build 16:37: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 flake8 16:37:54 INFO - Using env: {'DISPLAY': ':0', 16:37:54 INFO - 'HOME': '/home/cltbld', 16:37:54 INFO - 'LANG': 'en_US.UTF-8', 16:37:54 INFO - 'LANGUAGE': 'en_US:en', 16:37:54 INFO - 'LOGNAME': 'cltbld', 16:37:54 INFO - 'MAIL': '/var/mail/cltbld', 16:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:54 INFO - 'MOZ_NO_REMOTE': '1', 16:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:54 INFO - 'NO_EM_RESTART': '1', 16:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:54 INFO - 'PWD': '/builds/slave/test', 16:37:54 INFO - 'SHELL': '/bin/bash', 16:37:54 INFO - 'SHLVL': '1', 16:37:54 INFO - 'TERM': 'linux', 16:37:54 INFO - 'TMOUT': '86400', 16:37:54 INFO - 'USER': 'cltbld', 16:37:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:54 INFO - '_': '/tools/buildbot/bin/python'} 16:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:55 INFO - Downloading/unpacking flake8 16:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:57 INFO - no previously-included directories found matching 'docs/_build' 16:37:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:57 INFO - Running setup.py install for pep8 16:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:57 INFO - no previously-included directories found matching 'docs/_build' 16:37:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:57 INFO - Cleaning up... 16:37:57 INFO - Return code: 0 16:37:57 INFO - Running post-action listener: _resource_record_post_action 16:37:57 INFO - Running post-action listener: _start_resource_monitoring 16:37:58 INFO - Starting resource monitoring. 16:37:58 INFO - ##### 16:37:58 INFO - ##### Running install step. 16:37:58 INFO - ##### 16:37:58 INFO - Running pre-action listener: _resource_record_pre_action 16:37:58 INFO - Running main action method: install 16:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:58 INFO - Reading from file tmpfile_stdout 16:37:58 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:58 INFO - Reading from file tmpfile_stdout 16:37:58 INFO - Output received: 16:37:58 INFO - Usage: mozinstall [options] installer 16:37:58 INFO - Options: 16:37:58 INFO - -h, --help show this help message and exit 16:37:58 INFO - -d DEST, --destination=DEST 16:37:58 INFO - Directory to install application into. [default: 16:37:58 INFO - "/builds/slave/test"] 16:37:58 INFO - --app=APP Application being installed. [default: firefox] 16:37:58 INFO - mkdir: /builds/slave/test/build/application 16:37:58 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'] 16:37:58 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 16:38:11 INFO - Reading from file tmpfile_stdout 16:38:11 INFO - Output received: 16:38:11 INFO - /builds/slave/test/build/application/firefox/firefox 16:38:11 INFO - Running post-action listener: _resource_record_post_action 16:38:11 INFO - ##### 16:38:11 INFO - ##### Running run-tests step. 16:38:11 INFO - ##### 16:38:11 INFO - Running pre-action listener: _resource_record_pre_action 16:38:11 INFO - Running main action method: run_tests 16:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:11 INFO - Python 2.7.3 16:38:11 INFO - Return code: 0 16:38:11 INFO - grabbing minidump binary from tooltool 16:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:11 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 0x180b160>, '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 0x180c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180c4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:38:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:11 INFO - Return code: 0 16:38:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:38:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:38:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:12 INFO - Return code: 0 16:38:12 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/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:38:12 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/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 16:38:12 INFO - Using env: {'DISPLAY': ':0', 16:38:12 INFO - 'HOME': '/home/cltbld', 16:38:12 INFO - 'LANG': 'en_US.UTF-8', 16:38:12 INFO - 'LANGUAGE': 'en_US:en', 16:38:12 INFO - 'LOGNAME': 'cltbld', 16:38:12 INFO - 'MAIL': '/var/mail/cltbld', 16:38:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:12 INFO - 'MOZ_NO_REMOTE': '1', 16:38:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:12 INFO - 'NO_EM_RESTART': '1', 16:38:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:12 INFO - 'PWD': '/builds/slave/test', 16:38:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:12 INFO - 'SHELL': '/bin/bash', 16:38:12 INFO - 'SHLVL': '1', 16:38:12 INFO - 'TERM': 'linux', 16:38:12 INFO - 'TMOUT': '86400', 16:38:12 INFO - 'USER': 'cltbld', 16:38:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350', 16:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:12 INFO - '_': '/tools/buildbot/bin/python'} 16:38:12 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/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:38:12 INFO - mozversion application_buildid: 20160526140250 16:38:12 INFO - mozversion application_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:38:12 INFO - mozversion application_display_name: Firefox 16:38:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:12 INFO - mozversion application_name: Firefox 16:38:12 INFO - mozversion application_remotingname: firefox 16:38:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:12 INFO - mozversion application_vendor: Mozilla 16:38:12 INFO - mozversion application_version: 47.0 16:38:12 INFO - mozversion platform_buildid: 20160526140250 16:38:12 INFO - mozversion platform_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:38:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:12 INFO - mozversion platform_version: 47.0 16:38:12 INFO - using testdate: 1464651492 16:38:12 INFO - actual date: 1464651492 16:38:12 INFO - starting webserver on 'localhost:43199' 16:38:12 INFO - SUITE-START | Running 2 tests 16:38:12 INFO - TEST-START | dromaeo_css 16:38:12 INFO - operating with platform_type : linux_ 16:38:12 INFO - Initialising browser for dromaeo_css test... 16:38:12 INFO - TEST-INFO | started process 17436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7FwqG/profile http://localhost:43199/getInfo.html) 16:38:16 INFO - PROCESS | 17436 | __metrics Screen width/height:1600/1200 16:38:16 INFO - PROCESS | 17436 | colorDepth:24 16:38:16 INFO - PROCESS | 17436 | Browser inner width/height: 1024/697 16:38:16 INFO - PROCESS | 17436 | __metrics 16:38:16 INFO - PROCESS | 17436 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:17 INFO - TEST-INFO | 17436: exit 0 16:38:17 INFO - Browser initialized. 16:38:17 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:17 INFO - TEST-INFO | started process 17524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7FwqG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:29 INFO - PROCESS | 17524 | RSS: Main: 139288576 16:38:29 INFO - PROCESS | 17524 | 16:39:20 INFO - PROCESS | 17524 | 1464651560968 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:41:27 INFO - PROCESS | 17524 | Cycle 1(1): loaded http://localhost:43199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43199/tests/dromaeo/cssquery-ext.html) 16:41:29 INFO - PROCESS | 17524 | RSS: Main: 290639872 16:41:29 INFO - PROCESS | 17524 | 16:44:31 INFO - PROCESS | 17524 | Cycle 1(1): loaded http://localhost:43199/tests/dromaeo/cssquery-ext.html (next: http://localhost:43199/tests/dromaeo/cssquery-jquery.html) 16:44:31 INFO - PROCESS | 17524 | RSS: Main: 231591936 16:44:31 INFO - PROCESS | 17524 | 16:47:33 INFO - PROCESS | 17524 | Cycle 1(1): loaded http://localhost:43199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43199/tests/dromaeo/cssquery-mootools.html) 16:47:34 INFO - PROCESS | 17524 | RSS: Main: 235782144 16:47:34 INFO - PROCESS | 17524 | 16:50:36 INFO - PROCESS | 17524 | Cycle 1(1): loaded http://localhost:43199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43199/tests/dromaeo/cssquery-prototype.html) 16:50:36 INFO - PROCESS | 17524 | RSS: Main: 193064960 16:50:36 INFO - PROCESS | 17524 | 16:53:39 INFO - PROCESS | 17524 | Cycle 1(1): loaded http://localhost:43199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43199/tests/dromaeo/cssquery-yui.html) 16:53:39 INFO - PROCESS | 17524 | RSS: Main: 209883136 16:53:39 INFO - PROCESS | 17524 | 16:56:41 INFO - PROCESS | 17524 | Cycle 1(1): loaded http://localhost:43199/tests/dromaeo/cssquery-yui.html (next: http://localhost:43199/tests/dromaeo/cssquery-dojo.html) 16:56:42 INFO - PROCESS | 17524 | RSS: Main: 260542464 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | __start_tp_report 16:56:42 INFO - PROCESS | 17524 | _x_x_mozilla_page_load 16:56:42 INFO - PROCESS | 17524 | _x_x_mozilla_page_load_details 16:56:42 INFO - PROCESS | 17524 | |i|pagename|runs| 16:56:42 INFO - PROCESS | 17524 | |0;dojo.html;3243.935121297574;3291.0455967769362;3295.3409318136364;3318.1041118897883;3326.101952472832;5223.112070947938;5230.764615592298;5232.764525596348;5237.659552129109;5245.527902488775;5235.947640523594;5253.369595648527;5256.921146182801;5259.500347466994;5264.921026184601;4736.810527578893;4772.379590653219;4823.831165909194;4840.806367745286;4878.170710979142;4823.276508523714;4834.492378300263;4867.68360056597;4872.147374209517;4873.390826146731;4847.660663753539;4898.951010489885;4914.877128071791;4926.334944782462;4982.103221420143;4839.758012099416;4900.068986892515;4914.066327397783;4918.458969513351;4929.162042452792;4755.619550435957;4849.9030019399415;4865.3675022247235;4893.804247830082;4911.115999120157;5117.181250999859;5172.974135129338;5176.7929282828645;5182.093133701587;5216.087184742692;5726.742296596622;5743.10981797822;5753.913691294634;5757.942420575782;5758.6544807311275;5598.44015598441;5633.915491267634;5769.365369809318;5773.509251713609;5801.24583804107;5334.866628334284;5340.893182136374;5344.679319240858;5347.304850369466;5380.354357477088;5823.359430462646;5829.679367634821;5831.125331200354;5833.125031245348;5834.358220595731;5460.6177567569885;5559.444055594408;5598.272224610856;5600;5604.663720176803;5696.11710184922;5698.373178950312;5702.800401985911;5706.429357064343;5708.086706127;5653.208550802891;5663.773449062074;5673;5673.290838645169;5674.602777805597;5564.8330550083565;5636.915446268309;5709.0865461525955;5769.163471296639;5786.421357864264;4344.370066340363;4347.478302603708;4350.60844523988;4353.804078816461;4376.693631445768;3934.8229329680235;3936.940945885814;3957.465742124834;3973.602639736061;3980.124372638015;5427.9185812212845;5448.700321482277;5512.669239845542;5527.115661494142;5548.112302031655;5701.4013528579735;5702.372738998707;5724.942750572524;5729.856753581111;5731.054376027909;5400.864978375494;5401.243825864382;5446.7276636168035;5454.3454785426;5459.808906688247;4846.29728689338;4889.193283108248;4894;4902.044101400193;4923.08922849274;5905.675187864708;5909.70451477433;5915.438033386821;5917.201177841022;5919.3192782829665;5632.042552766122;5675.574331925205;5684.6020778545935;5709.7430615623225;5748.712564371848;5933.940660593339;6001.879962400815;6008.188894499187;6008.188894499362;6018.51851851842;5667.773289068391;5680.318361796611;5680.460356266148;5680.573956953328;5681.77272909079;5596.86007849807;5692.373838877637;5736.053551164178;5763.250777398911;5774.682392468455;5604.243427137284;5606.327240731139;5620;5624.465675760796;5624.634398764068;5569.470900264469;5596.384397716167;5607.214989901336;5607.635503692247;5607.859803504945;5354.196870469461;5463.371712253142;5482.479164479368;5525.392206857162;5550.555955523468;5489.505944465017;5519.061759500814;5532.585056120726;5553.861153471195;5555.749991250323;5367.490088441592;5389.757460914347;5432.2123292123215;5480.780768769205;5483.040467918178 16:56:42 INFO - PROCESS | 17524 | |1;ext.html;519.1900635009385;521.2858384013902;529.3964880036759;540.5783488878675;545.334691676155;30198.849005754968;39289.410658840105;39788.40317395238;39883.80058099706;39888.60111398885;46505.767471162595;47280.81797955053;47319.29021064687;47393;47422.76288618561;9038.051004644516;9238.214751746109;9239.630414783434;9251;9254.120858518463;9034.051424600388;9183.540822958825;9195.540222988857;9197.49413782245;9199;9159.725208243763;9233.030531794133;9252.53737313135;9259.398139120969;9260.953695231514;9114.589843457026;9185.219256363218;9207.585658645343;9211.815763684755;9221.30840186982;9063.864042039375;9211.493367864765;9211.861822072675;9216.124468175512;9219.078092190794;43602.563974360484;44202.33696494555;44207;44208.778956105336;44231.77884110559;3229.3185768224243;3410.539577157077;3534.5228394166716;3564.2515071834946;3977.781222032787;34260.82869585636;34572.13569660753;34869.12827179315;35000.12499687503;35676.64323356759;4219.092895027584;4223.324268117087;4225.345071513921;4234.491860976703;4286.228478873802;229693;232729;233179;233583;233846;63546.6822665893;64474.35525644777;64480.35519644837;72304.63847680834;72377.27622723706;79083.60458197672;79329.60335198288;79380;79569;79623;18273.725894111598;18535.44393668192;18541.721874171897;18637.534061648297;18772.061396930098;14289.142651440947;14415.063020903817;14445.855541444662;14446.566603001716;14465.13209207451;22636.434089147573;23477.647835282485;23491;23533.529329413315;23593.292201233646;8310.8337833243;8437.57812109392;9029.864552031724;9055.2459958521;9118.270538356915;907.0430695616188;940.6137903547312;1059.51262419288;1142.2289954280827;1187.9940600296943;30668.846655766578;31079.223019424244;31359.216019599236;31804.68195318017;33103.3379332412;1003.4581326083979;1061.808874402615;1073.2755390111643;1208.5045131496045;1224.1736827641485;15209.543713688607;15213.391464341303;15332.540023799304;15493.380264789508;15621;443059;448979;449811;450867;450944;62337.376626234065;63646.36353636497;63654;63689.999999999076;63732;1335.9332033398487;1495.5961890289777;1499.9925000374928;1506.1339729655274;1512.455516014234;28473.00344487933;29820.701792981792;31160.22099447532;31325;31838.84080579675;50090.2486462696;50125.24812127748;50574;50624.240636389746;50702.23946640877;255845;259044;260090;260953;261561;30581.54127688131;34926.65073349234;35355.82322088373;35378.29243415066;35380.11549711175;52148.21777673262;53752.73123634357;56342.71828640831;57176.42823571711;57268.427315727975;40331;40950.59049409587;41032.58967410288;41287.587124128375;42414.78792606017;39790;40092.79953600213;40110.99722506961;40373.1925361497;41069.58930410658;39691.40462893117;39870.20259594734;40546.18907621772;40840;41014;34797.652023480456;36555.634443655224;36666.45000325051;37047.25905481929;37127.6287237135;27916.720832791412;28055.298617534725;28060.29849253785;28110.718892811627;28126.578101328905 16:56:42 INFO - PROCESS | 17524 | |2;jquery.html;328.96545862684417;344.13106905064717;346.321210427562;360.45931103344964;360.72404610473006;17326.306947722074;17555.648887022253;17915.372961946334;18104.547386315317;18149.455516334532;17642.294308227687;18257.634847303045;18592.628147437044;18610.72083918739;18640.347587834396;5213.452587478317;5611.663300201981;5611.887762244753;5617.41017193195;5620.718964051802;4251.256030194719;4373.475182978032;4373.737575745449;5440.4287549807295;5797.449242321973;6029.909551356734;6033;6039.365866584011;6057.242844644419;6064.42387973144;5242.1088414969545;5429.67421954684;5435.619506634517;5440.591955603346;6005.909911351311;3883.2233553289457;5191.532762051434;5203.063448579254;5239.973800130975;5254.290670759437;12901.806472902914;13191.736165276641;13211.207327560378;13362.86637133626;13388.799168012487;2177.8911054447212;2263.1060731011157;2274.8180145588312;2542.478791847667;2601.115620688956;9889.901100989042;10216.74458138545;10232.693019209435;10533.631322903739;13378.39797209128;1786.88385254958;1891.1206289075508;1908.6469003234447;1926.5761532462836;1934.6807776716826;60152;64534;65720;65780.34219657838;66237.66881165611;9726.465044422624;10161.4919254037;10355.275130740776;10432.122218000834;10466.842997355046;14509.709805803825;14780;14819.407223711147;14851.777223341658;14901.254937253094;7830.33442157423;7858.17489163641;7975.401844861659;8130.390220733469;8223.794405139799;7684.7310344138805;7702.691892324357;7781.377489800802;7816.8827467588035;8011.83976320482;4451.755153466525;4581.427321584802;4634.652401069933;4668.649851261169;4764.190087685102;1795.1203910083964;1868.2246867549813;1896.8429258152516;1908.6850669639355;1951.5706544560173;937.5780898595523;940.4122423485321;962.5043102802063;964.6816550538306;1010.4947526236881;16169.757453638205;16609.252583633766;16711.080890551137;16795;17055.829441705424;963.5471328475745;975.6195083917136;999.5452069308448;1008.1833714691123;1042.0100904141095;9788.363756355957;9906.900930990598;10000.149987251165;10034.64878729241;10176.236782241362;427929;454600;459643;459899;461442;74938.25061749313;76267.61866190634;76897.61551192208;77487;77905;1029.9433531155858;1030.443560477334;1045.968620941373;1050.3487837540774;1062.436908438529;15467.149306788235;15545.611359716098;15582.220888955733;15742.602413726045;15975.920120399323;32480.187995300308;32900.177495561846;33528.32943341168;34305;34514.65485345215;49170.508294916595;49365;49865;49908.500914990385;50004.499954999985;8144.959275203586;8298;8551.1448855114;8627.568621569022;8640.524771137396;11315.830262545904;12779.23324600527;12808.551700690432;12873;12933.935330323287;10691.227685030835;11117.166212534254;11203.159763017644;11254.324740515594;11466.197366184288;10818.24272300963;10878.292910960763;10970.835437468284;11238.831417528907;11587.188896777145;10790.892091079302;10940.23418360739;10987.450627468435;11035.613753518588;11439.199256051996;8132.2680958711635;8279.254867061993;8322.750317490485;8334.83330333402;8399.70601028961;10384.688459346231;10500.47497625131;10544;10903.618373356894;10917.39954302521 16:56:42 INFO - PROCESS | 17524 | |3;mootools.html;1470.0591621362337;1576.8580827725502;1602.431136946384;1855.8236967488092;1955.2374573916184;7458.888116678248;8022.91977080229;8072.434929554934;8079.515229086244;8080.636371363288;8121.75634730959;8289.088200297962;8299.751007469771;8300.418970672055;8313.542755148464;2426;2452.1172377943926;2452.3256104571296;2454.2882564056404;2454.3373289211904;2404.5791986402396;2425.357280320716;2460.9753902461016;2463.4210960424284;2480.379905023744;2481.5036992601463;2496.10140349474;2544.5165418570505;2553.9106131285407;2555.4122551813093;2498.925032249035;2512.095645567594;2520.1305549585454;2540;2551.2346296111277;2427.2232885476656;2456.275398757371;2514.208024472304;2526.166365099513;2526.68416447944;8369;8410.663573457054;8426.873596896052;8436.45163064399;8455.154484551496;5337.3061502004875;5475.206095116226;5476.863078423071;5478.863028424282;5482.342118945712;3198.1524895902603;3225.5645487859306;3259.755518336134;3312.403767321881;3349.698527132545;1019.9133073688745;1021.5686665735576;1036.5853658536646;1050.7425680708275;1103.0568863621568;12296.692582685415;12308.199967002205;12320.260784352968;12358;12367.443465044094;4734.597559207437;4754.95245047552;4891.755412229445;4924.852254432372;4937.530934561211;9217.44695318283;9256.398334108262;9296.16334529882;9310.441373517475;9317.254619630414;5248.422673505911;5257.342832145981;5259.263703081571;5271.446498117719;5275.841724748264;4257.212415703105;4736.3369128322065;4813.855584332476;4814.398200224972;4823.27650852375;3658.414653655402;3692.390755525308;3719.590845007047;3758.4174452959833;3785.413260944558;1131.3438205840594;1145.4158379226487;1152.4295473740551;1164.1152723929874;1165.6794381545144;1415.3701602786662;1430.6137342917561;1439.1293267573176;1447.7321695486369;1475.2623688155923;7858.528488290721;7892.013498312711;7927.3658107351275;7935.206479352134;7945.562994035268;497.59197458084026;502.42472369137136;505.524806681718;527.4646234072419;547.5236544206487;5836.562257830679;5897.587168898136;5900.262467191601;5930.080837470199;5940.940590594038;9988;10274.743131421625;10298.536565854554;10326.690199294033;10334.741631459123;9676.661316854017;10102.09081182697;10103.696889093339;10128.59485620567;10160.4919754012;7839;7898.802529936683;7916.445848790529;7928.127905930343;7953.244441778022;7702.268284512962;7720.961395193212;7743.961280193563;7807.336376408069;8001.479903806467;8906.777330566529;9029.322800789836;9153.816923661623;9300.488473134043;9302.906970930204;9227.492487913229;9286.257099431894;9303.162715355651;9342.486163261086;9369.906300936904;6734.56225345351;6853.554518956252;6907.033015377951;7590.392768578611;7685.423593230418;8134.471259368359;8145.959270203611;8187.5087494750505;8234.094249632415;8241.50550966944;7331.816704582428;7483.363914067365;7503.287187717158;7567.848643027219;7609.885851712118;7167.605781682058;7234.782956511313;7294.927050729637;7319.63401829917;7324.450666199949;7657.846843062996;7697.191794861459;7714.498557593738;7724.652390642547;7743.186965368555;6822.420094292041;7025.156981162293;7049.330313620198;7051.576905385693;7063.399611032914;7042.507024508235;7155.499115061895;7159.140903091662;7165.8925116122255;7178.964105179441 16:56:42 INFO - PROCESS | 17524 | |4;prototype.html;325.55724215067505;331.3422855631571;331.62857599488575;340.4620699295114;342.07809952178883;5822.446867547586;5866.823995280138;5880.059190529516;5882.352941176472;5884.529237660988;5800.622959507629;5823.796167134151;5825.038868586688;5830.883382332351;5838.591298609099;4344.847930322439;4376.89057773555;4539.341795439659;4545.136424079423;4547.63618910488;4524;4526.864194074166;4541.2733962566;4546.431696037996;4546.704464209833;4495.775211239441;4498.392716983198;4500.707454015478;4504.932426013613;4513.165064463068;4340.631046361063;4376.1247750449875;4486.753228572427;4488.708233964782;4500.144972455223;3926.587708290617;3937.3109705801658;3938;3944.053427177457;3960;5498.120300751901;5499.285092937933;5502.312210973629;5505.779768809283;5511.862203444906;5212.452692467275;5251.632385733;5255.894882102375;5256.132738098209;5261.158214685632;6170.136180934673;6177.567570270083;6178.505719542426;6179.938200617981;6182.072689096626;4128.091819799639;4255.148970205972;4263.126059157897;4361.476622805252;4374.825006999717;6421.871562568723;6479.028145778124;6497.93502064978;6511.479081673502;6515.804525864231;4369.148016136886;4371;4371.409859668967;4373.1472362888935;4375.671824613103;4424.579664931826;4428.645708343325;4432.180046691373;4433.534478879736;4440.067585807016;5092.8472145835685;5095.464976177448;5144.176931690911;5155.74221288934;5165.225216217597;6068.21113255274;6264.561480696308;6273.62358258506;6289.433950944437;6290.087937249074;1542.406173623163;1549.9147546885029;1555.0747305353298;1561.5861796623904;1563.9452619158503;999.7250756042001;1016.6594190945968;1030.567161792049;1043.879953805307;1069.4011353641986;6066.4540191382985;6071.210742603434;6106.847328816726;6117.265928088658;6126.877462450726;6388.552801303864;6395.040743888454;6402.231732192166;6408.231012278557;6411.647359395185;6102.816915492543;6111;6111.144439778434;6118.877622447615;6123.08153776937;3428.5885693716414;3459.221675123077;3465.54947856777;3468.514407982884;3469.340825243196;6611.404973552403;6691;6698.39714425704;6726.125603671491;6757.256701762803;6488.643124628191;6492.870142597121;6520.152380190545;6526.67366631676;6548.3124271950755;6662.56693314933;6677.165354330708;6680.16497937748;6681.5656982296;6699.6315202663345;6325.209348831396;6356.809295721136;6376.936230637634;6418.4544313731985;6484.28672845996;6140.692965351625;6272.310045894857;6279.623222606659;6296.33888441707;6348.460380867678;6770.93229067703;6771.492138089565;6806.387425131762;6814.352636499525;6817.659117044029;4506.954930450654;4554.726716397026;4554.817807287804;4555.180067587866;4561.521040290721;6436.645984470899;6438.195225596801;6449.129367535323;6451.903221451588;6452.806415807533;6264.123022776724;6266.592671476339;6282.497400207881;6287.056941458635;6291.276503202191;6103.816885493442;6346.048092786119;6358.713857876314;6380.042993551005;6383.234011918599;6215.502759779117;6299.4645455135;6310.558260921875;6313.905291420724;6316.936830631635;6389.073584330339;6391.936080639134;6391.968040159955;6405.743770249138;6406.135171751754;6009.429104235091;6013.488853447506;6236.6258024518675;6260.311365749672;6263 16:56:42 INFO - PROCESS | 17524 | |5;yui.html;729.2853004056025;845.5265051571124;860.157046094827;879.5030807593711;888.320434867327;13629.727405451886;13878;13909.513167039157;13947.232902190388;13947.651308717288;13702.588922332347;13917.37371818268;13981.860181398182;14045.78931316031;14076.436942522312;785.4070177016345;796.1998191817215;912.2610685344858;927.1146055516999;940.9717708468756;957.3394357893067;958.156821996642;959.0697023886819;959.7120863740885;960.4573416019962;1003.257589383858;1004.4877112672553;1004.8743907011624;1005.1707341443301;1005.1807776662033;808;964.1756298364902;989.0505115089522;989.351974456732;990.1484723138095;729.963501824912;732.0885497555524;733.1458850439285;733.545201974779;733.5635296998278;13241.271730054843;13339.866601334057;13399.062065655407;13404.530841420503;13408.530701425403;13798.103123297054;14016.579502614937;14101.2949352533;14182;14343.21112338821;11093.72265693356;11120.721981950435;11219.439028048646;11283.435828208556;11388.430578471127;3876.8255428505786;3883.49514563105;3945.309570825123;3947.822347994347;4008.378701301274;51512;51862;53143.73428132835;53180.468195318324;53273;10737.087347575387;10817.242793004572;10870.72823179411;11290.943545282222;11601.303921764722;20532.281370151974;20577.279795207094;20599.588008239753;20606.17575297001;20609.79390206079;7440.85118297631;7536.773896783106;7628.313451789366;7708.113566939762;7873.37013038967;3857.035741064734;4001.9415359926725;4032.1330913853662;4267.957320426818;4281.914361712748;3412.5563676722363;3419.401604719164;3442.087846720621;3447.7586568940437;3454.274602333538;565.8104534980745;588.4233451217744;591.3347484080409;597.2325561653255;606.1453350775386;459.9701019433726;615.9476444502178;627.9372062793775;646.8395558833519;649.5647915896361;8384.916150838535;8448.408611397266;8466.915330846736;8503.532305723245;8636.395452318404;548.4405905975962;665.6072916978909;691.5746815708303;696.3071743615135;718.0450001497995;4112.527059388149;4118.91762164761;4177.665786737054;4178.143480586473;4185.916281674349;58771;58903.41096589065;59518;59943;60297.09554356688;50141.96110914272;51135.48864511307;51549;51792.44622661326;52534.21198682023;44770.776146119715;46647.76676116598;47094;47187.528124719;47736.761316193195;8059.83880322402;8273.669053238043;8359.456635318686;8359.628482972135;8364.456310339809;36380.27239455249;37023.444648330835;37209.4418583716;37713.81143094267;37768.811155944044;42964.35553466638;43112.35331470093;44668.55331446774;45294.77352613216;46355.53644463512;10747.247692661438;11012.50443730018;11087.22389432732;11160.44197790091;11302;11150.665480035612;11275.830862536905;11365.829512557153;11397.772044558897;12229.633111006684;10371.325863818827;10538.631147909786;10593.258471906893;10791.460426978776;10821.026107650348;10113.69658910234;10164;10167.135793457639;10209;10741.570337186426;11021.504032318404;11037.172212084286;11080.722981925517;11091;11117.746591022067;9010.729678109667;9201.493917834583;9377.671781487616;9534.809303814023;9762.951185244028;8859.291256699578;9008.189262966365;9273.119053689888;9308.581113850028;9425.481598512148 16:56:42 INFO - PROCESS | 17524 | __end_tp_report 16:56:42 INFO - PROCESS | 17524 | __start_cc_report 16:56:42 INFO - PROCESS | 17524 | _x_x_mozilla_cycle_collect,1167 16:56:42 INFO - PROCESS | 17524 | __end_cc_report 16:56:42 INFO - PROCESS | 17524 | __startTimestamp1464652602138__endTimestamp 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | ------- Summary: start ------- 16:56:42 INFO - PROCESS | 17524 | Number of tests: 6 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | [#0] dojo.html Cycles:165 Average:5304.39 Median:5512.67 stddev:577.01 (10.5%) stddev-sans-first:555.68 16:56:42 INFO - PROCESS | 17524 | Values: 3243.9 3291.0 3295.3 3318.1 3326.1 5223.1 5230.8 5232.8 5237.7 5245.5 5235.9 5253.4 5256.9 5259.5 5264.9 4736.8 4772.4 4823.8 4840.8 4878.2 4823.3 4834.5 4867.7 4872.1 4873.4 4847.7 4899.0 4914.9 4926.3 4982.1 4839.8 4900.1 4914.1 4918.5 4929.2 4755.6 4849.9 4865.4 4893.8 4911.1 5117.2 5173.0 5176.8 5182.1 5216.1 5726.7 5743.1 5753.9 5757.9 5758.7 5598.4 5633.9 5769.4 5773.5 5801.2 5334.9 5340.9 5344.7 5347.3 5380.4 5823.4 5829.7 5831.1 5833.1 5834.4 5460.6 5559.4 5598.3 5600.0 5604.7 5696.1 5698.4 5702.8 5706.4 5708.1 5653.2 5663.8 5673.0 5673.3 5674.6 5564.8 5636.9 5709.1 5769.2 5786.4 4344.4 4347.5 4350.6 4353.8 4376.7 3934.8 3936.9 3957.5 3973.6 3980.1 5427.9 5448.7 5512.7 5527.1 5548.1 5701.4 5702.4 5724.9 5729.9 5731.1 5400.9 5401.2 5446.7 5454.3 5459.8 4846.3 4889.2 4894.0 4902.0 4923.1 5905.7 5909.7 5915.4 5917.2 5919.3 5632.0 5675.6 5684.6 5709.7 5748.7 5933.9 6001.9 6008.2 6008.2 6018.5 5667.8 5680.3 5680.5 5680.6 5681.8 5596.9 5692.4 5736.1 5763.3 5774.7 5604.2 5606.3 5620.0 5624.5 5624.6 5569.5 5596.4 5607.2 5607.6 5607.9 5354.2 5463.4 5482.5 5525.4 5550.6 5489.5 5519.1 5532.6 5553.9 5555.7 5367.5 5389.8 5432.2 5480.8 5483.0 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | [#1] ext.html Cycles:180 Average:51167.26 Median:40693.09 stddev:86513.89 (212.6%) stddev-sans-first:86673.01 16:56:42 INFO - PROCESS | 17524 | Values: 519.2 521.3 529.4 540.6 545.3 30198.8 39289.4 39788.4 39883.8 39888.6 46505.8 47280.8 47319.3 47393.0 47422.8 9038.1 9238.2 9239.6 9251.0 9254.1 9034.1 9183.5 9195.5 9197.5 9199.0 9159.7 9233.0 9252.5 9259.4 9261.0 9114.6 9185.2 9207.6 9211.8 9221.3 9063.9 9211.5 9211.9 9216.1 9219.1 43602.6 44202.3 44207.0 44208.8 44231.8 3229.3 3410.5 3534.5 3564.3 3977.8 34260.8 34572.1 34869.1 35000.1 35676.6 4219.1 4223.3 4225.3 4234.5 4286.2 229693.0 232729.0 233179.0 233583.0 233846.0 63546.7 64474.4 64480.4 72304.6 72377.3 79083.6 79329.6 79380.0 79569.0 79623.0 18273.7 18535.4 18541.7 18637.5 18772.1 14289.1 14415.1 14445.9 14446.6 14465.1 22636.4 23477.6 23491.0 23533.5 23593.3 8310.8 8437.6 9029.9 9055.2 9118.3 907.0 940.6 1059.5 1142.2 1188.0 30668.8 31079.2 31359.2 31804.7 33103.3 1003.5 1061.8 1073.3 1208.5 1224.2 15209.5 15213.4 15332.5 15493.4 15621.0 443059.0 448979.0 449811.0 450867.0 450944.0 62337.4 63646.4 63654.0 63690.0 63732.0 1335.9 1495.6 1500.0 1506.1 1512.5 28473.0 29820.7 31160.2 31325.0 31838.8 50090.2 50125.2 50574.0 50624.2 50702.2 255845.0 259044.0 260090.0 260953.0 261561.0 30581.5 34926.7 35355.8 35378.3 35380.1 52148.2 53752.7 56342.7 57176.4 57268.4 40331.0 40950.6 41032.6 41287.6 42414.8 39790.0 40092.8 40111.0 40373.2 41069.6 39691.4 39870.2 40546.2 40840.0 41014.0 34797.7 36555.6 36666.5 37047.3 37127.6 27916.7 28055.3 28060.3 28110.7 28126.6 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | [#2] jquery.html Cycles:180 Average:25962.90 Median:16614.57 stddev:74266.38 (447.0%) stddev-sans-first:74449.77 16:56:42 INFO - PROCESS | 17524 | Values: 329.0 344.1 346.3 360.5 360.7 17326.3 17555.6 17915.4 18104.5 18149.5 17642.3 18257.6 18592.6 18610.7 18640.3 5213.5 5611.7 5611.9 5617.4 5620.7 4251.3 4373.5 4373.7 5440.4 5797.4 6029.9 6033.0 6039.4 6057.2 6064.4 5242.1 5429.7 5435.6 5440.6 6005.9 3883.2 5191.5 5203.1 5240.0 5254.3 12901.8 13191.7 13211.2 13362.9 13388.8 2177.9 2263.1 2274.8 2542.5 2601.1 9889.9 10216.7 10232.7 10533.6 13378.4 1786.9 1891.1 1908.6 1926.6 1934.7 60152.0 64534.0 65720.0 65780.3 66237.7 9726.5 10161.5 10355.3 10432.1 10466.8 14509.7 14780.0 14819.4 14851.8 14901.3 7830.3 7858.2 7975.4 8130.4 8223.8 7684.7 7702.7 7781.4 7816.9 8011.8 4451.8 4581.4 4634.7 4668.6 4764.2 1795.1 1868.2 1896.8 1908.7 1951.6 937.6 940.4 962.5 964.7 1010.5 16169.8 16609.3 16711.1 16795.0 17055.8 963.5 975.6 999.5 1008.2 1042.0 9788.4 9906.9 10000.1 10034.6 10176.2 427929.0 454600.0 459643.0 459899.0 461442.0 74938.3 76267.6 76897.6 77487.0 77905.0 1029.9 1030.4 1046.0 1050.3 1062.4 15467.1 15545.6 15582.2 15742.6 15975.9 32480.2 32900.2 33528.3 34305.0 34514.7 49170.5 49365.0 49865.0 49908.5 50004.5 8145.0 8298.0 8551.1 8627.6 8640.5 11315.8 12779.2 12808.6 12873.0 12933.9 10691.2 11117.2 11203.2 11254.3 11466.2 10818.2 10878.3 10970.8 11238.8 11587.2 10790.9 10940.2 10987.5 11035.6 11439.2 8132.3 8279.3 8322.8 8334.8 8399.7 10384.7 10500.5 10544.0 10903.6 10917.4 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | [#3] mootools.html Cycles:180 Average:5887.84 Median:5477.86 stddev:3091.12 (56.4%) stddev-sans-first:3081.95 16:56:42 INFO - PROCESS | 17524 | Values: 1470.1 1576.9 1602.4 1855.8 1955.2 7458.9 8022.9 8072.4 8079.5 8080.6 8121.8 8289.1 8299.8 8300.4 8313.5 2426.0 2452.1 2452.3 2454.3 2454.3 2404.6 2425.4 2461.0 2463.4 2480.4 2481.5 2496.1 2544.5 2553.9 2555.4 2498.9 2512.1 2520.1 2540.0 2551.2 2427.2 2456.3 2514.2 2526.2 2526.7 8369.0 8410.7 8426.9 8436.5 8455.2 5337.3 5475.2 5476.9 5478.9 5482.3 3198.2 3225.6 3259.8 3312.4 3349.7 1019.9 1021.6 1036.6 1050.7 1103.1 12296.7 12308.2 12320.3 12358.0 12367.4 4734.6 4755.0 4891.8 4924.9 4937.5 9217.4 9256.4 9296.2 9310.4 9317.3 5248.4 5257.3 5259.3 5271.4 5275.8 4257.2 4736.3 4813.9 4814.4 4823.3 3658.4 3692.4 3719.6 3758.4 3785.4 1131.3 1145.4 1152.4 1164.1 1165.7 1415.4 1430.6 1439.1 1447.7 1475.3 7858.5 7892.0 7927.4 7935.2 7945.6 497.6 502.4 505.5 527.5 547.5 5836.6 5897.6 5900.3 5930.1 5940.9 9988.0 10274.7 10298.5 10326.7 10334.7 9676.7 10102.1 10103.7 10128.6 10160.5 7839.0 7898.8 7916.4 7928.1 7953.2 7702.3 7721.0 7744.0 7807.3 8001.5 8906.8 9029.3 9153.8 9300.5 9302.9 9227.5 9286.3 9303.2 9342.5 9369.9 6734.6 6853.6 6907.0 7590.4 7685.4 8134.5 8146.0 8187.5 8234.1 8241.5 7331.8 7483.4 7503.3 7567.8 7609.9 7167.6 7234.8 7294.9 7319.6 7324.5 7657.8 7697.2 7714.5 7724.7 7743.2 6822.4 7025.2 7049.3 7051.6 7063.4 7042.5 7155.5 7159.1 7165.9 7179.0 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | [#4] prototype.html Cycles:180 Average:5228.13 Median:6039.97 stddev:1586.05 (26.3%) stddev-sans-first:1547.22 16:56:42 INFO - PROCESS | 17524 | Values: 325.6 331.3 331.6 340.5 342.1 5822.4 5866.8 5880.1 5882.4 5884.5 5800.6 5823.8 5825.0 5830.9 5838.6 4344.8 4376.9 4539.3 4545.1 4547.6 4524.0 4526.9 4541.3 4546.4 4546.7 4495.8 4498.4 4500.7 4504.9 4513.2 4340.6 4376.1 4486.8 4488.7 4500.1 3926.6 3937.3 3938.0 3944.1 3960.0 5498.1 5499.3 5502.3 5505.8 5511.9 5212.5 5251.6 5255.9 5256.1 5261.2 6170.1 6177.6 6178.5 6179.9 6182.1 4128.1 4255.1 4263.1 4361.5 4374.8 6421.9 6479.0 6497.9 6511.5 6515.8 4369.1 4371.0 4371.4 4373.1 4375.7 4424.6 4428.6 4432.2 4433.5 4440.1 5092.8 5095.5 5144.2 5155.7 5165.2 6068.2 6264.6 6273.6 6289.4 6290.1 1542.4 1549.9 1555.1 1561.6 1563.9 999.7 1016.7 1030.6 1043.9 1069.4 6066.5 6071.2 6106.8 6117.3 6126.9 6388.6 6395.0 6402.2 6408.2 6411.6 6102.8 6111.0 6111.1 6118.9 6123.1 3428.6 3459.2 3465.5 3468.5 3469.3 6611.4 6691.0 6698.4 6726.1 6757.3 6488.6 6492.9 6520.2 6526.7 6548.3 6662.6 6677.2 6680.2 6681.6 6699.6 6325.2 6356.8 6376.9 6418.5 6484.3 6140.7 6272.3 6279.6 6296.3 6348.5 6770.9 6771.5 6806.4 6814.4 6817.7 4507.0 4554.7 4554.8 4555.2 4561.5 6436.6 6438.2 6449.1 6451.9 6452.8 6264.1 6266.6 6282.5 6287.1 6291.3 6103.8 6346.0 6358.7 6380.0 6383.2 6215.5 6299.5 6310.6 6313.9 6316.9 6389.1 6391.9 6392.0 6405.7 6406.1 6009.4 6013.5 6236.6 6260.3 6263.0 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - PROCESS | 17524 | [#5] yui.html Cycles:180 Average:14175.59 Median:43038.35 stddev:16489.01 (38.3%) stddev-sans-first:16504.35 16:56:42 INFO - PROCESS | 17524 | Values: 729.3 845.5 860.2 879.5 888.3 13629.7 13878.0 13909.5 13947.2 13947.7 13702.6 13917.4 13981.9 14045.8 14076.4 785.4 796.2 912.3 927.1 941.0 957.3 958.2 959.1 959.7 960.5 1003.3 1004.5 1004.9 1005.2 1005.2 808.0 964.2 989.1 989.4 990.1 730.0 732.1 733.1 733.5 733.6 13241.3 13339.9 13399.1 13404.5 13408.5 13798.1 14016.6 14101.3 14182.0 14343.2 11093.7 11120.7 11219.4 11283.4 11388.4 3876.8 3883.5 3945.3 3947.8 4008.4 51512.0 51862.0 53143.7 53180.5 53273.0 10737.1 10817.2 10870.7 11290.9 11601.3 20532.3 20577.3 20599.6 20606.2 20609.8 7440.9 7536.8 7628.3 7708.1 7873.4 3857.0 4001.9 4032.1 4268.0 4281.9 3412.6 3419.4 3442.1 3447.8 3454.3 565.8 588.4 591.3 597.2 606.1 460.0 615.9 627.9 646.8 649.6 8384.9 8448.4 8466.9 8503.5 8636.4 548.4 665.6 691.6 696.3 718.0 4112.5 4118.9 4177.7 4178.1 4185.9 58771.0 58903.4 59518.0 59943.0 60297.1 50142.0 51135.5 51549.0 51792.4 52534.2 44770.8 46647.8 47094.0 47187.5 47736.8 8059.8 8273.7 8359.5 8359.6 8364.5 36380.3 37023.4 37209.4 37713.8 37768.8 42964.4 43112.4 44668.6 45294.8 46355.5 10747.2 11012.5 11087.2 11160.4 11302.0 11150.7 11275.8 11365.8 11397.8 12229.6 10371.3 10538.6 10593.3 10791.5 10821.0 10113.7 10164.0 10167.1 10209.0 10741.6 11021.5 11037.2 11080.7 11091.0 11117.7 9010.7 9201.5 9377.7 9534.8 9763.0 8859.3 9008.2 9273.1 9308.6 9425.5 16:56:42 INFO - PROCESS | 17524 | -------- Summary: end -------- 16:56:42 INFO - PROCESS | 17524 | 16:56:42 INFO - TEST-INFO | 17524: exit 0 16:56:42 INFO - TEST-OK | dromaeo_css | took 1110577ms 16:56:42 INFO - TEST-START | kraken 16:56:42 INFO - operating with platform_type : linux_ 16:56:42 INFO - Initialising browser for kraken test... 16:56:42 INFO - TEST-INFO | started process 17721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4TV1gd/profile http://localhost:43199/getInfo.html) 16:56:46 INFO - PROCESS | 17721 | __metrics Screen width/height:1600/1200 16:56:46 INFO - PROCESS | 17721 | colorDepth:24 16:56:46 INFO - PROCESS | 17721 | Browser inner width/height: 1024/697 16:56:46 INFO - PROCESS | 17721 | __metrics 16:56:47 INFO - PROCESS | 17721 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:48 INFO - TEST-INFO | 17721: exit 0 16:56:48 INFO - Browser initialized. 16:56:48 INFO - Running cycle 1/1 for kraken test... 16:56:48 INFO - TEST-INFO | started process 17813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4TV1gd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:00 INFO - PROCESS | 17813 | RSS: Main: 139231232 16:57:00 INFO - PROCESS | 17813 | 16:57:02 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43199/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:03 INFO - PROCESS | 17813 | RSS: Main: 182571008 16:57:03 INFO - PROCESS | 17813 | 16:57:05 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43199/tests/kraken/driver.html?testName=audio-dft) 16:57:06 INFO - PROCESS | 17813 | RSS: Main: 175759360 16:57:06 INFO - PROCESS | 17813 | 16:57:09 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43199/tests/kraken/driver.html?testName=audio-fft) 16:57:09 INFO - PROCESS | 17813 | RSS: Main: 175034368 16:57:09 INFO - PROCESS | 17813 | 16:57:12 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43199/tests/kraken/driver.html?testName=audio-oscillator) 16:57:12 INFO - PROCESS | 17813 | RSS: Main: 176050176 16:57:12 INFO - PROCESS | 17813 | 16:57:14 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:15 INFO - PROCESS | 17813 | RSS: Main: 174641152 16:57:15 INFO - PROCESS | 17813 | 16:57:18 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43199/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:18 INFO - PROCESS | 17813 | RSS: Main: 174456832 16:57:18 INFO - PROCESS | 17813 | 16:57:22 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43199/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:22 INFO - PROCESS | 17813 | RSS: Main: 175116288 16:57:22 INFO - PROCESS | 17813 | 16:57:25 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43199/tests/kraken/driver.html?testName=json-parse-financial) 16:57:26 INFO - PROCESS | 17813 | RSS: Main: 174411776 16:57:26 INFO - PROCESS | 17813 | 16:57:27 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:28 INFO - PROCESS | 17813 | RSS: Main: 183922688 16:57:28 INFO - PROCESS | 17813 | 16:57:30 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:30 INFO - PROCESS | 17813 | RSS: Main: 183332864 16:57:30 INFO - PROCESS | 17813 | 16:57:32 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:33 INFO - PROCESS | 17813 | RSS: Main: 184901632 16:57:33 INFO - PROCESS | 17813 | 16:57:35 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:36 INFO - PROCESS | 17813 | RSS: Main: 188043264 16:57:36 INFO - PROCESS | 17813 | 16:57:38 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:39 INFO - PROCESS | 17813 | RSS: Main: 184807424 16:57:39 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | Cycle 1(1): loaded http://localhost:43199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43199/tests/kraken/driver.html?testName=ai-astar) 16:57:41 INFO - PROCESS | 17813 | RSS: Main: 246370304 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | __start_tp_report 16:57:41 INFO - PROCESS | 17813 | _x_x_mozilla_page_load 16:57:41 INFO - PROCESS | 17813 | _x_x_mozilla_page_load_details 16:57:41 INFO - PROCESS | 17813 | |i|pagename|runs| 16:57:41 INFO - PROCESS | 17813 | |0;ai-astar;112;112;111;110;112;113;113;112;112;125 16:57:41 INFO - PROCESS | 17813 | |1;audio-beat-detection;152;127;154;175;128;160;154;134;183;127 16:57:41 INFO - PROCESS | 17813 | |2;audio-dft;161;161;162;161;161;160;162;161;161;161 16:57:41 INFO - PROCESS | 17813 | |3;audio-fft;74;77;78;158;76;76;84;77;164;75 16:57:41 INFO - PROCESS | 17813 | |4;audio-oscillator;94;94;151;94;93;94;147;95;93;146 16:57:41 INFO - PROCESS | 17813 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;116 16:57:41 INFO - PROCESS | 17813 | |6;imaging-darkroom;147;145;146;146;146;147;146;146;147;145 16:57:41 INFO - PROCESS | 17813 | |7;imaging-desaturate;95;96;96;95;96;95;96;95;96;95 16:57:41 INFO - PROCESS | 17813 | |8;json-parse-financial;56;57;55;56;55;59;55;56;70;52 16:57:41 INFO - PROCESS | 17813 | |9;json-stringify-tinderbox;65;65;65;67;65;66;65;65;64;65 16:57:41 INFO - PROCESS | 17813 | |10;stanford-crypto-aes;94;87;78;86;80;89;80;80;86;80 16:57:41 INFO - PROCESS | 17813 | |11;stanford-crypto-ccm;114;112;112;117;122;120;113;113;114;115 16:57:41 INFO - PROCESS | 17813 | |12;stanford-crypto-pbkdf2;148;134;147;145;144;140;146;149;150;155 16:57:41 INFO - PROCESS | 17813 | |13;stanford-crypto-sha256-iterative;68;70;69;68;75;69;67;66;66;67 16:57:41 INFO - PROCESS | 17813 | __end_tp_report 16:57:41 INFO - PROCESS | 17813 | __start_cc_report 16:57:41 INFO - PROCESS | 17813 | _x_x_mozilla_cycle_collect,1055 16:57:41 INFO - PROCESS | 17813 | __end_cc_report 16:57:41 INFO - PROCESS | 17813 | __startTimestamp1464652661334__endTimestamp 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | ------- Summary: start ------- 16:57:41 INFO - PROCESS | 17813 | Number of tests: 14 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#0] ai-astar Cycles:10 Average:113.20 Median:112.00 stddev:4.24 (3.8%) stddev-sans-first:4.47 16:57:41 INFO - PROCESS | 17813 | Values: 112.0 112.0 111.0 110.0 112.0 113.0 113.0 112.0 112.0 125.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:154.00 stddev:20.12 (13.1%) stddev-sans-first:21.32 16:57:41 INFO - PROCESS | 17813 | Values: 152.0 127.0 154.0 175.0 128.0 160.0 154.0 134.0 183.0 127.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:57:41 INFO - PROCESS | 17813 | Values: 161.0 161.0 162.0 161.0 161.0 160.0 162.0 161.0 161.0 161.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:35.49 (46.4%) stddev-sans-first:36.91 16:57:41 INFO - PROCESS | 17813 | Values: 74.0 77.0 78.0 158.0 76.0 76.0 84.0 77.0 164.0 75.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:94.00 stddev:26.19 (27.9%) stddev-sans-first:27.12 16:57:41 INFO - PROCESS | 17813 | Values: 94.0 94.0 151.0 94.0 93.0 94.0 147.0 95.0 93.0 146.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:57:41 INFO - PROCESS | 17813 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 16:57:41 INFO - PROCESS | 17813 | Values: 147.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 145.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:57:41 INFO - PROCESS | 17813 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.00 stddev:4.86 (8.7%) stddev-sans-first:5.14 16:57:41 INFO - PROCESS | 17813 | Values: 56.0 57.0 55.0 56.0 55.0 59.0 55.0 56.0 70.0 52.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 16:57:41 INFO - PROCESS | 17813 | Values: 65.0 65.0 65.0 67.0 65.0 66.0 65.0 65.0 64.0 65.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:86.00 stddev:5.19 (6.0%) stddev-sans-first:4.04 16:57:41 INFO - PROCESS | 17813 | Values: 94.0 87.0 78.0 86.0 80.0 89.0 80.0 80.0 86.0 80.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:114.50 stddev:3.43 (3.0%) stddev-sans-first:3.61 16:57:41 INFO - PROCESS | 17813 | Values: 114.0 112.0 112.0 117.0 122.0 120.0 113.0 113.0 114.0 115.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.50 stddev:5.73 (3.9%) stddev-sans-first:6.02 16:57:41 INFO - PROCESS | 17813 | Values: 148.0 134.0 147.0 145.0 144.0 140.0 146.0 149.0 150.0 155.0 16:57:41 INFO - PROCESS | 17813 | 16:57:41 INFO - PROCESS | 17813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.64 (3.8%) stddev-sans-first:2.79 16:57:41 INFO - PROCESS | 17813 | Values: 68.0 70.0 69.0 68.0 75.0 69.0 67.0 66.0 66.0 67.0 16:57:41 INFO - PROCESS | 17813 | -------- Summary: end -------- 16:57:41 INFO - PROCESS | 17813 | 16:57:42 INFO - TEST-INFO | 17813: exit 0 16:57:42 INFO - TEST-OK | kraken | took 59387ms 16:57:42 INFO - SUITE-END | took 1169s 16:57:42 INFO - Completed test suite (00:19:30) 16:57:42 INFO - javascript benchmark 16:57:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3243.935121297574, 3291.0455967769362, 3295.3409318136364, 3318.1041118897883, 3326.101952472832, 5223.112070947938, 5230.764615592298, 5232.764525596348, 5237.659552129109, 5245.527902488775, 5235.947640523594, 5253.369595648527, 5256.921146182801, 5259.500347466994, 5264.921026184601, 4736.810527578893, 4772.379590653219, 4823.831165909194, 4840.806367745286, 4878.170710979142, 4823.276508523714, 4834.492378300263, 4867.68360056597, 4872.147374209517, 4873.390826146731, 4847.660663753539, 4898.951010489885, 4914.877128071791, 4926.334944782462, 4982.103221420143, 4839.758012099416, 4900.068986892515, 4914.066327397783, 4918.458969513351, 4929.162042452792, 4755.619550435957, 4849.9030019399415, 4865.3675022247235, 4893.804247830082, 4911.115999120157, 5117.181250999859, 5172.974135129338, 5176.7929282828645, 5182.093133701587, 5216.087184742692, 5726.742296596622, 5743.10981797822, 5753.913691294634, 5757.942420575782, 5758.6544807311275, 5598.44015598441, 5633.915491267634, 5769.365369809318, 5773.509251713609, 5801.24583804107, 5334.866628334284, 5340.893182136374, 5344.679319240858, 5347.304850369466, 5380.354357477088, 5823.359430462646, 5829.679367634821, 5831.125331200354, 5833.125031245348, 5834.358220595731, 5460.6177567569885, 5559.444055594408, 5598.272224610856, 5600.0, 5604.663720176803, 5696.11710184922, 5698.373178950312, 5702.800401985911, 5706.429357064343, 5708.086706127, 5653.208550802891, 5663.773449062074, 5673.0, 5673.290838645169, 5674.602777805597, 5564.8330550083565, 5636.915446268309, 5709.0865461525955, 5769.163471296639, 5786.421357864264, 4344.370066340363, 4347.478302603708, 4350.60844523988, 4353.804078816461, 4376.693631445768, 3934.8229329680235, 3936.940945885814, 3957.465742124834, 3973.602639736061, 3980.124372638015, 5427.9185812212845, 5448.700321482277, 5512.669239845542, 5527.115661494142, 5548.112302031655, 5701.4013528579735, 5702.372738998707, 5724.942750572524, 5729.856753581111, 5731.054376027909, 5400.864978375494, 5401.243825864382, 5446.7276636168035, 5454.3454785426, 5459.808906688247, 4846.29728689338, 4889.193283108248, 4894.0, 4902.044101400193, 4923.08922849274, 5905.675187864708, 5909.70451477433, 5915.438033386821, 5917.201177841022, 5919.3192782829665, 5632.042552766122, 5675.574331925205, 5684.6020778545935, 5709.7430615623225, 5748.712564371848, 5933.940660593339, 6001.879962400815, 6008.188894499187, 6008.188894499362, 6018.51851851842, 5667.773289068391, 5680.318361796611, 5680.460356266148, 5680.573956953328, 5681.77272909079, 5596.86007849807, 5692.373838877637, 5736.053551164178, 5763.250777398911, 5774.682392468455, 5604.243427137284, 5606.327240731139, 5620.0, 5624.465675760796, 5624.634398764068, 5569.470900264469, 5596.384397716167, 5607.214989901336, 5607.635503692247, 5607.859803504945, 5354.196870469461, 5463.371712253142, 5482.479164479368, 5525.392206857162, 5550.555955523468, 5489.505944465017, 5519.061759500814, 5532.585056120726, 5553.861153471195, 5555.749991250323, 5367.490088441592, 5389.757460914347, 5432.2123292123215, 5480.780768769205, 5483.040467918178], "unit": "score", "name": "dojo.html", "value": 5268.177929091866}, {"lowerIsBetter": false, "replicates": [519.1900635009385, 521.2858384013902, 529.3964880036759, 540.5783488878675, 545.334691676155, 30198.849005754968, 39289.410658840105, 39788.40317395238, 39883.80058099706, 39888.60111398885, 46505.767471162595, 47280.81797955053, 47319.29021064687, 47393.0, 47422.76288618561, 9038.051004644516, 9238.214751746109, 9239.630414783434, 9251.0, 9254.120858518463, 9034.051424600388, 9183.540822958825, 9195.540222988857, 9197.49413782245, 9199.0, 9159.725208243763, 9233.030531794133, 9252.53737313135, 9259.398139120969, 9260.953695231514, 9114.589843457026, 9185.219256363218, 9207.585658645343, 9211.815763684755, 9221.30840186982, 9063.864042039375, 9211.493367864765, 9211.861822072675, 9216.124468175512, 9219.078092190794, 43602.563974360484, 44202.33696494555, 44207.0, 44208.778956105336, 44231.77884110559, 3229.3185768224243, 3410.539577157077, 3534.5228394166716, 3564.2515071834946, 3977.781222032787, 34260.82869585636, 34572.13569660753, 34869.12827179315, 35000.12499687503, 35676.64323356759, 4219.092895027584, 4223.324268117087, 4225.345071513921, 4234.491860976703, 4286.228478873802, 229693.0, 232729.0, 233179.0, 233583.0, 233846.0, 63546.6822665893, 64474.35525644777, 64480.35519644837, 72304.63847680834, 72377.27622723706, 79083.60458197672, 79329.60335198288, 79380.0, 79569.0, 79623.0, 18273.725894111598, 18535.44393668192, 18541.721874171897, 18637.534061648297, 18772.061396930098, 14289.142651440947, 14415.063020903817, 14445.855541444662, 14446.566603001716, 14465.13209207451, 22636.434089147573, 23477.647835282485, 23491.0, 23533.529329413315, 23593.292201233646, 8310.8337833243, 8437.57812109392, 9029.864552031724, 9055.2459958521, 9118.270538356915, 907.0430695616188, 940.6137903547312, 1059.51262419288, 1142.2289954280827, 1187.9940600296943, 30668.846655766578, 31079.223019424244, 31359.216019599236, 31804.68195318017, 33103.3379332412, 1003.4581326083979, 1061.808874402615, 1073.2755390111643, 1208.5045131496045, 1224.1736827641485, 15209.543713688607, 15213.391464341303, 15332.540023799304, 15493.380264789508, 15621.0, 443059.0, 448979.0, 449811.0, 450867.0, 450944.0, 62337.376626234065, 63646.36353636497, 63654.0, 63689.999999999076, 63732.0, 1335.9332033398487, 1495.5961890289777, 1499.9925000374928, 1506.1339729655274, 1512.455516014234, 28473.00344487933, 29820.701792981792, 31160.22099447532, 31325.0, 31838.84080579675, 50090.2486462696, 50125.24812127748, 50574.0, 50624.240636389746, 50702.23946640877, 255845.0, 259044.0, 260090.0, 260953.0, 261561.0, 30581.54127688131, 34926.65073349234, 35355.82322088373, 35378.29243415066, 35380.11549711175, 52148.21777673262, 53752.73123634357, 56342.71828640831, 57176.42823571711, 57268.427315727975, 40331.0, 40950.59049409587, 41032.58967410288, 41287.587124128375, 42414.78792606017, 39790.0, 40092.79953600213, 40110.99722506961, 40373.1925361497, 41069.58930410658, 39691.40462893117, 39870.20259594734, 40546.18907621772, 40840.0, 41014.0, 34797.652023480456, 36555.634443655224, 36666.45000325051, 37047.25905481929, 37127.6287237135, 27916.720832791412, 28055.298617534725, 28060.29849253785, 28110.718892811627, 28126.578101328905], "unit": "score", "name": "ext.html", "value": 20320.132638292765}, {"lowerIsBetter": false, "replicates": [328.96545862684417, 344.13106905064717, 346.321210427562, 360.45931103344964, 360.72404610473006, 17326.306947722074, 17555.648887022253, 17915.372961946334, 18104.547386315317, 18149.455516334532, 17642.294308227687, 18257.634847303045, 18592.628147437044, 18610.72083918739, 18640.347587834396, 5213.452587478317, 5611.663300201981, 5611.887762244753, 5617.41017193195, 5620.718964051802, 4251.256030194719, 4373.475182978032, 4373.737575745449, 5440.4287549807295, 5797.449242321973, 6029.909551356734, 6033.0, 6039.365866584011, 6057.242844644419, 6064.42387973144, 5242.1088414969545, 5429.67421954684, 5435.619506634517, 5440.591955603346, 6005.909911351311, 3883.2233553289457, 5191.532762051434, 5203.063448579254, 5239.973800130975, 5254.290670759437, 12901.806472902914, 13191.736165276641, 13211.207327560378, 13362.86637133626, 13388.799168012487, 2177.8911054447212, 2263.1060731011157, 2274.8180145588312, 2542.478791847667, 2601.115620688956, 9889.901100989042, 10216.74458138545, 10232.693019209435, 10533.631322903739, 13378.39797209128, 1786.88385254958, 1891.1206289075508, 1908.6469003234447, 1926.5761532462836, 1934.6807776716826, 60152.0, 64534.0, 65720.0, 65780.34219657838, 66237.66881165611, 9726.465044422624, 10161.4919254037, 10355.275130740776, 10432.122218000834, 10466.842997355046, 14509.709805803825, 14780.0, 14819.407223711147, 14851.777223341658, 14901.254937253094, 7830.33442157423, 7858.17489163641, 7975.401844861659, 8130.390220733469, 8223.794405139799, 7684.7310344138805, 7702.691892324357, 7781.377489800802, 7816.8827467588035, 8011.83976320482, 4451.755153466525, 4581.427321584802, 4634.652401069933, 4668.649851261169, 4764.190087685102, 1795.1203910083964, 1868.2246867549813, 1896.8429258152516, 1908.6850669639355, 1951.5706544560173, 937.5780898595523, 940.4122423485321, 962.5043102802063, 964.6816550538306, 1010.4947526236881, 16169.757453638205, 16609.252583633766, 16711.080890551137, 16795.0, 17055.829441705424, 963.5471328475745, 975.6195083917136, 999.5452069308448, 1008.1833714691123, 1042.0100904141095, 9788.363756355957, 9906.900930990598, 10000.149987251165, 10034.64878729241, 10176.236782241362, 427929.0, 454600.0, 459643.0, 459899.0, 461442.0, 74938.25061749313, 76267.61866190634, 76897.61551192208, 77487.0, 77905.0, 1029.9433531155858, 1030.443560477334, 1045.968620941373, 1050.3487837540774, 1062.436908438529, 15467.149306788235, 15545.611359716098, 15582.220888955733, 15742.602413726045, 15975.920120399323, 32480.187995300308, 32900.177495561846, 33528.32943341168, 34305.0, 34514.65485345215, 49170.508294916595, 49365.0, 49865.0, 49908.500914990385, 50004.499954999985, 8144.959275203586, 8298.0, 8551.1448855114, 8627.568621569022, 8640.524771137396, 11315.830262545904, 12779.23324600527, 12808.551700690432, 12873.0, 12933.935330323287, 10691.227685030835, 11117.166212534254, 11203.159763017644, 11254.324740515594, 11466.197366184288, 10818.24272300963, 10878.292910960763, 10970.835437468284, 11238.831417528907, 11587.188896777145, 10790.892091079302, 10940.23418360739, 10987.450627468435, 11035.613753518588, 11439.199256051996, 8132.2680958711635, 8279.254867061993, 8322.750317490485, 8334.83330333402, 8399.70601028961, 10384.688459346231, 10500.47497625131, 10544.0, 10903.618373356894, 10917.39954302521], "unit": "score", "name": "jquery.html", "value": 8534.719436240985}, {"lowerIsBetter": false, "replicates": [1470.0591621362337, 1576.8580827725502, 1602.431136946384, 1855.8236967488092, 1955.2374573916184, 7458.888116678248, 8022.91977080229, 8072.434929554934, 8079.515229086244, 8080.636371363288, 8121.75634730959, 8289.088200297962, 8299.751007469771, 8300.418970672055, 8313.542755148464, 2426.0, 2452.1172377943926, 2452.3256104571296, 2454.2882564056404, 2454.3373289211904, 2404.5791986402396, 2425.357280320716, 2460.9753902461016, 2463.4210960424284, 2480.379905023744, 2481.5036992601463, 2496.10140349474, 2544.5165418570505, 2553.9106131285407, 2555.4122551813093, 2498.925032249035, 2512.095645567594, 2520.1305549585454, 2540.0, 2551.2346296111277, 2427.2232885476656, 2456.275398757371, 2514.208024472304, 2526.166365099513, 2526.68416447944, 8369.0, 8410.663573457054, 8426.873596896052, 8436.45163064399, 8455.154484551496, 5337.3061502004875, 5475.206095116226, 5476.863078423071, 5478.863028424282, 5482.342118945712, 3198.1524895902603, 3225.5645487859306, 3259.755518336134, 3312.403767321881, 3349.698527132545, 1019.9133073688745, 1021.5686665735576, 1036.5853658536646, 1050.7425680708275, 1103.0568863621568, 12296.692582685415, 12308.199967002205, 12320.260784352968, 12358.0, 12367.443465044094, 4734.597559207437, 4754.95245047552, 4891.755412229445, 4924.852254432372, 4937.530934561211, 9217.44695318283, 9256.398334108262, 9296.16334529882, 9310.441373517475, 9317.254619630414, 5248.422673505911, 5257.342832145981, 5259.263703081571, 5271.446498117719, 5275.841724748264, 4257.212415703105, 4736.3369128322065, 4813.855584332476, 4814.398200224972, 4823.27650852375, 3658.414653655402, 3692.390755525308, 3719.590845007047, 3758.4174452959833, 3785.413260944558, 1131.3438205840594, 1145.4158379226487, 1152.4295473740551, 1164.1152723929874, 1165.6794381545144, 1415.3701602786662, 1430.6137342917561, 1439.1293267573176, 1447.7321695486369, 1475.2623688155923, 7858.528488290721, 7892.013498312711, 7927.3658107351275, 7935.206479352134, 7945.562994035268, 497.59197458084026, 502.42472369137136, 505.524806681718, 527.4646234072419, 547.5236544206487, 5836.562257830679, 5897.587168898136, 5900.262467191601, 5930.080837470199, 5940.940590594038, 9988.0, 10274.743131421625, 10298.536565854554, 10326.690199294033, 10334.741631459123, 9676.661316854017, 10102.09081182697, 10103.696889093339, 10128.59485620567, 10160.4919754012, 7839.0, 7898.802529936683, 7916.445848790529, 7928.127905930343, 7953.244441778022, 7702.268284512962, 7720.961395193212, 7743.961280193563, 7807.336376408069, 8001.479903806467, 8906.777330566529, 9029.322800789836, 9153.816923661623, 9300.488473134043, 9302.906970930204, 9227.492487913229, 9286.257099431894, 9303.162715355651, 9342.486163261086, 9369.906300936904, 6734.56225345351, 6853.554518956252, 6907.033015377951, 7590.392768578611, 7685.423593230418, 8134.471259368359, 8145.959270203611, 8187.5087494750505, 8234.094249632415, 8241.50550966944, 7331.816704582428, 7483.363914067365, 7503.287187717158, 7567.848643027219, 7609.885851712118, 7167.605781682058, 7234.782956511313, 7294.927050729637, 7319.63401829917, 7324.450666199949, 7657.846843062996, 7697.191794861459, 7714.498557593738, 7724.652390642547, 7743.186965368555, 6822.420094292041, 7025.156981162293, 7049.330313620198, 7051.576905385693, 7063.399611032914, 7042.507024508235, 7155.499115061895, 7159.140903091662, 7165.8925116122255, 7178.964105179441], "unit": "score", "name": "mootools.html", "value": 4747.32755375135}, {"lowerIsBetter": false, "replicates": [325.55724215067505, 331.3422855631571, 331.62857599488575, 340.4620699295114, 342.07809952178883, 5822.446867547586, 5866.823995280138, 5880.059190529516, 5882.352941176472, 5884.529237660988, 5800.622959507629, 5823.796167134151, 5825.038868586688, 5830.883382332351, 5838.591298609099, 4344.847930322439, 4376.89057773555, 4539.341795439659, 4545.136424079423, 4547.63618910488, 4524.0, 4526.864194074166, 4541.2733962566, 4546.431696037996, 4546.704464209833, 4495.775211239441, 4498.392716983198, 4500.707454015478, 4504.932426013613, 4513.165064463068, 4340.631046361063, 4376.1247750449875, 4486.753228572427, 4488.708233964782, 4500.144972455223, 3926.587708290617, 3937.3109705801658, 3938.0, 3944.053427177457, 3960.0, 5498.120300751901, 5499.285092937933, 5502.312210973629, 5505.779768809283, 5511.862203444906, 5212.452692467275, 5251.632385733, 5255.894882102375, 5256.132738098209, 5261.158214685632, 6170.136180934673, 6177.567570270083, 6178.505719542426, 6179.938200617981, 6182.072689096626, 4128.091819799639, 4255.148970205972, 4263.126059157897, 4361.476622805252, 4374.825006999717, 6421.871562568723, 6479.028145778124, 6497.93502064978, 6511.479081673502, 6515.804525864231, 4369.148016136886, 4371.0, 4371.409859668967, 4373.1472362888935, 4375.671824613103, 4424.579664931826, 4428.645708343325, 4432.180046691373, 4433.534478879736, 4440.067585807016, 5092.8472145835685, 5095.464976177448, 5144.176931690911, 5155.74221288934, 5165.225216217597, 6068.21113255274, 6264.561480696308, 6273.62358258506, 6289.433950944437, 6290.087937249074, 1542.406173623163, 1549.9147546885029, 1555.0747305353298, 1561.5861796623904, 1563.9452619158503, 999.7250756042001, 1016.6594190945968, 1030.567161792049, 1043.879953805307, 1069.4011353641986, 6066.4540191382985, 6071.210742603434, 6106.847328816726, 6117.265928088658, 6126.877462450726, 6388.552801303864, 6395.040743888454, 6402.231732192166, 6408.231012278557, 6411.647359395185, 6102.816915492543, 6111.0, 6111.144439778434, 6118.877622447615, 6123.08153776937, 3428.5885693716414, 3459.221675123077, 3465.54947856777, 3468.514407982884, 3469.340825243196, 6611.404973552403, 6691.0, 6698.39714425704, 6726.125603671491, 6757.256701762803, 6488.643124628191, 6492.870142597121, 6520.152380190545, 6526.67366631676, 6548.3124271950755, 6662.56693314933, 6677.165354330708, 6680.16497937748, 6681.5656982296, 6699.6315202663345, 6325.209348831396, 6356.809295721136, 6376.936230637634, 6418.4544313731985, 6484.28672845996, 6140.692965351625, 6272.310045894857, 6279.623222606659, 6296.33888441707, 6348.460380867678, 6770.93229067703, 6771.492138089565, 6806.387425131762, 6814.352636499525, 6817.659117044029, 4506.954930450654, 4554.726716397026, 4554.817807287804, 4555.180067587866, 4561.521040290721, 6436.645984470899, 6438.195225596801, 6449.129367535323, 6451.903221451588, 6452.806415807533, 6264.123022776724, 6266.592671476339, 6282.497400207881, 6287.056941458635, 6291.276503202191, 6103.816885493442, 6346.048092786119, 6358.713857876314, 6380.042993551005, 6383.234011918599, 6215.502759779117, 6299.4645455135, 6310.558260921875, 6313.905291420724, 6316.936830631635, 6389.073584330339, 6391.936080639134, 6391.968040159955, 6405.743770249138, 6406.135171751754, 6009.429104235091, 6013.488853447506, 6236.6258024518675, 6260.311365749672, 6263.0], "unit": "score", "name": "prototype.html", "value": 4710.375106590742}, {"lowerIsBetter": false, "replicates": [729.2853004056025, 845.5265051571124, 860.157046094827, 879.5030807593711, 888.320434867327, 13629.727405451886, 13878.0, 13909.513167039157, 13947.232902190388, 13947.651308717288, 13702.588922332347, 13917.37371818268, 13981.860181398182, 14045.78931316031, 14076.436942522312, 785.4070177016345, 796.1998191817215, 912.2610685344858, 927.1146055516999, 940.9717708468756, 957.3394357893067, 958.156821996642, 959.0697023886819, 959.7120863740885, 960.4573416019962, 1003.257589383858, 1004.4877112672553, 1004.8743907011624, 1005.1707341443301, 1005.1807776662033, 808.0, 964.1756298364902, 989.0505115089522, 989.351974456732, 990.1484723138095, 729.963501824912, 732.0885497555524, 733.1458850439285, 733.545201974779, 733.5635296998278, 13241.271730054843, 13339.866601334057, 13399.062065655407, 13404.530841420503, 13408.530701425403, 13798.103123297054, 14016.579502614937, 14101.2949352533, 14182.0, 14343.21112338821, 11093.72265693356, 11120.721981950435, 11219.439028048646, 11283.435828208556, 11388.430578471127, 3876.8255428505786, 3883.49514563105, 3945.309570825123, 3947.822347994347, 4008.378701301274, 51512.0, 51862.0, 53143.73428132835, 53180.468195318324, 53273.0, 10737.087347575387, 10817.242793004572, 10870.72823179411, 11290.943545282222, 11601.303921764722, 20532.281370151974, 20577.279795207094, 20599.588008239753, 20606.17575297001, 20609.79390206079, 7440.85118297631, 7536.773896783106, 7628.313451789366, 7708.113566939762, 7873.37013038967, 3857.035741064734, 4001.9415359926725, 4032.1330913853662, 4267.957320426818, 4281.914361712748, 3412.5563676722363, 3419.401604719164, 3442.087846720621, 3447.7586568940437, 3454.274602333538, 565.8104534980745, 588.4233451217744, 591.3347484080409, 597.2325561653255, 606.1453350775386, 459.9701019433726, 615.9476444502178, 627.9372062793775, 646.8395558833519, 649.5647915896361, 8384.916150838535, 8448.408611397266, 8466.915330846736, 8503.532305723245, 8636.395452318404, 548.4405905975962, 665.6072916978909, 691.5746815708303, 696.3071743615135, 718.0450001497995, 4112.527059388149, 4118.91762164761, 4177.665786737054, 4178.143480586473, 4185.916281674349, 58771.0, 58903.41096589065, 59518.0, 59943.0, 60297.09554356688, 50141.96110914272, 51135.48864511307, 51549.0, 51792.44622661326, 52534.21198682023, 44770.776146119715, 46647.76676116598, 47094.0, 47187.528124719, 47736.761316193195, 8059.83880322402, 8273.669053238043, 8359.456635318686, 8359.628482972135, 8364.456310339809, 36380.27239455249, 37023.444648330835, 37209.4418583716, 37713.81143094267, 37768.811155944044, 42964.35553466638, 43112.35331470093, 44668.55331446774, 45294.77352613216, 46355.53644463512, 10747.247692661438, 11012.50443730018, 11087.22389432732, 11160.44197790091, 11302.0, 11150.665480035612, 11275.830862536905, 11365.829512557153, 11397.772044558897, 12229.633111006684, 10371.325863818827, 10538.631147909786, 10593.258471906893, 10791.460426978776, 10821.026107650348, 10113.69658910234, 10164.0, 10167.135793457639, 10209.0, 10741.570337186426, 11021.504032318404, 11037.172212084286, 11080.722981925517, 11091.0, 11117.746591022067, 9010.729678109667, 9201.493917834583, 9377.671781487616, 9534.809303814023, 9762.951185244028, 8859.291256699578, 9008.189262966365, 9273.119053689888, 9308.581113850028, 9425.481598512148], "unit": "score", "name": "yui.html", "value": 6531.416333357312}], "name": "dromaeo_css", "value": 7148.607259674185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 111.0, 110.0, 112.0, 113.0, 113.0, 112.0, 112.0, 125.0], "unit": "score", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 154.0, 175.0, 128.0, 160.0, 154.0, 134.0, 183.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 78.0, 158.0, 76.0, 76.0, 84.0, 77.0, 164.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 151.0, 94.0, 93.0, 94.0, 147.0, 95.0, 93.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 56.0, 55.0, 59.0, 55.0, 56.0, 70.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 67.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [94.0, 87.0, 78.0, 86.0, 80.0, 89.0, 80.0, 80.0, 86.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [114.0, 112.0, 112.0, 117.0, 122.0, 120.0, 113.0, 113.0, 114.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.2}, {"lowerIsBetter": true, "replicates": [148.0, 134.0, 147.0, 145.0, 144.0, 140.0, 146.0, 149.0, 150.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 68.0, 75.0, 69.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1521.8000000000002}]} 16:57:42 INFO - Return code: 0 16:57:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:42 INFO - # TBPL SUCCESS # 16:57:42 INFO - Running post-action listener: _resource_record_post_action 16:57:42 INFO - Running post-run listener: _resource_record_post_run 16:57:43 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 461430784; Read time: 32; Write time: 341344 16:57:43 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 233938944; Read time: 0; Write time: 233428 16:57:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 223096832; Read time: 32; Write time: 107420 16:57:43 INFO - Running post-run listener: _upload_blobber_files 16:57:43 INFO - Blob upload gear active. 16:57:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:57:43 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'] 16:57:43 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 16:57:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:57:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:57:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:44 INFO - (blobuploader) - INFO - Done attempting. 16:57:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:57:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:57:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:45 INFO - (blobuploader) - INFO - Done attempting. 16:57:45 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:45 INFO - Return code: 0 16:57:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e547384834364826f01a3122adc05d27e0a5f500924c9d836cb6db73d90e403ca98c09b7ade6ce3f13e6f13a07028f75eb8929cc64ff421a256a2bde17e48364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a341cda7f6956488fbe31019d0af5871a1460ab6fc12b083aa2a4d6f8ef1643bc208bdeef94d61b36bdf894e6ce8397a4ef35d1e3ae668dd415d6ae4cb379cdf"} 16:57:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:45 INFO - Contents: 16:57:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e547384834364826f01a3122adc05d27e0a5f500924c9d836cb6db73d90e403ca98c09b7ade6ce3f13e6f13a07028f75eb8929cc64ff421a256a2bde17e48364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a341cda7f6956488fbe31019d0af5871a1460ab6fc12b083aa2a4d6f8ef1643bc208bdeef94d61b36bdf894e6ce8397a4ef35d1e3ae668dd415d6ae4cb379cdf"} 16:57:45 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:45 INFO - Copying logs to upload dir... 16:57:45 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.645819 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-05-30 16:57:44.474202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:44.477914) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350 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/e547384834364826f01a3122adc05d27e0a5f500924c9d836cb6db73d90e403ca98c09b7ade6ce3f13e6f13a07028f75eb8929cc64ff421a256a2bde17e48364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a341cda7f6956488fbe31019d0af5871a1460ab6fc12b083aa2a4d6f8ef1643bc208bdeef94d61b36bdf894e6ce8397a4ef35d1e3ae668dd415d6ae4cb379cdf"} build_url:https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011470 build_url: 'https://queue.taskcluster.net/v1/task/NlZf2TaITQq31TgRtOAIMA/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/e547384834364826f01a3122adc05d27e0a5f500924c9d836cb6db73d90e403ca98c09b7ade6ce3f13e6f13a07028f75eb8929cc64ff421a256a2bde17e48364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a341cda7f6956488fbe31019d0af5871a1460ab6fc12b083aa2a4d6f8ef1643bc208bdeef94d61b36bdf894e6ce8397a4ef35d1e3ae668dd415d6ae4cb379cdf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:44.504974) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:44.505539) ========= 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=3a3620fb28aea1604ab609ef000001d2-1464650816.129119-996580350 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:44.587384) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:44.587719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:44.588039) ========= ========= Total master_lag: 0.16 =========